builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1470075873.02 results: success (0) buildid: 20160801070053 builduid: eaf10adbc6074edb9e3b1e3d32dab73b revision: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:33.024119) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:33.024591) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:33.024880) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:33.070859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:33.071142) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 11:24:33-- 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% 38.6M=0s 2016-08-01 11:24:33 (38.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168483 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:33.258399) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:33.258736) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018796 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:33.308052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:33.308402) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 --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=652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 11:24:33,584 truncating revision to first 12 chars 2016-08-01 11:24:33,584 Setting DEBUG logging. 2016-08-01 11:24:33,584 attempt 1/10 2016-08-01 11:24:33,584 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bad9d4f5bf7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 11:24:34,152 unpacking tar archive at: mozilla-beta-bad9d4f5bf7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.914050 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:34.236829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:34.237158) ========= script_repo_revision: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:34.237545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:34.237808) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:34.248225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-01 11:24:34.248502) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:34 INFO - MultiFileLogger online at 20160801 11:24:34 in /builds/slave/test 11:24:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:24:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:34 INFO - {'append_to_log': False, 11:24:34 INFO - 'base_work_dir': '/builds/slave/test', 11:24:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:24:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:34 INFO - 'branch': 'Mozilla-Beta', 11:24:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:34 INFO - 'config_files': ('talos/linux_config.py',), 11:24:34 INFO - 'default_actions': ('clobber', 11:24:34 INFO - 'read-buildbot-config', 11:24:34 INFO - 'download-and-extract', 11:24:34 INFO - 'populate-webroot', 11:24:34 INFO - 'create-virtualenv', 11:24:34 INFO - 'install', 11:24:34 INFO - 'run-tests'), 11:24:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:34 INFO - 'download_minidump_stackwalk': True, 11:24:34 INFO - 'download_symbols': 'ondemand', 11:24:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:24:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:24:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:24:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:24:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:34 INFO - 'installer_path': 'installer.exe', 11:24:34 INFO - 'log_level': 'info', 11:24:34 INFO - 'log_name': 'talos', 11:24:34 INFO - 'log_to_console': True, 11:24:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:34 INFO - 'opt_config_files': (), 11:24:34 INFO - 'pip_index': False, 11:24:34 INFO - 'sps_profile': False, 11:24:34 INFO - 'sps_profile_interval': 0, 11:24:34 INFO - 'suite': 'dromaeojs-e10s', 11:24:34 INFO - 'system_bits': '32', 11:24:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:34 INFO - 'title': 'talos-linux64-ix-046', 11:24:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:34 INFO - 'use_talos_json': True, 11:24:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:34 INFO - 'work_dir': 'build'} 11:24:34 INFO - ##### 11:24:34 INFO - ##### Running clobber step. 11:24:34 INFO - ##### 11:24:34 INFO - Running pre-action listener: _resource_record_pre_action 11:24:34 INFO - Running main action method: clobber 11:24:34 INFO - rmtree: /builds/slave/test/build 11:24:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:35 INFO - Running post-action listener: _resource_record_post_action 11:24:35 INFO - ##### 11:24:35 INFO - ##### Finished clobber step (success) 11:24:35 INFO - ##### 11:24:35 INFO - ##### 11:24:35 INFO - ##### Running read-buildbot-config step. 11:24:35 INFO - ##### 11:24:35 INFO - Running pre-action listener: _resource_record_pre_action 11:24:35 INFO - Running main action method: read_buildbot_config 11:24:35 INFO - Using buildbot properties: 11:24:35 INFO - { 11:24:35 INFO - "project": "", 11:24:35 INFO - "product": "firefox", 11:24:35 INFO - "script_repo_revision": "production", 11:24:35 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:24:35 INFO - "repository": "", 11:24:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 11:24:35 INFO - "buildid": "20160801070053", 11:24:35 INFO - "pgo_build": "True", 11:24:35 INFO - "basedir": "/builds/slave/test", 11:24:35 INFO - "buildnumber": 189, 11:24:35 INFO - "slavename": "talos-linux64-ix-046", 11:24:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:24:35 INFO - "platform": "ubuntu64_hw", 11:24:35 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:24:35 INFO - "branch": "mozilla-beta", 11:24:35 INFO - "repo_path": "releases/mozilla-beta", 11:24:35 INFO - "revision": "bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2", 11:24:35 INFO - "stage_platform": "linux64-pgo", 11:24:35 INFO - "builduid": "eaf10adbc6074edb9e3b1e3d32dab73b", 11:24:35 INFO - "slavebuilddir": "test" 11:24:35 INFO - } 11:24:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 11:24:35 INFO - Running post-action listener: _resource_record_post_action 11:24:35 INFO - ##### 11:24:35 INFO - ##### Finished read-buildbot-config step (success) 11:24:35 INFO - ##### 11:24:35 INFO - ##### 11:24:35 INFO - ##### Running download-and-extract step. 11:24:35 INFO - ##### 11:24:35 INFO - Running pre-action listener: _resource_record_pre_action 11:24:35 INFO - Running main action method: download_and_extract 11:24:35 INFO - mkdir: /builds/slave/test/build/tests 11:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:35 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:24:36 INFO - Downloaded 1327 bytes. 11:24:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:36 INFO - Using the following test package requirements: 11:24:36 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 11:24:36 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:36 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:24:36 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:36 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 11:24:36 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:36 INFO - u'jsshell-linux-x86_64.zip'], 11:24:36 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:36 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:24:36 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 11:24:36 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:36 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 11:24:36 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:36 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 11:24:36 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:36 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:24:36 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:36 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:24:36 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:24:36 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')]} 11:24:36 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:24:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:24:37 INFO - Downloaded 21968684 bytes. 11:24:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:24:38 INFO - Return code: 0 11:24:38 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:38 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:24:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:24:39 INFO - Downloaded 21968684 bytes. 11:24:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:24:41 INFO - Return code: 0 11:24:41 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')]} 11:24:41 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:24:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:24:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:24:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:24:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:24:42 INFO - Downloaded 10833369 bytes. 11:24:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:24:42 INFO - Return code: 0 11:24:42 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')]} 11:24:42 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:24:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:24:43 INFO - Downloaded 55264299 bytes. 11:24:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:43 INFO - mkdir: /builds/slave/test/properties 11:24:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:43 INFO - Contents: 11:24:43 INFO - build_url:https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:44 INFO - Running post-action listener: _resource_record_post_action 11:24:44 INFO - Running post-action listener: set_extra_try_arguments 11:24:44 INFO - ##### 11:24:44 INFO - ##### Finished download-and-extract step (success) 11:24:44 INFO - ##### 11:24:44 INFO - ##### 11:24:44 INFO - ##### Running populate-webroot step. 11:24:44 INFO - ##### 11:24:44 INFO - Running pre-action listener: _resource_record_pre_action 11:24:44 INFO - Running main action method: populate_webroot 11:24:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:24:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:24:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:24:44 INFO - '--tppagecycles', 11:24:44 INFO - '7'], 11:24:44 INFO - 'tests': ['tsvgm']}}, 11:24:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:24:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:24:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:24:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:24:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:44 INFO - 'talos_options': ['--disable-e10s'], 11:24:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:44 INFO - 'talos_options': ['--disable-e10s'], 11:24:44 INFO - 'tests': ['damp', 'tps']}, 11:24:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:44 INFO - 'tests': ['damp', 'tps']}, 11:24:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:24:44 INFO - 'tests': ['dromaeo_dom']}, 11:24:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:24:44 INFO - 'tests': ['a11yr', 11:24:44 INFO - 'ts_paint', 11:24:44 INFO - 'tpaint', 11:24:44 INFO - 'sessionrestore', 11:24:44 INFO - 'sessionrestore_no_auto_restore', 11:24:44 INFO - 'tabpaint']}, 11:24:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:44 INFO - 'ts_paint', 11:24:44 INFO - 'tpaint', 11:24:44 INFO - 'sessionrestore', 11:24:44 INFO - 'sessionrestore_no_auto_restore', 11:24:44 INFO - 'tabpaint']}, 11:24:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:24:44 INFO - 'ts_paint', 11:24:44 INFO - 'tpaint', 11:24:44 INFO - 'sessionrestore', 11:24:44 INFO - 'sessionrestore_no_auto_restore', 11:24:44 INFO - 'tabpaint']}, 11:24:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:24:44 INFO - 'ts_paint', 11:24:44 INFO - 'tpaint', 11:24:44 INFO - 'sessionrestore', 11:24:44 INFO - 'sessionrestore_no_auto_restore', 11:24:44 INFO - 'tabpaint']}, 11:24:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:24:44 INFO - 'tests': ['a11yr', 11:24:44 INFO - 'ts_paint', 11:24:44 INFO - 'tpaint', 11:24:44 INFO - 'sessionrestore', 11:24:44 INFO - 'sessionrestore_no_auto_restore', 11:24:44 INFO - 'tabpaint']}, 11:24:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:24:44 INFO - 'tests': ['a11yr', 11:24:44 INFO - 'ts_paint', 11:24:44 INFO - 'tpaint', 11:24:44 INFO - 'sessionrestore', 11:24:44 INFO - 'sessionrestore_no_auto_restore', 11:24:44 INFO - 'tabpaint']}, 11:24:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:24:44 INFO - 'tests': ['tsvgx', 11:24:44 INFO - 'tsvgr_opacity', 11:24:44 INFO - 'tart', 11:24:44 INFO - 'tscrollx', 11:24:44 INFO - 'cart']}, 11:24:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:44 INFO - 'tsvgr_opacity', 11:24:44 INFO - 'tart', 11:24:44 INFO - 'tscrollx', 11:24:44 INFO - 'cart']}, 11:24:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:44 INFO - 'talos_options': ['--disable-e10s'], 11:24:44 INFO - 'tests': ['tp5o']}, 11:24:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:44 INFO - 'tests': ['tp5o']}, 11:24:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:44 INFO - 'talos_options': ['--disable-e10s', 11:24:44 INFO - '--xperf_path', 11:24:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:44 INFO - 'tests': ['tp5n']}, 11:24:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:44 INFO - 'talos_options': ['--xperf_path', 11:24:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:44 INFO - 'tests': ['tp5n']}}, 11:24:44 INFO - 'talos.zip': {'path': '', 11:24:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:24:44 INFO - Running post-action listener: _resource_record_post_action 11:24:44 INFO - ##### 11:24:44 INFO - ##### Finished populate-webroot step (success) 11:24:44 INFO - ##### 11:24:44 INFO - ##### 11:24:44 INFO - ##### Running create-virtualenv step. 11:24:44 INFO - ##### 11:24:44 INFO - Running pre-action listener: _resource_record_pre_action 11:24:44 INFO - Running main action method: create_virtualenv 11:24:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:44 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 11:24:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:44 INFO - Using real prefix '/usr' 11:24:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:47 INFO - Installing pip.................done. 11:24:47 INFO - Return code: 0 11:24:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:47 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 0x7f8017704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c1c0>, '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 0x229d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d550>, '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': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', '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 11:24:47 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 11:24:47 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 11:24:47 INFO - Using env: {'DISPLAY': ':0', 11:24:47 INFO - 'HOME': '/home/cltbld', 11:24:47 INFO - 'LANG': 'en_US.UTF-8', 11:24:47 INFO - 'LANGUAGE': 'en_US:en', 11:24:47 INFO - 'LOGNAME': 'cltbld', 11:24:47 INFO - 'MAIL': '/var/mail/cltbld', 11:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:47 INFO - 'MOZ_NO_REMOTE': '1', 11:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:47 INFO - 'NO_EM_RESTART': '1', 11:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:47 INFO - 'PWD': '/builds/slave/test', 11:24:47 INFO - 'SHELL': '/bin/bash', 11:24:47 INFO - 'SHLVL': '1', 11:24:47 INFO - 'TERM': 'linux', 11:24:47 INFO - 'TMOUT': '86400', 11:24:47 INFO - 'USER': 'cltbld', 11:24:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', 11:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:47 INFO - '_': '/tools/buildbot/bin/python'} 11:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:48 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 11:24:48 INFO - Cleaning up... 11:24:48 INFO - Return code: 0 11:24:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:48 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 0x7f8017704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c1c0>, '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 0x229d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d550>, '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': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', '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 11:24:48 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 11:24:48 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 11:24:48 INFO - Using env: {'DISPLAY': ':0', 11:24:48 INFO - 'HOME': '/home/cltbld', 11:24:48 INFO - 'LANG': 'en_US.UTF-8', 11:24:48 INFO - 'LANGUAGE': 'en_US:en', 11:24:48 INFO - 'LOGNAME': 'cltbld', 11:24:48 INFO - 'MAIL': '/var/mail/cltbld', 11:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:48 INFO - 'MOZ_NO_REMOTE': '1', 11:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:48 INFO - 'NO_EM_RESTART': '1', 11:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:48 INFO - 'PWD': '/builds/slave/test', 11:24:48 INFO - 'SHELL': '/bin/bash', 11:24:48 INFO - 'SHLVL': '1', 11:24:48 INFO - 'TERM': 'linux', 11:24:48 INFO - 'TMOUT': '86400', 11:24:48 INFO - 'USER': 'cltbld', 11:24:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', 11:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:48 INFO - '_': '/tools/buildbot/bin/python'} 11:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:48 INFO - Downloading/unpacking psutil>=3.1.1 11:24:48 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 11:24:48 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 11:24:48 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 11:24:48 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 11:24:48 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 11:24:48 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 11:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:50 INFO - Installing collected packages: psutil 11:24:50 INFO - Running setup.py install for psutil 11:24:50 INFO - building 'psutil._psutil_linux' extension 11:24:50 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 11:24:51 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 11:24:51 INFO - building 'psutil._psutil_posix' extension 11:24:51 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 11:24:51 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 11:24:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:52 INFO - Successfully installed psutil 11:24:52 INFO - Cleaning up... 11:24:52 INFO - Return code: 0 11:24:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:52 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 0x7f8017704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c1c0>, '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 0x229d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d550>, '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': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', '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 11:24:52 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 11:24:52 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 11:24:52 INFO - Using env: {'DISPLAY': ':0', 11:24:52 INFO - 'HOME': '/home/cltbld', 11:24:52 INFO - 'LANG': 'en_US.UTF-8', 11:24:52 INFO - 'LANGUAGE': 'en_US:en', 11:24:52 INFO - 'LOGNAME': 'cltbld', 11:24:52 INFO - 'MAIL': '/var/mail/cltbld', 11:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:52 INFO - 'MOZ_NO_REMOTE': '1', 11:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:52 INFO - 'NO_EM_RESTART': '1', 11:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:52 INFO - 'PWD': '/builds/slave/test', 11:24:52 INFO - 'SHELL': '/bin/bash', 11:24:52 INFO - 'SHLVL': '1', 11:24:52 INFO - 'TERM': 'linux', 11:24:52 INFO - 'TMOUT': '86400', 11:24:52 INFO - 'USER': 'cltbld', 11:24:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', 11:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:52 INFO - '_': '/tools/buildbot/bin/python'} 11:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:24:52 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 11:24:52 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 11:24:52 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 11:24:52 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 11:24:52 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 11:24:52 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 11:24:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:24:54 INFO - Installing collected packages: mozsystemmonitor 11:24:54 INFO - Running setup.py install for mozsystemmonitor 11:24:54 INFO - Successfully installed mozsystemmonitor 11:24:54 INFO - Cleaning up... 11:24:54 INFO - Return code: 0 11:24:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8017704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c1c0>, '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 0x229d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d550>, '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': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', '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 11:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:24:54 INFO - Using env: {'DISPLAY': ':0', 11:24:54 INFO - 'HOME': '/home/cltbld', 11:24:54 INFO - 'LANG': 'en_US.UTF-8', 11:24:54 INFO - 'LANGUAGE': 'en_US:en', 11:24:54 INFO - 'LOGNAME': 'cltbld', 11:24:54 INFO - 'MAIL': '/var/mail/cltbld', 11:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:54 INFO - 'MOZ_NO_REMOTE': '1', 11:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:54 INFO - 'NO_EM_RESTART': '1', 11:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:54 INFO - 'PWD': '/builds/slave/test', 11:24:54 INFO - 'SHELL': '/bin/bash', 11:24:54 INFO - 'SHLVL': '1', 11:24:54 INFO - 'TERM': 'linux', 11:24:54 INFO - 'TMOUT': '86400', 11:24:54 INFO - 'USER': 'cltbld', 11:24:54 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', 11:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:54 INFO - '_': '/tools/buildbot/bin/python'} 11:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:54 INFO - Downloading/unpacking jsonschema==2.5.1 11:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24:56 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 11:24:56 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 11:24:56 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 11:24:56 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 11:24:56 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 11:24:56 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 11:24:56 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:56 INFO - warning: no files found matching '*.txt' 11:24:56 INFO - no previously-included directories found matching 'build' 11:24:56 INFO - no previously-included directories found matching 'dist' 11:24:56 INFO - no previously-included directories found matching '.git*' 11:24:56 INFO - Installing collected packages: jsonschema, functools32 11:24:56 INFO - Running setup.py install for functools32 11:24:57 INFO - warning: no files found matching '*.txt' 11:24:57 INFO - no previously-included directories found matching 'build' 11:24:57 INFO - no previously-included directories found matching 'dist' 11:24:57 INFO - no previously-included directories found matching '.git*' 11:24:57 INFO - Successfully installed jsonschema functools32 11:24:57 INFO - Cleaning up... 11:24:57 INFO - Return code: 0 11:24:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:57 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 0x7f8017704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c1c0>, '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 0x229d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d550>, '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': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', '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 11:24:57 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 11:24:57 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 11:24:57 INFO - Using env: {'DISPLAY': ':0', 11:24:57 INFO - 'HOME': '/home/cltbld', 11:24:57 INFO - 'LANG': 'en_US.UTF-8', 11:24:57 INFO - 'LANGUAGE': 'en_US:en', 11:24:57 INFO - 'LOGNAME': 'cltbld', 11:24:57 INFO - 'MAIL': '/var/mail/cltbld', 11:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:57 INFO - 'MOZ_NO_REMOTE': '1', 11:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:57 INFO - 'NO_EM_RESTART': '1', 11:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:57 INFO - 'PWD': '/builds/slave/test', 11:24:57 INFO - 'SHELL': '/bin/bash', 11:24:57 INFO - 'SHLVL': '1', 11:24:57 INFO - 'TERM': 'linux', 11:24:57 INFO - 'TMOUT': '86400', 11:24:57 INFO - 'USER': 'cltbld', 11:24:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', 11:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:57 INFO - '_': '/tools/buildbot/bin/python'} 11:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:57 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:59 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:59 INFO - Downloading docopt-0.6.1.tar.gz 11:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:59 INFO - Running setup.py install for blobuploader 11:25:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:00 INFO - Running setup.py install for requests 11:25:00 INFO - Running setup.py install for docopt 11:25:00 INFO - Successfully installed blobuploader requests docopt 11:25:00 INFO - Cleaning up... 11:25:00 INFO - Return code: 0 11:25:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:00 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')]} 11:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:00 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')]} 11:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:00 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 0x7f8017704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c1c0>, '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 0x229d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d550>, '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': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', '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 11:25:00 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 11:25:00 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 11:25:00 INFO - Using env: {'DISPLAY': ':0', 11:25:00 INFO - 'HOME': '/home/cltbld', 11:25:00 INFO - 'LANG': 'en_US.UTF-8', 11:25:00 INFO - 'LANGUAGE': 'en_US:en', 11:25:00 INFO - 'LOGNAME': 'cltbld', 11:25:00 INFO - 'MAIL': '/var/mail/cltbld', 11:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:00 INFO - 'MOZ_NO_REMOTE': '1', 11:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:00 INFO - 'NO_EM_RESTART': '1', 11:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:00 INFO - 'PWD': '/builds/slave/test', 11:25:00 INFO - 'SHELL': '/bin/bash', 11:25:00 INFO - 'SHLVL': '1', 11:25:00 INFO - 'TERM': 'linux', 11:25:00 INFO - 'TMOUT': '86400', 11:25:00 INFO - 'USER': 'cltbld', 11:25:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', 11:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:00 INFO - '_': '/tools/buildbot/bin/python'} 11:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:00 INFO - Running setup.py (path:/tmp/pip-18NtpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:00 INFO - Running setup.py (path:/tmp/pip-pjJ6LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:00 INFO - Running setup.py (path:/tmp/pip-GWzgCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:01 INFO - Running setup.py (path:/tmp/pip-JaLPCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:01 INFO - Running setup.py (path:/tmp/pip-GzpYBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:01 INFO - Running setup.py (path:/tmp/pip-VypUVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:01 INFO - Running setup.py (path:/tmp/pip-iwPnjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:01 INFO - Running setup.py (path:/tmp/pip-BT_A_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:01 INFO - Running setup.py (path:/tmp/pip-xag4Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:01 INFO - Running setup.py (path:/tmp/pip-KnyDwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:01 INFO - Running setup.py (path:/tmp/pip-vq55zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:01 INFO - Running setup.py (path:/tmp/pip-plvqeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:01 INFO - Running setup.py (path:/tmp/pip-XxDfxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:01 INFO - Running setup.py (path:/tmp/pip-vmc_N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:01 INFO - Running setup.py (path:/tmp/pip-c_94U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:01 INFO - Running setup.py (path:/tmp/pip-7FbuGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:01 INFO - Running setup.py (path:/tmp/pip-gWqH0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:02 INFO - Running setup.py install for manifestparser 11:25:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Running setup.py install for mozcrash 11:25:02 INFO - Running setup.py install for mozdebug 11:25:02 INFO - Running setup.py install for mozdevice 11:25:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Running setup.py install for mozfile 11:25:02 INFO - Running setup.py install for mozhttpd 11:25:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Running setup.py install for mozinfo 11:25:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Running setup.py install for mozInstall 11:25:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:02 INFO - Running setup.py install for mozleak 11:25:02 INFO - Running setup.py install for mozlog 11:25:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:03 INFO - Running setup.py install for moznetwork 11:25:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:03 INFO - Running setup.py install for mozprocess 11:25:03 INFO - Running setup.py install for mozprofile 11:25:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:03 INFO - Running setup.py install for mozrunner 11:25:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:03 INFO - Running setup.py install for mozscreenshot 11:25:03 INFO - Running setup.py install for moztest 11:25:03 INFO - Running setup.py install for mozversion 11:25:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:03 INFO - Cleaning up... 11:25:03 INFO - Return code: 0 11:25:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:03 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 0x7f8017704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c1c0>, '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 0x229d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d550>, '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': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', '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 11:25:03 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 11:25:03 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 11:25:03 INFO - Using env: {'DISPLAY': ':0', 11:25:03 INFO - 'HOME': '/home/cltbld', 11:25:03 INFO - 'LANG': 'en_US.UTF-8', 11:25:03 INFO - 'LANGUAGE': 'en_US:en', 11:25:03 INFO - 'LOGNAME': 'cltbld', 11:25:03 INFO - 'MAIL': '/var/mail/cltbld', 11:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:03 INFO - 'MOZ_NO_REMOTE': '1', 11:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:03 INFO - 'NO_EM_RESTART': '1', 11:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:03 INFO - 'PWD': '/builds/slave/test', 11:25:03 INFO - 'SHELL': '/bin/bash', 11:25:03 INFO - 'SHLVL': '1', 11:25:03 INFO - 'TERM': 'linux', 11:25:03 INFO - 'TMOUT': '86400', 11:25:03 INFO - 'USER': 'cltbld', 11:25:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', 11:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:03 INFO - '_': '/tools/buildbot/bin/python'} 11:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:04 INFO - Running setup.py (path:/tmp/pip-xikfdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:04 INFO - Running setup.py (path:/tmp/pip-bMc9Fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:04 INFO - Running setup.py (path:/tmp/pip-6fkPR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:04 INFO - Running setup.py (path:/tmp/pip-KqPnNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:04 INFO - Running setup.py (path:/tmp/pip-npzS5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:04 INFO - Running setup.py (path:/tmp/pip-lItQlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:04 INFO - Running setup.py (path:/tmp/pip-jhMeWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:04 INFO - Running setup.py (path:/tmp/pip-jodoIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:04 INFO - Running setup.py (path:/tmp/pip-b4kqDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:04 INFO - Running setup.py (path:/tmp/pip-6izwNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:04 INFO - Running setup.py (path:/tmp/pip-pLcsEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:04 INFO - Running setup.py (path:/tmp/pip-MHRX57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:04 INFO - Running setup.py (path:/tmp/pip-2PofYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:04 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)) 11:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:04 INFO - Running setup.py (path:/tmp/pip-UbM4yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:05 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)) 11:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:05 INFO - Running setup.py (path:/tmp/pip-z1BGWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:05 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)) 11:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:05 INFO - Running setup.py (path:/tmp/pip-H_bFJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:05 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)) 11:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:05 INFO - Running setup.py (path:/tmp/pip-xglafw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:05 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)) 11:25:05 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)) 11:25:05 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)) 11:25:05 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)) 11:25:05 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)) 11:25:05 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)) 11:25:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:07 INFO - Downloading blessings-1.6.tar.gz 11:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:07 INFO - Installing collected packages: blessings 11:25:07 INFO - Running setup.py install for blessings 11:25:07 INFO - Successfully installed blessings 11:25:07 INFO - Cleaning up... 11:25:07 INFO - Return code: 0 11:25:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:07 INFO - Reading from file tmpfile_stdout 11:25:07 INFO - Current package versions: 11:25:07 INFO - argparse == 1.2.1 11:25:07 INFO - blessings == 1.6 11:25:07 INFO - blobuploader == 1.2.4 11:25:07 INFO - docopt == 0.6.1 11:25:07 INFO - functools32 == 3.2.3-2 11:25:07 INFO - jsonschema == 2.5.1 11:25:07 INFO - manifestparser == 1.1 11:25:07 INFO - mozInstall == 1.12 11:25:07 INFO - mozcrash == 0.17 11:25:07 INFO - mozdebug == 0.1 11:25:07 INFO - mozdevice == 0.48 11:25:07 INFO - mozfile == 1.2 11:25:07 INFO - mozhttpd == 0.7 11:25:07 INFO - mozinfo == 0.9 11:25:07 INFO - mozleak == 0.1 11:25:07 INFO - mozlog == 3.2 11:25:07 INFO - moznetwork == 0.27 11:25:07 INFO - mozprocess == 0.23 11:25:07 INFO - mozprofile == 0.28 11:25:07 INFO - mozrunner == 6.12 11:25:07 INFO - mozscreenshot == 0.1 11:25:07 INFO - mozsystemmonitor == 0.3 11:25:07 INFO - moztest == 0.7 11:25:07 INFO - mozversion == 1.4 11:25:07 INFO - psutil == 3.1.1 11:25:07 INFO - requests == 1.2.3 11:25:07 INFO - wsgiref == 0.1.2 11:25:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:07 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 0x7f8017704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c1c0>, '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 0x229d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d550>, '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': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', '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 11:25:07 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 11:25:07 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 11:25:07 INFO - Using env: {'DISPLAY': ':0', 11:25:07 INFO - 'HOME': '/home/cltbld', 11:25:07 INFO - 'LANG': 'en_US.UTF-8', 11:25:07 INFO - 'LANGUAGE': 'en_US:en', 11:25:07 INFO - 'LOGNAME': 'cltbld', 11:25:07 INFO - 'MAIL': '/var/mail/cltbld', 11:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:07 INFO - 'MOZ_NO_REMOTE': '1', 11:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:07 INFO - 'NO_EM_RESTART': '1', 11:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:07 INFO - 'PWD': '/builds/slave/test', 11:25:07 INFO - 'SHELL': '/bin/bash', 11:25:07 INFO - 'SHLVL': '1', 11:25:07 INFO - 'TERM': 'linux', 11:25:07 INFO - 'TMOUT': '86400', 11:25:07 INFO - 'USER': 'cltbld', 11:25:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', 11:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:07 INFO - '_': '/tools/buildbot/bin/python'} 11:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:07 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)) 11:25:07 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)) 11:25:07 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)) 11:25:07 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)) 11:25:07 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)) 11:25:07 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)) 11:25:07 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)) 11:25:07 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)) 11:25:07 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)) 11:25:07 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)) 11:25:07 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)) 11:25:07 INFO - Cleaning up... 11:25:07 INFO - Return code: 0 11:25:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8017704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c1c0>, '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 0x229d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d550>, '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': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', '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 11:25: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', 'jsonschema'] in /builds/slave/test/build 11:25: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 jsonschema 11:25:07 INFO - Using env: {'DISPLAY': ':0', 11:25:07 INFO - 'HOME': '/home/cltbld', 11:25:07 INFO - 'LANG': 'en_US.UTF-8', 11:25:07 INFO - 'LANGUAGE': 'en_US:en', 11:25:07 INFO - 'LOGNAME': 'cltbld', 11:25:07 INFO - 'MAIL': '/var/mail/cltbld', 11:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:07 INFO - 'MOZ_NO_REMOTE': '1', 11:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:07 INFO - 'NO_EM_RESTART': '1', 11:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:07 INFO - 'PWD': '/builds/slave/test', 11:25:07 INFO - 'SHELL': '/bin/bash', 11:25:07 INFO - 'SHLVL': '1', 11:25:07 INFO - 'TERM': 'linux', 11:25:07 INFO - 'TMOUT': '86400', 11:25:07 INFO - 'USER': 'cltbld', 11:25:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', 11:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:07 INFO - '_': '/tools/buildbot/bin/python'} 11:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:25:08 INFO - Cleaning up... 11:25:08 INFO - Return code: 0 11:25:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8017704f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229c1c0>, '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 0x229d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d550>, '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': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', '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 11:25: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', 'flake8'] in /builds/slave/test/build 11:25: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 flake8 11:25:08 INFO - Using env: {'DISPLAY': ':0', 11:25:08 INFO - 'HOME': '/home/cltbld', 11:25:08 INFO - 'LANG': 'en_US.UTF-8', 11:25:08 INFO - 'LANGUAGE': 'en_US:en', 11:25:08 INFO - 'LOGNAME': 'cltbld', 11:25:08 INFO - 'MAIL': '/var/mail/cltbld', 11:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:08 INFO - 'MOZ_NO_REMOTE': '1', 11:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:08 INFO - 'NO_EM_RESTART': '1', 11:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:08 INFO - 'PWD': '/builds/slave/test', 11:25:08 INFO - 'SHELL': '/bin/bash', 11:25:08 INFO - 'SHLVL': '1', 11:25:08 INFO - 'TERM': 'linux', 11:25:08 INFO - 'TMOUT': '86400', 11:25:08 INFO - 'USER': 'cltbld', 11:25:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', 11:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:08 INFO - '_': '/tools/buildbot/bin/python'} 11:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:08 INFO - Downloading/unpacking flake8 11:25: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 11:25: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 11:25: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 11:25: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 11:25: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 11:25: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 11:25:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:25:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:25: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 11:25: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 11:25: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 11:25: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 11:25: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 11:25: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 11:25:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:25:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:25: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 11:25: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 11:25: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 11:25: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 11:25: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 11:25: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 11:25:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:25: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 11:25: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 11:25: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 11:25: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 11:25: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 11:25: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 11:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:25:10 INFO - no previously-included directories found matching 'docs/_build' 11:25:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:25:10 INFO - Running setup.py install for pep8 11:25:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:25:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:25:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:25:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:25:11 INFO - no previously-included directories found matching 'docs/_build' 11:25:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:25:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:25:11 INFO - Cleaning up... 11:25:11 INFO - Return code: 0 11:25:11 INFO - Running post-action listener: _resource_record_post_action 11:25:11 INFO - Running post-action listener: _start_resource_monitoring 11:25:11 INFO - Starting resource monitoring. 11:25:11 INFO - ##### 11:25:11 INFO - ##### Finished create-virtualenv step (success) 11:25:11 INFO - ##### 11:25:11 INFO - ##### 11:25:11 INFO - ##### Running install step. 11:25:11 INFO - ##### 11:25:11 INFO - Running pre-action listener: _resource_record_pre_action 11:25:11 INFO - Running main action method: install 11:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:11 INFO - Reading from file tmpfile_stdout 11:25:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:11 INFO - Reading from file tmpfile_stdout 11:25:11 INFO - Output received: 11:25:11 INFO - Usage: mozinstall [options] installer 11:25:11 INFO - Options: 11:25:11 INFO - -h, --help show this help message and exit 11:25:11 INFO - -d DEST, --destination=DEST 11:25:11 INFO - Directory to install application into. [default: 11:25:11 INFO - "/builds/slave/test"] 11:25:11 INFO - --app=APP Application being installed. [default: firefox] 11:25:11 INFO - mkdir: /builds/slave/test/build/application 11:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:25:24 INFO - Reading from file tmpfile_stdout 11:25:24 INFO - Output received: 11:25:24 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:24 INFO - Running post-action listener: _resource_record_post_action 11:25:24 INFO - ##### 11:25:24 INFO - ##### Finished install step (success) 11:25:24 INFO - ##### 11:25:24 INFO - ##### 11:25:24 INFO - ##### Running run-tests step. 11:25:24 INFO - ##### 11:25:24 INFO - Running pre-action listener: _resource_record_pre_action 11:25:24 INFO - Running main action method: run_tests 11:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:24 INFO - Python 2.7.3 11:25:24 INFO - Return code: 0 11:25:24 INFO - grabbing minidump binary from tooltool 11:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:24 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 0x229c1c0>, '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 0x229d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:24 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 11:25:24 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 11:25:24 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 11:25:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:24 INFO - Return code: 0 11:25:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:25:25 INFO - Return code: 0 11:25:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:25:25 INFO - Using env: {'DISPLAY': ':0', 11:25:25 INFO - 'HOME': '/home/cltbld', 11:25:25 INFO - 'LANG': 'en_US.UTF-8', 11:25:25 INFO - 'LANGUAGE': 'en_US:en', 11:25:25 INFO - 'LOGNAME': 'cltbld', 11:25:25 INFO - 'MAIL': '/var/mail/cltbld', 11:25:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:25 INFO - 'MOZ_NO_REMOTE': '1', 11:25:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:25 INFO - 'NO_EM_RESTART': '1', 11:25:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:25 INFO - 'PWD': '/builds/slave/test', 11:25:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:25 INFO - 'SHELL': '/bin/bash', 11:25:25 INFO - 'SHLVL': '1', 11:25:25 INFO - 'TERM': 'linux', 11:25:25 INFO - 'TMOUT': '86400', 11:25:25 INFO - 'USER': 'cltbld', 11:25:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656', 11:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:25 INFO - '_': '/tools/buildbot/bin/python'} 11:25:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:25:25 INFO - mozversion application_buildid: 20160801070053 11:25:25 INFO - mozversion application_changeset: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 11:25:25 INFO - mozversion application_display_name: Firefox 11:25:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:25 INFO - mozversion application_name: Firefox 11:25:25 INFO - mozversion application_remotingname: firefox 11:25:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:25 INFO - mozversion application_vendor: Mozilla 11:25:25 INFO - mozversion application_version: 49.0 11:25:25 INFO - mozversion platform_buildid: 20160801070053 11:25:25 INFO - mozversion platform_changeset: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 11:25:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:25 INFO - mozversion platform_version: 49.0 11:25:25 INFO - using testdate: 1470075925 11:25:25 INFO - actual date: 1470075925 11:25:25 INFO - starting webserver on 'localhost:58218' 11:25:25 INFO - SUITE-START | Running 2 tests 11:25:25 INFO - TEST-START | dromaeo_css 11:25:25 INFO - operating with platform_type : linux_ 11:25:25 INFO - Initialising browser for dromaeo_css test... 11:25:25 INFO - TEST-INFO | started process 3311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVECmAL/profile http://localhost:58218/getInfo.html) 11:25:30 INFO - PROCESS | 3311 | __metrics Screen width/height:1600/1200 11:25:30 INFO - PROCESS | 3311 | colorDepth:24 11:25:30 INFO - PROCESS | 3311 | Browser inner width/height: 1024/697 11:25:30 INFO - PROCESS | 3311 | __metrics 11:25:32 ERROR - PROCESS | 3311 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 11:25:33 INFO - TEST-INFO | 3311: exit 0 11:25:33 INFO - Browser initialized. 11:25:33 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:33 INFO - TEST-INFO | started process 3443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVECmAL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:44 INFO - PROCESS | 3443 | RSS: Main: 153198592 11:25:44 INFO - PROCESS | 3443 | 11:26:34 INFO - PROCESS | 3443 | 1470075994573 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] 11:28:42 INFO - PROCESS | 3443 | Cycle 1(1): loaded http://localhost:58218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58218/tests/dromaeo/cssquery-ext.html) 11:28:43 INFO - PROCESS | 3443 | RSS: Main: 157585408 11:28:43 INFO - PROCESS | 3443 | 11:31:45 INFO - PROCESS | 3443 | Cycle 1(1): loaded http://localhost:58218/tests/dromaeo/cssquery-ext.html (next: http://localhost:58218/tests/dromaeo/cssquery-jquery.html) 11:31:46 INFO - PROCESS | 3443 | RSS: Main: 154685440 11:31:46 INFO - PROCESS | 3443 | 11:34:48 INFO - PROCESS | 3443 | Cycle 1(1): loaded http://localhost:58218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58218/tests/dromaeo/cssquery-mootools.html) 11:34:48 INFO - PROCESS | 3443 | RSS: Main: 154349568 11:34:48 INFO - PROCESS | 3443 | 11:37:50 INFO - PROCESS | 3443 | Cycle 1(1): loaded http://localhost:58218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58218/tests/dromaeo/cssquery-prototype.html) 11:37:50 INFO - PROCESS | 3443 | RSS: Main: 155508736 11:37:50 INFO - PROCESS | 3443 | 11:40:53 INFO - PROCESS | 3443 | Cycle 1(1): loaded http://localhost:58218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58218/tests/dromaeo/cssquery-yui.html) 11:40:53 INFO - PROCESS | 3443 | RSS: Main: 155164672 11:40:53 INFO - PROCESS | 3443 | 11:43:56 INFO - PROCESS | 3443 | Cycle 1(1): loaded http://localhost:58218/tests/dromaeo/cssquery-yui.html (next: http://localhost:58218/tests/dromaeo/cssquery-dojo.html) 11:43:56 INFO - PROCESS | 3443 | RSS: Main: 159264768 11:43:56 INFO - PROCESS | 3443 | 11:43:56 INFO - PROCESS | 3443 | __start_tp_report 11:43:56 INFO - PROCESS | 3443 | _x_x_mozilla_page_load 11:43:56 INFO - PROCESS | 3443 | _x_x_mozilla_page_load_details 11:43:56 INFO - PROCESS | 3443 | |i|pagename|runs| 11:43:56 INFO - PROCESS | 3443 | |0;dojo.html;3446.931061378774;3447.3794716950947;3488.1454043759277;3493.9650603493956;3506.614272430034;5770.480656740892;5773;5847;5874.1188821676715;5875.471207591316;5833;5890.028145356022;5897.705114744267;5902.675352855591;5920.644761314325;5246.658967167141;5301.257823904656;5334.5732341412595;5357.678539287635;5364.839054828361;5188.584913206934;5208.713520756357;5255.237990491377;5379.300690910176;5380.058489764295;5255.868603284929;5255.947440525603;5282.5245727884485;5283.392409872876;5285.841424757264;5248.0815857225025;5317.494837990384;5325.520703136717;5328.8401347959625;5339.67961922282;5127.435982041972;5196.220566914955;5242.18746094356;5322.4411436799355;5334.03987282289;5589.580781441367;5642.238297829782;5645.125005624135;5670.829875103754;5710.457506536873;6214.223222097238;6236.376362363727;6261.561690681654;6265.592736472115;6269.87460250797;6170.074488826712;6183.536234782365;6291.182146320949;6294.685265736694;6310.716017779165;5862.325832529271;5908.527317814564;5910.320313163998;5930.021546444788;5955.076963070731;6387.137736405526;6415.166028416369;6417.711202995783;6427.807165785034;6452.322506136788;6009.369016253318;6142.907856382158;6180.938190618036;6192.845178870564;6231.2522497300615;6343.5876668016435;6345.936540634534;6347.238331400169;6350.872982540323;6359.713812878432;6269.905951410732;6313.652749098752;6313.96843015782;6318.08387783778;6347.5556711029785;6126.731429653714;6133.212252453595;6159.076138579159;6203.410675985774;6314.116023756677;4737.147313483537;4749.762511874462;4750.667453278237;4751.596114330251;4790.473047964721;4243.27864263076;4246.299360605527;4249;4257.489101307863;4300.935485967713;5893.174955506232;6034.215551978303;6094.2077529920825;6097.542684298606;6143.354947730513;6250.937490625127;6319.715612797435;6329.525285603599;6362.618242905441;6365.49076073913;5905.261842269716;6078.027515597571;6086.726097325631;6101.908471372933;6118.877622447526;5337.946620533745;5374.059539580558;5408.513233808976;5441.6190866639745;5447.210154527571;6518.57629254097;6541.672916354259;6549.050387693757;6551.541392102507;6551.836204094936;6112.625067133501;6235.158253635701;6331.778387756499;6377.553571250153;6396.648184349905;6455.67721613908;6492.577982431127;6576.572522786004;6581.539292249497;6613.140291762233;6236.158118653923;6253.312135664983;6264.310925798068;6272.278687950944;6289.654069026247;6170.969145154246;6269.780557680459;6295.401936815995;6370.936290637034;6375.649339286384;6212.937870621236;6227.034809604518;6248.593841400295;6248.906266406098;6263.96868015657;6189.0406986915295;6190.876182476415;6223.284322302812;6228.003519436868;6238.532110091671;5872.1778950947755;5950.642961422329;5979.073243647242;5997.970010149921;6122.326544080059;6115.357887421935;6117.724702388492;6165.815025549241;6166.753329866934;6176.536759742948;6020.518358531394;6027.367126451835;6039.879202415839;6049.455549000611;6055.939440605537 11:43:56 INFO - PROCESS | 3443 | |1;ext.html;602.9035354343306;655.8163714160033;657.3886285754247;664.365530917973;670.7987603718884;34895.4765678515;38104.80947595265;47365.28952065722;47850.760746196305;48060.51939480604;49880.50119498804;50126;50239.748801256035;50361.49638503623;50430.495695043035;9003.549822508881;9178.357514973955;9218.17036466718;9231.215346695539;9268.304877134207;9102.499362535058;9178.495182764946;9189.851268591427;9190.31072669549;9198.678046268382;9238.399504032217;9263.444193348387;9267.351285410025;9298.302627302946;9310.813783724321;9136.086391360877;9167.908320916773;9215.585298661576;9221.123993220634;9236.399634023766;9041.186293233575;9094.681686141019;9156.359054866161;9174.954125229398;9175.220106290973;45096.3235551467;45585.77207113943;45617.08765824665;45691.543084569064;45691.54308456939;3898.9610103899167;3937.822797974098;3988.3419235826054;4035.3745169498775;4408.845690400821;35038.47442288368;35509.82245088758;35633.82183089068;35712;37213.255734885424;4734.857954261378;4828.855134345975;4834.129856625806;4844.975775121137;4850.102730994778;400334;402611;405632;405743;406893;68721.65639171773;68926.31073689199;69292.65353673199;69336.65331673309;69583;40431.393529097084;40798.59201408007;41072.589274106875;43226.78386608047;72461.63769181121;18160.727589086175;18191.90904045498;18281;18414.263429462673;18417.81582184188;13920.30398480072;13922.09506382082;13928.86071139296;13972.930135349257;14010.789838152436;21410.143594256366;21567.352979410643;21634.89182554077;21647.783522164893;21809;7460.440466964891;7485.588292643957;7606.201348858401;7745.457817952689;7756.495827771177;1031.7781676939494;1084.7071290751453;1089.9128069754402;1137.9076086956613;1260.8017431351818;34042.659573404446;34178.48732269018;34268.79479996387;34771.65228347735;34812.477812832825;1165.5629139072848;1213.2659740856654;1214.2532342609231;1242.1801610936739;1279.4945996331396;17611.207495662726;17714;17844.107794610216;17971.820281797016;17974.3708970188;562000;564786;566998;568509;569549;61235;66886.66556667186;67365.6631716848;67391.32608673851;67622.66188669026;1508.5700575335977;1533.3363300818514;1536.907785532894;1550.9689806203812;1557.18247919843;33945.49081763825;34384.82807585946;34397.656023440446;34479;34603.48094778631;57983.420165797805;58506.707466462394;58817.70591147017;58830.70584647221;58856.4114358868;477102;479225;483006;483481;487604;31691.20771980719;31888.202794930312;32148.678513214567;32188.356232875678;32281.192970175933;51901.7404912973;52075;52622.47377526176;52712.209316861044;53590.732046339515;42988;43977.34033989429;44949;45215.77392113018;45971.77014114908;44431;44589.33116003198;45219.095618086794;45330.093398132514;45451.54548454473;44585.55414445814;44871.32693009542;45008;45382.31926521039;45773.54226457693;38356;39005.219895602495;41191.588084118775;41695.374569380874;42442;30681.8465907669;30952.226194345323;31072.378552428374;31267.687323126476;31312.373752525276 11:43:56 INFO - PROCESS | 3443 | |2;jquery.html;409.1326388057319;417.5052562713187;424.537254392712;431.3637384857335;439.0976543203717;18276.54308642283;19311.613767724637;19933.401997940065;19943.601127977432;20228.797712022875;12569.371531423416;16228.269727862245;19936.10287537061;20593.176272949066;20739.963001849886;5240.135377662681;5468.7539060742165;5469.124940009599;5494.36814766301;5496.917546236809;5377.193420986844;5425.864353391157;5754.942450575482;5964.2842858857;5980.491658209057;5913.024350982083;5918.378570250126;5919.911201331962;5927.466528012478;5927.466528012478;5632.746526406321;5910.143029260733;5915.1718759373725;5922.318933322658;5955.553333500005;5514.6139770216105;5736.741846616912;5742.6841523716175;5793.131030345482;5802.941970580282;22788.316350509347;23789.524209515886;23794.88102559476;24032.399190020216;24770.38074048145;2257.9435514112115;2427.5873101572774;2477.8884950177285;2526.9494610107877;2641.2076377086796;10542.209334299958;10653.946730266376;10959.0684791792;11163.83254251187;14769;1885.811418858117;2084.2080009596257;2097.9895100524554;2134.9786502134934;2176.1295481807247;83186.58406707988;86628;86994.99999999937;87286.56356718176;87783;11477.598284060017;11562.190646654823;11887;12126.514939402501;12161.270323780602;14902.329395177243;16748.24632891523;16878.662426751398;16933.915330423515;16967.660646786993;8331.95834020826;8730.345224108218;8835.823283534293;8919.55402229899;9085.636574537077;8445.577721114043;8452.112528184574;8462.746117616482;8529.82940341202;8649.697260595849;5121.180611102206;5131.230315452712;5159.303494028333;5225.059489291888;5270.262163297141;2027.108072448118;2088.6136064828056;2113.704081428601;2151.806337429639;2157.3420106867243;996.9152622027063;1009.8232809258351;1070.9611676673615;1089.2484185911696;1112.9538234059958;19643.705344419846;19746.308879189448;19870.801291986896;20149;20214.696779548318;1068.6847380022912;1076.8923107689168;1080.508368692243;1086.0931122512632;1115.319655010443;11022.228444008842;11199.384033878052;11210.215284929976;11223.382713950648;11227.887721122685;537115;539906;548181;551064;551953;90897.54551227334;93587.53206234062;95940;97883;98626.50686746664;1071.1163290285544;1119.871214810291;1144.9542018319341;1146.4955419615342;1148.7932172209082;17671;17770.91114544419;17777.73333400026;18053.819461805215;18264.726029109308;39697.206055878145;41325.79337103295;41411;41796.79101604473;42332.36501452542;59152.40847591469;60330;60694.393056068875;60738;60755.69622151861;7884.2115788423;8500.489970601784;8641.783955401166;8770.429922055046;8791.208791208566;12253;13742.244176569984;13998.300084995913;14199.929000354932;14230.288485575473;11873.643790686294;11876.228045177037;11883.465244063866;12313.753724925273;12317.44571494267;11670.649880503599;11781.234219775688;11786.941065294619;11889.346085965355;12089.093318001009;12291;12432.564860229848;12669.366531673564;12822.422990965242;12906;8010.519368837889;8472.49165050099;8496.447730897471;8540.871886921825;8541.359398045295;9042.547872606212;11451.942740286246;11698.70753231176;11810.704732381759;11972.64082077539 11:43:56 INFO - PROCESS | 3443 | |3;mootools.html;1583.825779164292;1614.1687031178942;1833.5599456130524;1924.8075192480744;1930.1217945834646;9562.952185239074;9817.116459518642;10145.746356341077;10173.151517575072;10196.133328667063;10019;10161.745956351095;10184.796304073932;10187.286889917708;10228.693139205818;2472.208893154191;2519.748025197475;2519.8488090714523;2522.117258959368;2523.911663091792;2404.146527982567;2518.0431436054273;2524.2931979045898;2526.166365099522;2531.0129049670645;2420.092465325503;2472.443700167457;2484.5155194737035;2486.7513248675077;2491.5515207262683;2434.659147719312;2444.4744379958306;2454.5949918263555;2473.703155621319;2479.925602231936;2422.81828862836;2423.1761201191503;2432.404061005065;2448.755124487537;2455.815813813971;9945.80108397828;10021.498925053718;10070.345427547187;10076.093151616316;10090.293679442442;5888.823335299948;5918.112283157518;5923.081922302007;5939.287285525721;5942.554308426886;3451.016460308825;3515.138790996197;3529.2059286660296;3579.1052236940764;3611.94582081269;1082.2045796339685;1121.293585041427;1123.1464087293716;1132.9490172942237;1141.2182654881433;13956.651083722887;14120.788188177083;14196.432142714382;14257.572272831832;14261.215633140173;4938.530839570235;4968.850934471971;5064.721440320818;5093.567046800989;5132.897342053138;10952.671419857417;10999.175061870392;11043.668689939315;11072.944635276772;11073;5766.135079738073;5807.767689292466;5852.765889364463;5854.4730974212525;5860.413958604106;4858.684185527929;5349.732513374316;5477.589180811455;5487.067198576252;5509.889802203934;4007.5591684914634;4011.3982902564267;4058.553559108496;4125.216208920296;4139.97930010348;1162.2329262686587;1172.7126853920674;1181.9054475641929;1185.9407029648482;1186.7329850783676;923.7829110159107;962.485070487286;1002.9398236105857;1006.3961623026125;1086.7618080850225;6316.589421687576;6463.127477790532;6509.316521765241;6618.966905165444;6632.403083722488;494.45362874023687;503.7556784959292;505.1992591742056;1094.9616763413242;1114.7380365614074;4533.52397998212;4598.287265473857;4612.215923293048;4612.377329060601;4630.72215667061;11876.10929180315;12043.578474753342;12299.508019679291;12439;12506.624801255977;12450.564230251897;12497.312647804458;12586.496540138292;12604.747905041848;12617.93691031539;9242.121998410275;9371.578278977462;9389.108034736826;9436.103570160823;9441.339106262632;6614.140161778938;6735.427488663322;6774.966125169342;6822.795316140524;6922.169339679271;11318.151138664469;11343.546258149581;11384.715382115513;11554.248973816675;11609.071274297867;11440.771184576095;11451.25566838153;11638.70903227426;11802.881971180179;11868.347240901834;7892.329152022143;8244.670213191404;8375.95812020936;8874.378793484395;8959.01450840394;9502.429854208769;9557.426554406758;9570.473623950471;9608.66369677058;9623.470709111067;8388.370872184489;8544.273736732448;8593.226609605166;8639.395242333228;8767.298616110824;8073.83852322962;8102.108768035393;8169.305609023299;8177.05963814169;8375.120612335617;7591.506552074318;7842.529448233125;7846.568438735924;7853.057633083838;7857.882131767914;5325.068113080118;5850.795222167204;5862.413758624274;5868.853278668067;6078.969605151946;5878.617889837147;5906.940930590639;5940.6435613863305;5957.553183511341;6013.639181649115 11:43:56 INFO - PROCESS | 3443 | |4;prototype.html;353.7506058228948;355.0838835803627;358.7363287983332;358.77576514678327;360.61234173263733;5819.9709001454985;5868.677222752753;5871.471567558919;5902.439268269508;5931.673757943311;5739.799107031255;5792.565557583177;5792.565557583177;5798.420157984199;5800.781835814473;4468.97765511172;4469.620082293009;4505.369248305224;4548.953740639655;4551.704139230956;4505.977470112645;4507.842225522108;4518.683692141535;4530.456345238576;4531.43357080365;4461.442319710036;4488.685791994545;4493.393391892086;4494.820012294035;4499.1901457737595;4311.719738217022;4436.778161091933;4442.556593873357;4447.933281000787;4455;3953.1895961328146;3983.1237127831832;4001.5998400160042;4006.2187873364705;4013.137175507251;5558.722063896789;5574.247476590689;5577.3028371453565;5600.27196464457;5627.030539311249;5151.716655583941;5206.245094461282;5209.7134657593815;5235.293235413209;5243.370795504526;6106.053561697944;6109.908351374733;6147.278761946662;6147.907781383283;6212.689365531705;4272.166927449149;4436.157130145262;4468.039371535103;4490.932636010462;4491.483479399878;6118.418750218722;6292.968535157341;6299.433051025429;6324.841878953017;6460.676966151721;4470;4491.281394976788;4498.730076195438;4500.572445617661;4510.300903359985;4531.116432295737;4556.544345565417;4572.428446444194;4578.748168850745;4595.770211489412;4919.926201106986;5208.583313334924;5222.164453687392;5222.8955420892125;5246.527812496894;6099.8475038123515;6143.385661433821;6163.660998645118;6164.599301045418;6170.50635949123;1546.7293223686036;1551.0383562191514;1575.3383578896892;1576.9921150394175;1578.2030074812146;975.707287813653;995.5271246158017;997.7954519323521;1004.9949750251349;1022.8288609542182;5419.539339156216;5422.566194704415;5424.531838013694;5425.9186112208345;5429.1856221566295;5582.91625625616;5618.859528511738;5663.263775709213;5669.837683274919;5688.544916406678;5073.543381095646;5137.306463627438;5347.491988261109;5408.972955135199;5431.755570999315;2988.790784645054;3008.247938015496;3012.2469382654335;3019.5772591837163;3054.7708921830954;5484.451554844483;5785.768569257182;5794.913076303858;5801.679328268726;5828.79599214034;5589.972050139723;5604.505994832342;5633.63381380209;5676.943230567642;5713.600047996683;5693.316801983706;5742.827715168552;5756.942430575725;5760.798372056958;5773.6824474654295;5208.890399388254;5558.97220513911;5573.359063707726;5592.133219350844;5607.607467477237;5496.657640463989;5529.695866727368;5532.75102620375;5609.186667933045;6112.847178820565;6569.638669873203;6626.469882409492;6629.801105966829;6646.169228846395;6648;4463.330500424962;4464.767616191904;4465.531119232433;4474.098508133965;4499.280115181556;6184.948558744934;6342.936570634234;6349.333320001333;6386.65880165152;6393.584417012879;6162.506999439945;6209.627422354673;6213.720382582705;6247.843803904939;6257.937420625917;5978.491828194652;6167.229096362955;6231.376862313732;6240.375962403723;6254.21822272216;6075.696215189311;6104;6107.328193898757;6110.388961103854;6126.1423400724825;6191.783287584913;6193.009118541192;6207.441330280297;6226.688665566613;6262.718177681924;5836.824895253149;6039.2823229546;6041.909371359346;6042.697865106815;6103.328633850184 11:43:56 INFO - PROCESS | 3443 | |5;yui.html;822.7696245051384;835.0563862834999;853.2534032721369;906.0622255965077;909.4134283387211;15807.689451142527;17011.404600838956;17303.826961730378;17352.305907763704;17382.826171738277;15864.920675396606;15986.200689965484;16051.438199663015;16129.919350403232;16178.433754818583;877.3419935048713;888.7778055486112;902.2150728865896;902.2240872849344;907.1291560102277;868.3357231717741;873.4933738431727;874.3398733955854;874.510274246424;875.4222213339198;914.4604683236889;914.6158613382362;914.9130832570928;916.5829547555846;918.1598837064079;906.2432868554764;906.8549032154824;907.0340087806497;908.4730856103478;910.4309806371018;662.6984721951501;665.1751827733624;665.2017578905333;666.6666666666666;667.4560233409804;16659;16682.58293542659;16723.163841807982;16730.581735456588;16763.078030708308;15761.703475652641;15830.9208453957;15988.4404045859;16119.597010074842;16312.347506099743;9705.369151005232;10281.897181028244;10976.231663783537;11271.887281127249;11641.126915481289;4048.9392659110135;4089.8773036808943;4120.896977575555;4136.623337741068;4215.620594146541;81095.5945220276;81434.59282703607;81468.18531814666;81731.59134204291;82074.58962705148;11917.463714132884;11971.700707482383;12062.457189426497;12269.877301227052;12363.505459781509;21741.130354785946;21837.890810546163;21893.562128757654;22381.32856014322;22401.103955841583;8653.653853845775;8982.820343593092;9331.72004839856;9398.48308343034;9598.232141428669;4830.29960655703;4968.403791544965;4998.775055122455;5060.063888180698;5068.239764035424;3846.1730727893637;3963.603639636071;3975.1254723960683;3976.8011599420493;3979.184267225212;645.8934275844528;646.3794757033301;650.8187639434506;666.0409011024207;676.3202981004059;628.1244720077135;652.7878439507084;661.9144602851328;697.0264830403495;727.7198278662647;9918.950405247928;10145.188384929188;10249.33379330341;10270.33242839213;10357.223208259411;681.3288910423229;715.8783006888841;763.1262204775612;779.3726050529378;798.3613109512366;4617.653675974316;4840.394950631171;4864.464908860023;4887.560119589254;4952.876178095505;85244;111073;113013;117200.41399793117;117627;64849.96846929687;100379.49810250902;101274;102918;103116.48441757743;88291.55854220688;89087.55456222677;89993;90805.54597226971;91379.54310228406;8862.113788621085;9164.495952722664;9189.310801689766;9223.985361610352;9224.40041397307;49534.75232623814;51561.48438515717;51683.48316516787;52628;56152;53809.46190538201;72987.63506182435;74212.62893685713;76781.61609191919;79171.60414197893;12591.622251332476;12878.871211287767;13173.60479185626;13432.126911750705;13981.091229070078;13415.664608384868;13534.729305414034;13661.248631324976;13811.240381778696;13904.860951390761;12135.332556709112;12497.37513124322;12692.746145076862;12748.362581871055;13727.245001525012;12874.935625321814;13310.33448327599;13366.131201471873;13382.531611393555;13459.394327255493;12654.240745555297;12833.679158021125;12963.805542917053;12975.416106275052;12978.610641680765;10127.59489620407;10170.288079834636;10348.534315955649;10384.792304154025;10716.946415267874;11279.718007049889;11445.942770286096;11495.252808567417;11571.363575003455;11706.88293117058 11:43:56 INFO - PROCESS | 3443 | __end_tp_report 11:43:56 INFO - PROCESS | 3443 | __start_cc_report 11:43:56 INFO - PROCESS | 3443 | _x_x_mozilla_cycle_collect,331 11:43:56 INFO - PROCESS | 3443 | __end_cc_report 11:43:56 INFO - PROCESS | 3443 | __startTimestamp1470077036293__endTimestamp 11:43:56 INFO - PROCESS | 3443 | 11:43:56 INFO - PROCESS | 3443 | ------- Summary: start ------- 11:43:56 INFO - PROCESS | 3443 | Number of tests: 6 11:43:56 INFO - PROCESS | 3443 | 11:43:56 INFO - PROCESS | 3443 | [#0] dojo.html Cycles:165 Average:5834.16 Median:6101.91 stddev:672.87 (11.0%) stddev-sans-first:648.35 11:43:56 INFO - PROCESS | 3443 | Values: 3446.9 3447.4 3488.1 3494.0 3506.6 5770.5 5773.0 5847.0 5874.1 5875.5 5833.0 5890.0 5897.7 5902.7 5920.6 5246.7 5301.3 5334.6 5357.7 5364.8 5188.6 5208.7 5255.2 5379.3 5380.1 5255.9 5255.9 5282.5 5283.4 5285.8 5248.1 5317.5 5325.5 5328.8 5339.7 5127.4 5196.2 5242.2 5322.4 5334.0 5589.6 5642.2 5645.1 5670.8 5710.5 6214.2 6236.4 6261.6 6265.6 6269.9 6170.1 6183.5 6291.2 6294.7 6310.7 5862.3 5908.5 5910.3 5930.0 5955.1 6387.1 6415.2 6417.7 6427.8 6452.3 6009.4 6142.9 6180.9 6192.8 6231.3 6343.6 6345.9 6347.2 6350.9 6359.7 6269.9 6313.7 6314.0 6318.1 6347.6 6126.7 6133.2 6159.1 6203.4 6314.1 4737.1 4749.8 4750.7 4751.6 4790.5 4243.3 4246.3 4249.0 4257.5 4300.9 5893.2 6034.2 6094.2 6097.5 6143.4 6250.9 6319.7 6329.5 6362.6 6365.5 5905.3 6078.0 6086.7 6101.9 6118.9 5337.9 5374.1 5408.5 5441.6 5447.2 6518.6 6541.7 6549.1 6551.5 6551.8 6112.6 6235.2 6331.8 6377.6 6396.6 6455.7 6492.6 6576.6 6581.5 6613.1 6236.2 6253.3 6264.3 6272.3 6289.7 6171.0 6269.8 6295.4 6370.9 6375.6 6212.9 6227.0 6248.6 6248.9 6264.0 6189.0 6190.9 6223.3 6228.0 6238.5 5872.2 5950.6 5979.1 5998.0 6122.3 6115.4 6117.7 6165.8 6166.8 6176.5 6020.5 6027.4 6039.9 6049.5 6055.9 11:43:56 INFO - PROCESS | 3443 | 11:43:56 INFO - PROCESS | 3443 | [#1] ext.html Cycles:180 Average:65760.37 Median:45217.43 stddev:129502.02 (286.4%) stddev-sans-first:129772.91 11:43:56 INFO - PROCESS | 3443 | Values: 602.9 655.8 657.4 664.4 670.8 34895.5 38104.8 47365.3 47850.8 48060.5 49880.5 50126.0 50239.7 50361.5 50430.5 9003.5 9178.4 9218.2 9231.2 9268.3 9102.5 9178.5 9189.9 9190.3 9198.7 9238.4 9263.4 9267.4 9298.3 9310.8 9136.1 9167.9 9215.6 9221.1 9236.4 9041.2 9094.7 9156.4 9175.0 9175.2 45096.3 45585.8 45617.1 45691.5 45691.5 3899.0 3937.8 3988.3 4035.4 4408.8 35038.5 35509.8 35633.8 35712.0 37213.3 4734.9 4828.9 4834.1 4845.0 4850.1 400334.0 402611.0 405632.0 405743.0 406893.0 68721.7 68926.3 69292.7 69336.7 69583.0 40431.4 40798.6 41072.6 43226.8 72461.6 18160.7 18191.9 18281.0 18414.3 18417.8 13920.3 13922.1 13928.9 13972.9 14010.8 21410.1 21567.4 21634.9 21647.8 21809.0 7460.4 7485.6 7606.2 7745.5 7756.5 1031.8 1084.7 1089.9 1137.9 1260.8 34042.7 34178.5 34268.8 34771.7 34812.5 1165.6 1213.3 1214.3 1242.2 1279.5 17611.2 17714.0 17844.1 17971.8 17974.4 562000.0 564786.0 566998.0 568509.0 569549.0 61235.0 66886.7 67365.7 67391.3 67622.7 1508.6 1533.3 1536.9 1551.0 1557.2 33945.5 34384.8 34397.7 34479.0 34603.5 57983.4 58506.7 58817.7 58830.7 58856.4 477102.0 479225.0 483006.0 483481.0 487604.0 31691.2 31888.2 32148.7 32188.4 32281.2 51901.7 52075.0 52622.5 52712.2 53590.7 42988.0 43977.3 44949.0 45215.8 45971.8 44431.0 44589.3 45219.1 45330.1 45451.5 44585.6 44871.3 45008.0 45382.3 45773.5 38356.0 39005.2 41191.6 41695.4 42442.0 30681.8 30952.2 31072.4 31267.7 31312.4 11:43:56 INFO - PROCESS | 3443 | 11:43:56 INFO - PROCESS | 3443 | [#2] jquery.html Cycles:180 Average:31088.33 Median:23792.20 stddev:89821.17 (377.5%) stddev-sans-first:90043.60 11:43:56 INFO - PROCESS | 3443 | Values: 409.1 417.5 424.5 431.4 439.1 18276.5 19311.6 19933.4 19943.6 20228.8 12569.4 16228.3 19936.1 20593.2 20740.0 5240.1 5468.8 5469.1 5494.4 5496.9 5377.2 5425.9 5754.9 5964.3 5980.5 5913.0 5918.4 5919.9 5927.5 5927.5 5632.7 5910.1 5915.2 5922.3 5955.6 5514.6 5736.7 5742.7 5793.1 5802.9 22788.3 23789.5 23794.9 24032.4 24770.4 2257.9 2427.6 2477.9 2526.9 2641.2 10542.2 10653.9 10959.1 11163.8 14769.0 1885.8 2084.2 2098.0 2135.0 2176.1 83186.6 86628.0 86995.0 87286.6 87783.0 11477.6 11562.2 11887.0 12126.5 12161.3 14902.3 16748.2 16878.7 16933.9 16967.7 8332.0 8730.3 8835.8 8919.6 9085.6 8445.6 8452.1 8462.7 8529.8 8649.7 5121.2 5131.2 5159.3 5225.1 5270.3 2027.1 2088.6 2113.7 2151.8 2157.3 996.9 1009.8 1071.0 1089.2 1113.0 19643.7 19746.3 19870.8 20149.0 20214.7 1068.7 1076.9 1080.5 1086.1 1115.3 11022.2 11199.4 11210.2 11223.4 11227.9 537115.0 539906.0 548181.0 551064.0 551953.0 90897.5 93587.5 95940.0 97883.0 98626.5 1071.1 1119.9 1145.0 1146.5 1148.8 17671.0 17770.9 17777.7 18053.8 18264.7 39697.2 41325.8 41411.0 41796.8 42332.4 59152.4 60330.0 60694.4 60738.0 60755.7 7884.2 8500.5 8641.8 8770.4 8791.2 12253.0 13742.2 13998.3 14199.9 14230.3 11873.6 11876.2 11883.5 12313.8 12317.4 11670.6 11781.2 11786.9 11889.3 12089.1 12291.0 12432.6 12669.4 12822.4 12906.0 8010.5 8472.5 8496.4 8540.9 8541.4 9042.5 11451.9 11698.7 11810.7 11972.6 11:43:56 INFO - PROCESS | 3443 | 11:43:56 INFO - PROCESS | 3443 | [#3] mootools.html Cycles:180 Average:6465.35 Median:3595.53 stddev:3796.65 (105.6%) stddev-sans-first:3789.58 11:43:56 INFO - PROCESS | 3443 | Values: 1583.8 1614.2 1833.6 1924.8 1930.1 9563.0 9817.1 10145.7 10173.2 10196.1 10019.0 10161.7 10184.8 10187.3 10228.7 2472.2 2519.7 2519.8 2522.1 2523.9 2404.1 2518.0 2524.3 2526.2 2531.0 2420.1 2472.4 2484.5 2486.8 2491.6 2434.7 2444.5 2454.6 2473.7 2479.9 2422.8 2423.2 2432.4 2448.8 2455.8 9945.8 10021.5 10070.3 10076.1 10090.3 5888.8 5918.1 5923.1 5939.3 5942.6 3451.0 3515.1 3529.2 3579.1 3611.9 1082.2 1121.3 1123.1 1132.9 1141.2 13956.7 14120.8 14196.4 14257.6 14261.2 4938.5 4968.9 5064.7 5093.6 5132.9 10952.7 10999.2 11043.7 11072.9 11073.0 5766.1 5807.8 5852.8 5854.5 5860.4 4858.7 5349.7 5477.6 5487.1 5509.9 4007.6 4011.4 4058.6 4125.2 4140.0 1162.2 1172.7 1181.9 1185.9 1186.7 923.8 962.5 1002.9 1006.4 1086.8 6316.6 6463.1 6509.3 6619.0 6632.4 494.5 503.8 505.2 1095.0 1114.7 4533.5 4598.3 4612.2 4612.4 4630.7 11876.1 12043.6 12299.5 12439.0 12506.6 12450.6 12497.3 12586.5 12604.7 12617.9 9242.1 9371.6 9389.1 9436.1 9441.3 6614.1 6735.4 6775.0 6822.8 6922.2 11318.2 11343.5 11384.7 11554.2 11609.1 11440.8 11451.3 11638.7 11802.9 11868.3 7892.3 8244.7 8376.0 8874.4 8959.0 9502.4 9557.4 9570.5 9608.7 9623.5 8388.4 8544.3 8593.2 8639.4 8767.3 8073.8 8102.1 8169.3 8177.1 8375.1 7591.5 7842.5 7846.6 7853.1 7857.9 5325.1 5850.8 5862.4 5868.9 6079.0 5878.6 5906.9 5940.6 5957.6 6013.6 11:43:56 INFO - PROCESS | 3443 | 11:43:56 INFO - PROCESS | 3443 | [#4] prototype.html Cycles:180 Average:5010.32 Median:5575.78 stddev:1462.85 (26.2%) stddev-sans-first:1424.59 11:43:56 INFO - PROCESS | 3443 | Values: 353.8 355.1 358.7 358.8 360.6 5820.0 5868.7 5871.5 5902.4 5931.7 5739.8 5792.6 5792.6 5798.4 5800.8 4469.0 4469.6 4505.4 4549.0 4551.7 4506.0 4507.8 4518.7 4530.5 4531.4 4461.4 4488.7 4493.4 4494.8 4499.2 4311.7 4436.8 4442.6 4447.9 4455.0 3953.2 3983.1 4001.6 4006.2 4013.1 5558.7 5574.2 5577.3 5600.3 5627.0 5151.7 5206.2 5209.7 5235.3 5243.4 6106.1 6109.9 6147.3 6147.9 6212.7 4272.2 4436.2 4468.0 4490.9 4491.5 6118.4 6293.0 6299.4 6324.8 6460.7 4470.0 4491.3 4498.7 4500.6 4510.3 4531.1 4556.5 4572.4 4578.7 4595.8 4919.9 5208.6 5222.2 5222.9 5246.5 6099.8 6143.4 6163.7 6164.6 6170.5 1546.7 1551.0 1575.3 1577.0 1578.2 975.7 995.5 997.8 1005.0 1022.8 5419.5 5422.6 5424.5 5425.9 5429.2 5582.9 5618.9 5663.3 5669.8 5688.5 5073.5 5137.3 5347.5 5409.0 5431.8 2988.8 3008.2 3012.2 3019.6 3054.8 5484.5 5785.8 5794.9 5801.7 5828.8 5590.0 5604.5 5633.6 5676.9 5713.6 5693.3 5742.8 5756.9 5760.8 5773.7 5208.9 5559.0 5573.4 5592.1 5607.6 5496.7 5529.7 5532.8 5609.2 6112.8 6569.6 6626.5 6629.8 6646.2 6648.0 4463.3 4464.8 4465.5 4474.1 4499.3 6184.9 6342.9 6349.3 6386.7 6393.6 6162.5 6209.6 6213.7 6247.8 6257.9 5978.5 6167.2 6231.4 6240.4 6254.2 6075.7 6104.0 6107.3 6110.4 6126.1 6191.8 6193.0 6207.4 6226.7 6262.7 5836.8 6039.3 6041.9 6042.7 6103.3 11:43:56 INFO - PROCESS | 3443 | 11:43:56 INFO - PROCESS | 3443 | [#5] yui.html Cycles:180 Average:20845.49 Median:4416.64 stddev:29640.49 (671.1%) stddev-sans-first:29685.51 11:43:56 INFO - PROCESS | 3443 | Values: 822.8 835.1 853.3 906.1 909.4 15807.7 17011.4 17303.8 17352.3 17382.8 15864.9 15986.2 16051.4 16129.9 16178.4 877.3 888.8 902.2 902.2 907.1 868.3 873.5 874.3 874.5 875.4 914.5 914.6 914.9 916.6 918.2 906.2 906.9 907.0 908.5 910.4 662.7 665.2 665.2 666.7 667.5 16659.0 16682.6 16723.2 16730.6 16763.1 15761.7 15830.9 15988.4 16119.6 16312.3 9705.4 10281.9 10976.2 11271.9 11641.1 4048.9 4089.9 4120.9 4136.6 4215.6 81095.6 81434.6 81468.2 81731.6 82074.6 11917.5 11971.7 12062.5 12269.9 12363.5 21741.1 21837.9 21893.6 22381.3 22401.1 8653.7 8982.8 9331.7 9398.5 9598.2 4830.3 4968.4 4998.8 5060.1 5068.2 3846.2 3963.6 3975.1 3976.8 3979.2 645.9 646.4 650.8 666.0 676.3 628.1 652.8 661.9 697.0 727.7 9919.0 10145.2 10249.3 10270.3 10357.2 681.3 715.9 763.1 779.4 798.4 4617.7 4840.4 4864.5 4887.6 4952.9 85244.0 111073.0 113013.0 117200.4 117627.0 64850.0 100379.5 101274.0 102918.0 103116.5 88291.6 89087.6 89993.0 90805.5 91379.5 8862.1 9164.5 9189.3 9224.0 9224.4 49534.8 51561.5 51683.5 52628.0 56152.0 53809.5 72987.6 74212.6 76781.6 79171.6 12591.6 12878.9 13173.6 13432.1 13981.1 13415.7 13534.7 13661.2 13811.2 13904.9 12135.3 12497.4 12692.7 12748.4 13727.2 12874.9 13310.3 13366.1 13382.5 13459.4 12654.2 12833.7 12963.8 12975.4 12978.6 10127.6 10170.3 10348.5 10384.8 10716.9 11279.7 11445.9 11495.3 11571.4 11706.9 11:43:56 INFO - PROCESS | 3443 | -------- Summary: end -------- 11:43:56 INFO - PROCESS | 3443 | 11:43:56 INFO - TEST-INFO | 3443: exit 0 11:43:56 INFO - TEST-OK | dromaeo_css | took 1111062ms 11:43:56 INFO - TEST-START | kraken 11:43:56 INFO - operating with platform_type : linux_ 11:43:56 INFO - Initialising browser for kraken test... 11:43:57 INFO - TEST-INFO | started process 3685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu4YPPF/profile http://localhost:58218/getInfo.html) 11:44:01 INFO - PROCESS | 3685 | __metrics Screen width/height:1600/1200 11:44:01 INFO - PROCESS | 3685 | colorDepth:24 11:44:01 INFO - PROCESS | 3685 | Browser inner width/height: 1024/697 11:44:01 INFO - PROCESS | 3685 | __metrics 11:44:01 ERROR - PROCESS | 3685 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 11:44:02 INFO - TEST-INFO | 3685: exit 0 11:44:02 INFO - Browser initialized. 11:44:02 INFO - Running cycle 1/1 for kraken test... 11:44:02 INFO - TEST-INFO | started process 3816 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu4YPPF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:14 INFO - PROCESS | 3816 | RSS: Main: 152543232 11:44:14 INFO - PROCESS | 3816 | 11:44:16 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58218/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:17 INFO - PROCESS | 3816 | RSS: Main: 158117888 11:44:17 INFO - PROCESS | 3816 | 11:44:20 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58218/tests/kraken/driver.html?testName=audio-dft) 11:44:21 INFO - PROCESS | 3816 | RSS: Main: 156913664 11:44:21 INFO - PROCESS | 3816 | 11:44:23 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58218/tests/kraken/driver.html?testName=audio-fft) 11:44:24 INFO - PROCESS | 3816 | RSS: Main: 157605888 11:44:24 INFO - PROCESS | 3816 | 11:44:26 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58218/tests/kraken/driver.html?testName=audio-oscillator) 11:44:27 INFO - PROCESS | 3816 | RSS: Main: 157859840 11:44:27 INFO - PROCESS | 3816 | 11:44:29 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:30 INFO - PROCESS | 3816 | RSS: Main: 157659136 11:44:30 INFO - PROCESS | 3816 | 11:44:33 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58218/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:33 INFO - PROCESS | 3816 | RSS: Main: 156794880 11:44:33 INFO - PROCESS | 3816 | 11:44:37 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58218/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:37 INFO - PROCESS | 3816 | RSS: Main: 157241344 11:44:37 INFO - PROCESS | 3816 | 11:44:40 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58218/tests/kraken/driver.html?testName=json-parse-financial) 11:44:41 INFO - PROCESS | 3816 | RSS: Main: 157847552 11:44:41 INFO - PROCESS | 3816 | 11:44:42 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:43 INFO - PROCESS | 3816 | RSS: Main: 157782016 11:44:43 INFO - PROCESS | 3816 | 11:44:45 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:45 INFO - PROCESS | 3816 | RSS: Main: 157581312 11:44:45 INFO - PROCESS | 3816 | 11:44:48 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:48 INFO - PROCESS | 3816 | RSS: Main: 158445568 11:44:48 INFO - PROCESS | 3816 | 11:44:51 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:52 INFO - PROCESS | 3816 | RSS: Main: 158167040 11:44:52 INFO - PROCESS | 3816 | 11:44:54 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:55 INFO - PROCESS | 3816 | RSS: Main: 158085120 11:44:55 INFO - PROCESS | 3816 | 11:44:56 INFO - PROCESS | 3816 | Cycle 1(1): loaded http://localhost:58218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58218/tests/kraken/driver.html?testName=ai-astar) 11:44:57 INFO - PROCESS | 3816 | RSS: Main: 158896128 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | __start_tp_report 11:44:57 INFO - PROCESS | 3816 | _x_x_mozilla_page_load 11:44:57 INFO - PROCESS | 3816 | _x_x_mozilla_page_load_details 11:44:57 INFO - PROCESS | 3816 | |i|pagename|runs| 11:44:57 INFO - PROCESS | 3816 | |0;ai-astar;111;105;110;110;110;112;110;109;109;109 11:44:57 INFO - PROCESS | 3816 | |1;audio-beat-detection;160;130;155;168;126;148;161;126;173;133 11:44:57 INFO - PROCESS | 3816 | |2;audio-dft;162;161;162;162;163;162;163;161;164;161 11:44:57 INFO - PROCESS | 3816 | |3;audio-fft;76;75;77;168;77;75;74;75;179;74 11:44:57 INFO - PROCESS | 3816 | |4;audio-oscillator;84;84;163;83;85;85;139;84;84;148 11:44:57 INFO - PROCESS | 3816 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;117 11:44:57 INFO - PROCESS | 3816 | |6;imaging-darkroom;147;146;147;147;147;149;149;147;147;146 11:44:57 INFO - PROCESS | 3816 | |7;imaging-desaturate;95;96;98;95;95;95;95;95;95;95 11:44:57 INFO - PROCESS | 3816 | |8;json-parse-financial;54;54;52;52;56;54;58;53;53;52 11:44:57 INFO - PROCESS | 3816 | |9;json-stringify-tinderbox;59;60;60;60;60;59;59;60;59;59 11:44:57 INFO - PROCESS | 3816 | |10;stanford-crypto-aes;76;77;77;77;78;84;79;78;110;82 11:44:57 INFO - PROCESS | 3816 | |11;stanford-crypto-ccm;122;127;126;117;132;119;124;120;134;130 11:44:57 INFO - PROCESS | 3816 | |12;stanford-crypto-pbkdf2;158;160;159;152;159;152;153;155;154;152 11:44:57 INFO - PROCESS | 3816 | |13;stanford-crypto-sha256-iterative;62;62;64;62;62;62;62;62;63;61 11:44:57 INFO - PROCESS | 3816 | __end_tp_report 11:44:57 INFO - PROCESS | 3816 | __start_cc_report 11:44:57 INFO - PROCESS | 3816 | _x_x_mozilla_cycle_collect,855 11:44:57 INFO - PROCESS | 3816 | __end_cc_report 11:44:57 INFO - PROCESS | 3816 | __startTimestamp1470077097145__endTimestamp 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | ------- Summary: start ------- 11:44:57 INFO - PROCESS | 3816 | Number of tests: 14 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.84 (1.7%) stddev-sans-first:1.87 11:44:57 INFO - PROCESS | 3816 | Values: 111.0 105.0 110.0 110.0 110.0 112.0 110.0 109.0 109.0 109.0 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:157.50 stddev:17.96 (11.4%) stddev-sans-first:18.52 11:44:57 INFO - PROCESS | 3816 | Values: 160.0 130.0 155.0 168.0 126.0 148.0 161.0 126.0 173.0 133.0 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 11:44:57 INFO - PROCESS | 3816 | Values: 162.0 161.0 162.0 162.0 163.0 162.0 163.0 161.0 164.0 161.0 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.00 stddev:41.47 (55.3%) stddev-sans-first:43.41 11:44:57 INFO - PROCESS | 3816 | Values: 76.0 75.0 77.0 168.0 77.0 75.0 74.0 75.0 179.0 74.0 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:84.00 stddev:32.33 (38.5%) stddev-sans-first:33.48 11:44:57 INFO - PROCESS | 3816 | Values: 84.0 84.0 163.0 83.0 85.0 85.0 139.0 84.0 84.0 148.0 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 11:44:57 INFO - PROCESS | 3816 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 11:44:57 INFO - PROCESS | 3816 | Values: 147.0 146.0 147.0 147.0 147.0 149.0 149.0 147.0 147.0 146.0 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 11:44:57 INFO - PROCESS | 3816 | Values: 95.0 96.0 98.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.93 (3.6%) stddev-sans-first:2.05 11:44:57 INFO - PROCESS | 3816 | Values: 54.0 54.0 52.0 52.0 56.0 54.0 58.0 53.0 53.0 52.0 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 11:44:57 INFO - PROCESS | 3816 | Values: 59.0 60.0 60.0 60.0 60.0 59.0 59.0 60.0 59.0 59.0 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:78.00 stddev:10.22 (13.1%) stddev-sans-first:10.62 11:44:57 INFO - PROCESS | 3816 | Values: 76.0 77.0 77.0 77.0 78.0 84.0 79.0 78.0 110.0 82.0 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:126.50 stddev:5.72 (4.5%) stddev-sans-first:5.96 11:44:57 INFO - PROCESS | 3816 | Values: 122.0 127.0 126.0 117.0 132.0 119.0 124.0 120.0 134.0 130.0 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:156.50 stddev:3.27 (2.1%) stddev-sans-first:3.33 11:44:57 INFO - PROCESS | 3816 | Values: 158.0 160.0 159.0 152.0 159.0 152.0 153.0 155.0 154.0 152.0 11:44:57 INFO - PROCESS | 3816 | 11:44:57 INFO - PROCESS | 3816 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 11:44:57 INFO - PROCESS | 3816 | Values: 62.0 62.0 64.0 62.0 62.0 62.0 62.0 62.0 63.0 61.0 11:44:57 INFO - PROCESS | 3816 | -------- Summary: end -------- 11:44:57 INFO - PROCESS | 3816 | 11:44:58 INFO - TEST-INFO | 3816: exit 0 11:44:58 INFO - TEST-OK | kraken | took 61074ms 11:44:58 INFO - SUITE-END | took 1172s 11:44:58 INFO - Completed test suite (00:19:32) 11:44:58 INFO - javascript benchmark 11:44:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7746.57981604658, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3446.931061378774, 3447.3794716950947, 3488.1454043759277, 3493.9650603493956, 3506.614272430034, 5770.480656740892, 5773.0, 5847.0, 5874.1188821676715, 5875.471207591316, 5833.0, 5890.028145356022, 5897.705114744267, 5902.675352855591, 5920.644761314325, 5246.658967167141, 5301.257823904656, 5334.5732341412595, 5357.678539287635, 5364.839054828361, 5188.584913206934, 5208.713520756357, 5255.237990491377, 5379.300690910176, 5380.058489764295, 5255.868603284929, 5255.947440525603, 5282.5245727884485, 5283.392409872876, 5285.841424757264, 5248.0815857225025, 5317.494837990384, 5325.520703136717, 5328.8401347959625, 5339.67961922282, 5127.435982041972, 5196.220566914955, 5242.18746094356, 5322.4411436799355, 5334.03987282289, 5589.580781441367, 5642.238297829782, 5645.125005624135, 5670.829875103754, 5710.457506536873, 6214.223222097238, 6236.376362363727, 6261.561690681654, 6265.592736472115, 6269.87460250797, 6170.074488826712, 6183.536234782365, 6291.182146320949, 6294.685265736694, 6310.716017779165, 5862.325832529271, 5908.527317814564, 5910.320313163998, 5930.021546444788, 5955.076963070731, 6387.137736405526, 6415.166028416369, 6417.711202995783, 6427.807165785034, 6452.322506136788, 6009.369016253318, 6142.907856382158, 6180.938190618036, 6192.845178870564, 6231.2522497300615, 6343.5876668016435, 6345.936540634534, 6347.238331400169, 6350.872982540323, 6359.713812878432, 6269.905951410732, 6313.652749098752, 6313.96843015782, 6318.08387783778, 6347.5556711029785, 6126.731429653714, 6133.212252453595, 6159.076138579159, 6203.410675985774, 6314.116023756677, 4737.147313483537, 4749.762511874462, 4750.667453278237, 4751.596114330251, 4790.473047964721, 4243.27864263076, 4246.299360605527, 4249.0, 4257.489101307863, 4300.935485967713, 5893.174955506232, 6034.215551978303, 6094.2077529920825, 6097.542684298606, 6143.354947730513, 6250.937490625127, 6319.715612797435, 6329.525285603599, 6362.618242905441, 6365.49076073913, 5905.261842269716, 6078.027515597571, 6086.726097325631, 6101.908471372933, 6118.877622447526, 5337.946620533745, 5374.059539580558, 5408.513233808976, 5441.6190866639745, 5447.210154527571, 6518.57629254097, 6541.672916354259, 6549.050387693757, 6551.541392102507, 6551.836204094936, 6112.625067133501, 6235.158253635701, 6331.778387756499, 6377.553571250153, 6396.648184349905, 6455.67721613908, 6492.577982431127, 6576.572522786004, 6581.539292249497, 6613.140291762233, 6236.158118653923, 6253.312135664983, 6264.310925798068, 6272.278687950944, 6289.654069026247, 6170.969145154246, 6269.780557680459, 6295.401936815995, 6370.936290637034, 6375.649339286384, 6212.937870621236, 6227.034809604518, 6248.593841400295, 6248.906266406098, 6263.96868015657, 6189.0406986915295, 6190.876182476415, 6223.284322302812, 6228.003519436868, 6238.532110091671, 5872.1778950947755, 5950.642961422329, 5979.073243647242, 5997.970010149921, 6122.326544080059, 6115.357887421935, 6117.724702388492, 6165.815025549241, 6166.753329866934, 6176.536759742948, 6020.518358531394, 6027.367126451835, 6039.879202415839, 6049.455549000611, 6055.939440605537], "value": 5788.719388182655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.9035354343306, 655.8163714160033, 657.3886285754247, 664.365530917973, 670.7987603718884, 34895.4765678515, 38104.80947595265, 47365.28952065722, 47850.760746196305, 48060.51939480604, 49880.50119498804, 50126.0, 50239.748801256035, 50361.49638503623, 50430.495695043035, 9003.549822508881, 9178.357514973955, 9218.17036466718, 9231.215346695539, 9268.304877134207, 9102.499362535058, 9178.495182764946, 9189.851268591427, 9190.31072669549, 9198.678046268382, 9238.399504032217, 9263.444193348387, 9267.351285410025, 9298.302627302946, 9310.813783724321, 9136.086391360877, 9167.908320916773, 9215.585298661576, 9221.123993220634, 9236.399634023766, 9041.186293233575, 9094.681686141019, 9156.359054866161, 9174.954125229398, 9175.220106290973, 45096.3235551467, 45585.77207113943, 45617.08765824665, 45691.543084569064, 45691.54308456939, 3898.9610103899167, 3937.822797974098, 3988.3419235826054, 4035.3745169498775, 4408.845690400821, 35038.47442288368, 35509.82245088758, 35633.82183089068, 35712.0, 37213.255734885424, 4734.857954261378, 4828.855134345975, 4834.129856625806, 4844.975775121137, 4850.102730994778, 400334.0, 402611.0, 405632.0, 405743.0, 406893.0, 68721.65639171773, 68926.31073689199, 69292.65353673199, 69336.65331673309, 69583.0, 40431.393529097084, 40798.59201408007, 41072.589274106875, 43226.78386608047, 72461.63769181121, 18160.727589086175, 18191.90904045498, 18281.0, 18414.263429462673, 18417.81582184188, 13920.30398480072, 13922.09506382082, 13928.86071139296, 13972.930135349257, 14010.789838152436, 21410.143594256366, 21567.352979410643, 21634.89182554077, 21647.783522164893, 21809.0, 7460.440466964891, 7485.588292643957, 7606.201348858401, 7745.457817952689, 7756.495827771177, 1031.7781676939494, 1084.7071290751453, 1089.9128069754402, 1137.9076086956613, 1260.8017431351818, 34042.659573404446, 34178.48732269018, 34268.79479996387, 34771.65228347735, 34812.477812832825, 1165.5629139072848, 1213.2659740856654, 1214.2532342609231, 1242.1801610936739, 1279.4945996331396, 17611.207495662726, 17714.0, 17844.107794610216, 17971.820281797016, 17974.3708970188, 562000.0, 564786.0, 566998.0, 568509.0, 569549.0, 61235.0, 66886.66556667186, 67365.6631716848, 67391.32608673851, 67622.66188669026, 1508.5700575335977, 1533.3363300818514, 1536.907785532894, 1550.9689806203812, 1557.18247919843, 33945.49081763825, 34384.82807585946, 34397.656023440446, 34479.0, 34603.48094778631, 57983.420165797805, 58506.707466462394, 58817.70591147017, 58830.70584647221, 58856.4114358868, 477102.0, 479225.0, 483006.0, 483481.0, 487604.0, 31691.20771980719, 31888.202794930312, 32148.678513214567, 32188.356232875678, 32281.192970175933, 51901.7404912973, 52075.0, 52622.47377526176, 52712.209316861044, 53590.732046339515, 42988.0, 43977.34033989429, 44949.0, 45215.77392113018, 45971.77014114908, 44431.0, 44589.33116003198, 45219.095618086794, 45330.093398132514, 45451.54548454473, 44585.55414445814, 44871.32693009542, 45008.0, 45382.31926521039, 45773.54226457693, 38356.0, 39005.219895602495, 41191.588084118775, 41695.374569380874, 42442.0, 30681.8465907669, 30952.226194345323, 31072.378552428374, 31267.687323126476, 31312.373752525276], "value": 21786.046411708438, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.1326388057319, 417.5052562713187, 424.537254392712, 431.3637384857335, 439.0976543203717, 18276.54308642283, 19311.613767724637, 19933.401997940065, 19943.601127977432, 20228.797712022875, 12569.371531423416, 16228.269727862245, 19936.10287537061, 20593.176272949066, 20739.963001849886, 5240.135377662681, 5468.7539060742165, 5469.124940009599, 5494.36814766301, 5496.917546236809, 5377.193420986844, 5425.864353391157, 5754.942450575482, 5964.2842858857, 5980.491658209057, 5913.024350982083, 5918.378570250126, 5919.911201331962, 5927.466528012478, 5927.466528012478, 5632.746526406321, 5910.143029260733, 5915.1718759373725, 5922.318933322658, 5955.553333500005, 5514.6139770216105, 5736.741846616912, 5742.6841523716175, 5793.131030345482, 5802.941970580282, 22788.316350509347, 23789.524209515886, 23794.88102559476, 24032.399190020216, 24770.38074048145, 2257.9435514112115, 2427.5873101572774, 2477.8884950177285, 2526.9494610107877, 2641.2076377086796, 10542.209334299958, 10653.946730266376, 10959.0684791792, 11163.83254251187, 14769.0, 1885.811418858117, 2084.2080009596257, 2097.9895100524554, 2134.9786502134934, 2176.1295481807247, 83186.58406707988, 86628.0, 86994.99999999937, 87286.56356718176, 87783.0, 11477.598284060017, 11562.190646654823, 11887.0, 12126.514939402501, 12161.270323780602, 14902.329395177243, 16748.24632891523, 16878.662426751398, 16933.915330423515, 16967.660646786993, 8331.95834020826, 8730.345224108218, 8835.823283534293, 8919.55402229899, 9085.636574537077, 8445.577721114043, 8452.112528184574, 8462.746117616482, 8529.82940341202, 8649.697260595849, 5121.180611102206, 5131.230315452712, 5159.303494028333, 5225.059489291888, 5270.262163297141, 2027.108072448118, 2088.6136064828056, 2113.704081428601, 2151.806337429639, 2157.3420106867243, 996.9152622027063, 1009.8232809258351, 1070.9611676673615, 1089.2484185911696, 1112.9538234059958, 19643.705344419846, 19746.308879189448, 19870.801291986896, 20149.0, 20214.696779548318, 1068.6847380022912, 1076.8923107689168, 1080.508368692243, 1086.0931122512632, 1115.319655010443, 11022.228444008842, 11199.384033878052, 11210.215284929976, 11223.382713950648, 11227.887721122685, 537115.0, 539906.0, 548181.0, 551064.0, 551953.0, 90897.54551227334, 93587.53206234062, 95940.0, 97883.0, 98626.50686746664, 1071.1163290285544, 1119.871214810291, 1144.9542018319341, 1146.4955419615342, 1148.7932172209082, 17671.0, 17770.91114544419, 17777.73333400026, 18053.819461805215, 18264.726029109308, 39697.206055878145, 41325.79337103295, 41411.0, 41796.79101604473, 42332.36501452542, 59152.40847591469, 60330.0, 60694.393056068875, 60738.0, 60755.69622151861, 7884.2115788423, 8500.489970601784, 8641.783955401166, 8770.429922055046, 8791.208791208566, 12253.0, 13742.244176569984, 13998.300084995913, 14199.929000354932, 14230.288485575473, 11873.643790686294, 11876.228045177037, 11883.465244063866, 12313.753724925273, 12317.44571494267, 11670.649880503599, 11781.234219775688, 11786.941065294619, 11889.346085965355, 12089.093318001009, 12291.0, 12432.564860229848, 12669.366531673564, 12822.422990965242, 12906.0, 8010.519368837889, 8472.49165050099, 8496.447730897471, 8540.871886921825, 8541.359398045295, 9042.547872606212, 11451.942740286246, 11698.70753231176, 11810.704732381759, 11972.64082077539], "value": 9609.21384716034, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1583.825779164292, 1614.1687031178942, 1833.5599456130524, 1924.8075192480744, 1930.1217945834646, 9562.952185239074, 9817.116459518642, 10145.746356341077, 10173.151517575072, 10196.133328667063, 10019.0, 10161.745956351095, 10184.796304073932, 10187.286889917708, 10228.693139205818, 2472.208893154191, 2519.748025197475, 2519.8488090714523, 2522.117258959368, 2523.911663091792, 2404.146527982567, 2518.0431436054273, 2524.2931979045898, 2526.166365099522, 2531.0129049670645, 2420.092465325503, 2472.443700167457, 2484.5155194737035, 2486.7513248675077, 2491.5515207262683, 2434.659147719312, 2444.4744379958306, 2454.5949918263555, 2473.703155621319, 2479.925602231936, 2422.81828862836, 2423.1761201191503, 2432.404061005065, 2448.755124487537, 2455.815813813971, 9945.80108397828, 10021.498925053718, 10070.345427547187, 10076.093151616316, 10090.293679442442, 5888.823335299948, 5918.112283157518, 5923.081922302007, 5939.287285525721, 5942.554308426886, 3451.016460308825, 3515.138790996197, 3529.2059286660296, 3579.1052236940764, 3611.94582081269, 1082.2045796339685, 1121.293585041427, 1123.1464087293716, 1132.9490172942237, 1141.2182654881433, 13956.651083722887, 14120.788188177083, 14196.432142714382, 14257.572272831832, 14261.215633140173, 4938.530839570235, 4968.850934471971, 5064.721440320818, 5093.567046800989, 5132.897342053138, 10952.671419857417, 10999.175061870392, 11043.668689939315, 11072.944635276772, 11073.0, 5766.135079738073, 5807.767689292466, 5852.765889364463, 5854.4730974212525, 5860.413958604106, 4858.684185527929, 5349.732513374316, 5477.589180811455, 5487.067198576252, 5509.889802203934, 4007.5591684914634, 4011.3982902564267, 4058.553559108496, 4125.216208920296, 4139.97930010348, 1162.2329262686587, 1172.7126853920674, 1181.9054475641929, 1185.9407029648482, 1186.7329850783676, 923.7829110159107, 962.485070487286, 1002.9398236105857, 1006.3961623026125, 1086.7618080850225, 6316.589421687576, 6463.127477790532, 6509.316521765241, 6618.966905165444, 6632.403083722488, 494.45362874023687, 503.7556784959292, 505.1992591742056, 1094.9616763413242, 1114.7380365614074, 4533.52397998212, 4598.287265473857, 4612.215923293048, 4612.377329060601, 4630.72215667061, 11876.10929180315, 12043.578474753342, 12299.508019679291, 12439.0, 12506.624801255977, 12450.564230251897, 12497.312647804458, 12586.496540138292, 12604.747905041848, 12617.93691031539, 9242.121998410275, 9371.578278977462, 9389.108034736826, 9436.103570160823, 9441.339106262632, 6614.140161778938, 6735.427488663322, 6774.966125169342, 6822.795316140524, 6922.169339679271, 11318.151138664469, 11343.546258149581, 11384.715382115513, 11554.248973816675, 11609.071274297867, 11440.771184576095, 11451.25566838153, 11638.70903227426, 11802.881971180179, 11868.347240901834, 7892.329152022143, 8244.670213191404, 8375.95812020936, 8874.378793484395, 8959.01450840394, 9502.429854208769, 9557.426554406758, 9570.473623950471, 9608.66369677058, 9623.470709111067, 8388.370872184489, 8544.273736732448, 8593.226609605166, 8639.395242333228, 8767.298616110824, 8073.83852322962, 8102.108768035393, 8169.305609023299, 8177.05963814169, 8375.120612335617, 7591.506552074318, 7842.529448233125, 7846.568438735924, 7853.057633083838, 7857.882131767914, 5325.068113080118, 5850.795222167204, 5862.413758624274, 5868.853278668067, 6078.969605151946, 5878.617889837147, 5906.940930590639, 5940.6435613863305, 5957.553183511341, 6013.639181649115], "value": 5047.179438831362, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.7506058228948, 355.0838835803627, 358.7363287983332, 358.77576514678327, 360.61234173263733, 5819.9709001454985, 5868.677222752753, 5871.471567558919, 5902.439268269508, 5931.673757943311, 5739.799107031255, 5792.565557583177, 5792.565557583177, 5798.420157984199, 5800.781835814473, 4468.97765511172, 4469.620082293009, 4505.369248305224, 4548.953740639655, 4551.704139230956, 4505.977470112645, 4507.842225522108, 4518.683692141535, 4530.456345238576, 4531.43357080365, 4461.442319710036, 4488.685791994545, 4493.393391892086, 4494.820012294035, 4499.1901457737595, 4311.719738217022, 4436.778161091933, 4442.556593873357, 4447.933281000787, 4455.0, 3953.1895961328146, 3983.1237127831832, 4001.5998400160042, 4006.2187873364705, 4013.137175507251, 5558.722063896789, 5574.247476590689, 5577.3028371453565, 5600.27196464457, 5627.030539311249, 5151.716655583941, 5206.245094461282, 5209.7134657593815, 5235.293235413209, 5243.370795504526, 6106.053561697944, 6109.908351374733, 6147.278761946662, 6147.907781383283, 6212.689365531705, 4272.166927449149, 4436.157130145262, 4468.039371535103, 4490.932636010462, 4491.483479399878, 6118.418750218722, 6292.968535157341, 6299.433051025429, 6324.841878953017, 6460.676966151721, 4470.0, 4491.281394976788, 4498.730076195438, 4500.572445617661, 4510.300903359985, 4531.116432295737, 4556.544345565417, 4572.428446444194, 4578.748168850745, 4595.770211489412, 4919.926201106986, 5208.583313334924, 5222.164453687392, 5222.8955420892125, 5246.527812496894, 6099.8475038123515, 6143.385661433821, 6163.660998645118, 6164.599301045418, 6170.50635949123, 1546.7293223686036, 1551.0383562191514, 1575.3383578896892, 1576.9921150394175, 1578.2030074812146, 975.707287813653, 995.5271246158017, 997.7954519323521, 1004.9949750251349, 1022.8288609542182, 5419.539339156216, 5422.566194704415, 5424.531838013694, 5425.9186112208345, 5429.1856221566295, 5582.91625625616, 5618.859528511738, 5663.263775709213, 5669.837683274919, 5688.544916406678, 5073.543381095646, 5137.306463627438, 5347.491988261109, 5408.972955135199, 5431.755570999315, 2988.790784645054, 3008.247938015496, 3012.2469382654335, 3019.5772591837163, 3054.7708921830954, 5484.451554844483, 5785.768569257182, 5794.913076303858, 5801.679328268726, 5828.79599214034, 5589.972050139723, 5604.505994832342, 5633.63381380209, 5676.943230567642, 5713.600047996683, 5693.316801983706, 5742.827715168552, 5756.942430575725, 5760.798372056958, 5773.6824474654295, 5208.890399388254, 5558.97220513911, 5573.359063707726, 5592.133219350844, 5607.607467477237, 5496.657640463989, 5529.695866727368, 5532.75102620375, 5609.186667933045, 6112.847178820565, 6569.638669873203, 6626.469882409492, 6629.801105966829, 6646.169228846395, 6648.0, 4463.330500424962, 4464.767616191904, 4465.531119232433, 4474.098508133965, 4499.280115181556, 6184.948558744934, 6342.936570634234, 6349.333320001333, 6386.65880165152, 6393.584417012879, 6162.506999439945, 6209.627422354673, 6213.720382582705, 6247.843803904939, 6257.937420625917, 5978.491828194652, 6167.229096362955, 6231.376862313732, 6240.375962403723, 6254.21822272216, 6075.696215189311, 6104.0, 6107.328193898757, 6110.388961103854, 6126.1423400724825, 6191.783287584913, 6193.009118541192, 6207.441330280297, 6226.688665566613, 6262.718177681924, 5836.824895253149, 6039.2823229546, 6041.909371359346, 6042.697865106815, 6103.328633850184], "value": 4543.92931121126, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.7696245051384, 835.0563862834999, 853.2534032721369, 906.0622255965077, 909.4134283387211, 15807.689451142527, 17011.404600838956, 17303.826961730378, 17352.305907763704, 17382.826171738277, 15864.920675396606, 15986.200689965484, 16051.438199663015, 16129.919350403232, 16178.433754818583, 877.3419935048713, 888.7778055486112, 902.2150728865896, 902.2240872849344, 907.1291560102277, 868.3357231717741, 873.4933738431727, 874.3398733955854, 874.510274246424, 875.4222213339198, 914.4604683236889, 914.6158613382362, 914.9130832570928, 916.5829547555846, 918.1598837064079, 906.2432868554764, 906.8549032154824, 907.0340087806497, 908.4730856103478, 910.4309806371018, 662.6984721951501, 665.1751827733624, 665.2017578905333, 666.6666666666666, 667.4560233409804, 16659.0, 16682.58293542659, 16723.163841807982, 16730.581735456588, 16763.078030708308, 15761.703475652641, 15830.9208453957, 15988.4404045859, 16119.597010074842, 16312.347506099743, 9705.369151005232, 10281.897181028244, 10976.231663783537, 11271.887281127249, 11641.126915481289, 4048.9392659110135, 4089.8773036808943, 4120.896977575555, 4136.623337741068, 4215.620594146541, 81095.5945220276, 81434.59282703607, 81468.18531814666, 81731.59134204291, 82074.58962705148, 11917.463714132884, 11971.700707482383, 12062.457189426497, 12269.877301227052, 12363.505459781509, 21741.130354785946, 21837.890810546163, 21893.562128757654, 22381.32856014322, 22401.103955841583, 8653.653853845775, 8982.820343593092, 9331.72004839856, 9398.48308343034, 9598.232141428669, 4830.29960655703, 4968.403791544965, 4998.775055122455, 5060.063888180698, 5068.239764035424, 3846.1730727893637, 3963.603639636071, 3975.1254723960683, 3976.8011599420493, 3979.184267225212, 645.8934275844528, 646.3794757033301, 650.8187639434506, 666.0409011024207, 676.3202981004059, 628.1244720077135, 652.7878439507084, 661.9144602851328, 697.0264830403495, 727.7198278662647, 9918.950405247928, 10145.188384929188, 10249.33379330341, 10270.33242839213, 10357.223208259411, 681.3288910423229, 715.8783006888841, 763.1262204775612, 779.3726050529378, 798.3613109512366, 4617.653675974316, 4840.394950631171, 4864.464908860023, 4887.560119589254, 4952.876178095505, 85244.0, 111073.0, 113013.0, 117200.41399793117, 117627.0, 64849.96846929687, 100379.49810250902, 101274.0, 102918.0, 103116.48441757743, 88291.55854220688, 89087.55456222677, 89993.0, 90805.54597226971, 91379.54310228406, 8862.113788621085, 9164.495952722664, 9189.310801689766, 9223.985361610352, 9224.40041397307, 49534.75232623814, 51561.48438515717, 51683.48316516787, 52628.0, 56152.0, 53809.46190538201, 72987.63506182435, 74212.62893685713, 76781.61609191919, 79171.60414197893, 12591.622251332476, 12878.871211287767, 13173.60479185626, 13432.126911750705, 13981.091229070078, 13415.664608384868, 13534.729305414034, 13661.248631324976, 13811.240381778696, 13904.860951390761, 12135.332556709112, 12497.37513124322, 12692.746145076862, 12748.362581871055, 13727.245001525012, 12874.935625321814, 13310.33448327599, 13366.131201471873, 13382.531611393555, 13459.394327255493, 12654.240745555297, 12833.679158021125, 12963.805542917053, 12975.416106275052, 12978.610641680765, 10127.59489620407, 10170.288079834636, 10348.534315955649, 10384.792304154025, 10716.946415267874, 11279.718007049889, 11445.942770286096, 11495.252808567417, 11571.363575003455, 11706.88293117058], "value": 7774.807712555996, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 110.0, 110.0, 112.0, 110.0, 109.0, 109.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 130.0, 155.0, 168.0, 126.0, 148.0, 161.0, 126.0, 173.0, 133.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 163.0, 162.0, 163.0, 161.0, 164.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 168.0, 77.0, 75.0, 74.0, 75.0, 179.0, 74.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 163.0, 83.0, 85.0, 85.0, 139.0, 84.0, 84.0, 148.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 149.0, 149.0, 147.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 98.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 52.0, 52.0, 56.0, 54.0, 58.0, 53.0, 53.0, 52.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 60.0, 59.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 77.0, 78.0, 84.0, 79.0, 78.0, 110.0, 82.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 127.0, 126.0, 117.0, 132.0, 119.0, 124.0, 120.0, 134.0, 130.0], "value": 125.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 159.0, 152.0, 159.0, 152.0, 153.0, 155.0, 154.0, 152.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 64.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 61.0], "value": 62.2, "unit": "score"}]}]} 11:44:58 INFO - Return code: 0 11:44:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:58 ERROR - # TBPL SUCCESS # 11:44:58 INFO - Running post-action listener: _resource_record_post_action 11:44:58 INFO - ##### 11:44:58 INFO - ##### Finished run-tests step (success) 11:44:58 INFO - ##### 11:44:58 INFO - Running post-run listener: _resource_record_post_run 11:44:58 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 7655424; Write bytes: 357814272; Read time: 1708; Write time: 281912 11:44:58 INFO - TinderboxPrint: CPU usage
13.4% 11:44:58 INFO - TinderboxPrint: I/O read bytes / time
7,655,424 / 1,708 11:44:58 INFO - TinderboxPrint: I/O write bytes / time
357,814,272 / 281,912 11:44:58 INFO - TinderboxPrint: CPU idle
8,202.8 (86.6%) 11:44:58 INFO - TinderboxPrint: CPU user
1,211.4 (12.8%) 11:44:58 INFO - TinderboxPrint: Swap in / out
0 / 0 11:44:58 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 13312000; Read time: 0; Write time: 3888 11:44:58 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 5894144; Write bytes: 344502272; Read time: 1644; Write time: 278024 11:44:59 INFO - Running post-run listener: _upload_blobber_files 11:44:59 INFO - Blob upload gear active. 11:44:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:59 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:44:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:45:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:00 INFO - (blobuploader) - INFO - Done attempting. 11:45:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:45:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:45:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:01 INFO - (blobuploader) - INFO - Done attempting. 11:45:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:45:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:06 INFO - (blobuploader) - INFO - Done attempting. 11:45:06 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:06 INFO - Return code: 0 11:45:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e65708fdbc3e75121792c2353478e741d8ca56aed8ed556ee6c9878098a43f8001421a014309de0998edcf774e4a8a0522f7647eab69a5bd9b1424c26a134ee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9e86ef07fd385cd1b9d6040f28f48831d075b7693a0274a1e4c92583a6165979aa0ca687e498b5b557b155fc8e9ac32470841f582b13d115a33980f680923c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01910fc1f06216d11a1ca87e23e896b3d6350d0db4a153be08e61e69d50d3fd757a3464712e04c0eed38b39ac1e0d8b88a5d52707e2ba662caa278c3c5163c4b"} 11:45:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:06 INFO - Contents: 11:45:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e65708fdbc3e75121792c2353478e741d8ca56aed8ed556ee6c9878098a43f8001421a014309de0998edcf774e4a8a0522f7647eab69a5bd9b1424c26a134ee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9e86ef07fd385cd1b9d6040f28f48831d075b7693a0274a1e4c92583a6165979aa0ca687e498b5b557b155fc8e9ac32470841f582b13d115a33980f680923c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01910fc1f06216d11a1ca87e23e896b3d6350d0db4a153be08e61e69d50d3fd757a3464712e04c0eed38b39ac1e0d8b88a5d52707e2ba662caa278c3c5163c4b"} 11:45:06 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:06 INFO - Copying logs to upload dir... 11:45:06 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.149820 ========= master_lag: 0.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-01 11:45:06.702778) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 11:45:06.706743) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e65708fdbc3e75121792c2353478e741d8ca56aed8ed556ee6c9878098a43f8001421a014309de0998edcf774e4a8a0522f7647eab69a5bd9b1424c26a134ee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9e86ef07fd385cd1b9d6040f28f48831d075b7693a0274a1e4c92583a6165979aa0ca687e498b5b557b155fc8e9ac32470841f582b13d115a33980f680923c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01910fc1f06216d11a1ca87e23e896b3d6350d0db4a153be08e61e69d50d3fd757a3464712e04c0eed38b39ac1e0d8b88a5d52707e2ba662caa278c3c5163c4b"} build_url:https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e65708fdbc3e75121792c2353478e741d8ca56aed8ed556ee6c9878098a43f8001421a014309de0998edcf774e4a8a0522f7647eab69a5bd9b1424c26a134ee8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9e86ef07fd385cd1b9d6040f28f48831d075b7693a0274a1e4c92583a6165979aa0ca687e498b5b557b155fc8e9ac32470841f582b13d115a33980f680923c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01910fc1f06216d11a1ca87e23e896b3d6350d0db4a153be08e61e69d50d3fd757a3464712e04c0eed38b39ac1e0d8b88a5d52707e2ba662caa278c3c5163c4b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 11:45:06.731787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:45:06.732109) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470075762.528583-1222315656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004326 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:45:06.814796) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 11:45:06.815172) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 11:45:06.815629) ========= ========= Total master_lag: 0.46 =========