builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1469820473.17 results: success (0) buildid: 20160729095225 builduid: 6ad86c4043474851a12ebc09c4ca67d0 revision: 29c64bded0f10e51480470e6f18b778863b07311 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 12:27:53.172112) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 12:27:53.172548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 12:27:53.172830) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 12:27:53.187401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 12:27:53.187686) ========= 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=0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 12:27:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.2M=0.001s 2016-07-29 12:27:53 (20.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104996 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 12:27:53.306519) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 12:27:53.306857) ========= 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=0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015658 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 12:27:53.355846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 12:27:53.356182) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 29c64bded0f10e51480470e6f18b778863b07311 --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 29c64bded0f10e51480470e6f18b778863b07311 --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=0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 12:27:53,765 truncating revision to first 12 chars 2016-07-29 12:27:53,765 Setting DEBUG logging. 2016-07-29 12:27:53,765 attempt 1/10 2016-07-29 12:27:53,765 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/29c64bded0f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 12:27:55,120 unpacking tar archive at: mozilla-aurora-29c64bded0f1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.681297 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 12:27:55.051493) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 12:27:55.051827) ========= script_repo_revision: 29c64bded0f10e51480470e6f18b778863b07311 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 12:27:55.052237) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 12:27:55.052596) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 12:27:55.061528) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-29 12:27:55.061839) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:27:55 INFO - MultiFileLogger online at 20160729 12:27:55 in /builds/slave/test 12:27:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:27:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:27:55 INFO - {'append_to_log': False, 12:27:55 INFO - 'base_work_dir': '/builds/slave/test', 12:27:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:27:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:27:55 INFO - 'branch': 'Mozilla-Aurora', 12:27:55 INFO - 'buildbot_json_path': 'buildprops.json', 12:27:55 INFO - 'config_files': ('talos/linux_config.py',), 12:27:55 INFO - 'default_actions': ('clobber', 12:27:55 INFO - 'read-buildbot-config', 12:27:55 INFO - 'download-and-extract', 12:27:55 INFO - 'populate-webroot', 12:27:55 INFO - 'create-virtualenv', 12:27:55 INFO - 'install', 12:27:55 INFO - 'run-tests'), 12:27:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:27:55 INFO - 'download_minidump_stackwalk': True, 12:27:55 INFO - 'download_symbols': 'ondemand', 12:27:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:27:55 INFO - 'tooltool.py': '/tools/tooltool.py', 12:27:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:27:55 INFO - '/tools/misc-python/virtualenv.py')}, 12:27:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:27:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:27:55 INFO - 'installer_path': 'installer.exe', 12:27:55 INFO - 'log_level': 'info', 12:27:55 INFO - 'log_name': 'talos', 12:27:55 INFO - 'log_to_console': True, 12:27:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:27:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:27:55 INFO - 'opt_config_files': (), 12:27:55 INFO - 'pip_index': False, 12:27:55 INFO - 'sps_profile': False, 12:27:55 INFO - 'sps_profile_interval': 0, 12:27:55 INFO - 'suite': 'dromaeojs', 12:27:55 INFO - 'system_bits': '32', 12:27:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:27:55 INFO - 'title': 'talos-linux64-ix-058', 12:27:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:27:55 INFO - 'use_talos_json': True, 12:27:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:27:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:27:55 INFO - 'work_dir': 'build'} 12:27:55 INFO - ##### 12:27:55 INFO - ##### Running clobber step. 12:27:55 INFO - ##### 12:27:55 INFO - Running pre-action listener: _resource_record_pre_action 12:27:55 INFO - Running main action method: clobber 12:27:55 INFO - rmtree: /builds/slave/test/build 12:27:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:27:56 INFO - Running post-action listener: _resource_record_post_action 12:27:56 INFO - ##### 12:27:56 INFO - ##### Finished clobber step (success) 12:27:56 INFO - ##### 12:27:56 INFO - ##### 12:27:56 INFO - ##### Running read-buildbot-config step. 12:27:56 INFO - ##### 12:27:56 INFO - Running pre-action listener: _resource_record_pre_action 12:27:56 INFO - Running main action method: read_buildbot_config 12:27:56 INFO - Using buildbot properties: 12:27:56 INFO - { 12:27:56 INFO - "project": "", 12:27:56 INFO - "product": "firefox", 12:27:56 INFO - "script_repo_revision": "production", 12:27:56 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:27:56 INFO - "repository": "", 12:27:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:27:56 INFO - "buildid": "20160729095225", 12:27:56 INFO - "pgo_build": "True", 12:27:56 INFO - "basedir": "/builds/slave/test", 12:27:56 INFO - "buildnumber": 643, 12:27:56 INFO - "slavename": "talos-linux64-ix-058", 12:27:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:27:56 INFO - "platform": "ubuntu64_hw", 12:27:56 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:27:56 INFO - "branch": "mozilla-aurora", 12:27:56 INFO - "repo_path": "releases/mozilla-aurora", 12:27:56 INFO - "revision": "29c64bded0f10e51480470e6f18b778863b07311", 12:27:56 INFO - "stage_platform": "linux64-pgo", 12:27:56 INFO - "builduid": "6ad86c4043474851a12ebc09c4ca67d0", 12:27:56 INFO - "slavebuilddir": "test" 12:27:56 INFO - } 12:27:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 12:27:56 INFO - Running post-action listener: _resource_record_post_action 12:27:56 INFO - ##### 12:27:56 INFO - ##### Finished read-buildbot-config step (success) 12:27:56 INFO - ##### 12:27:56 INFO - ##### 12:27:56 INFO - ##### Running download-and-extract step. 12:27:56 INFO - ##### 12:27:56 INFO - Running pre-action listener: _resource_record_pre_action 12:27:56 INFO - Running main action method: download_and_extract 12:27:56 INFO - mkdir: /builds/slave/test/build/tests 12:27: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')]} 12:27:56 INFO - https://queue.taskcluster.net/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:27:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:27:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:27:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/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 12:27:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/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 12:27:57 INFO - Downloaded 1361 bytes. 12:27:57 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:27:57 INFO - Using the following test package requirements: 12:27:57 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 12:27:57 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:27:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:27:57 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:27:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:27:57 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:27:57 INFO - u'jsshell-linux-x86_64.zip'], 12:27:57 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:27:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:27:57 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 12:27:57 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:27:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:27:57 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:27:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:27:57 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:27:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:27:57 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:27:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:27:57 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:27:57 INFO - https://queue.taskcluster.net/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:27:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:27:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:27:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/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 12:27:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/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 12:27:58 INFO - Downloaded 24495081 bytes. 12:27:58 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'] 12:27:58 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 12:27:59 INFO - Return code: 0 12:27:59 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 12:27: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')]} 12:27:59 INFO - https://queue.taskcluster.net/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:27:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:27:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:27:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/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 12:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/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 12:28:00 INFO - Downloaded 24495081 bytes. 12:28:00 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'] 12:28:00 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 12:28:02 INFO - Return code: 0 12:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:02 INFO - https://queue.taskcluster.net/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:28:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 12:28:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 12:28:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/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 12:28:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/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 12:28:02 INFO - Downloaded 10833369 bytes. 12:28:02 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'] 12:28:02 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 12:28:03 INFO - Return code: 0 12:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:03 INFO - https://queue.taskcluster.net/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:28:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:28:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:28:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/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 12:28:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/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 12:28:04 INFO - Downloaded 63644176 bytes. 12:28:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:28:04 INFO - mkdir: /builds/slave/test/properties 12:28:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:28:04 INFO - Writing to file /builds/slave/test/properties/build_url 12:28:04 INFO - Contents: 12:28:04 INFO - build_url:https://queue.taskcluster.net/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:28:05 INFO - Running post-action listener: _resource_record_post_action 12:28:05 INFO - Running post-action listener: set_extra_try_arguments 12:28:05 INFO - ##### 12:28:05 INFO - ##### Finished download-and-extract step (success) 12:28:05 INFO - ##### 12:28:05 INFO - ##### 12:28:05 INFO - ##### Running populate-webroot step. 12:28:05 INFO - ##### 12:28:05 INFO - Running pre-action listener: _resource_record_pre_action 12:28:05 INFO - Running main action method: populate_webroot 12:28:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:28:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:28:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:28:05 INFO - '--tppagecycles', 12:28:05 INFO - '7'], 12:28:05 INFO - 'tests': ['tsvgm']}}, 12:28:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:28:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:28:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:28:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:28:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:28:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:28:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:05 INFO - 'talos_options': ['--disable-e10s'], 12:28:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:28:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:28:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:05 INFO - 'talos_options': ['--disable-e10s'], 12:28:05 INFO - 'tests': ['damp', 'tps']}, 12:28:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:05 INFO - 'tests': ['damp', 'tps']}, 12:28:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:28:05 INFO - 'tests': ['dromaeo_dom']}, 12:28:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:28:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:28:05 INFO - 'tests': ['a11yr', 12:28:05 INFO - 'ts_paint', 12:28:05 INFO - 'tpaint', 12:28:05 INFO - 'sessionrestore', 12:28:05 INFO - 'sessionrestore_no_auto_restore', 12:28:05 INFO - 'tabpaint']}, 12:28:05 INFO - 'other-e10s': {'tests': ['a11yr', 12:28:05 INFO - 'ts_paint', 12:28:05 INFO - 'tpaint', 12:28:05 INFO - 'sessionrestore', 12:28:05 INFO - 'sessionrestore_no_auto_restore', 12:28:05 INFO - 'tabpaint']}, 12:28:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:28:05 INFO - 'ts_paint', 12:28:05 INFO - 'tpaint', 12:28:05 INFO - 'sessionrestore', 12:28:05 INFO - 'sessionrestore_no_auto_restore', 12:28:05 INFO - 'tabpaint']}, 12:28:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:28:05 INFO - 'ts_paint', 12:28:05 INFO - 'tpaint', 12:28:05 INFO - 'sessionrestore', 12:28:05 INFO - 'sessionrestore_no_auto_restore', 12:28:05 INFO - 'tabpaint']}, 12:28:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:28:05 INFO - 'tests': ['a11yr', 12:28:05 INFO - 'ts_paint', 12:28:05 INFO - 'tpaint', 12:28:05 INFO - 'sessionrestore', 12:28:05 INFO - 'sessionrestore_no_auto_restore', 12:28:05 INFO - 'tabpaint']}, 12:28:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:28:05 INFO - 'tests': ['a11yr', 12:28:05 INFO - 'ts_paint', 12:28:05 INFO - 'tpaint', 12:28:05 INFO - 'sessionrestore', 12:28:05 INFO - 'sessionrestore_no_auto_restore', 12:28:05 INFO - 'tabpaint']}, 12:28:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:28:05 INFO - 'tests': ['tsvgx', 12:28:05 INFO - 'tsvgr_opacity', 12:28:05 INFO - 'tart', 12:28:05 INFO - 'tscrollx', 12:28:05 INFO - 'cart']}, 12:28:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:28:05 INFO - 'tsvgr_opacity', 12:28:05 INFO - 'tart', 12:28:05 INFO - 'tscrollx', 12:28:05 INFO - 'cart']}, 12:28:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:05 INFO - 'talos_options': ['--disable-e10s'], 12:28:05 INFO - 'tests': ['tp5o']}, 12:28:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:05 INFO - 'tests': ['tp5o']}, 12:28:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:05 INFO - 'talos_options': ['--disable-e10s', 12:28:05 INFO - '--xperf_path', 12:28:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:28:05 INFO - 'tests': ['tp5n']}, 12:28:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:05 INFO - 'talos_options': ['--xperf_path', 12:28:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:28:05 INFO - 'tests': ['tp5n']}}, 12:28:05 INFO - 'talos.zip': {'path': '', 12:28:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:28:05 INFO - Running post-action listener: _resource_record_post_action 12:28:05 INFO - ##### 12:28:05 INFO - ##### Finished populate-webroot step (success) 12:28:05 INFO - ##### 12:28:05 INFO - ##### 12:28:05 INFO - ##### Running create-virtualenv step. 12:28:05 INFO - ##### 12:28:05 INFO - Running pre-action listener: _resource_record_pre_action 12:28:05 INFO - Running main action method: create_virtualenv 12:28:05 INFO - Creating virtualenv /builds/slave/test/build/venv 12:28:05 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 12:28:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:28:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:28:05 INFO - Using real prefix '/usr' 12:28:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:28:05 INFO - Installing distribute.............................................................................................................................................................................................done. 12:28:07 INFO - Installing pip.................done. 12:28:07 INFO - Return code: 0 12:28:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19af68cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2653450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22c0>, '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 0x26e31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e3650>, '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': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', '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 12:28:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:28:07 INFO - Using env: {'DISPLAY': ':0', 12:28:07 INFO - 'HOME': '/home/cltbld', 12:28:07 INFO - 'LANG': 'en_US.UTF-8', 12:28:07 INFO - 'LANGUAGE': 'en_US:en', 12:28:07 INFO - 'LOGNAME': 'cltbld', 12:28:07 INFO - 'MAIL': '/var/mail/cltbld', 12:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:07 INFO - 'MOZ_NO_REMOTE': '1', 12:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:07 INFO - 'NO_EM_RESTART': '1', 12:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:07 INFO - 'PWD': '/builds/slave/test', 12:28:07 INFO - 'SHELL': '/bin/bash', 12:28:07 INFO - 'SHLVL': '1', 12:28:07 INFO - 'TERM': 'linux', 12:28:07 INFO - 'TMOUT': '86400', 12:28:07 INFO - 'USER': 'cltbld', 12:28:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', 12:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:07 INFO - '_': '/tools/buildbot/bin/python'} 12:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:07 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 12:28:07 INFO - Cleaning up... 12:28:08 INFO - Return code: 0 12:28:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:28: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')]} 12:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28: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')]} 12:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28: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 0x7f19af68cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2653450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22c0>, '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 0x26e31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e3650>, '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': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', '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 12:28: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 12:28: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 12:28:08 INFO - Using env: {'DISPLAY': ':0', 12:28:08 INFO - 'HOME': '/home/cltbld', 12:28:08 INFO - 'LANG': 'en_US.UTF-8', 12:28:08 INFO - 'LANGUAGE': 'en_US:en', 12:28:08 INFO - 'LOGNAME': 'cltbld', 12:28:08 INFO - 'MAIL': '/var/mail/cltbld', 12:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:08 INFO - 'MOZ_NO_REMOTE': '1', 12:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:08 INFO - 'NO_EM_RESTART': '1', 12:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:08 INFO - 'PWD': '/builds/slave/test', 12:28:08 INFO - 'SHELL': '/bin/bash', 12:28:08 INFO - 'SHLVL': '1', 12:28:08 INFO - 'TERM': 'linux', 12:28:08 INFO - 'TMOUT': '86400', 12:28:08 INFO - 'USER': 'cltbld', 12:28:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', 12:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:08 INFO - '_': '/tools/buildbot/bin/python'} 12:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:08 INFO - Downloading/unpacking psutil>=3.1.1 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:28:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:28:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:28:10 INFO - Installing collected packages: psutil 12:28:10 INFO - Running setup.py install for psutil 12:28:10 INFO - building 'psutil._psutil_linux' extension 12:28: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 12:28:10 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 12:28:10 INFO - building 'psutil._psutil_posix' extension 12:28:10 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 12:28:10 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 12:28:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:28:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:28:10 INFO - Successfully installed psutil 12:28:10 INFO - Cleaning up... 12:28:10 INFO - Return code: 0 12:28:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19af68cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2653450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22c0>, '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 0x26e31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e3650>, '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': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', '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 12:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:28:10 INFO - Using env: {'DISPLAY': ':0', 12:28:10 INFO - 'HOME': '/home/cltbld', 12:28:10 INFO - 'LANG': 'en_US.UTF-8', 12:28:10 INFO - 'LANGUAGE': 'en_US:en', 12:28:10 INFO - 'LOGNAME': 'cltbld', 12:28:10 INFO - 'MAIL': '/var/mail/cltbld', 12:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:10 INFO - 'MOZ_NO_REMOTE': '1', 12:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:10 INFO - 'NO_EM_RESTART': '1', 12:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:10 INFO - 'PWD': '/builds/slave/test', 12:28:10 INFO - 'SHELL': '/bin/bash', 12:28:10 INFO - 'SHLVL': '1', 12:28:10 INFO - 'TERM': 'linux', 12:28:10 INFO - 'TMOUT': '86400', 12:28:10 INFO - 'USER': 'cltbld', 12:28:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', 12:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:10 INFO - '_': '/tools/buildbot/bin/python'} 12:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:28:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:28:12 INFO - Installing collected packages: mozsystemmonitor 12:28:12 INFO - Running setup.py install for mozsystemmonitor 12:28:13 INFO - Successfully installed mozsystemmonitor 12:28:13 INFO - Cleaning up... 12:28:13 INFO - Return code: 0 12:28:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:13 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 0x7f19af68cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2653450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22c0>, '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 0x26e31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e3650>, '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': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', '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 12:28:13 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 12:28:13 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 12:28:13 INFO - Using env: {'DISPLAY': ':0', 12:28:13 INFO - 'HOME': '/home/cltbld', 12:28:13 INFO - 'LANG': 'en_US.UTF-8', 12:28:13 INFO - 'LANGUAGE': 'en_US:en', 12:28:13 INFO - 'LOGNAME': 'cltbld', 12:28:13 INFO - 'MAIL': '/var/mail/cltbld', 12:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:13 INFO - 'MOZ_NO_REMOTE': '1', 12:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:13 INFO - 'NO_EM_RESTART': '1', 12:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:13 INFO - 'PWD': '/builds/slave/test', 12:28:13 INFO - 'SHELL': '/bin/bash', 12:28:13 INFO - 'SHLVL': '1', 12:28:13 INFO - 'TERM': 'linux', 12:28:13 INFO - 'TMOUT': '86400', 12:28:13 INFO - 'USER': 'cltbld', 12:28:13 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', 12:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:13 INFO - '_': '/tools/buildbot/bin/python'} 12:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:13 INFO - Downloading/unpacking jsonschema==2.5.1 12:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:28:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28:15 INFO - Downloading functools32-3.2.3-2.tar.gz 12:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:28:15 INFO - warning: no files found matching '*.txt' 12:28:15 INFO - no previously-included directories found matching 'build' 12:28:15 INFO - no previously-included directories found matching 'dist' 12:28:15 INFO - no previously-included directories found matching '.git*' 12:28:15 INFO - Installing collected packages: jsonschema, functools32 12:28:15 INFO - Running setup.py install for functools32 12:28:15 INFO - warning: no files found matching '*.txt' 12:28:15 INFO - no previously-included directories found matching 'build' 12:28:15 INFO - no previously-included directories found matching 'dist' 12:28:15 INFO - no previously-included directories found matching '.git*' 12:28:15 INFO - Successfully installed jsonschema functools32 12:28:15 INFO - Cleaning up... 12:28:15 INFO - Return code: 0 12:28:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:15 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 0x7f19af68cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2653450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22c0>, '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 0x26e31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e3650>, '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': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', '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 12:28:15 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 12:28:15 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 12:28:15 INFO - Using env: {'DISPLAY': ':0', 12:28:15 INFO - 'HOME': '/home/cltbld', 12:28:15 INFO - 'LANG': 'en_US.UTF-8', 12:28:15 INFO - 'LANGUAGE': 'en_US:en', 12:28:15 INFO - 'LOGNAME': 'cltbld', 12:28:15 INFO - 'MAIL': '/var/mail/cltbld', 12:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:15 INFO - 'MOZ_NO_REMOTE': '1', 12:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:15 INFO - 'NO_EM_RESTART': '1', 12:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:15 INFO - 'PWD': '/builds/slave/test', 12:28:15 INFO - 'SHELL': '/bin/bash', 12:28:15 INFO - 'SHLVL': '1', 12:28:15 INFO - 'TERM': 'linux', 12:28:15 INFO - 'TMOUT': '86400', 12:28:15 INFO - 'USER': 'cltbld', 12:28:15 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', 12:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:15 INFO - '_': '/tools/buildbot/bin/python'} 12:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:15 INFO - Downloading/unpacking blobuploader==1.2.4 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28:17 INFO - Downloading blobuploader-1.2.4.tar.gz 12:28:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:28:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:28:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:18 INFO - Downloading docopt-0.6.1.tar.gz 12:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:28:18 INFO - Installing collected packages: blobuploader, requests, docopt 12:28:18 INFO - Running setup.py install for blobuploader 12:28:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:28:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:28:18 INFO - Running setup.py install for requests 12:28:18 INFO - Running setup.py install for docopt 12:28:19 INFO - Successfully installed blobuploader requests docopt 12:28:19 INFO - Cleaning up... 12:28:19 INFO - Return code: 0 12:28:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:28:19 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')]} 12:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:19 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')]} 12:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:19 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 0x7f19af68cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2653450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22c0>, '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 0x26e31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e3650>, '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': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', '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 12:28:19 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 12:28:19 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 12:28:19 INFO - Using env: {'DISPLAY': ':0', 12:28:19 INFO - 'HOME': '/home/cltbld', 12:28:19 INFO - 'LANG': 'en_US.UTF-8', 12:28:19 INFO - 'LANGUAGE': 'en_US:en', 12:28:19 INFO - 'LOGNAME': 'cltbld', 12:28:19 INFO - 'MAIL': '/var/mail/cltbld', 12:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:19 INFO - 'MOZ_NO_REMOTE': '1', 12:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:19 INFO - 'NO_EM_RESTART': '1', 12:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:19 INFO - 'PWD': '/builds/slave/test', 12:28:19 INFO - 'SHELL': '/bin/bash', 12:28:19 INFO - 'SHLVL': '1', 12:28:19 INFO - 'TERM': 'linux', 12:28:19 INFO - 'TMOUT': '86400', 12:28:19 INFO - 'USER': 'cltbld', 12:28:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', 12:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:19 INFO - '_': '/tools/buildbot/bin/python'} 12:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:28:19 INFO - Running setup.py (path:/tmp/pip-Sf9RaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:28:19 INFO - Running setup.py (path:/tmp/pip-7gkLmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:28:19 INFO - Running setup.py (path:/tmp/pip-xM1PYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:28:19 INFO - Running setup.py (path:/tmp/pip-RL4wRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:28:19 INFO - Running setup.py (path:/tmp/pip-qSYIcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:28:19 INFO - Running setup.py (path:/tmp/pip-fo7579-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:28:19 INFO - Running setup.py (path:/tmp/pip-Q8taGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:28:19 INFO - Running setup.py (path:/tmp/pip-f2BJMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:28:19 INFO - Running setup.py (path:/tmp/pip-hvq1um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:28:19 INFO - Running setup.py (path:/tmp/pip-jhBobp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:28:20 INFO - Running setup.py (path:/tmp/pip-2WkCJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:28:20 INFO - Running setup.py (path:/tmp/pip-dJSGSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:28:20 INFO - Running setup.py (path:/tmp/pip-SfeDRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:28:20 INFO - Running setup.py (path:/tmp/pip-zmsiNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:20 INFO - Running setup.py (path:/tmp/pip-RN8j8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:28:20 INFO - Running setup.py (path:/tmp/pip-WE_kVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:28:20 INFO - Running setup.py (path:/tmp/pip-4vNHPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:28:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:28:20 INFO - Running setup.py install for manifestparser 12:28:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:28:20 INFO - Running setup.py install for mozcrash 12:28:20 INFO - Running setup.py install for mozdebug 12:28:20 INFO - Running setup.py install for mozdevice 12:28:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:28:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:28:20 INFO - Running setup.py install for mozfile 12:28:21 INFO - Running setup.py install for mozhttpd 12:28:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:28:21 INFO - Running setup.py install for mozinfo 12:28:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:28:21 INFO - Running setup.py install for mozInstall 12:28:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:28:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:28:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:28:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:28:21 INFO - Running setup.py install for mozleak 12:28:21 INFO - Running setup.py install for mozlog 12:28:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:28:21 INFO - Running setup.py install for moznetwork 12:28:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:28:21 INFO - Running setup.py install for mozprocess 12:28:21 INFO - Running setup.py install for mozprofile 12:28:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:28:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:28:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:28:21 INFO - Running setup.py install for mozrunner 12:28:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:28:22 INFO - Running setup.py install for mozscreenshot 12:28:22 INFO - Running setup.py install for moztest 12:28:22 INFO - Running setup.py install for mozversion 12:28:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:28:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:28:22 INFO - Cleaning up... 12:28:22 INFO - Return code: 0 12:28:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:28:22 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')]} 12:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:22 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')]} 12:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:22 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 0x7f19af68cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2653450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22c0>, '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 0x26e31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e3650>, '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': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', '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 12:28:22 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 12:28:22 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 12:28:22 INFO - Using env: {'DISPLAY': ':0', 12:28:22 INFO - 'HOME': '/home/cltbld', 12:28:22 INFO - 'LANG': 'en_US.UTF-8', 12:28:22 INFO - 'LANGUAGE': 'en_US:en', 12:28:22 INFO - 'LOGNAME': 'cltbld', 12:28:22 INFO - 'MAIL': '/var/mail/cltbld', 12:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:22 INFO - 'MOZ_NO_REMOTE': '1', 12:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:22 INFO - 'NO_EM_RESTART': '1', 12:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:22 INFO - 'PWD': '/builds/slave/test', 12:28:22 INFO - 'SHELL': '/bin/bash', 12:28:22 INFO - 'SHLVL': '1', 12:28:22 INFO - 'TERM': 'linux', 12:28:22 INFO - 'TMOUT': '86400', 12:28:22 INFO - 'USER': 'cltbld', 12:28:22 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', 12:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:22 INFO - '_': '/tools/buildbot/bin/python'} 12:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:28:22 INFO - Running setup.py (path:/tmp/pip-lsrwHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:28:22 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)) 12:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:28:22 INFO - Running setup.py (path:/tmp/pip-NYrU9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:28:22 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)) 12:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:28:22 INFO - Running setup.py (path:/tmp/pip-lqI9fG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:28:22 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)) 12:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:28:22 INFO - Running setup.py (path:/tmp/pip-4w9leC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:28:22 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)) 12:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:28:22 INFO - Running setup.py (path:/tmp/pip-PdMgpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:28:22 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)) 12:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:28:22 INFO - Running setup.py (path:/tmp/pip-FkbclG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:28:23 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)) 12:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:28:23 INFO - Running setup.py (path:/tmp/pip-ieigTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:28:23 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)) 12:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:28:23 INFO - Running setup.py (path:/tmp/pip-_oOUuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:28:23 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)) 12:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:28:23 INFO - Running setup.py (path:/tmp/pip-oEnqZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:28:23 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)) 12:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:28:23 INFO - Running setup.py (path:/tmp/pip-MONVMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:28:23 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)) 12:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:28:23 INFO - Running setup.py (path:/tmp/pip-ytaiY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:28:23 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)) 12:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:28:23 INFO - Running setup.py (path:/tmp/pip-8d9jEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:28:23 INFO - Running setup.py (path:/tmp/pip-hvpDXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:28:23 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)) 12:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:28:23 INFO - Running setup.py (path:/tmp/pip-VrDnVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:23 INFO - Running setup.py (path:/tmp/pip-i7_wa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:23 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)) 12:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:28:23 INFO - Running setup.py (path:/tmp/pip-O83arv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:28:23 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)) 12:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:28:23 INFO - Running setup.py (path:/tmp/pip-bYlh_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:28:23 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)) 12:28:23 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)) 12:28:23 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)) 12:28:23 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)) 12:28:23 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)) 12:28:23 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)) 12:28:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:25 INFO - Downloading blessings-1.6.tar.gz 12:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:28:25 INFO - Installing collected packages: blessings 12:28:25 INFO - Running setup.py install for blessings 12:28:25 INFO - Successfully installed blessings 12:28:25 INFO - Cleaning up... 12:28:25 INFO - Return code: 0 12:28:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:28:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:28:26 INFO - Reading from file tmpfile_stdout 12:28:26 INFO - Current package versions: 12:28:26 INFO - argparse == 1.2.1 12:28:26 INFO - blessings == 1.6 12:28:26 INFO - blobuploader == 1.2.4 12:28:26 INFO - docopt == 0.6.1 12:28:26 INFO - functools32 == 3.2.3-2 12:28:26 INFO - jsonschema == 2.5.1 12:28:26 INFO - manifestparser == 1.1 12:28:26 INFO - mozInstall == 1.12 12:28:26 INFO - mozcrash == 0.17 12:28:26 INFO - mozdebug == 0.1 12:28:26 INFO - mozdevice == 0.48 12:28:26 INFO - mozfile == 1.2 12:28:26 INFO - mozhttpd == 0.7 12:28:26 INFO - mozinfo == 0.9 12:28:26 INFO - mozleak == 0.1 12:28:26 INFO - mozlog == 3.2 12:28:26 INFO - moznetwork == 0.27 12:28:26 INFO - mozprocess == 0.23 12:28:26 INFO - mozprofile == 0.28 12:28:26 INFO - mozrunner == 6.12 12:28:26 INFO - mozscreenshot == 0.1 12:28:26 INFO - mozsystemmonitor == 0.3 12:28:26 INFO - moztest == 0.7 12:28:26 INFO - mozversion == 1.4 12:28:26 INFO - psutil == 3.1.1 12:28:26 INFO - requests == 1.2.3 12:28:26 INFO - wsgiref == 0.1.2 12:28:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:26 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 0x7f19af68cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2653450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22c0>, '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 0x26e31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e3650>, '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': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', '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 12:28:26 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 12:28:26 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 12:28:26 INFO - Using env: {'DISPLAY': ':0', 12:28:26 INFO - 'HOME': '/home/cltbld', 12:28:26 INFO - 'LANG': 'en_US.UTF-8', 12:28:26 INFO - 'LANGUAGE': 'en_US:en', 12:28:26 INFO - 'LOGNAME': 'cltbld', 12:28:26 INFO - 'MAIL': '/var/mail/cltbld', 12:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:26 INFO - 'MOZ_NO_REMOTE': '1', 12:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:26 INFO - 'NO_EM_RESTART': '1', 12:28:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:26 INFO - 'PWD': '/builds/slave/test', 12:28:26 INFO - 'SHELL': '/bin/bash', 12:28:26 INFO - 'SHLVL': '1', 12:28:26 INFO - 'TERM': 'linux', 12:28:26 INFO - 'TMOUT': '86400', 12:28:26 INFO - 'USER': 'cltbld', 12:28:26 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', 12:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:26 INFO - '_': '/tools/buildbot/bin/python'} 12:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:26 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)) 12:28:26 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)) 12:28:26 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)) 12:28:26 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)) 12:28:26 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)) 12:28:26 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)) 12:28:26 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)) 12:28:26 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)) 12:28:26 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)) 12:28:26 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)) 12:28:26 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)) 12:28:26 INFO - Cleaning up... 12:28:26 INFO - Return code: 0 12:28:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:26 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 0x7f19af68cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2653450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22c0>, '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 0x26e31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e3650>, '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': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', '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 12:28:26 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 12:28:26 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 12:28:26 INFO - Using env: {'DISPLAY': ':0', 12:28:26 INFO - 'HOME': '/home/cltbld', 12:28:26 INFO - 'LANG': 'en_US.UTF-8', 12:28:26 INFO - 'LANGUAGE': 'en_US:en', 12:28:26 INFO - 'LOGNAME': 'cltbld', 12:28:26 INFO - 'MAIL': '/var/mail/cltbld', 12:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:26 INFO - 'MOZ_NO_REMOTE': '1', 12:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:26 INFO - 'NO_EM_RESTART': '1', 12:28:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:26 INFO - 'PWD': '/builds/slave/test', 12:28:26 INFO - 'SHELL': '/bin/bash', 12:28:26 INFO - 'SHLVL': '1', 12:28:26 INFO - 'TERM': 'linux', 12:28:26 INFO - 'TMOUT': '86400', 12:28:26 INFO - 'USER': 'cltbld', 12:28:26 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', 12:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:26 INFO - '_': '/tools/buildbot/bin/python'} 12:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:28:26 INFO - Cleaning up... 12:28:26 INFO - Return code: 0 12:28:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:26 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 0x7f19af68cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2653450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22c0>, '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 0x26e31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e3650>, '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': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', '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 12:28:26 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 12:28:26 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 12:28:26 INFO - Using env: {'DISPLAY': ':0', 12:28:26 INFO - 'HOME': '/home/cltbld', 12:28:26 INFO - 'LANG': 'en_US.UTF-8', 12:28:26 INFO - 'LANGUAGE': 'en_US:en', 12:28:26 INFO - 'LOGNAME': 'cltbld', 12:28:26 INFO - 'MAIL': '/var/mail/cltbld', 12:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:26 INFO - 'MOZ_NO_REMOTE': '1', 12:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:26 INFO - 'NO_EM_RESTART': '1', 12:28:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:26 INFO - 'PWD': '/builds/slave/test', 12:28:26 INFO - 'SHELL': '/bin/bash', 12:28:26 INFO - 'SHLVL': '1', 12:28:26 INFO - 'TERM': 'linux', 12:28:26 INFO - 'TMOUT': '86400', 12:28:26 INFO - 'USER': 'cltbld', 12:28:26 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', 12:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:26 INFO - '_': '/tools/buildbot/bin/python'} 12:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:26 INFO - Downloading/unpacking flake8 12:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:28:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:28:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:28:29 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 12:28:29 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 12:28:29 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 12:28:29 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 12:28:29 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 12:28:29 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 12:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:28:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:28:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:28:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:28:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:28:29 INFO - no previously-included directories found matching 'docs/_build' 12:28:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:28:29 INFO - Running setup.py install for pep8 12:28:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:28:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:28:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:28:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:28:29 INFO - no previously-included directories found matching 'docs/_build' 12:28:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:28:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:28:29 INFO - Cleaning up... 12:28:29 INFO - Return code: 0 12:28:29 INFO - Running post-action listener: _resource_record_post_action 12:28:29 INFO - Running post-action listener: _start_resource_monitoring 12:28:29 INFO - Starting resource monitoring. 12:28:29 INFO - ##### 12:28:29 INFO - ##### Finished create-virtualenv step (success) 12:28:29 INFO - ##### 12:28:29 INFO - ##### 12:28:29 INFO - ##### Running install step. 12:28:29 INFO - ##### 12:28:29 INFO - Running pre-action listener: _resource_record_pre_action 12:28:29 INFO - Running main action method: install 12:28:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:28:29 INFO - Reading from file tmpfile_stdout 12:28:29 INFO - Detecting whether we're running mozinstall >=1.0... 12:28:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:28:30 INFO - Reading from file tmpfile_stdout 12:28:30 INFO - Output received: 12:28:30 INFO - Usage: mozinstall [options] installer 12:28:30 INFO - Options: 12:28:30 INFO - -h, --help show this help message and exit 12:28:30 INFO - -d DEST, --destination=DEST 12:28:30 INFO - Directory to install application into. [default: 12:28:30 INFO - "/builds/slave/test"] 12:28:30 INFO - --app=APP Application being installed. [default: firefox] 12:28:30 INFO - mkdir: /builds/slave/test/build/application 12:28:30 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'] 12:28:30 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 12:28:45 INFO - Reading from file tmpfile_stdout 12:28:45 INFO - Output received: 12:28:45 INFO - /builds/slave/test/build/application/firefox/firefox 12:28:45 INFO - Running post-action listener: _resource_record_post_action 12:28:45 INFO - ##### 12:28:45 INFO - ##### Finished install step (success) 12:28:45 INFO - ##### 12:28:45 INFO - ##### 12:28:45 INFO - ##### Running run-tests step. 12:28:45 INFO - ##### 12:28:45 INFO - Running pre-action listener: _resource_record_pre_action 12:28:45 INFO - Running main action method: run_tests 12:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:28:45 INFO - Python 2.7.3 12:28:45 INFO - Return code: 0 12:28:45 INFO - grabbing minidump binary from tooltool 12:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:45 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 0x26e22c0>, '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 0x26e31c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e3650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:28:45 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 12:28:45 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 12:28:45 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 12:28:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:28:45 INFO - Return code: 0 12:28:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:28:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:28:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:28:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:28:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:28:46 INFO - Return code: 0 12:28:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:28:46 INFO - Using env: {'DISPLAY': ':0', 12:28:46 INFO - 'HOME': '/home/cltbld', 12:28:46 INFO - 'LANG': 'en_US.UTF-8', 12:28:46 INFO - 'LANGUAGE': 'en_US:en', 12:28:46 INFO - 'LOGNAME': 'cltbld', 12:28:46 INFO - 'MAIL': '/var/mail/cltbld', 12:28:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:28:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:46 INFO - 'MOZ_NO_REMOTE': '1', 12:28:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:46 INFO - 'NO_EM_RESTART': '1', 12:28:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:46 INFO - 'PWD': '/builds/slave/test', 12:28:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:28:46 INFO - 'SHELL': '/bin/bash', 12:28:46 INFO - 'SHLVL': '1', 12:28:46 INFO - 'TERM': 'linux', 12:28:46 INFO - 'TMOUT': '86400', 12:28:46 INFO - 'USER': 'cltbld', 12:28:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845', 12:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:46 INFO - '_': '/tools/buildbot/bin/python'} 12:28:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:28:47 INFO - mozversion application_buildid: 20160729095225 12:28:47 INFO - mozversion application_changeset: 29c64bded0f10e51480470e6f18b778863b07311 12:28:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:28:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:28:47 INFO - mozversion application_name: Firefox 12:28:47 INFO - mozversion application_remotingname: firefox-dev 12:28:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:28:47 INFO - mozversion application_vendor: Mozilla 12:28:47 INFO - mozversion application_version: 49.0a2 12:28:47 INFO - mozversion platform_buildid: 20160729095225 12:28:47 INFO - mozversion platform_changeset: 29c64bded0f10e51480470e6f18b778863b07311 12:28:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:28:47 INFO - mozversion platform_version: 49.0a2 12:28:47 INFO - using testdate: 1469820527 12:28:47 INFO - actual date: 1469820527 12:28:47 INFO - starting webserver on 'localhost:59389' 12:28:47 INFO - SUITE-START | Running 2 tests 12:28:47 INFO - TEST-START | dromaeo_css 12:28:47 INFO - operating with platform_type : linux_ 12:28:47 INFO - Initialising browser for dromaeo_css test... 12:28:47 INFO - TEST-INFO | started process 32739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptBbSZL/profile http://localhost:59389/getInfo.html) 12:28:51 INFO - PROCESS | 32739 | __metrics Screen width/height:1600/1200 12:28:51 INFO - PROCESS | 32739 | colorDepth:24 12:28:51 INFO - PROCESS | 32739 | Browser inner width/height: 1024/697 12:28:51 INFO - PROCESS | 32739 | __metrics 12:28:52 INFO - PROCESS | 32739 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:28:52 ERROR - PROCESS | 32739 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:28:52 INFO - TEST-INFO | 32739: exit 0 12:28:52 INFO - Browser initialized. 12:28:52 INFO - Running cycle 1/1 for dromaeo_css test... 12:28:52 INFO - TEST-INFO | started process 362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptBbSZL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:29:04 INFO - PROCESS | 362 | RSS: Main: 145154048 12:29:04 INFO - PROCESS | 362 | 12:29:55 INFO - PROCESS | 362 | 1469820595882 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] 12:32:03 INFO - PROCESS | 362 | Cycle 1(1): loaded http://localhost:59389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59389/tests/dromaeo/cssquery-ext.html) 12:32:04 INFO - PROCESS | 362 | RSS: Main: 248483840 12:32:04 INFO - PROCESS | 362 | 12:35:07 INFO - PROCESS | 362 | Cycle 1(1): loaded http://localhost:59389/tests/dromaeo/cssquery-ext.html (next: http://localhost:59389/tests/dromaeo/cssquery-jquery.html) 12:35:07 INFO - PROCESS | 362 | RSS: Main: 231718912 12:35:07 INFO - PROCESS | 362 | 12:38:09 INFO - PROCESS | 362 | Cycle 1(1): loaded http://localhost:59389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59389/tests/dromaeo/cssquery-mootools.html) 12:38:10 INFO - PROCESS | 362 | RSS: Main: 227889152 12:38:10 INFO - PROCESS | 362 | 12:41:12 INFO - PROCESS | 362 | Cycle 1(1): loaded http://localhost:59389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59389/tests/dromaeo/cssquery-prototype.html) 12:41:13 INFO - PROCESS | 362 | RSS: Main: 222195712 12:41:13 INFO - PROCESS | 362 | 12:44:15 INFO - PROCESS | 362 | Cycle 1(1): loaded http://localhost:59389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59389/tests/dromaeo/cssquery-yui.html) 12:44:16 INFO - PROCESS | 362 | RSS: Main: 208474112 12:44:16 INFO - PROCESS | 362 | 12:47:18 INFO - PROCESS | 362 | Cycle 1(1): loaded http://localhost:59389/tests/dromaeo/cssquery-yui.html (next: http://localhost:59389/tests/dromaeo/cssquery-dojo.html) 12:47:18 INFO - PROCESS | 362 | RSS: Main: 251293696 12:47:18 INFO - PROCESS | 362 | 12:47:18 INFO - PROCESS | 362 | __start_tp_report 12:47:18 INFO - PROCESS | 362 | _x_x_mozilla_page_load 12:47:18 INFO - PROCESS | 362 | _x_x_mozilla_page_load_details 12:47:18 INFO - PROCESS | 362 | |i|pagename|runs| 12:47:18 INFO - PROCESS | 362 | |0;dojo.html;3273.0998975281796;3293.720033797127;3321.385543674422;3323.617783954846;3328.3676101540705;5440.646357986733;5470.617056806025;5501.614886957915;5505.6696598204135;5536.75084621192;5483.040467918108;5524.889502209953;5530.170474428838;5539.501444869961;5580.107182850745;4869.269609558559;4993.400791904976;4998;5034.1945288753805;5064.366954130734;4828.179209534387;4927.926081108786;4989.226669866177;4990.201567749161;5000.224965130393;5039.899202015958;5088.618353623475;5093.847184584469;5101.744912754366;5132.076226279269;5174.275601415768;5190.858011237522;5201.895962080737;5209.114450543417;5220.216967454874;4839.225723884161;4928.48250933654;4932.753362331905;5104.974475127638;5115.974420127913;5374.328208973879;5388.245645609618;5426.348838139448;5438.972805135989;5439.782408703647;5997.4002599740115;6002.069679199731;6012.0380739081975;6014.278286605635;6019.127226552169;5870.09013602888;5900.881982360329;5935.614185077956;5960.582759206857;5999.790007349766;5609.52319052881;5619.6066275360745;5634.3520495143175;5636.689982050985;5651.463111004448;5759.94240057594;6096.367738972413;6097.817065488042;6100.908486372708;6133.785317513954;5700.144978253213;5816.5928385013485;5821.563382746311;5833.88332233353;5853.912191317134;5890.734916928748;5891.734871930774;5897.67562784051;5930.851728706817;5935.851603709855;5682.516986056149;5811.535077193815;5857.150713146655;5870.530357571384;5871.4715675589405;5836.854078648068;5948.434898684618;5951.9107213391835;5954.10688396744;5991.55063370249;4566.4748553916725;4573.634109271316;4578.244589642738;4579.908401832011;4599;3995.440638310639;4007.1584967157223;4058.1072164123843;4088.325426304686;4130.463039804806;5648.435156484319;5662.292213473316;5670.262865827499;5694.829155125353;5704.201411802351;5918.319393269743;5936.198613187251;5937.881242375129;5940.70296485174;5978.671173085522;5434.809781657623;5548.833534993957;5602.187682785973;5662.66024038559;5666.46168613981;5170;5170.095233334151;5177.663451875691;5178.352705911761;5184.248283998799;6273.62358258506;6289.654069026247;6294.748210071546;6298.590591611531;6299.275583307886;5677.148427735708;5821.068629019336;5904.261967254093;5905.586608937505;5974.103884417372;6144.099453127427;6200.06998950143;6207.782727604512;6218.036204388327;6228.968855155696;5852.063669812809;5855.94144058554;5859.267591551056;5860.062390017577;5861.794837180678;5743.282089738783;5827.825165245049;5862.355140934579;5889.998700221058;5995.5803093783015;5828.76684932598;5836.387179346278;5841.153032810304;5842.853928651818;5854;5749.13762935563;5808.477237048686;5810.477057064884;5818.185454036523;5819.301683797971;5442.238086667949;5597.888042239214;5653.265075540154;5669.829905102853;5682.5453963681975;5723.484886360081;5745.482906538432;5850.53195744348;5852.648841069549;5858.238429004202;5494.670319780826;5688.544916406595;5698.2592263005545;5699.886002279848;5723.370429252695 12:47:18 INFO - PROCESS | 362 | |1;ext.html;594.8037147741243;645.4997377032802;650.677914432356;661.7319985405911;671.7783131566583;32664.510032349535;44847.103057938824;45940.540594594044;45955.77022114893;46012.999999999956;47404;47885.521144788545;47960.841762120705;48008;48013.51986480143;8246.340292776564;8406.663733450685;8427.915720842775;9071.727848164533;9232.076792320748;8418.78953026173;10535.84196237057;10779.245452818306;10789.136869050497;11144.721381965435;11006;11041.227114102016;11048.944755276212;11057.11543076556;11071.114310855111;8438.78903027423;10714.250002499828;10773.407462589634;10775.94612026935;10787.892121078767;10575.101116405114;10653.786924261549;10977.451127443675;11008.669739907735;11018.39398833064;45245.09509809785;45648.543514564764;45722;45724;45840.77079614614;3757.755745876537;3763.1156678180605;3768.7361884668085;3953.525576930758;4243.957560424387;35562.28875422477;35790.642093578994;36014.199290035656;36039.4594081089;36107.45838812394;4710.646701497401;4802.687825291345;4837.879053023667;4860.513948605147;4905.2642103684375;432317;434665;435849;435932.99999999686;436173;36961;71856.28143718495;72453;72700.63649681718;72768.27231727721;38594;40887;40903.38644920329;41000.33497822632;41030;16748.162591870358;16781.916090419712;16925.407610733564;16925.830741692425;16941.068241246605;11607;13884.652883677787;14033.368498417596;14134;14192.503262385973;9546.379485333431;9606.51967401641;9625.133737963477;9645.37305075182;9680.419174849532;3626.1409710986877;3684.1894783147663;3691.7046636269033;3697.297513472485;3698.3527882620433;1033.2095946600857;1102.7573933734566;1171.0924033873816;1173.9236949598248;1195.3664557784389;34114.658853411645;34600.82699586536;34800;35159.12102197414;35394;1126.3639563534045;1144.7252659361693;1149.4540093455541;1240.2372540887288;1260.4328052376468;17871.910640446713;18045.187966541536;18136.183871725803;18140.274389024293;18160.1827917744;662846;668524;668571;669428;669760;64241.678791605744;64553;64672.35327646758;64820.67589662116;64943;1378.1248906943963;1453.14264583896;1493.5892629526968;1512.4026009726097;1512.9697406051816;34037.319253615286;34738.305233895684;35398.115047124025;35609.46585801163;36279;52726.73636631792;53024;53364.19953700775;53399.46600533945;53402.19896701475;326239;326934;327024;327178;327714;27651.723482764915;30464.543031854984;31066.378672426876;31337.37325253528;32627.836860815543;52110.21834672407;53526.73236633792;53780.19329710136;54033.18950215671;54716.45283547114;44005;44294.77852610716;44695.776521117186;45052.32421513746;45749.31376029296;43747.56252437562;43912.34131487966;44118.558814411444;45111.32333014942;45360;44013.77993110142;44623.55376446194;44938.55061449474;44959.55040449554;45394.092118158114;33184.50223246701;34474.310513790086;34881.30237395187;35470.290594187456;35926.64073359233;29394.706052939197;29641.5553766698;29691.55462668105;29788.255293617833;29925.251868703457 12:47:18 INFO - PROCESS | 362 | |2;jquery.html;425.9063006138649;427.43578476411113;428.69991006295584;439.2554619919236;439.69221544918565;18817.529561760963;19979.400617981464;20565.794342056575;21144.154233830628;21158.153673853027;20134.789403999905;20179.29372471964;20491.487712807186;20500.282490112848;20535;5685.715714214293;5866.413358664142;5917.58576899615;5919.437653422918;5921;5686.289213848269;5707.686077265748;5750.654960702351;5821.301443826746;5824.388439213885;5809.331926828406;5811.331696854852;5815.360310365856;5818.650880947135;5835.649861008332;5676.347220069703;5778.7977420790285;5961.761529538857;5968.6717230552085;6061.090836374535;5681.176229446707;5843.5033022193165;5847.736851841677;5850.3564607893095;5866.9119963200155;14627.926860365737;14640.780388294184;14828;14854.33155507994;14864.554063378007;2553.74462553745;2566.486702659457;2570.8714564271713;2593.8314009589503;2624.7506486883717;10203.591856325813;14432.20622865742;14826.33281502335;15030.549083527512;15330.233488325539;1860.3023866050232;1862.3481781376545;1935.1872213670292;1973.6743437332966;2038.6840039793708;64744.3525564743;68774.65612671904;79512;80698;83319.58340208321;11335.149863760085;11589.826152607717;11598.478068486938;11739.295642261492;11786.233894796811;16071.598210044609;16420.75368869468;16424.425145119865;16453.095079770726;16477.258523366476;7772.65023073963;8148;8173.223543763452;8468.576571171418;8557.614907329185;8305.501669899704;8323.916760832435;8384.077751447336;8459.492430454193;8501.14988501145;4535.4103966484145;4899.779509922062;4915.655904086751;4995.200767877195;5119.180931051088;1807.5246436005111;1947.6299503094367;2042.7650820155575;2054.6609809381284;2105.968410473844;846.54709730294;1045.9267851250493;1091.7379828841022;1108.7415783086094;1122.259308856151;18713.251469941322;18995;19342.4197274082;19447.805521944883;19686.212551497778;1038.0709265207597;1045.9633912813167;1063.4576366053368;1086.9510872010621;1106.2145876427826;10481.580736770597;10765.730856728644;10879.401632910265;10890.183236257313;11045.061169800496;493724;494625;496778;499353;518113;97060.51469742606;100821.49589252006;102310;102789;103843;1055.794120146564;1071.3090056913247;1071.3946620159586;1081.0702795595782;1099.923005389631;16296;16785.244663990394;16859.764298024566;17349.913250433667;17441.738373924654;29186.56220156657;30136.698633014264;33752;42985.57014429941;43474.565254348316;59013.40986590251;59879.401205987386;61261.38738612735;61306.38693613007;61790.38209618026;8480.448770829877;8499.192576705203;8782.516961567175;8899.332550058642;8958.193762561401;12829.166104203197;13403.798943016058;13471.865281347062;13629.318534073058;13774.724505510034;11587.594434194763;11814.763704726029;12234.204776689487;12238.388080596113;12259.264444133381;11405.54377824911;11576.594819181288;11595.420228988685;11668.766624667629;11761.941190293994;10570.471476426303;11492.48283827213;11527;11759.118066145244;11872.228305160137;7880.408969327438;8249.79375515617;8719.564021798758;8864.911350886408;8953.552322383985;11826;11888.76222475563;11940.343281119622;11981.940090299842;12039.578614748792 12:47:18 INFO - PROCESS | 362 | |3;mootools.html;1407.725493528761;1443.7689969604862;1559.9938039964222;1712.6403455274392;1916.6550020996224;9225.446473211612;9624.518774061295;9640.421574705513;10025.298229123964;10046.799064018714;9720.416774993506;9896.752581185474;9920;9929.503524823765;9936.403815771058;2167.198136689427;2439.0487709793197;2505.974940250592;2531.253280282321;2577.7293384194672;2470.9258722238274;2501.537215615117;2504.6243063540524;2515.76100270474;2516.55960206964;2462.9753702463013;2485.72657007729;2487.2413913756295;2488.30327508298;2490.22802931091;2195.242641288753;2450.987745061272;2514.0697941761664;2519.722830488645;2532.5061612985473;2472.5673007223663;2491.3273416177713;2500.8874600643016;2504.3613878460874;2508.2224510401834;9835.360701554377;9937.155341795957;9960.452175130366;9967.601295948225;9977.551010204557;5670.8015219467125;5808.82573522795;5809.099589563624;5825.912611310834;5829.533637309005;3614.963850361489;3741.38267185914;3751.4372844073337;3778.924421511582;3799.183175617228;1122.6351435783404;1154.1286328821686;1166.6150170443734;1174.994125029378;1187.6437068879388;14451.855481445156;14498.347574359179;14501.854981450157;14504.492342768059;14509.709805803825;5052.317937078521;5131.409887862869;5228.9477105229225;5258.3689957204615;5301.469853014668;10977.83533247002;11021.338719676845;11054.22620416563;11122.944385278022;11147.665570032912;5013.3983921928875;5693.516051135617;5696.8006119785605;5706.714664266853;5707.543396528351;4959.652824302264;5088.084144853888;5098.9490105098475;5142.768575414116;5148.073346797538;4093.7953102344763;4124.711270211116;4139.172165566899;4152.563980782034;4170.374443833449;1209.9576514821938;1220.371508673034;1224.908131890112;1226.8957138643136;1235.5860786636397;911.7583840282331;946.2099147212155;958.4824194934657;958.4967891856692;986.8026394721085;6134.723937422827;6252.280987686383;6431.13179720741;6718.0930574372815;6830.931690683129;988.8220120378257;1058.8147074261974;1068.5672302717412;1070.5814795395975;1117.776444711061;4099.61053699898;4206.621404073648;4299.806508707115;4311.719738217006;4347.826086956549;12222.572209972786;12585.056120790978;12621.74756504883;12624.81062784059;12629.305388203737;11832.17174797756;12283.938580307042;12308.630741077783;12515.311657858905;12538;9120.407173533698;9242.676506322246;9251.814963700688;9268.95365523168;9311.255099592016;6558.737650493927;6784;6827.112475378169;6854.50062264034;6945.270746571739;11281.266717663653;11366.318020918772;11643.767124657628;11813.881861181622;11821.940890295493;11581.594644187413;11777.764444711229;11818.172727908965;11992.820107698566;11999.64001079969;7730.613469326624;7739.883901741366;7833.49082309648;8768.95615521944;8907.821843563223;9451.385659932082;9763.609455621696;9819.16537094355;9836.458994755358;9837.950810245902;8305.626246818787;8566;8651.826963460822;8656.0478347383;8744.562771861509;8315.584220789058;8377.45546539473;8468.830623387374;8503.574821259035;8575.442596231225;7793.376529877482;7846.646900889359;7921.287084162453;7921.643526041226;7922.881156782538;5054.09026375256;5103.591712662904;5163.483651634957;5255.106631872514;5312.601554883477;5182.300389447376;5265.921011184759;5270.552003079782;5357.116075847442;5420.241166236651 12:47:18 INFO - PROCESS | 362 | |4;prototype.html;351.4131400561063;354.37983528824554;358.0407928471186;365.0417653659145;367.10426559195577;5370.301860758096;5413.43158968308;5433.293671822667;5453.563714902808;5461.781528738846;5307.363116426025;5372.516473517383;5374.059539580578;5385;5419.458054194579;4119.107443465926;4266.552012038738;4287.756550600322;4297.677674174433;4304.677149213806;4235.343521754133;4256.744595324275;4296.742195468266;4298.914021719564;4324.913501729963;4063.1264278180183;4096.873359826041;4274.145170965804;4276.5295817460055;4277.230098582254;4227.239096962546;4251.5323314435545;4278.208531421666;4285.807138678767;4290.721103128318;3800.4109363048497;3802.714796390254;3812.1613245086037;3828.7319887607878;3835.5780864104927;4978.626603004753;5094.745262736886;5168.689878607258;5201.1678131498775;5202.4277329493725;4883.536064073907;4898.314236006961;4909.533594308535;4923.409190897115;4961.131801934647;5610.438956104398;5616.775328986876;5625.437456254383;5646.927083854054;5677.801276955287;4105.3431450968;4211.620954114113;4223.598758117974;4230.259704551722;4231.746095234295;5805.187273781674;5827.504662103684;5827.796027139072;5850.2102216200265;5853.268341457318;4336.154449882242;4341.544137865479;4350.825277175145;4352.216601011848;4362.607365337135;4206.179794939957;4405.383246345515;4405.471343438808;4423.336499525097;4425.535318791545;4861.270809378621;4893.84994526286;4905.656604037755;4930.2851086592245;4933.333999910038;5641.548676105902;5667.801626943037;5685.469965865151;5695.145728140812;5706.9714651426475;1431.9332097587155;1467.8972471927077;1475.8524147585156;1483.940642374293;1485.92570371481;984.4929861121528;990.7077412163429;1006.7365456352377;1013.9188864890791;1018.9745256368502;4946.936408672081;4949.65352425334;4949.737816856678;4971.1109778284745;4983.526564976321;5109.693418394908;5117.488251174927;5149.382074151126;5152.381714194321;5240.868978275497;4975.203967365204;5355.259540649305;5372.946270537244;5493.835184944378;5591.888162236733;3035.5598438226334;3060.32672811981;3067.217859445827;3074.6778885079184;3100.240441091947;5765.4522820332;5993.880122397615;6062.363451837582;6074.51403887688;6089.391060893875;5888.970555147197;5899.203607513016;5904.498117660047;5929.199558059693;5998.34018258;6126.448619624255;6133.84665383369;6135.601185922901;6145.508359331243;6151.938480615226;5651.406602306699;5864.32560255576;5885.499732522783;5905.320888097752;5908;5826.737796799239;5854.092615644582;5855.765769369177;5856.267966504187;5869.589128761117;5948.940510594839;6027.67391173941;6036.456718895321;6077.4226448487325;6083.239595050619;4264.722793018444;4286.29276169441;4288.721233119837;4293.892652683708;4298.484181898192;5817.632856278687;5826.7763769608855;5846.269216347957;5850.531957443309;5901.350851406428;5474.91787623194;5680.636647204558;5702;5710.2862142232225;5710.857228569319;5671.858203544779;5677.8864422710485;5688.175214593778;5695.800646977336;5726.570507211893;5321.2816269804625;5616.69108199053;5640.774369025193;5663.830085097454;5683.119116536944;5728.684922329312;5732.656040637575;5760.193572899713;5779.133130030529;5782.971085144547;5398.919016214839;5623.718814059363;5632.464915832989;5647.265855438766;5664.235328230636 12:47:18 INFO - PROCESS | 362 | |5;yui.html;810.9959450202748;830.2403300979604;848.1094850407071;887.1572006593735;924.8797656304681;14452.132872027685;15381.615459613487;15820.525384238463;15862.444814431483;16227.756583651255;14474.203918784462;14501.709965800677;14628.926855365735;14632.634184145401;14677.119372837637;725.5465334166146;836.7824365664941;849.1932663969238;852.2159613155911;853.1553761775859;842.4650347029619;861.6424183963679;862.0560486267527;862.4954401674996;862.5557837713583;914.3142643017736;920.0983036624112;920.2408013388947;920.779013036873;922.7693076730817;760.2397602397575;887.6981826179131;905.7735566108473;915.702396721065;916.564631799893;665.0390186180971;665.2848188197659;665.4476784269045;665.9200895892476;667.302668711198;15088.39646414142;15099;15103.622409439742;15104.697906041818;15117.470888518848;15971.600709982227;16189.676206475922;16352;16430.83569164317;16683.91658041702;13049.151805132731;13265.602031939057;13408.10043580831;13506.392212350467;13611.183329000192;4055.2700513907484;4175.373693945902;4188.308929026707;4188.91622167558;4248.192843359751;76609.61695191544;77485;77571;78655.60672196602;79906.20093799046;12532.373381330897;12620.179688320413;12655.557055503197;12682.936585317015;12786.296753678636;23715.169969051;23913.402164945666;23926.282211533682;23943.52112957731;23968.28095157148;8860.689875854314;8887.333449991276;8927.776805579913;9156.992730799606;9387.906120938704;5216.660917040456;5228.712420816892;5234.555062819627;5245.475452454724;5315.627906046617;3996.5204175499125;4142.233686767958;4150.937735933963;4151.481064866892;4156.127213285184;590.5924911810837;601.7893737191948;604.5526310530176;611.4649681528663;669.4844969373555;711.3313485323779;758.2682711183623;778.8908712606018;801.1867954026668;813.3127507256359;10860.728481788019;10965.780684386267;11097.44512774358;11106.000459958643;11298.210209250146;692.0346117166625;759.6429678051308;763.7288762489347;817.9713710020121;823.8146417056234;4912.336834527293;5079.6952182869145;5287.762050707727;5441.129419292894;5465.617406781566;71481.64259178775;71529.2847071533;71712.2828771716;71967.6401617999;104153.47923260335;96255;96255.51872240593;97321.51339243258;97908.51045744725;98255.50872245592;85278;85948;86236.56881715551;86732.99999999873;88066;8683.044865064712;8725.52009639476;8728.912710873064;9146.405483643543;9308.115729006004;37934.24131517409;43219.56780432155;45949.99999999866;51528;53719.46280537145;51861.48138518567;52030.479695202564;64406.35593644191;77337;79477.60261198657;12229.205101668364;12869.806952895528;13884.930575347058;13932.651683707583;13998.720025599634;15229.6192595186;15499.922500387425;15681.921590391976;15780.447684331453;16500.83499165041;11234.943825280821;11785.823212651989;14955.25223738787;15263.3894644213;15509.457168999483;13471.326433678472;14545.490907818175;14919.776203357176;15000.774988375402;15378.84621153774;14448.494302699775;14560.490382836973;15096.16971066602;15144.848551514784;15400.07599544031;12125.333106679218;12414.751704965669;12600.684982875135;12779.297138657092;12803.167794093353;11793.587224447103;12569.692335953287;12633.368331583568;12649.547128496288;12709.872901270868 12:47:18 INFO - PROCESS | 362 | __end_tp_report 12:47:18 INFO - PROCESS | 362 | __start_cc_report 12:47:18 INFO - PROCESS | 362 | _x_x_mozilla_cycle_collect,829 12:47:18 INFO - PROCESS | 362 | __end_cc_report 12:47:18 INFO - PROCESS | 362 | __startTimestamp1469821638876__endTimestamp 12:47:18 INFO - PROCESS | 362 | 12:47:18 INFO - PROCESS | 362 | ------- Summary: start ------- 12:47:18 INFO - PROCESS | 362 | Number of tests: 6 12:47:18 INFO - PROCESS | 362 | 12:47:18 INFO - PROCESS | 362 | [#0] dojo.html Cycles:165 Average:5510.24 Median:5694.83 stddev:615.39 (10.8%) stddev-sans-first:591.72 12:47:18 INFO - PROCESS | 362 | Values: 3273.1 3293.7 3321.4 3323.6 3328.4 5440.6 5470.6 5501.6 5505.7 5536.8 5483.0 5524.9 5530.2 5539.5 5580.1 4869.3 4993.4 4998.0 5034.2 5064.4 4828.2 4927.9 4989.2 4990.2 5000.2 5039.9 5088.6 5093.8 5101.7 5132.1 5174.3 5190.9 5201.9 5209.1 5220.2 4839.2 4928.5 4932.8 5105.0 5116.0 5374.3 5388.2 5426.3 5439.0 5439.8 5997.4 6002.1 6012.0 6014.3 6019.1 5870.1 5900.9 5935.6 5960.6 5999.8 5609.5 5619.6 5634.4 5636.7 5651.5 5759.9 6096.4 6097.8 6100.9 6133.8 5700.1 5816.6 5821.6 5833.9 5853.9 5890.7 5891.7 5897.7 5930.9 5935.9 5682.5 5811.5 5857.2 5870.5 5871.5 5836.9 5948.4 5951.9 5954.1 5991.6 4566.5 4573.6 4578.2 4579.9 4599.0 3995.4 4007.2 4058.1 4088.3 4130.5 5648.4 5662.3 5670.3 5694.8 5704.2 5918.3 5936.2 5937.9 5940.7 5978.7 5434.8 5548.8 5602.2 5662.7 5666.5 5170.0 5170.1 5177.7 5178.4 5184.2 6273.6 6289.7 6294.7 6298.6 6299.3 5677.1 5821.1 5904.3 5905.6 5974.1 6144.1 6200.1 6207.8 6218.0 6229.0 5852.1 5855.9 5859.3 5860.1 5861.8 5743.3 5827.8 5862.4 5890.0 5995.6 5828.8 5836.4 5841.2 5842.9 5854.0 5749.1 5808.5 5810.5 5818.2 5819.3 5442.2 5597.9 5653.3 5669.8 5682.5 5723.5 5745.5 5850.5 5852.6 5858.2 5494.7 5688.5 5698.3 5699.9 5723.4 12:47:18 INFO - PROCESS | 362 | 12:47:18 INFO - PROCESS | 362 | [#1] ext.html Cycles:180 Average:64024.72 Median:3760.44 stddev:132769.66 (3530.7%) stddev-sans-first:133056.70 12:47:18 INFO - PROCESS | 362 | Values: 594.8 645.5 650.7 661.7 671.8 32664.5 44847.1 45940.5 45955.8 46013.0 47404.0 47885.5 47960.8 48008.0 48013.5 8246.3 8406.7 8427.9 9071.7 9232.1 8418.8 10535.8 10779.2 10789.1 11144.7 11006.0 11041.2 11048.9 11057.1 11071.1 8438.8 10714.3 10773.4 10775.9 10787.9 10575.1 10653.8 10977.5 11008.7 11018.4 45245.1 45648.5 45722.0 45724.0 45840.8 3757.8 3763.1 3768.7 3953.5 4244.0 35562.3 35790.6 36014.2 36039.5 36107.5 4710.6 4802.7 4837.9 4860.5 4905.3 432317.0 434665.0 435849.0 435933.0 436173.0 36961.0 71856.3 72453.0 72700.6 72768.3 38594.0 40887.0 40903.4 41000.3 41030.0 16748.2 16781.9 16925.4 16925.8 16941.1 11607.0 13884.7 14033.4 14134.0 14192.5 9546.4 9606.5 9625.1 9645.4 9680.4 3626.1 3684.2 3691.7 3697.3 3698.4 1033.2 1102.8 1171.1 1173.9 1195.4 34114.7 34600.8 34800.0 35159.1 35394.0 1126.4 1144.7 1149.5 1240.2 1260.4 17871.9 18045.2 18136.2 18140.3 18160.2 662846.0 668524.0 668571.0 669428.0 669760.0 64241.7 64553.0 64672.4 64820.7 64943.0 1378.1 1453.1 1493.6 1512.4 1513.0 34037.3 34738.3 35398.1 35609.5 36279.0 52726.7 53024.0 53364.2 53399.5 53402.2 326239.0 326934.0 327024.0 327178.0 327714.0 27651.7 30464.5 31066.4 31337.4 32627.8 52110.2 53526.7 53780.2 54033.2 54716.5 44005.0 44294.8 44695.8 45052.3 45749.3 43747.6 43912.3 44118.6 45111.3 45360.0 44013.8 44623.6 44938.6 44959.6 45394.1 33184.5 34474.3 34881.3 35470.3 35926.6 29394.7 29641.6 29691.6 29788.3 29925.3 12:47:18 INFO - PROCESS | 362 | 12:47:18 INFO - PROCESS | 362 | [#2] jquery.html Cycles:180 Average:29353.50 Median:20495.89 stddev:82601.52 (403.0%) stddev-sans-first:82804.68 12:47:18 INFO - PROCESS | 362 | Values: 425.9 427.4 428.7 439.3 439.7 18817.5 19979.4 20565.8 21144.2 21158.2 20134.8 20179.3 20491.5 20500.3 20535.0 5685.7 5866.4 5917.6 5919.4 5921.0 5686.3 5707.7 5750.7 5821.3 5824.4 5809.3 5811.3 5815.4 5818.7 5835.6 5676.3 5778.8 5961.8 5968.7 6061.1 5681.2 5843.5 5847.7 5850.4 5866.9 14627.9 14640.8 14828.0 14854.3 14864.6 2553.7 2566.5 2570.9 2593.8 2624.8 10203.6 14432.2 14826.3 15030.5 15330.2 1860.3 1862.3 1935.2 1973.7 2038.7 64744.4 68774.7 79512.0 80698.0 83319.6 11335.1 11589.8 11598.5 11739.3 11786.2 16071.6 16420.8 16424.4 16453.1 16477.3 7772.7 8148.0 8173.2 8468.6 8557.6 8305.5 8323.9 8384.1 8459.5 8501.1 4535.4 4899.8 4915.7 4995.2 5119.2 1807.5 1947.6 2042.8 2054.7 2106.0 846.5 1045.9 1091.7 1108.7 1122.3 18713.3 18995.0 19342.4 19447.8 19686.2 1038.1 1046.0 1063.5 1087.0 1106.2 10481.6 10765.7 10879.4 10890.2 11045.1 493724.0 494625.0 496778.0 499353.0 518113.0 97060.5 100821.5 102310.0 102789.0 103843.0 1055.8 1071.3 1071.4 1081.1 1099.9 16296.0 16785.2 16859.8 17349.9 17441.7 29186.6 30136.7 33752.0 42985.6 43474.6 59013.4 59879.4 61261.4 61306.4 61790.4 8480.4 8499.2 8782.5 8899.3 8958.2 12829.2 13403.8 13471.9 13629.3 13774.7 11587.6 11814.8 12234.2 12238.4 12259.3 11405.5 11576.6 11595.4 11668.8 11761.9 10570.5 11492.5 11527.0 11759.1 11872.2 7880.4 8249.8 8719.6 8864.9 8953.6 11826.0 11888.8 11940.3 11981.9 12039.6 12:47:18 INFO - PROCESS | 362 | 12:47:18 INFO - PROCESS | 362 | [#3] mootools.html Cycles:180 Average:6425.22 Median:4653.74 stddev:3820.65 (82.1%) stddev-sans-first:3812.76 12:47:18 INFO - PROCESS | 362 | Values: 1407.7 1443.8 1560.0 1712.6 1916.7 9225.4 9624.5 9640.4 10025.3 10046.8 9720.4 9896.8 9920.0 9929.5 9936.4 2167.2 2439.0 2506.0 2531.3 2577.7 2470.9 2501.5 2504.6 2515.8 2516.6 2463.0 2485.7 2487.2 2488.3 2490.2 2195.2 2451.0 2514.1 2519.7 2532.5 2472.6 2491.3 2500.9 2504.4 2508.2 9835.4 9937.2 9960.5 9967.6 9977.6 5670.8 5808.8 5809.1 5825.9 5829.5 3615.0 3741.4 3751.4 3778.9 3799.2 1122.6 1154.1 1166.6 1175.0 1187.6 14451.9 14498.3 14501.9 14504.5 14509.7 5052.3 5131.4 5228.9 5258.4 5301.5 10977.8 11021.3 11054.2 11122.9 11147.7 5013.4 5693.5 5696.8 5706.7 5707.5 4959.7 5088.1 5098.9 5142.8 5148.1 4093.8 4124.7 4139.2 4152.6 4170.4 1210.0 1220.4 1224.9 1226.9 1235.6 911.8 946.2 958.5 958.5 986.8 6134.7 6252.3 6431.1 6718.1 6830.9 988.8 1058.8 1068.6 1070.6 1117.8 4099.6 4206.6 4299.8 4311.7 4347.8 12222.6 12585.1 12621.7 12624.8 12629.3 11832.2 12283.9 12308.6 12515.3 12538.0 9120.4 9242.7 9251.8 9269.0 9311.3 6558.7 6784.0 6827.1 6854.5 6945.3 11281.3 11366.3 11643.8 11813.9 11821.9 11581.6 11777.8 11818.2 11992.8 11999.6 7730.6 7739.9 7833.5 8769.0 8907.8 9451.4 9763.6 9819.2 9836.5 9838.0 8305.6 8566.0 8651.8 8656.0 8744.6 8315.6 8377.5 8468.8 8503.6 8575.4 7793.4 7846.6 7921.3 7921.6 7922.9 5054.1 5103.6 5163.5 5255.1 5312.6 5182.3 5265.9 5270.6 5357.1 5420.2 12:47:18 INFO - PROCESS | 362 | 12:47:18 INFO - PROCESS | 362 | [#4] prototype.html Cycles:180 Average:4783.72 Median:5338.27 stddev:1382.39 (25.9%) stddev-sans-first:1345.65 12:47:18 INFO - PROCESS | 362 | Values: 351.4 354.4 358.0 365.0 367.1 5370.3 5413.4 5433.3 5453.6 5461.8 5307.4 5372.5 5374.1 5385.0 5419.5 4119.1 4266.6 4287.8 4297.7 4304.7 4235.3 4256.7 4296.7 4298.9 4324.9 4063.1 4096.9 4274.1 4276.5 4277.2 4227.2 4251.5 4278.2 4285.8 4290.7 3800.4 3802.7 3812.2 3828.7 3835.6 4978.6 5094.7 5168.7 5201.2 5202.4 4883.5 4898.3 4909.5 4923.4 4961.1 5610.4 5616.8 5625.4 5646.9 5677.8 4105.3 4211.6 4223.6 4230.3 4231.7 5805.2 5827.5 5827.8 5850.2 5853.3 4336.2 4341.5 4350.8 4352.2 4362.6 4206.2 4405.4 4405.5 4423.3 4425.5 4861.3 4893.8 4905.7 4930.3 4933.3 5641.5 5667.8 5685.5 5695.1 5707.0 1431.9 1467.9 1475.9 1483.9 1485.9 984.5 990.7 1006.7 1013.9 1019.0 4946.9 4949.7 4949.7 4971.1 4983.5 5109.7 5117.5 5149.4 5152.4 5240.9 4975.2 5355.3 5372.9 5493.8 5591.9 3035.6 3060.3 3067.2 3074.7 3100.2 5765.5 5993.9 6062.4 6074.5 6089.4 5889.0 5899.2 5904.5 5929.2 5998.3 6126.4 6133.8 6135.6 6145.5 6151.9 5651.4 5864.3 5885.5 5905.3 5908.0 5826.7 5854.1 5855.8 5856.3 5869.6 5948.9 6027.7 6036.5 6077.4 6083.2 4264.7 4286.3 4288.7 4293.9 4298.5 5817.6 5826.8 5846.3 5850.5 5901.4 5474.9 5680.6 5702.0 5710.3 5710.9 5671.9 5677.9 5688.2 5695.8 5726.6 5321.3 5616.7 5640.8 5663.8 5683.1 5728.7 5732.7 5760.2 5779.1 5783.0 5398.9 5623.7 5632.5 5647.3 5664.2 12:47:18 INFO - PROCESS | 362 | 12:47:18 INFO - PROCESS | 362 | [#5] yui.html Cycles:180 Average:19869.02 Median:28303.85 stddev:26559.26 (93.8%) stddev-sans-first:26595.21 12:47:18 INFO - PROCESS | 362 | Values: 811.0 830.2 848.1 887.2 924.9 14452.1 15381.6 15820.5 15862.4 16227.8 14474.2 14501.7 14628.9 14632.6 14677.1 725.5 836.8 849.2 852.2 853.2 842.5 861.6 862.1 862.5 862.6 914.3 920.1 920.2 920.8 922.8 760.2 887.7 905.8 915.7 916.6 665.0 665.3 665.4 665.9 667.3 15088.4 15099.0 15103.6 15104.7 15117.5 15971.6 16189.7 16352.0 16430.8 16683.9 13049.2 13265.6 13408.1 13506.4 13611.2 4055.3 4175.4 4188.3 4188.9 4248.2 76609.6 77485.0 77571.0 78655.6 79906.2 12532.4 12620.2 12655.6 12682.9 12786.3 23715.2 23913.4 23926.3 23943.5 23968.3 8860.7 8887.3 8927.8 9157.0 9387.9 5216.7 5228.7 5234.6 5245.5 5315.6 3996.5 4142.2 4150.9 4151.5 4156.1 590.6 601.8 604.6 611.5 669.5 711.3 758.3 778.9 801.2 813.3 10860.7 10965.8 11097.4 11106.0 11298.2 692.0 759.6 763.7 818.0 823.8 4912.3 5079.7 5287.8 5441.1 5465.6 71481.6 71529.3 71712.3 71967.6 104153.5 96255.0 96255.5 97321.5 97908.5 98255.5 85278.0 85948.0 86236.6 86733.0 88066.0 8683.0 8725.5 8728.9 9146.4 9308.1 37934.2 43219.6 45950.0 51528.0 53719.5 51861.5 52030.5 64406.4 77337.0 79477.6 12229.2 12869.8 13884.9 13932.7 13998.7 15229.6 15499.9 15681.9 15780.4 16500.8 11234.9 11785.8 14955.3 15263.4 15509.5 13471.3 14545.5 14919.8 15000.8 15378.8 14448.5 14560.5 15096.2 15144.8 15400.1 12125.3 12414.8 12600.7 12779.3 12803.2 11793.6 12569.7 12633.4 12649.5 12709.9 12:47:18 INFO - PROCESS | 362 | -------- Summary: end -------- 12:47:18 INFO - PROCESS | 362 | 12:47:19 INFO - TEST-INFO | 362: exit 0 12:47:19 INFO - TEST-OK | dromaeo_css | took 1112537ms 12:47:19 INFO - TEST-START | kraken 12:47:19 INFO - operating with platform_type : linux_ 12:47:19 INFO - Initialising browser for kraken test... 12:47:19 INFO - TEST-INFO | started process 558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvWXwCG/profile http://localhost:59389/getInfo.html) 12:47:23 INFO - PROCESS | 558 | __metrics Screen width/height:1600/1200 12:47:23 INFO - PROCESS | 558 | colorDepth:24 12:47:23 INFO - PROCESS | 558 | Browser inner width/height: 1024/697 12:47:23 INFO - PROCESS | 558 | __metrics 12:47:24 INFO - PROCESS | 558 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:47:24 ERROR - PROCESS | 558 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:47:25 INFO - TEST-INFO | 558: exit 0 12:47:25 INFO - Browser initialized. 12:47:25 INFO - Running cycle 1/1 for kraken test... 12:47:25 INFO - TEST-INFO | started process 651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvWXwCG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:47:37 INFO - PROCESS | 651 | RSS: Main: 145403904 12:47:37 INFO - PROCESS | 651 | 12:47:39 INFO - PROCESS | 651 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59389/tests/kraken/driver.html?testName=audio-beat-detection) 12:47:40 INFO - PROCESS | 651 | RSS: Main: 194416640 12:47:40 INFO - PROCESS | 651 | 12:47:43 INFO - PROCESS | 651 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59389/tests/kraken/driver.html?testName=audio-dft) 12:47:43 INFO - PROCESS | 651 | RSS: Main: 187342848 12:47:43 INFO - PROCESS | 651 | 12:47:46 INFO - PROCESS | 651 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59389/tests/kraken/driver.html?testName=audio-fft) 12:47:47 INFO - PROCESS | 651 | RSS: Main: 278863872 12:47:47 INFO - PROCESS | 651 | 12:47:49 INFO - PROCESS | 651 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59389/tests/kraken/driver.html?testName=audio-oscillator) 12:47:49 INFO - PROCESS | 651 | RSS: Main: 187236352 12:47:49 INFO - PROCESS | 651 | 12:47:51 INFO - PROCESS | 651 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:47:52 INFO - PROCESS | 651 | RSS: Main: 188444672 12:47:52 INFO - PROCESS | 651 | 12:47:55 INFO - PROCESS | 651 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59389/tests/kraken/driver.html?testName=imaging-darkroom) 12:47:56 INFO - PROCESS | 651 | RSS: Main: 223416320 12:47:56 INFO - PROCESS | 651 | 12:47:59 INFO - PROCESS | 651 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59389/tests/kraken/driver.html?testName=imaging-desaturate) 12:48:00 INFO - PROCESS | 651 | RSS: Main: 222056448 12:48:00 INFO - PROCESS | 651 | 12:48:02 INFO - PROCESS | 651 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59389/tests/kraken/driver.html?testName=json-parse-financial) 12:48:03 INFO - PROCESS | 651 | RSS: Main: 222818304 12:48:03 INFO - PROCESS | 651 | 12:48:04 INFO - PROCESS | 651 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:48:05 INFO - PROCESS | 651 | RSS: Main: 201199616 12:48:05 INFO - PROCESS | 651 | 12:48:07 INFO - PROCESS | 651 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:48:07 INFO - PROCESS | 651 | RSS: Main: 201535488 12:48:07 INFO - PROCESS | 651 | 12:48:09 INFO - PROCESS | 651 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:48:10 INFO - PROCESS | 651 | RSS: Main: 208420864 12:48:10 INFO - PROCESS | 651 | 12:48:12 INFO - PROCESS | 651 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:48:13 INFO - PROCESS | 651 | RSS: Main: 212918272 12:48:13 INFO - PROCESS | 651 | 12:48:16 INFO - PROCESS | 651 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:48:16 INFO - PROCESS | 651 | RSS: Main: 213008384 12:48:16 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59389/tests/kraken/driver.html?testName=ai-astar) 12:48:18 INFO - PROCESS | 651 | RSS: Main: 255836160 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | __start_tp_report 12:48:18 INFO - PROCESS | 651 | _x_x_mozilla_page_load 12:48:18 INFO - PROCESS | 651 | _x_x_mozilla_page_load_details 12:48:18 INFO - PROCESS | 651 | |i|pagename|runs| 12:48:18 INFO - PROCESS | 651 | |0;ai-astar;112;106;114;114;111;112;110;112;110;109 12:48:18 INFO - PROCESS | 651 | |1;audio-beat-detection;152;131;136;170;124;128;155;124;163;123 12:48:18 INFO - PROCESS | 651 | |2;audio-dft;161;161;162;161;160;161;161;161;161;160 12:48:18 INFO - PROCESS | 651 | |3;audio-fft;76;74;75;104;75;76;76;74;98;76 12:48:18 INFO - PROCESS | 651 | |4;audio-oscillator;85;86;109;84;85;85;120;84;85;133 12:48:18 INFO - PROCESS | 651 | |5;imaging-gaussian-blur;118;117;116;116;117;116;117;117;116;116 12:48:18 INFO - PROCESS | 651 | |6;imaging-darkroom;147;146;147;147;147;145;147;146;146;145 12:48:18 INFO - PROCESS | 651 | |7;imaging-desaturate;95;95;94;94;95;95;95;94;96;95 12:48:18 INFO - PROCESS | 651 | |8;json-parse-financial;52;52;51;52;52;53;56;54;54;53 12:48:18 INFO - PROCESS | 651 | |9;json-stringify-tinderbox;60;61;60;59;60;59;59;59;65;59 12:48:18 INFO - PROCESS | 651 | |10;stanford-crypto-aes;79;79;77;76;77;78;76;77;115;86 12:48:18 INFO - PROCESS | 651 | |11;stanford-crypto-ccm;121;121;120;121;117;118;126;118;125;123 12:48:18 INFO - PROCESS | 651 | |12;stanford-crypto-pbkdf2;155;154;155;152;157;159;153;155;154;153 12:48:18 INFO - PROCESS | 651 | |13;stanford-crypto-sha256-iterative;65;63;62;61;63;63;62;62;61;61 12:48:18 INFO - PROCESS | 651 | __end_tp_report 12:48:18 INFO - PROCESS | 651 | __start_cc_report 12:48:18 INFO - PROCESS | 651 | _x_x_mozilla_cycle_collect,1597 12:48:18 INFO - PROCESS | 651 | __end_cc_report 12:48:18 INFO - PROCESS | 651 | __startTimestamp1469821698750__endTimestamp 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | ------- Summary: start ------- 12:48:18 INFO - PROCESS | 651 | Number of tests: 14 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.40 (2.1%) stddev-sans-first:2.52 12:48:18 INFO - PROCESS | 651 | Values: 112.0 106.0 114.0 114.0 111.0 112.0 110.0 112.0 110.0 109.0 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:144.00 stddev:17.75 (12.3%) stddev-sans-first:18.34 12:48:18 INFO - PROCESS | 651 | Values: 152.0 131.0 136.0 170.0 124.0 128.0 155.0 124.0 163.0 123.0 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 12:48:18 INFO - PROCESS | 651 | Values: 161.0 161.0 162.0 161.0 160.0 161.0 161.0 161.0 161.0 160.0 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | [#3] audio-fft Cycles:10 Average:80.40 Median:76.00 stddev:10.98 (14.4%) stddev-sans-first:11.53 12:48:18 INFO - PROCESS | 651 | Values: 76.0 74.0 75.0 104.0 75.0 76.0 76.0 74.0 98.0 76.0 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:85.00 stddev:18.21 (21.4%) stddev-sans-first:18.91 12:48:18 INFO - PROCESS | 651 | Values: 85.0 86.0 109.0 84.0 85.0 85.0 120.0 84.0 85.0 133.0 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 12:48:18 INFO - PROCESS | 651 | Values: 118.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 12:48:18 INFO - PROCESS | 651 | Values: 147.0 146.0 147.0 147.0 147.0 145.0 147.0 146.0 146.0 145.0 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 12:48:18 INFO - PROCESS | 651 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 96.0 95.0 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.45 (2.7%) stddev-sans-first:1.50 12:48:18 INFO - PROCESS | 651 | Values: 52.0 52.0 51.0 52.0 52.0 53.0 56.0 54.0 54.0 53.0 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:1.85 (3.1%) stddev-sans-first:1.96 12:48:18 INFO - PROCESS | 651 | Values: 60.0 61.0 60.0 59.0 60.0 59.0 59.0 59.0 65.0 59.0 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:77.50 stddev:11.95 (15.4%) stddev-sans-first:12.63 12:48:18 INFO - PROCESS | 651 | Values: 79.0 79.0 77.0 76.0 77.0 78.0 76.0 77.0 115.0 86.0 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:121.00 stddev:2.98 (2.5%) stddev-sans-first:3.16 12:48:18 INFO - PROCESS | 651 | Values: 121.0 121.0 120.0 121.0 117.0 118.0 126.0 118.0 125.0 123.0 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:155.00 stddev:2.06 (1.3%) stddev-sans-first:2.18 12:48:18 INFO - PROCESS | 651 | Values: 155.0 154.0 155.0 152.0 157.0 159.0 153.0 155.0 154.0 153.0 12:48:18 INFO - PROCESS | 651 | 12:48:18 INFO - PROCESS | 651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:1.25 (2.0%) stddev-sans-first:0.87 12:48:18 INFO - PROCESS | 651 | Values: 65.0 63.0 62.0 61.0 63.0 63.0 62.0 62.0 61.0 61.0 12:48:18 INFO - PROCESS | 651 | -------- Summary: end -------- 12:48:18 INFO - PROCESS | 651 | 12:48:19 INFO - TEST-INFO | 651: exit 0 12:48:19 INFO - TEST-OK | kraken | took 60108ms 12:48:19 INFO - SUITE-END | took 1172s 12:48:19 INFO - Completed test suite (00:19:32) 12:48:19 INFO - javascript benchmark 12:48:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3273.0998975281796, 3293.720033797127, 3321.385543674422, 3323.617783954846, 3328.3676101540705, 5440.646357986733, 5470.617056806025, 5501.614886957915, 5505.6696598204135, 5536.75084621192, 5483.040467918108, 5524.889502209953, 5530.170474428838, 5539.501444869961, 5580.107182850745, 4869.269609558559, 4993.400791904976, 4998.0, 5034.1945288753805, 5064.366954130734, 4828.179209534387, 4927.926081108786, 4989.226669866177, 4990.201567749161, 5000.224965130393, 5039.899202015958, 5088.618353623475, 5093.847184584469, 5101.744912754366, 5132.076226279269, 5174.275601415768, 5190.858011237522, 5201.895962080737, 5209.114450543417, 5220.216967454874, 4839.225723884161, 4928.48250933654, 4932.753362331905, 5104.974475127638, 5115.974420127913, 5374.328208973879, 5388.245645609618, 5426.348838139448, 5438.972805135989, 5439.782408703647, 5997.4002599740115, 6002.069679199731, 6012.0380739081975, 6014.278286605635, 6019.127226552169, 5870.09013602888, 5900.881982360329, 5935.614185077956, 5960.582759206857, 5999.790007349766, 5609.52319052881, 5619.6066275360745, 5634.3520495143175, 5636.689982050985, 5651.463111004448, 5759.94240057594, 6096.367738972413, 6097.817065488042, 6100.908486372708, 6133.785317513954, 5700.144978253213, 5816.5928385013485, 5821.563382746311, 5833.88332233353, 5853.912191317134, 5890.734916928748, 5891.734871930774, 5897.67562784051, 5930.851728706817, 5935.851603709855, 5682.516986056149, 5811.535077193815, 5857.150713146655, 5870.530357571384, 5871.4715675589405, 5836.854078648068, 5948.434898684618, 5951.9107213391835, 5954.10688396744, 5991.55063370249, 4566.4748553916725, 4573.634109271316, 4578.244589642738, 4579.908401832011, 4599.0, 3995.440638310639, 4007.1584967157223, 4058.1072164123843, 4088.325426304686, 4130.463039804806, 5648.435156484319, 5662.292213473316, 5670.262865827499, 5694.829155125353, 5704.201411802351, 5918.319393269743, 5936.198613187251, 5937.881242375129, 5940.70296485174, 5978.671173085522, 5434.809781657623, 5548.833534993957, 5602.187682785973, 5662.66024038559, 5666.46168613981, 5170.0, 5170.095233334151, 5177.663451875691, 5178.352705911761, 5184.248283998799, 6273.62358258506, 6289.654069026247, 6294.748210071546, 6298.590591611531, 6299.275583307886, 5677.148427735708, 5821.068629019336, 5904.261967254093, 5905.586608937505, 5974.103884417372, 6144.099453127427, 6200.06998950143, 6207.782727604512, 6218.036204388327, 6228.968855155696, 5852.063669812809, 5855.94144058554, 5859.267591551056, 5860.062390017577, 5861.794837180678, 5743.282089738783, 5827.825165245049, 5862.355140934579, 5889.998700221058, 5995.5803093783015, 5828.76684932598, 5836.387179346278, 5841.153032810304, 5842.853928651818, 5854.0, 5749.13762935563, 5808.477237048686, 5810.477057064884, 5818.185454036523, 5819.301683797971, 5442.238086667949, 5597.888042239214, 5653.265075540154, 5669.829905102853, 5682.5453963681975, 5723.484886360081, 5745.482906538432, 5850.53195744348, 5852.648841069549, 5858.238429004202, 5494.670319780826, 5688.544916406595, 5698.2592263005545, 5699.886002279848, 5723.370429252695], "value": 5470.106639316477, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.8037147741243, 645.4997377032802, 650.677914432356, 661.7319985405911, 671.7783131566583, 32664.510032349535, 44847.103057938824, 45940.540594594044, 45955.77022114893, 46012.999999999956, 47404.0, 47885.521144788545, 47960.841762120705, 48008.0, 48013.51986480143, 8246.340292776564, 8406.663733450685, 8427.915720842775, 9071.727848164533, 9232.076792320748, 8418.78953026173, 10535.84196237057, 10779.245452818306, 10789.136869050497, 11144.721381965435, 11006.0, 11041.227114102016, 11048.944755276212, 11057.11543076556, 11071.114310855111, 8438.78903027423, 10714.250002499828, 10773.407462589634, 10775.94612026935, 10787.892121078767, 10575.101116405114, 10653.786924261549, 10977.451127443675, 11008.669739907735, 11018.39398833064, 45245.09509809785, 45648.543514564764, 45722.0, 45724.0, 45840.77079614614, 3757.755745876537, 3763.1156678180605, 3768.7361884668085, 3953.525576930758, 4243.957560424387, 35562.28875422477, 35790.642093578994, 36014.199290035656, 36039.4594081089, 36107.45838812394, 4710.646701497401, 4802.687825291345, 4837.879053023667, 4860.513948605147, 4905.2642103684375, 432317.0, 434665.0, 435849.0, 435932.99999999686, 436173.0, 36961.0, 71856.28143718495, 72453.0, 72700.63649681718, 72768.27231727721, 38594.0, 40887.0, 40903.38644920329, 41000.33497822632, 41030.0, 16748.162591870358, 16781.916090419712, 16925.407610733564, 16925.830741692425, 16941.068241246605, 11607.0, 13884.652883677787, 14033.368498417596, 14134.0, 14192.503262385973, 9546.379485333431, 9606.51967401641, 9625.133737963477, 9645.37305075182, 9680.419174849532, 3626.1409710986877, 3684.1894783147663, 3691.7046636269033, 3697.297513472485, 3698.3527882620433, 1033.2095946600857, 1102.7573933734566, 1171.0924033873816, 1173.9236949598248, 1195.3664557784389, 34114.658853411645, 34600.82699586536, 34800.0, 35159.12102197414, 35394.0, 1126.3639563534045, 1144.7252659361693, 1149.4540093455541, 1240.2372540887288, 1260.4328052376468, 17871.910640446713, 18045.187966541536, 18136.183871725803, 18140.274389024293, 18160.1827917744, 662846.0, 668524.0, 668571.0, 669428.0, 669760.0, 64241.678791605744, 64553.0, 64672.35327646758, 64820.67589662116, 64943.0, 1378.1248906943963, 1453.14264583896, 1493.5892629526968, 1512.4026009726097, 1512.9697406051816, 34037.319253615286, 34738.305233895684, 35398.115047124025, 35609.46585801163, 36279.0, 52726.73636631792, 53024.0, 53364.19953700775, 53399.46600533945, 53402.19896701475, 326239.0, 326934.0, 327024.0, 327178.0, 327714.0, 27651.723482764915, 30464.543031854984, 31066.378672426876, 31337.37325253528, 32627.836860815543, 52110.21834672407, 53526.73236633792, 53780.19329710136, 54033.18950215671, 54716.45283547114, 44005.0, 44294.77852610716, 44695.776521117186, 45052.32421513746, 45749.31376029296, 43747.56252437562, 43912.34131487966, 44118.558814411444, 45111.32333014942, 45360.0, 44013.77993110142, 44623.55376446194, 44938.55061449474, 44959.55040449554, 45394.092118158114, 33184.50223246701, 34474.310513790086, 34881.30237395187, 35470.290594187456, 35926.64073359233, 29394.706052939197, 29641.5553766698, 29691.55462668105, 29788.255293617833, 29925.251868703457], "value": 20632.408476079905, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.9063006138649, 427.43578476411113, 428.69991006295584, 439.2554619919236, 439.69221544918565, 18817.529561760963, 19979.400617981464, 20565.794342056575, 21144.154233830628, 21158.153673853027, 20134.789403999905, 20179.29372471964, 20491.487712807186, 20500.282490112848, 20535.0, 5685.715714214293, 5866.413358664142, 5917.58576899615, 5919.437653422918, 5921.0, 5686.289213848269, 5707.686077265748, 5750.654960702351, 5821.301443826746, 5824.388439213885, 5809.331926828406, 5811.331696854852, 5815.360310365856, 5818.650880947135, 5835.649861008332, 5676.347220069703, 5778.7977420790285, 5961.761529538857, 5968.6717230552085, 6061.090836374535, 5681.176229446707, 5843.5033022193165, 5847.736851841677, 5850.3564607893095, 5866.9119963200155, 14627.926860365737, 14640.780388294184, 14828.0, 14854.33155507994, 14864.554063378007, 2553.74462553745, 2566.486702659457, 2570.8714564271713, 2593.8314009589503, 2624.7506486883717, 10203.591856325813, 14432.20622865742, 14826.33281502335, 15030.549083527512, 15330.233488325539, 1860.3023866050232, 1862.3481781376545, 1935.1872213670292, 1973.6743437332966, 2038.6840039793708, 64744.3525564743, 68774.65612671904, 79512.0, 80698.0, 83319.58340208321, 11335.149863760085, 11589.826152607717, 11598.478068486938, 11739.295642261492, 11786.233894796811, 16071.598210044609, 16420.75368869468, 16424.425145119865, 16453.095079770726, 16477.258523366476, 7772.65023073963, 8148.0, 8173.223543763452, 8468.576571171418, 8557.614907329185, 8305.501669899704, 8323.916760832435, 8384.077751447336, 8459.492430454193, 8501.14988501145, 4535.4103966484145, 4899.779509922062, 4915.655904086751, 4995.200767877195, 5119.180931051088, 1807.5246436005111, 1947.6299503094367, 2042.7650820155575, 2054.6609809381284, 2105.968410473844, 846.54709730294, 1045.9267851250493, 1091.7379828841022, 1108.7415783086094, 1122.259308856151, 18713.251469941322, 18995.0, 19342.4197274082, 19447.805521944883, 19686.212551497778, 1038.0709265207597, 1045.9633912813167, 1063.4576366053368, 1086.9510872010621, 1106.2145876427826, 10481.580736770597, 10765.730856728644, 10879.401632910265, 10890.183236257313, 11045.061169800496, 493724.0, 494625.0, 496778.0, 499353.0, 518113.0, 97060.51469742606, 100821.49589252006, 102310.0, 102789.0, 103843.0, 1055.794120146564, 1071.3090056913247, 1071.3946620159586, 1081.0702795595782, 1099.923005389631, 16296.0, 16785.244663990394, 16859.764298024566, 17349.913250433667, 17441.738373924654, 29186.56220156657, 30136.698633014264, 33752.0, 42985.57014429941, 43474.565254348316, 59013.40986590251, 59879.401205987386, 61261.38738612735, 61306.38693613007, 61790.38209618026, 8480.448770829877, 8499.192576705203, 8782.516961567175, 8899.332550058642, 8958.193762561401, 12829.166104203197, 13403.798943016058, 13471.865281347062, 13629.318534073058, 13774.724505510034, 11587.594434194763, 11814.763704726029, 12234.204776689487, 12238.388080596113, 12259.264444133381, 11405.54377824911, 11576.594819181288, 11595.420228988685, 11668.766624667629, 11761.941190293994, 10570.471476426303, 11492.48283827213, 11527.0, 11759.118066145244, 11872.228305160137, 7880.408969327438, 8249.79375515617, 8719.564021798758, 8864.911350886408, 8953.552322383985, 11826.0, 11888.76222475563, 11940.343281119622, 11981.940090299842, 12039.578614748792], "value": 9397.71024571223, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.725493528761, 1443.7689969604862, 1559.9938039964222, 1712.6403455274392, 1916.6550020996224, 9225.446473211612, 9624.518774061295, 9640.421574705513, 10025.298229123964, 10046.799064018714, 9720.416774993506, 9896.752581185474, 9920.0, 9929.503524823765, 9936.403815771058, 2167.198136689427, 2439.0487709793197, 2505.974940250592, 2531.253280282321, 2577.7293384194672, 2470.9258722238274, 2501.537215615117, 2504.6243063540524, 2515.76100270474, 2516.55960206964, 2462.9753702463013, 2485.72657007729, 2487.2413913756295, 2488.30327508298, 2490.22802931091, 2195.242641288753, 2450.987745061272, 2514.0697941761664, 2519.722830488645, 2532.5061612985473, 2472.5673007223663, 2491.3273416177713, 2500.8874600643016, 2504.3613878460874, 2508.2224510401834, 9835.360701554377, 9937.155341795957, 9960.452175130366, 9967.601295948225, 9977.551010204557, 5670.8015219467125, 5808.82573522795, 5809.099589563624, 5825.912611310834, 5829.533637309005, 3614.963850361489, 3741.38267185914, 3751.4372844073337, 3778.924421511582, 3799.183175617228, 1122.6351435783404, 1154.1286328821686, 1166.6150170443734, 1174.994125029378, 1187.6437068879388, 14451.855481445156, 14498.347574359179, 14501.854981450157, 14504.492342768059, 14509.709805803825, 5052.317937078521, 5131.409887862869, 5228.9477105229225, 5258.3689957204615, 5301.469853014668, 10977.83533247002, 11021.338719676845, 11054.22620416563, 11122.944385278022, 11147.665570032912, 5013.3983921928875, 5693.516051135617, 5696.8006119785605, 5706.714664266853, 5707.543396528351, 4959.652824302264, 5088.084144853888, 5098.9490105098475, 5142.768575414116, 5148.073346797538, 4093.7953102344763, 4124.711270211116, 4139.172165566899, 4152.563980782034, 4170.374443833449, 1209.9576514821938, 1220.371508673034, 1224.908131890112, 1226.8957138643136, 1235.5860786636397, 911.7583840282331, 946.2099147212155, 958.4824194934657, 958.4967891856692, 986.8026394721085, 6134.723937422827, 6252.280987686383, 6431.13179720741, 6718.0930574372815, 6830.931690683129, 988.8220120378257, 1058.8147074261974, 1068.5672302717412, 1070.5814795395975, 1117.776444711061, 4099.61053699898, 4206.621404073648, 4299.806508707115, 4311.719738217006, 4347.826086956549, 12222.572209972786, 12585.056120790978, 12621.74756504883, 12624.81062784059, 12629.305388203737, 11832.17174797756, 12283.938580307042, 12308.630741077783, 12515.311657858905, 12538.0, 9120.407173533698, 9242.676506322246, 9251.814963700688, 9268.95365523168, 9311.255099592016, 6558.737650493927, 6784.0, 6827.112475378169, 6854.50062264034, 6945.270746571739, 11281.266717663653, 11366.318020918772, 11643.767124657628, 11813.881861181622, 11821.940890295493, 11581.594644187413, 11777.764444711229, 11818.172727908965, 11992.820107698566, 11999.64001079969, 7730.613469326624, 7739.883901741366, 7833.49082309648, 8768.95615521944, 8907.821843563223, 9451.385659932082, 9763.609455621696, 9819.16537094355, 9836.458994755358, 9837.950810245902, 8305.626246818787, 8566.0, 8651.826963460822, 8656.0478347383, 8744.562771861509, 8315.584220789058, 8377.45546539473, 8468.830623387374, 8503.574821259035, 8575.442596231225, 7793.376529877482, 7846.646900889359, 7921.287084162453, 7921.643526041226, 7922.881156782538, 5054.09026375256, 5103.591712662904, 5163.483651634957, 5255.106631872514, 5312.601554883477, 5182.300389447376, 5265.921011184759, 5270.552003079782, 5357.116075847442, 5420.241166236651], "value": 5042.329497963367, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.4131400561063, 354.37983528824554, 358.0407928471186, 365.0417653659145, 367.10426559195577, 5370.301860758096, 5413.43158968308, 5433.293671822667, 5453.563714902808, 5461.781528738846, 5307.363116426025, 5372.516473517383, 5374.059539580578, 5385.0, 5419.458054194579, 4119.107443465926, 4266.552012038738, 4287.756550600322, 4297.677674174433, 4304.677149213806, 4235.343521754133, 4256.744595324275, 4296.742195468266, 4298.914021719564, 4324.913501729963, 4063.1264278180183, 4096.873359826041, 4274.145170965804, 4276.5295817460055, 4277.230098582254, 4227.239096962546, 4251.5323314435545, 4278.208531421666, 4285.807138678767, 4290.721103128318, 3800.4109363048497, 3802.714796390254, 3812.1613245086037, 3828.7319887607878, 3835.5780864104927, 4978.626603004753, 5094.745262736886, 5168.689878607258, 5201.1678131498775, 5202.4277329493725, 4883.536064073907, 4898.314236006961, 4909.533594308535, 4923.409190897115, 4961.131801934647, 5610.438956104398, 5616.775328986876, 5625.437456254383, 5646.927083854054, 5677.801276955287, 4105.3431450968, 4211.620954114113, 4223.598758117974, 4230.259704551722, 4231.746095234295, 5805.187273781674, 5827.504662103684, 5827.796027139072, 5850.2102216200265, 5853.268341457318, 4336.154449882242, 4341.544137865479, 4350.825277175145, 4352.216601011848, 4362.607365337135, 4206.179794939957, 4405.383246345515, 4405.471343438808, 4423.336499525097, 4425.535318791545, 4861.270809378621, 4893.84994526286, 4905.656604037755, 4930.2851086592245, 4933.333999910038, 5641.548676105902, 5667.801626943037, 5685.469965865151, 5695.145728140812, 5706.9714651426475, 1431.9332097587155, 1467.8972471927077, 1475.8524147585156, 1483.940642374293, 1485.92570371481, 984.4929861121528, 990.7077412163429, 1006.7365456352377, 1013.9188864890791, 1018.9745256368502, 4946.936408672081, 4949.65352425334, 4949.737816856678, 4971.1109778284745, 4983.526564976321, 5109.693418394908, 5117.488251174927, 5149.382074151126, 5152.381714194321, 5240.868978275497, 4975.203967365204, 5355.259540649305, 5372.946270537244, 5493.835184944378, 5591.888162236733, 3035.5598438226334, 3060.32672811981, 3067.217859445827, 3074.6778885079184, 3100.240441091947, 5765.4522820332, 5993.880122397615, 6062.363451837582, 6074.51403887688, 6089.391060893875, 5888.970555147197, 5899.203607513016, 5904.498117660047, 5929.199558059693, 5998.34018258, 6126.448619624255, 6133.84665383369, 6135.601185922901, 6145.508359331243, 6151.938480615226, 5651.406602306699, 5864.32560255576, 5885.499732522783, 5905.320888097752, 5908.0, 5826.737796799239, 5854.092615644582, 5855.765769369177, 5856.267966504187, 5869.589128761117, 5948.940510594839, 6027.67391173941, 6036.456718895321, 6077.4226448487325, 6083.239595050619, 4264.722793018444, 4286.29276169441, 4288.721233119837, 4293.892652683708, 4298.484181898192, 5817.632856278687, 5826.7763769608855, 5846.269216347957, 5850.531957443309, 5901.350851406428, 5474.91787623194, 5680.636647204558, 5702.0, 5710.2862142232225, 5710.857228569319, 5671.858203544779, 5677.8864422710485, 5688.175214593778, 5695.800646977336, 5726.570507211893, 5321.2816269804625, 5616.69108199053, 5640.774369025193, 5663.830085097454, 5683.119116536944, 5728.684922329312, 5732.656040637575, 5760.193572899713, 5779.133130030529, 5782.971085144547, 5398.919016214839, 5623.718814059363, 5632.464915832989, 5647.265855438766, 5664.235328230636], "value": 4350.959864962645, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.9959450202748, 830.2403300979604, 848.1094850407071, 887.1572006593735, 924.8797656304681, 14452.132872027685, 15381.615459613487, 15820.525384238463, 15862.444814431483, 16227.756583651255, 14474.203918784462, 14501.709965800677, 14628.926855365735, 14632.634184145401, 14677.119372837637, 725.5465334166146, 836.7824365664941, 849.1932663969238, 852.2159613155911, 853.1553761775859, 842.4650347029619, 861.6424183963679, 862.0560486267527, 862.4954401674996, 862.5557837713583, 914.3142643017736, 920.0983036624112, 920.2408013388947, 920.779013036873, 922.7693076730817, 760.2397602397575, 887.6981826179131, 905.7735566108473, 915.702396721065, 916.564631799893, 665.0390186180971, 665.2848188197659, 665.4476784269045, 665.9200895892476, 667.302668711198, 15088.39646414142, 15099.0, 15103.622409439742, 15104.697906041818, 15117.470888518848, 15971.600709982227, 16189.676206475922, 16352.0, 16430.83569164317, 16683.91658041702, 13049.151805132731, 13265.602031939057, 13408.10043580831, 13506.392212350467, 13611.183329000192, 4055.2700513907484, 4175.373693945902, 4188.308929026707, 4188.91622167558, 4248.192843359751, 76609.61695191544, 77485.0, 77571.0, 78655.60672196602, 79906.20093799046, 12532.373381330897, 12620.179688320413, 12655.557055503197, 12682.936585317015, 12786.296753678636, 23715.169969051, 23913.402164945666, 23926.282211533682, 23943.52112957731, 23968.28095157148, 8860.689875854314, 8887.333449991276, 8927.776805579913, 9156.992730799606, 9387.906120938704, 5216.660917040456, 5228.712420816892, 5234.555062819627, 5245.475452454724, 5315.627906046617, 3996.5204175499125, 4142.233686767958, 4150.937735933963, 4151.481064866892, 4156.127213285184, 590.5924911810837, 601.7893737191948, 604.5526310530176, 611.4649681528663, 669.4844969373555, 711.3313485323779, 758.2682711183623, 778.8908712606018, 801.1867954026668, 813.3127507256359, 10860.728481788019, 10965.780684386267, 11097.44512774358, 11106.000459958643, 11298.210209250146, 692.0346117166625, 759.6429678051308, 763.7288762489347, 817.9713710020121, 823.8146417056234, 4912.336834527293, 5079.6952182869145, 5287.762050707727, 5441.129419292894, 5465.617406781566, 71481.64259178775, 71529.2847071533, 71712.2828771716, 71967.6401617999, 104153.47923260335, 96255.0, 96255.51872240593, 97321.51339243258, 97908.51045744725, 98255.50872245592, 85278.0, 85948.0, 86236.56881715551, 86732.99999999873, 88066.0, 8683.044865064712, 8725.52009639476, 8728.912710873064, 9146.405483643543, 9308.115729006004, 37934.24131517409, 43219.56780432155, 45949.99999999866, 51528.0, 53719.46280537145, 51861.48138518567, 52030.479695202564, 64406.35593644191, 77337.0, 79477.60261198657, 12229.205101668364, 12869.806952895528, 13884.930575347058, 13932.651683707583, 13998.720025599634, 15229.6192595186, 15499.922500387425, 15681.921590391976, 15780.447684331453, 16500.83499165041, 11234.943825280821, 11785.823212651989, 14955.25223738787, 15263.3894644213, 15509.457168999483, 13471.326433678472, 14545.490907818175, 14919.776203357176, 15000.774988375402, 15378.84621153774, 14448.494302699775, 14560.490382836973, 15096.16971066602, 15144.848551514784, 15400.07599544031, 12125.333106679218, 12414.751704965669, 12600.684982875135, 12779.297138657092, 12803.167794093353, 11793.587224447103, 12569.692335953287, 12633.368331583568, 12649.547128496288, 12709.872901270868], "value": 7866.372315663129, "unit": "score"}], "name": "dromaeo_css", "value": 7535.292118876307, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 114.0, 114.0, 111.0, 112.0, 110.0, 112.0, 110.0, 109.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 131.0, 136.0, 170.0, 124.0, 128.0, 155.0, 124.0, 163.0, 123.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 104.0, 75.0, 76.0, 76.0, 74.0, 98.0, 76.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 109.0, 84.0, 85.0, 85.0, 120.0, 84.0, 85.0, 133.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 145.0, 147.0, 146.0, 146.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 52.0, 52.0, 53.0, 56.0, 54.0, 54.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 65.0, 59.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 77.0, 76.0, 77.0, 78.0, 76.0, 77.0, 115.0, 86.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 120.0, 121.0, 117.0, 118.0, 126.0, 118.0, 125.0, 123.0], "value": 121.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 155.0, 152.0, 157.0, 159.0, 153.0, 155.0, 154.0, 153.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 61.0, 63.0, 63.0, 62.0, 62.0, 61.0, 61.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1479.2, "alertThreshold": 2.0}]} 12:48:19 INFO - Return code: 0 12:48:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:48:20 ERROR - # TBPL SUCCESS # 12:48:20 INFO - Running post-action listener: _resource_record_post_action 12:48:20 INFO - ##### 12:48:20 INFO - ##### Finished run-tests step (success) 12:48:20 INFO - ##### 12:48:20 INFO - Running post-run listener: _resource_record_post_run 12:48:20 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 290816; Write bytes: 506490880; Read time: 48; Write time: 347772 12:48:20 INFO - TinderboxPrint: CPU usage
13.1% 12:48:20 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 48 12:48:20 INFO - TinderboxPrint: I/O write bytes / time
506,490,880 / 347,772 12:48:20 INFO - TinderboxPrint: CPU idle
8,255.5 (86.9%) 12:48:20 INFO - TinderboxPrint: CPU user
1,199.0 (12.6%) 12:48:20 INFO - TinderboxPrint: Swap in / out
0 / 0 12:48:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 252801024; Read time: 0; Write time: 226544 12:48:20 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253689856; Read time: 32; Write time: 121228 12:48:20 INFO - Running post-run listener: _upload_blobber_files 12:48:20 INFO - Blob upload gear active. 12:48:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:48:20 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 12:48:20 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'] 12:48:20 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 12:48:21 INFO - (blobuploader) - INFO - Open directory for files ... 12:48:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:48:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:48:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:48:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:48:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:48:21 INFO - (blobuploader) - INFO - Done attempting. 12:48:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:48:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:48:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:48:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:48:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:48:22 INFO - (blobuploader) - INFO - Done attempting. 12:48:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:48:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:48:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:48:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:48:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:48:28 INFO - (blobuploader) - INFO - Done attempting. 12:48:28 INFO - (blobuploader) - INFO - Iteration through files over. 12:48:28 INFO - Return code: 0 12:48:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:48:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:48:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/896a044de3d923b4f245e290f07f59b84d84558f78cb01ae1750d6298073500fad3947a9b775ea18066a5852320dc19214de22397604f2ab0e3cdc11d5f06151", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a2ba86d4d7c86917b60ca1459148934c393acb71da7383d73c23939026f30afe49f33a852cbb3ba1e1f63c6c1157b661265b31a61af40843e1d41cdc2eb556b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7db9ba3b2265fd988310d41c5faef18f01a908e4ea1ba32e1439f94df98bf9aed0cf31e05a139047117b32d7e2066b465d3d72a9532b92ae3e223225c7ccd973"} 12:48:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:48:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:48:28 INFO - Contents: 12:48:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/896a044de3d923b4f245e290f07f59b84d84558f78cb01ae1750d6298073500fad3947a9b775ea18066a5852320dc19214de22397604f2ab0e3cdc11d5f06151", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a2ba86d4d7c86917b60ca1459148934c393acb71da7383d73c23939026f30afe49f33a852cbb3ba1e1f63c6c1157b661265b31a61af40843e1d41cdc2eb556b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7db9ba3b2265fd988310d41c5faef18f01a908e4ea1ba32e1439f94df98bf9aed0cf31e05a139047117b32d7e2066b465d3d72a9532b92ae3e223225c7ccd973"} 12:48:28 INFO - Running post-run listener: copy_logs_to_upload_dir 12:48:28 INFO - Copying logs to upload dir... 12:48:28 INFO - mkdir: /builds/slave/test/build/upload/logs 12:48:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.264043 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-29 12:48:28.339270) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 12:48:28.342808) ========= 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=0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/896a044de3d923b4f245e290f07f59b84d84558f78cb01ae1750d6298073500fad3947a9b775ea18066a5852320dc19214de22397604f2ab0e3cdc11d5f06151", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a2ba86d4d7c86917b60ca1459148934c393acb71da7383d73c23939026f30afe49f33a852cbb3ba1e1f63c6c1157b661265b31a61af40843e1d41cdc2eb556b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7db9ba3b2265fd988310d41c5faef18f01a908e4ea1ba32e1439f94df98bf9aed0cf31e05a139047117b32d7e2066b465d3d72a9532b92ae3e223225c7ccd973"} build_url:https://queue.taskcluster.net/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/QoN7YhzdQiKD-4aUUMa8IQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/896a044de3d923b4f245e290f07f59b84d84558f78cb01ae1750d6298073500fad3947a9b775ea18066a5852320dc19214de22397604f2ab0e3cdc11d5f06151", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a2ba86d4d7c86917b60ca1459148934c393acb71da7383d73c23939026f30afe49f33a852cbb3ba1e1f63c6c1157b661265b31a61af40843e1d41cdc2eb556b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7db9ba3b2265fd988310d41c5faef18f01a908e4ea1ba32e1439f94df98bf9aed0cf31e05a139047117b32d7e2066b465d3d72a9532b92ae3e223225c7ccd973"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 12:48:28.368204) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 12:48:28.368541) ========= 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=0e2a256762fed810e2f0f810000001b3-1469820472.795694-38177845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 12:48:28.450696) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 12:48:28.451030) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 12:48:28.451348) ========= ========= Total master_lag: 0.17 =========