builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1467033890.5 results: success (0) buildid: 20160627025709 builduid: 149c76c2819e40dabdae4b1b3c7151ea revision: 9f311d92805addcd093ba46dabfcf385a0f7fed3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:50.500273) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:50.500724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:50.500999) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:50.515875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:50.516154) ========= 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=41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 06:24:51-- 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% 224M=0s 2016-06-27 06:24:51 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088313 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:50.618763) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:50.619076) ========= 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=41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016189 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:50.668447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:50.668844) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9f311d92805addcd093ba46dabfcf385a0f7fed3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9f311d92805addcd093ba46dabfcf385a0f7fed3 --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=41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 06:24:51,760 truncating revision to first 12 chars 2016-06-27 06:24:51,761 Setting DEBUG logging. 2016-06-27 06:24:51,761 attempt 1/10 2016-06-27 06:24:51,761 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9f311d92805a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 06:24:52,074 unpacking tar archive at: mozilla-aurora-9f311d92805a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661482 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:51.347901) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:51.348671) ========= script_repo_revision: 9f311d92805addcd093ba46dabfcf385a0f7fed3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:51.349573) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:51.350207) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:51.361684) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-27 06:24:51.361955) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:24:52 INFO - MultiFileLogger online at 20160627 06:24:52 in /builds/slave/test 06:24:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:24:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:24:52 INFO - {'append_to_log': False, 06:24:52 INFO - 'base_work_dir': '/builds/slave/test', 06:24:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:24:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:24:52 INFO - 'branch': 'Mozilla-Aurora', 06:24:52 INFO - 'buildbot_json_path': 'buildprops.json', 06:24:52 INFO - 'config_files': ('talos/linux_config.py',), 06:24:52 INFO - 'default_actions': ('clobber', 06:24:52 INFO - 'read-buildbot-config', 06:24:52 INFO - 'download-and-extract', 06:24:52 INFO - 'populate-webroot', 06:24:52 INFO - 'create-virtualenv', 06:24:52 INFO - 'install', 06:24:52 INFO - 'run-tests'), 06:24:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:24:52 INFO - 'download_minidump_stackwalk': True, 06:24:52 INFO - 'download_symbols': 'ondemand', 06:24:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:24:52 INFO - 'tooltool.py': '/tools/tooltool.py', 06:24:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:24:52 INFO - '/tools/misc-python/virtualenv.py')}, 06:24:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:24:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:24:52 INFO - 'installer_path': 'installer.exe', 06:24:52 INFO - 'log_level': 'info', 06:24:52 INFO - 'log_name': 'talos', 06:24:52 INFO - 'log_to_console': True, 06:24:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:24:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:24:52 INFO - 'opt_config_files': (), 06:24:52 INFO - 'pip_index': False, 06:24:52 INFO - 'sps_profile': False, 06:24:52 INFO - 'sps_profile_interval': 0, 06:24:52 INFO - 'suite': 'dromaeojs-e10s', 06:24:52 INFO - 'system_bits': '32', 06:24:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:24:52 INFO - 'title': 'talos-linux64-ix-024', 06:24:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:24:52 INFO - 'use_talos_json': True, 06:24:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:24:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:24:52 INFO - 'work_dir': 'build'} 06:24:52 INFO - ##### 06:24:52 INFO - ##### Running clobber step. 06:24:52 INFO - ##### 06:24:52 INFO - Running pre-action listener: _resource_record_pre_action 06:24:52 INFO - Running main action method: clobber 06:24:52 INFO - rmtree: /builds/slave/test/build 06:24:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:24:53 INFO - Running post-action listener: _resource_record_post_action 06:24:53 INFO - ##### 06:24:53 INFO - ##### Finished clobber step (success) 06:24:53 INFO - ##### 06:24:53 INFO - ##### 06:24:53 INFO - ##### Running read-buildbot-config step. 06:24:53 INFO - ##### 06:24:53 INFO - Running pre-action listener: _resource_record_pre_action 06:24:53 INFO - Running main action method: read_buildbot_config 06:24:53 INFO - Using buildbot properties: 06:24:53 INFO - { 06:24:53 INFO - "project": "", 06:24:53 INFO - "product": "firefox", 06:24:53 INFO - "script_repo_revision": "production", 06:24:53 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:24:53 INFO - "repository": "", 06:24:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:24:53 INFO - "buildid": "20160627025709", 06:24:53 INFO - "pgo_build": "True", 06:24:53 INFO - "basedir": "/builds/slave/test", 06:24:53 INFO - "buildnumber": 372, 06:24:53 INFO - "slavename": "talos-linux64-ix-024", 06:24:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:24:53 INFO - "platform": "ubuntu64_hw", 06:24:53 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:24:53 INFO - "branch": "mozilla-aurora", 06:24:53 INFO - "repo_path": "releases/mozilla-aurora", 06:24:53 INFO - "revision": "9f311d92805addcd093ba46dabfcf385a0f7fed3", 06:24:53 INFO - "stage_platform": "linux64-pgo", 06:24:53 INFO - "builduid": "149c76c2819e40dabdae4b1b3c7151ea", 06:24:53 INFO - "slavebuilddir": "test" 06:24:53 INFO - } 06:24:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 06:24:53 INFO - Running post-action listener: _resource_record_post_action 06:24:53 INFO - ##### 06:24:53 INFO - ##### Finished read-buildbot-config step (success) 06:24:53 INFO - ##### 06:24:53 INFO - ##### 06:24:53 INFO - ##### Running download-and-extract step. 06:24:53 INFO - ##### 06:24:53 INFO - Running pre-action listener: _resource_record_pre_action 06:24:53 INFO - Running main action method: download_and_extract 06:24:53 INFO - mkdir: /builds/slave/test/build/tests 06:24:53 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')]} 06:24:53 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:24:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:24:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:24:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:24:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:24:53 INFO - Downloaded 1361 bytes. 06:24:53 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:24:53 INFO - Using the following test package requirements: 06:24:53 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:24:53 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:53 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:24:53 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:53 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:24:53 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:53 INFO - u'jsshell-linux-x86_64.zip'], 06:24:53 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:53 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:24:53 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:24:53 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:53 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:24:53 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:53 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:24:53 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:53 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:24:53 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:53 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:24:53 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:24:53 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')]} 06:24:53 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:24:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:24:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:24:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:24:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:24:54 INFO - Downloaded 24517304 bytes. 06:24:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:24:56 INFO - Return code: 0 06:24:56 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:56 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:24:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:24:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:24:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:24:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:24:57 INFO - Downloaded 24517304 bytes. 06:24:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:24:58 INFO - Return code: 0 06:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:58 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:24:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:24:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:24:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:24:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:24:59 INFO - Downloaded 10833369 bytes. 06:24:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:24:59 INFO - Return code: 0 06:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:59 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:24:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:24:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:24:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:24:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:25:01 INFO - Downloaded 63617093 bytes. 06:25:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:25:01 INFO - mkdir: /builds/slave/test/properties 06:25:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:25:01 INFO - Writing to file /builds/slave/test/properties/build_url 06:25:01 INFO - Contents: 06:25:01 INFO - build_url:https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:25:01 INFO - Running post-action listener: _resource_record_post_action 06:25:01 INFO - Running post-action listener: set_extra_try_arguments 06:25:01 INFO - ##### 06:25:01 INFO - ##### Finished download-and-extract step (success) 06:25:01 INFO - ##### 06:25:01 INFO - ##### 06:25:01 INFO - ##### Running populate-webroot step. 06:25:01 INFO - ##### 06:25:01 INFO - Running pre-action listener: _resource_record_pre_action 06:25:01 INFO - Running main action method: populate_webroot 06:25:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:25:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:25:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:25:01 INFO - '--tppagecycles', 06:25:01 INFO - '7'], 06:25:01 INFO - 'tests': ['tsvgm']}}, 06:25:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:25:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:25:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:25:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:25:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:25:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:25:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:01 INFO - 'talos_options': ['--disable-e10s'], 06:25:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:25:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:25:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:01 INFO - 'talos_options': ['--disable-e10s'], 06:25:01 INFO - 'tests': ['damp', 'tps']}, 06:25:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:01 INFO - 'tests': ['damp', 'tps']}, 06:25:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:25:01 INFO - 'tests': ['dromaeo_dom']}, 06:25:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:25:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:25:01 INFO - 'tests': ['a11yr', 06:25:01 INFO - 'ts_paint', 06:25:01 INFO - 'tpaint', 06:25:01 INFO - 'sessionrestore', 06:25:01 INFO - 'sessionrestore_no_auto_restore', 06:25:01 INFO - 'tabpaint']}, 06:25:01 INFO - 'other-e10s': {'tests': ['a11yr', 06:25:01 INFO - 'ts_paint', 06:25:01 INFO - 'tpaint', 06:25:01 INFO - 'sessionrestore', 06:25:01 INFO - 'sessionrestore_no_auto_restore', 06:25:01 INFO - 'tabpaint']}, 06:25:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:25:01 INFO - 'ts_paint', 06:25:01 INFO - 'tpaint', 06:25:01 INFO - 'sessionrestore', 06:25:01 INFO - 'sessionrestore_no_auto_restore', 06:25:01 INFO - 'tabpaint']}, 06:25:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:25:01 INFO - 'ts_paint', 06:25:01 INFO - 'tpaint', 06:25:01 INFO - 'sessionrestore', 06:25:01 INFO - 'sessionrestore_no_auto_restore', 06:25:01 INFO - 'tabpaint']}, 06:25:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:25:01 INFO - 'tests': ['a11yr', 06:25:01 INFO - 'ts_paint', 06:25:01 INFO - 'tpaint', 06:25:01 INFO - 'sessionrestore', 06:25:01 INFO - 'sessionrestore_no_auto_restore', 06:25:01 INFO - 'tabpaint']}, 06:25:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:25:01 INFO - 'tests': ['a11yr', 06:25:01 INFO - 'ts_paint', 06:25:01 INFO - 'tpaint', 06:25:01 INFO - 'sessionrestore', 06:25:01 INFO - 'sessionrestore_no_auto_restore', 06:25:01 INFO - 'tabpaint']}, 06:25:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:25:01 INFO - 'tests': ['tsvgx', 06:25:01 INFO - 'tsvgr_opacity', 06:25:01 INFO - 'tart', 06:25:01 INFO - 'tscrollx', 06:25:01 INFO - 'cart']}, 06:25:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:25:01 INFO - 'tsvgr_opacity', 06:25:01 INFO - 'tart', 06:25:01 INFO - 'tscrollx', 06:25:01 INFO - 'cart']}, 06:25:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:01 INFO - 'talos_options': ['--disable-e10s'], 06:25:01 INFO - 'tests': ['tp5o']}, 06:25:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:01 INFO - 'tests': ['tp5o']}, 06:25:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:01 INFO - 'talos_options': ['--disable-e10s', 06:25:01 INFO - '--xperf_path', 06:25:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:25:01 INFO - 'tests': ['tp5n']}, 06:25:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:25:01 INFO - 'talos_options': ['--xperf_path', 06:25:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:25:01 INFO - 'tests': ['tp5n']}}, 06:25:01 INFO - 'talos.zip': {'path': '', 06:25:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:25:01 INFO - Running post-action listener: _resource_record_post_action 06:25:01 INFO - ##### 06:25:01 INFO - ##### Finished populate-webroot step (success) 06:25:01 INFO - ##### 06:25:01 INFO - ##### 06:25:01 INFO - ##### Running create-virtualenv step. 06:25:01 INFO - ##### 06:25:01 INFO - Running pre-action listener: _resource_record_pre_action 06:25:01 INFO - Running main action method: create_virtualenv 06:25:01 INFO - Creating virtualenv /builds/slave/test/build/venv 06:25:01 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 06:25:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:25:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:25:02 INFO - Using real prefix '/usr' 06:25:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:25:02 INFO - Installing distribute.............................................................................................................................................................................................done. 06:25:04 INFO - Installing pip.................done. 06:25:04 INFO - Return code: 0 06:25:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:04 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 0x7f759af2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dee2e0>, '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 0x1d5a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a5d0>, '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': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', '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 06:25:04 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 06:25:04 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 06:25:04 INFO - Using env: {'DISPLAY': ':0', 06:25:04 INFO - 'HOME': '/home/cltbld', 06:25:04 INFO - 'LANG': 'en_US.UTF-8', 06:25:04 INFO - 'LANGUAGE': 'en_US:en', 06:25:04 INFO - 'LOGNAME': 'cltbld', 06:25:04 INFO - 'MAIL': '/var/mail/cltbld', 06:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:04 INFO - 'MOZ_NO_REMOTE': '1', 06:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:04 INFO - 'NO_EM_RESTART': '1', 06:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:04 INFO - 'PWD': '/builds/slave/test', 06:25:04 INFO - 'SHELL': '/bin/bash', 06:25:04 INFO - 'SHLVL': '1', 06:25:04 INFO - 'TERM': 'linux', 06:25:04 INFO - 'TMOUT': '86400', 06:25:04 INFO - 'USER': 'cltbld', 06:25:04 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', 06:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:04 INFO - '_': '/tools/buildbot/bin/python'} 06:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:04 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 06:25:04 INFO - Cleaning up... 06:25:04 INFO - Return code: 0 06:25:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:04 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 0x7f759af2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dee2e0>, '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 0x1d5a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a5d0>, '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': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', '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 06:25:04 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 06:25:04 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 06:25:04 INFO - Using env: {'DISPLAY': ':0', 06:25:04 INFO - 'HOME': '/home/cltbld', 06:25:04 INFO - 'LANG': 'en_US.UTF-8', 06:25:04 INFO - 'LANGUAGE': 'en_US:en', 06:25:04 INFO - 'LOGNAME': 'cltbld', 06:25:04 INFO - 'MAIL': '/var/mail/cltbld', 06:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:04 INFO - 'MOZ_NO_REMOTE': '1', 06:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:04 INFO - 'NO_EM_RESTART': '1', 06:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:04 INFO - 'PWD': '/builds/slave/test', 06:25:04 INFO - 'SHELL': '/bin/bash', 06:25:04 INFO - 'SHLVL': '1', 06:25:04 INFO - 'TERM': 'linux', 06:25:04 INFO - 'TMOUT': '86400', 06:25:04 INFO - 'USER': 'cltbld', 06:25:04 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', 06:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:04 INFO - '_': '/tools/buildbot/bin/python'} 06:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:04 INFO - Downloading/unpacking psutil>=3.1.1 06:25:04 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 06:25:04 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 06:25:04 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 06:25:04 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 06:25:04 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 06:25:04 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 06:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:25:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:06 INFO - Installing collected packages: psutil 06:25:06 INFO - Running setup.py install for psutil 06:25:07 INFO - building 'psutil._psutil_linux' extension 06:25:07 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 06:25:07 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 06:25:07 INFO - building 'psutil._psutil_posix' extension 06:25:07 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 06:25:07 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 06:25:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:07 INFO - Successfully installed psutil 06:25:07 INFO - Cleaning up... 06:25:07 INFO - Return code: 0 06:25:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06: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')]} 06:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f759af2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dee2e0>, '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 0x1d5a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a5d0>, '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': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', '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 06: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06: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 mozsystemmonitor==0.3 06:25:07 INFO - Using env: {'DISPLAY': ':0', 06:25:07 INFO - 'HOME': '/home/cltbld', 06:25:07 INFO - 'LANG': 'en_US.UTF-8', 06:25:07 INFO - 'LANGUAGE': 'en_US:en', 06:25:07 INFO - 'LOGNAME': 'cltbld', 06:25:07 INFO - 'MAIL': '/var/mail/cltbld', 06:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:07 INFO - 'MOZ_NO_REMOTE': '1', 06:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:07 INFO - 'NO_EM_RESTART': '1', 06:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:07 INFO - 'PWD': '/builds/slave/test', 06:25:07 INFO - 'SHELL': '/bin/bash', 06:25:07 INFO - 'SHLVL': '1', 06:25:07 INFO - 'TERM': 'linux', 06:25:07 INFO - 'TMOUT': '86400', 06:25:07 INFO - 'USER': 'cltbld', 06:25:07 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', 06:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:07 INFO - '_': '/tools/buildbot/bin/python'} 06:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:25:09 INFO - Installing collected packages: mozsystemmonitor 06:25:09 INFO - Running setup.py install for mozsystemmonitor 06:25:09 INFO - Successfully installed mozsystemmonitor 06:25:09 INFO - Cleaning up... 06:25:09 INFO - Return code: 0 06:25:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:25:09 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')]} 06:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:09 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')]} 06:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:09 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 0x7f759af2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dee2e0>, '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 0x1d5a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a5d0>, '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': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', '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 06:25:09 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 06:25:09 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 06:25:09 INFO - Using env: {'DISPLAY': ':0', 06:25:09 INFO - 'HOME': '/home/cltbld', 06:25:09 INFO - 'LANG': 'en_US.UTF-8', 06:25:09 INFO - 'LANGUAGE': 'en_US:en', 06:25:09 INFO - 'LOGNAME': 'cltbld', 06:25:09 INFO - 'MAIL': '/var/mail/cltbld', 06:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:09 INFO - 'MOZ_NO_REMOTE': '1', 06:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:09 INFO - 'NO_EM_RESTART': '1', 06:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:09 INFO - 'PWD': '/builds/slave/test', 06:25:09 INFO - 'SHELL': '/bin/bash', 06:25:09 INFO - 'SHLVL': '1', 06:25:09 INFO - 'TERM': 'linux', 06:25:09 INFO - 'TMOUT': '86400', 06:25:09 INFO - 'USER': 'cltbld', 06:25:09 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', 06:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:09 INFO - '_': '/tools/buildbot/bin/python'} 06:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:10 INFO - Downloading/unpacking jsonschema==2.5.1 06: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 06: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 06: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 06: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 06: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 06: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 06:25:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:25:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:25:11 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 06:25:11 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 06:25:11 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 06:25:11 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 06:25:11 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 06:25:11 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 06:25:12 INFO - Downloading functools32-3.2.3-2.tar.gz 06:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:25:12 INFO - warning: no files found matching '*.txt' 06:25:12 INFO - no previously-included directories found matching 'build' 06:25:12 INFO - no previously-included directories found matching 'dist' 06:25:12 INFO - no previously-included directories found matching '.git*' 06:25:12 INFO - Installing collected packages: jsonschema, functools32 06:25:12 INFO - Running setup.py install for functools32 06:25:12 INFO - warning: no files found matching '*.txt' 06:25:12 INFO - no previously-included directories found matching 'build' 06:25:12 INFO - no previously-included directories found matching 'dist' 06:25:12 INFO - no previously-included directories found matching '.git*' 06:25:12 INFO - Successfully installed jsonschema functools32 06:25:12 INFO - Cleaning up... 06:25:12 INFO - Return code: 0 06:25:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f759af2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dee2e0>, '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 0x1d5a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a5d0>, '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': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', '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 06:25:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:25:12 INFO - Using env: {'DISPLAY': ':0', 06:25:12 INFO - 'HOME': '/home/cltbld', 06:25:12 INFO - 'LANG': 'en_US.UTF-8', 06:25:12 INFO - 'LANGUAGE': 'en_US:en', 06:25:12 INFO - 'LOGNAME': 'cltbld', 06:25:12 INFO - 'MAIL': '/var/mail/cltbld', 06:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:12 INFO - 'MOZ_NO_REMOTE': '1', 06:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:12 INFO - 'NO_EM_RESTART': '1', 06:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:12 INFO - 'PWD': '/builds/slave/test', 06:25:12 INFO - 'SHELL': '/bin/bash', 06:25:12 INFO - 'SHLVL': '1', 06:25:12 INFO - 'TERM': 'linux', 06:25:12 INFO - 'TMOUT': '86400', 06:25:12 INFO - 'USER': 'cltbld', 06:25:12 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', 06:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:12 INFO - '_': '/tools/buildbot/bin/python'} 06:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:12 INFO - Downloading/unpacking blobuploader==1.2.4 06:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:14 INFO - Downloading blobuploader-1.2.4.tar.gz 06:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:25:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:25:14 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 06:25:14 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 06:25:14 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 06:25:14 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 06:25:14 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 06:25:14 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 06:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:25:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:25:14 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 06:25:14 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 06:25:14 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 06:25:14 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 06:25:14 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 06:25:14 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 06:25:15 INFO - Downloading docopt-0.6.1.tar.gz 06:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:25:15 INFO - Installing collected packages: blobuploader, requests, docopt 06:25:15 INFO - Running setup.py install for blobuploader 06:25:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:25:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:25:15 INFO - Running setup.py install for requests 06:25:15 INFO - Running setup.py install for docopt 06:25:15 INFO - Successfully installed blobuploader requests docopt 06:25:15 INFO - Cleaning up... 06:25:15 INFO - Return code: 0 06:25:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:15 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 0x7f759af2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dee2e0>, '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 0x1d5a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a5d0>, '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': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', '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 06:25:15 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 06:25:15 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 06:25:15 INFO - Using env: {'DISPLAY': ':0', 06:25:15 INFO - 'HOME': '/home/cltbld', 06:25:15 INFO - 'LANG': 'en_US.UTF-8', 06:25:15 INFO - 'LANGUAGE': 'en_US:en', 06:25:15 INFO - 'LOGNAME': 'cltbld', 06:25:15 INFO - 'MAIL': '/var/mail/cltbld', 06:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:15 INFO - 'MOZ_NO_REMOTE': '1', 06:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:15 INFO - 'NO_EM_RESTART': '1', 06:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:15 INFO - 'PWD': '/builds/slave/test', 06:25:15 INFO - 'SHELL': '/bin/bash', 06:25:15 INFO - 'SHLVL': '1', 06:25:15 INFO - 'TERM': 'linux', 06:25:15 INFO - 'TMOUT': '86400', 06:25:15 INFO - 'USER': 'cltbld', 06:25:15 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', 06:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:15 INFO - '_': '/tools/buildbot/bin/python'} 06:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:25:16 INFO - Running setup.py (path:/tmp/pip-EojTP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:25:16 INFO - Running setup.py (path:/tmp/pip-zdpHsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:25:16 INFO - Running setup.py (path:/tmp/pip-j7Rp7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:25:16 INFO - Running setup.py (path:/tmp/pip-qJiBYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:25:16 INFO - Running setup.py (path:/tmp/pip-d9R1_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:25:16 INFO - Running setup.py (path:/tmp/pip-K4FPXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:25:16 INFO - Running setup.py (path:/tmp/pip-hGulvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:25:16 INFO - Running setup.py (path:/tmp/pip-azce9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:25:16 INFO - Running setup.py (path:/tmp/pip-yC9bSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:25:16 INFO - Running setup.py (path:/tmp/pip-IwcJHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:25:16 INFO - Running setup.py (path:/tmp/pip-Oyg49x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:25:16 INFO - Running setup.py (path:/tmp/pip-jUPAYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:25:16 INFO - Running setup.py (path:/tmp/pip-6GWOtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:25:16 INFO - Running setup.py (path:/tmp/pip-R5G3Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:17 INFO - Running setup.py (path:/tmp/pip-dbwm7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:25:17 INFO - Running setup.py (path:/tmp/pip-0BjiI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:25:17 INFO - Running setup.py (path:/tmp/pip-N8dumM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:25:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:25:17 INFO - Running setup.py install for manifestparser 06:25:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:25:17 INFO - Running setup.py install for mozcrash 06:25:17 INFO - Running setup.py install for mozdebug 06:25:17 INFO - Running setup.py install for mozdevice 06:25:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:25:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:25:17 INFO - Running setup.py install for mozfile 06:25:17 INFO - Running setup.py install for mozhttpd 06:25:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:25:17 INFO - Running setup.py install for mozinfo 06:25:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:25:17 INFO - Running setup.py install for mozInstall 06:25:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:25:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:25:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:25:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:25:18 INFO - Running setup.py install for mozleak 06:25:18 INFO - Running setup.py install for mozlog 06:25:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:25:18 INFO - Running setup.py install for moznetwork 06:25:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:25:18 INFO - Running setup.py install for mozprocess 06:25:18 INFO - Running setup.py install for mozprofile 06:25:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:25:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:25:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:25:18 INFO - Running setup.py install for mozrunner 06:25:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:25:18 INFO - Running setup.py install for mozscreenshot 06:25:18 INFO - Running setup.py install for moztest 06:25:18 INFO - Running setup.py install for mozversion 06:25:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:25:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:25:19 INFO - Cleaning up... 06:25:19 INFO - Return code: 0 06:25:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:19 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 0x7f759af2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dee2e0>, '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 0x1d5a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a5d0>, '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': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', '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 06:25:19 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 06:25:19 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 06:25:19 INFO - Using env: {'DISPLAY': ':0', 06:25:19 INFO - 'HOME': '/home/cltbld', 06:25:19 INFO - 'LANG': 'en_US.UTF-8', 06:25:19 INFO - 'LANGUAGE': 'en_US:en', 06:25:19 INFO - 'LOGNAME': 'cltbld', 06:25:19 INFO - 'MAIL': '/var/mail/cltbld', 06:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:19 INFO - 'MOZ_NO_REMOTE': '1', 06:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:19 INFO - 'NO_EM_RESTART': '1', 06:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:19 INFO - 'PWD': '/builds/slave/test', 06:25:19 INFO - 'SHELL': '/bin/bash', 06:25:19 INFO - 'SHLVL': '1', 06:25:19 INFO - 'TERM': 'linux', 06:25:19 INFO - 'TMOUT': '86400', 06:25:19 INFO - 'USER': 'cltbld', 06:25:19 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', 06:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:19 INFO - '_': '/tools/buildbot/bin/python'} 06:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:25:19 INFO - Running setup.py (path:/tmp/pip-qEiLG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:25:19 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)) 06:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:25:19 INFO - Running setup.py (path:/tmp/pip-Fmviy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:25:19 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)) 06:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:25:19 INFO - Running setup.py (path:/tmp/pip-H1oJ3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:25:19 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)) 06:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:25:19 INFO - Running setup.py (path:/tmp/pip-_cRowU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:25:19 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)) 06:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:25:19 INFO - Running setup.py (path:/tmp/pip-Jjwzmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:25:19 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)) 06:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:25:19 INFO - Running setup.py (path:/tmp/pip-jpfGVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:25:19 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)) 06:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:25:19 INFO - Running setup.py (path:/tmp/pip-sxgjZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:25:19 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)) 06:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:25:19 INFO - Running setup.py (path:/tmp/pip-WAIgTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:25:19 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)) 06:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:25:19 INFO - Running setup.py (path:/tmp/pip-1FVO4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:25:19 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)) 06:25:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:25:19 INFO - Running setup.py (path:/tmp/pip-2GhLru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:25:20 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)) 06:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:25:20 INFO - Running setup.py (path:/tmp/pip-aSWAEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:25:20 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)) 06:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:25:20 INFO - Running setup.py (path:/tmp/pip-nNWpEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:25:20 INFO - Running setup.py (path:/tmp/pip-mqjuck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:25:20 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)) 06:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:25:20 INFO - Running setup.py (path:/tmp/pip-WFG58v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:20 INFO - Running setup.py (path:/tmp/pip-u6SlLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:20 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)) 06:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:25:20 INFO - Running setup.py (path:/tmp/pip-2dBTwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:25:20 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)) 06:25:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:25:20 INFO - Running setup.py (path:/tmp/pip-JakLwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:25:20 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)) 06:25:20 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)) 06:25:20 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)) 06:25:20 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)) 06:25:20 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)) 06:25:20 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)) 06:25:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:22 INFO - Downloading blessings-1.6.tar.gz 06:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:25:22 INFO - Installing collected packages: blessings 06:25:22 INFO - Running setup.py install for blessings 06:25:22 INFO - Successfully installed blessings 06:25:22 INFO - Cleaning up... 06:25:22 INFO - Return code: 0 06:25:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:25:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:22 INFO - Reading from file tmpfile_stdout 06:25:22 INFO - Current package versions: 06:25:22 INFO - argparse == 1.2.1 06:25:22 INFO - blessings == 1.6 06:25:22 INFO - blobuploader == 1.2.4 06:25:22 INFO - docopt == 0.6.1 06:25:22 INFO - functools32 == 3.2.3-2 06:25:22 INFO - jsonschema == 2.5.1 06:25:22 INFO - manifestparser == 1.1 06:25:22 INFO - mozInstall == 1.12 06:25:22 INFO - mozcrash == 0.17 06:25:22 INFO - mozdebug == 0.1 06:25:22 INFO - mozdevice == 0.48 06:25:22 INFO - mozfile == 1.2 06:25:22 INFO - mozhttpd == 0.7 06:25:22 INFO - mozinfo == 0.9 06:25:22 INFO - mozleak == 0.1 06:25:22 INFO - mozlog == 3.2 06:25:22 INFO - moznetwork == 0.27 06:25:22 INFO - mozprocess == 0.22 06:25:22 INFO - mozprofile == 0.28 06:25:22 INFO - mozrunner == 6.11 06:25:22 INFO - mozscreenshot == 0.1 06:25:22 INFO - mozsystemmonitor == 0.3 06:25:22 INFO - moztest == 0.7 06:25:22 INFO - mozversion == 1.4 06:25:22 INFO - psutil == 3.1.1 06:25:22 INFO - requests == 1.2.3 06:25:22 INFO - wsgiref == 0.1.2 06:25:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:22 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 0x7f759af2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dee2e0>, '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 0x1d5a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a5d0>, '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': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', '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 06:25:22 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 06:25:22 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 06:25:22 INFO - Using env: {'DISPLAY': ':0', 06:25:22 INFO - 'HOME': '/home/cltbld', 06:25:22 INFO - 'LANG': 'en_US.UTF-8', 06:25:22 INFO - 'LANGUAGE': 'en_US:en', 06:25:22 INFO - 'LOGNAME': 'cltbld', 06:25:22 INFO - 'MAIL': '/var/mail/cltbld', 06:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:22 INFO - 'MOZ_NO_REMOTE': '1', 06:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:22 INFO - 'NO_EM_RESTART': '1', 06:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:22 INFO - 'PWD': '/builds/slave/test', 06:25:22 INFO - 'SHELL': '/bin/bash', 06:25:22 INFO - 'SHLVL': '1', 06:25:22 INFO - 'TERM': 'linux', 06:25:22 INFO - 'TMOUT': '86400', 06:25:22 INFO - 'USER': 'cltbld', 06:25:22 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', 06:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:22 INFO - '_': '/tools/buildbot/bin/python'} 06:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:23 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)) 06:25:23 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)) 06:25:23 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)) 06:25:23 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)) 06:25:23 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)) 06:25:23 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)) 06:25:23 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)) 06:25:23 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)) 06:25:23 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)) 06:25:23 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)) 06:25:23 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)) 06:25:23 INFO - Cleaning up... 06:25:23 INFO - Return code: 0 06:25:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f759af2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dee2e0>, '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 0x1d5a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a5d0>, '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': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', '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 06:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:25:23 INFO - Using env: {'DISPLAY': ':0', 06:25:23 INFO - 'HOME': '/home/cltbld', 06:25:23 INFO - 'LANG': 'en_US.UTF-8', 06:25:23 INFO - 'LANGUAGE': 'en_US:en', 06:25:23 INFO - 'LOGNAME': 'cltbld', 06:25:23 INFO - 'MAIL': '/var/mail/cltbld', 06:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:23 INFO - 'MOZ_NO_REMOTE': '1', 06:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:23 INFO - 'NO_EM_RESTART': '1', 06:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:23 INFO - 'PWD': '/builds/slave/test', 06:25:23 INFO - 'SHELL': '/bin/bash', 06:25:23 INFO - 'SHLVL': '1', 06:25:23 INFO - 'TERM': 'linux', 06:25:23 INFO - 'TMOUT': '86400', 06:25:23 INFO - 'USER': 'cltbld', 06:25:23 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', 06:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:23 INFO - '_': '/tools/buildbot/bin/python'} 06:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:25:23 INFO - Cleaning up... 06:25:23 INFO - Return code: 0 06:25:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f759af2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dee2e0>, '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 0x1d5a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a5d0>, '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': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', '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 06:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:25:23 INFO - Using env: {'DISPLAY': ':0', 06:25:23 INFO - 'HOME': '/home/cltbld', 06:25:23 INFO - 'LANG': 'en_US.UTF-8', 06:25:23 INFO - 'LANGUAGE': 'en_US:en', 06:25:23 INFO - 'LOGNAME': 'cltbld', 06:25:23 INFO - 'MAIL': '/var/mail/cltbld', 06:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:23 INFO - 'MOZ_NO_REMOTE': '1', 06:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:23 INFO - 'NO_EM_RESTART': '1', 06:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:23 INFO - 'PWD': '/builds/slave/test', 06:25:23 INFO - 'SHELL': '/bin/bash', 06:25:23 INFO - 'SHLVL': '1', 06:25:23 INFO - 'TERM': 'linux', 06:25:23 INFO - 'TMOUT': '86400', 06:25:23 INFO - 'USER': 'cltbld', 06:25:23 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', 06:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:23 INFO - '_': '/tools/buildbot/bin/python'} 06:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:23 INFO - Downloading/unpacking flake8 06:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:25:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:25:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:25:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:25:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:25:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:25:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:25:26 INFO - no previously-included directories found matching 'docs/_build' 06:25:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:25:26 INFO - Running setup.py install for pep8 06:25:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:25:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:25:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:25:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:25:26 INFO - no previously-included directories found matching 'docs/_build' 06:25:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:25:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:25:26 INFO - Cleaning up... 06:25:26 INFO - Return code: 0 06:25:26 INFO - Running post-action listener: _resource_record_post_action 06:25:26 INFO - Running post-action listener: _start_resource_monitoring 06:25:26 INFO - Starting resource monitoring. 06:25:26 INFO - ##### 06:25:26 INFO - ##### Finished create-virtualenv step (success) 06:25:26 INFO - ##### 06:25:26 INFO - ##### 06:25:26 INFO - ##### Running install step. 06:25:26 INFO - ##### 06:25:26 INFO - Running pre-action listener: _resource_record_pre_action 06:25:26 INFO - Running main action method: install 06:25:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:26 INFO - Reading from file tmpfile_stdout 06:25:26 INFO - Detecting whether we're running mozinstall >=1.0... 06:25:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:25:26 INFO - Reading from file tmpfile_stdout 06:25:26 INFO - Output received: 06:25:26 INFO - Usage: mozinstall [options] installer 06:25:26 INFO - Options: 06:25:26 INFO - -h, --help show this help message and exit 06:25:26 INFO - -d DEST, --destination=DEST 06:25:26 INFO - Directory to install application into. [default: 06:25:26 INFO - "/builds/slave/test"] 06:25:26 INFO - --app=APP Application being installed. [default: firefox] 06:25:26 INFO - mkdir: /builds/slave/test/build/application 06:25:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:25:42 INFO - Reading from file tmpfile_stdout 06:25:42 INFO - Output received: 06:25:42 INFO - /builds/slave/test/build/application/firefox/firefox 06:25:42 INFO - Running post-action listener: _resource_record_post_action 06:25:42 INFO - ##### 06:25:42 INFO - ##### Finished install step (success) 06:25:42 INFO - ##### 06:25:42 INFO - ##### 06:25:42 INFO - ##### Running run-tests step. 06:25:42 INFO - ##### 06:25:42 INFO - Running pre-action listener: _resource_record_pre_action 06:25:42 INFO - Running main action method: run_tests 06:25:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:25:42 INFO - Python 2.7.3 06:25:42 INFO - Return code: 0 06:25:42 INFO - grabbing minidump binary from tooltool 06:25: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')]} 06:25:42 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 0x1dee2e0>, '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 0x1d5a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:25:42 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 06:25:42 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 06:25:42 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 06:25:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:25:42 INFO - Return code: 0 06:25:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:25:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:25:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:25:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:25:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:25:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:25:43 INFO - Return code: 0 06:25:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 06:25:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 06:25:43 INFO - Using env: {'DISPLAY': ':0', 06:25:43 INFO - 'HOME': '/home/cltbld', 06:25:43 INFO - 'LANG': 'en_US.UTF-8', 06:25:43 INFO - 'LANGUAGE': 'en_US:en', 06:25:43 INFO - 'LOGNAME': 'cltbld', 06:25:43 INFO - 'MAIL': '/var/mail/cltbld', 06:25:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:25:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:43 INFO - 'MOZ_NO_REMOTE': '1', 06:25:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:43 INFO - 'NO_EM_RESTART': '1', 06:25:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:43 INFO - 'PWD': '/builds/slave/test', 06:25:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:25:43 INFO - 'SHELL': '/bin/bash', 06:25:43 INFO - 'SHLVL': '1', 06:25:43 INFO - 'TERM': 'linux', 06:25:43 INFO - 'TMOUT': '86400', 06:25:43 INFO - 'USER': 'cltbld', 06:25:43 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212', 06:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:43 INFO - '_': '/tools/buildbot/bin/python'} 06:25:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 06:25:43 INFO - mozversion application_buildid: 20160627025709 06:25:43 INFO - mozversion application_changeset: 9f311d92805addcd093ba46dabfcf385a0f7fed3 06:25:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:25:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:25:43 INFO - mozversion application_name: Firefox 06:25:43 INFO - mozversion application_remotingname: firefox-dev 06:25:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:25:43 INFO - mozversion application_vendor: Mozilla 06:25:43 INFO - mozversion application_version: 49.0a2 06:25:43 INFO - mozversion platform_buildid: 20160627025709 06:25:43 INFO - mozversion platform_changeset: 9f311d92805addcd093ba46dabfcf385a0f7fed3 06:25:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:25:43 INFO - mozversion platform_version: 49.0a2 06:25:43 INFO - using testdate: 1467033943 06:25:43 INFO - actual date: 1467033943 06:25:43 INFO - starting webserver on 'localhost:42104' 06:25:43 INFO - SUITE-START | Running 2 tests 06:25:43 INFO - TEST-START | dromaeo_css 06:25:43 INFO - operating with platform_type : linux_ 06:25:43 INFO - Initialising browser for dromaeo_css test... 06:25:43 INFO - TEST-INFO | started process 22004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkgu1vR/profile http://localhost:42104/getInfo.html) 06:25:48 INFO - PROCESS | 22004 | __metrics Screen width/height:1600/1200 06:25:48 INFO - PROCESS | 22004 | colorDepth:24 06:25:48 INFO - PROCESS | 22004 | Browser inner width/height: 1024/697 06:25:48 INFO - PROCESS | 22004 | __metrics 06:25:49 ERROR - PROCESS | 22004 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 06:25:49 INFO - TEST-INFO | 22004: exit 0 06:25:49 INFO - Browser initialized. 06:25:49 INFO - Running cycle 1/1 for dromaeo_css test... 06:25:49 INFO - TEST-INFO | started process 22131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkgu1vR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:26:01 INFO - PROCESS | 22131 | RSS: Main: 155721728 06:26:01 INFO - PROCESS | 22131 | 06:26:51 INFO - PROCESS | 22131 | 1467034011373 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] 06:28:59 INFO - PROCESS | 22131 | Cycle 1(1): loaded http://localhost:42104/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42104/tests/dromaeo/cssquery-ext.html) 06:29:00 INFO - PROCESS | 22131 | RSS: Main: 159248384 06:29:00 INFO - PROCESS | 22131 | 06:32:02 INFO - PROCESS | 22131 | Cycle 1(1): loaded http://localhost:42104/tests/dromaeo/cssquery-ext.html (next: http://localhost:42104/tests/dromaeo/cssquery-jquery.html) 06:32:02 INFO - PROCESS | 22131 | RSS: Main: 157097984 06:32:02 INFO - PROCESS | 22131 | 06:35:04 INFO - PROCESS | 22131 | Cycle 1(1): loaded http://localhost:42104/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42104/tests/dromaeo/cssquery-mootools.html) 06:35:05 INFO - PROCESS | 22131 | RSS: Main: 156594176 06:35:05 INFO - PROCESS | 22131 | 06:38:07 INFO - PROCESS | 22131 | Cycle 1(1): loaded http://localhost:42104/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42104/tests/dromaeo/cssquery-prototype.html) 06:38:07 INFO - PROCESS | 22131 | RSS: Main: 156323840 06:38:07 INFO - PROCESS | 22131 | 06:41:10 INFO - PROCESS | 22131 | Cycle 1(1): loaded http://localhost:42104/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42104/tests/dromaeo/cssquery-yui.html) 06:41:10 INFO - PROCESS | 22131 | RSS: Main: 158515200 06:41:10 INFO - PROCESS | 22131 | 06:44:13 INFO - PROCESS | 22131 | Cycle 1(1): loaded http://localhost:42104/tests/dromaeo/cssquery-yui.html (next: http://localhost:42104/tests/dromaeo/cssquery-dojo.html) 06:44:13 INFO - PROCESS | 22131 | RSS: Main: 158658560 06:44:13 INFO - PROCESS | 22131 | 06:44:13 INFO - PROCESS | 22131 | __start_tp_report 06:44:13 INFO - PROCESS | 22131 | _x_x_mozilla_page_load 06:44:13 INFO - PROCESS | 22131 | _x_x_mozilla_page_load_details 06:44:13 INFO - PROCESS | 22131 | |i|pagename|runs| 06:44:13 INFO - PROCESS | 22131 | |0;dojo.html;3373.173572474744;3377.746668999825;3406.9148271293216;3426.828658567071;3427.503012063251;5571.498565129143;5580.888382232358;5581.581381396396;5642.181883626871;5713.057345537981;5664.971675141629;5666.631668941516;5679.062954612484;5681.176229446728;5713.342965558962;5143.434222235551;5181.145111056671;5187.507186817246;5192.221166824987;5248.134057880445;5081.79672813087;5109.3357863477695;5208.348956380452;5214.921776173361;5251.054810134175;5160.793568257284;5176.5341119299255;5196.740162991854;5208.270842082112;5211.687298762067;5201.973990130063;5244.475552444763;5264.947350526484;5265.289185959885;5275.419703832576;5006.549410553068;5132.178851383761;5158.019976204547;5222.97388513055;5236.136037553799;5430.185472179165;5512.91730624041;5540;5551.3893471718075;5552.77788888444;6104.572679912408;6124.816255512342;6134.723937422827;6147.631142131487;6161.50707943368;6158.3841615838055;6170.167027451326;6206.472449841769;6207.596506227081;6220.284667263232;5564.165375193753;5603.691796951166;5652.943470565283;5785.421457854223;5795.362510123883;6268.310485846553;6278.6860656966965;6283.968580157161;6285.937140628626;6291.370862913672;5936.851578710481;6045;6051.243594550681;6052.485538729257;6054.212952316171;5910.290765108214;6077.179580756541;6123.801220575414;6126.877462450726;6156.538259630545;6062.848428789227;6104.420080092473;6121.868307950349;6139.154842350747;6140.8771824563255;6078.422549857756;6084.148219249309;6099.8475038123515;6102.176206212193;6111.908321375183;4551.544845515488;4572.725636461823;4596.264597664424;4651.62786977041;4681.578657920803;4154.833806647761;4163.916721665611;4165.229432554987;4191.224623444611;4202.579742025773;5690.5163061140265;5963;5969.2240008799445;5986.461218490357;6007.128966299862;5933.643981361132;5994.460498555151;5996.430339117864;6028.909566356509;6049.3950604939155;5857.238558987305;5860.179574859523;5877.324107727666;5927.73325200367;5945.048792193228;5132.8460146195675;5280.498352656491;5289.629725919226;5290.047791397508;5308.734563271898;6221.502279817604;6268.811935641938;6288.213973253343;6371.808845734636;6394.4564712;6160;6163.075538669146;6167;6181.1655426516845;6182.969085154546;6221.688915554295;6228.065790131516;6397.744090236339;6404.135441715309;6408.455281301141;5935.317438494629;6085.543584231289;6090.3605121461605;6103.328633850362;6121.724522396592;6163.741523733617;6176.9073463897175;6188.288346840171;6198.690065496798;6207.193064901534;5804.883902321845;5926.318473375617;5975.820725378246;6008.188894499187;6043.2748070231855;5965.761369545169;6031.698415079316;6045.939540604713;6068.362821903813;6080.665563394055;5897.233359663216;5936.732847021808;5949.940500595112;5950.672713000827;5961.254843144607;5873.119032145041;5876.44173803488;5939.4357536034;5944.3164036136395;6072.514198864169;5922.555808314308;5924.437178468039;5927.673977931083;5935.762569497172;5940.138679891305 06:44:13 INFO - PROCESS | 22131 | |1;ext.html;572.4504475703325;632.6488798716716;648.7761722205837;653.7385045981607;668.1080757189152;41897.58102418975;46001;46410.303845442264;46477.07045859085;46642.533574664245;47358.28962565564;47404.76297618507;47632.76183619086;47895.76052119734;47920.52079479213;8862.069482704304;9018.053104424007;9072.455652660861;9079.863802042975;9081.863772043425;8933.55332233389;9062.229710474618;9078;9083.31875109366;9089.63641454341;9075.95462022689;9176.036516165806;9185.678501252458;9186.770330741752;9190.816183676323;8966.193042626162;9076.18314351705;9083.909160908372;9084.091590840862;9109.908900910972;8984.730458086267;9086.45481271126;9098.909010909872;9100.544972751402;9111.589978450986;43389;43483.34774978378;43483.78258108689;43844.56155438437;43926.78036609828;3743.494628225182;3856.768593884348;3859.826307816155;3894.3963685628773;4333.696641235115;33942.15144621379;35066.123346916276;35390;35446.29107417863;35461.468077978854;4663.860084197479;4773.9761301193275;4814.205656066745;4828.179209534353;4891.559759621616;364535.1773241143;368002;368382;368992;370008;66144.33855661478;66287.33712662908;66542.33457665361;66606.66696666485;66816.6659166701;39630.60369396327;39733.80133099316;40243.39634905479;42278.36582451266;42495;17847.196876140606;17917.910410447865;18032.188551515213;18037.18832652534;18073.27706891736;13670.453181872812;13771.931140344233;13785;13787.310634468236;13787.448502059806;21417.46456338604;21647.13411463524;21676.783232167792;21679.241226556995;21686.24098156557;7579.810504737316;7630.160682324939;7681.7695469136015;7799.220077992155;7841.372690184771;1028.141501845967;1078.4068762180768;1097.3470784882982;1167.0838391862517;1200.9759804803855;32820.83589582085;33005.339893202;33454;33755.66244337525;34562.48156277658;1148.7300484386162;1165.1028707894873;1195.6831439668495;1202.2666173634077;1261.873812618749;17055.82944170567;17657.735133973;17733.290668373378;17741.379051733387;17860;541673;607310;617404;645991;662594;60910;61353.69323153356;61874.69062654658;61933;61961.38038619646;1499.3477837140879;1504.9473268435552;1514.9394024239127;1516.6132636177924;1541.982291687481;32045.35909281848;32219;32448;32990.96794820543;32996.83501582477;53801.73099134479;53832.73083634557;54504.727476362365;54547.72726136503;54652;384965;386922;389361;389574;391239;30160.3967920636;30573.235669107562;30941.845290773403;30991.380172395973;31230.21924451907;49585;50288;50396;51070.74464627653;51335.74332128315;42572.78713606412;42710.57289427066;43417.91455213645;43447.565524344354;44219.77890110529;41826.37260441157;42938;43205.56794432015;43551;43666.56333436625;41742.37386439145;42093.57906421019;42433;42814.57185428106;42929.141417172104;36945.81527092347;37051.258974819815;37527.2494550102;37995;38412.42381364226;28467;28498;28518.287042823264;28711.282217944718;28846.278843029093 06:44:13 INFO - PROCESS | 22131 | |2;jquery.html;423.6376088445358;425.83179644040626;438.13687036538016;438.56801050964805;448.44840845759734;18295.26818927243;19191.904040479796;20126.798732012674;20170.798292017076;20287.695684564707;17200.39798607049;18909;19406;20292.89853550734;20346.18615255388;5639.99999999999;5829.970850145764;5878.1476685880525;5880.26496687914;5902.232709747726;4287.614114729674;5808.273965754281;5858.1505681676135;6344.524160687967;6633.237177724551;6530.706118224692;6630.93369066308;6646.8005959821285;6665.833354166136;6681.53229273951;6353.555251132422;6602.768903088417;6630.336966303379;6638.900416493757;6645.368689974444;5736.942630573724;5825.893080314727;5855.941440585582;5866.6480011199465;5876.941230587725;23704.762952370427;23963.161289354965;24306.513869722505;24397.26808195739;24458.388540286458;2436.7319594844553;2437.9390515237083;2484.3789052736815;2513.3339664988794;2544;10476.79046419075;10784.946075269574;12509.812352814715;13706.65733356674;14473.565793026226;2052.404802607242;2077.5013996640696;2117.2801247575744;2150.47313408216;2194.7256592925883;81610.59194704048;85103;85314.14685853124;85474.5726271371;85658.57170714169;11693;11708.824367634492;11751.588694395656;11815.291082535075;11921.642350729491;16535.586610334598;16650.916745416438;16669.166541673112;16698.749518757228;16734;8473.788155296044;8564.143585641386;8628.482291062557;8712.128787121364;8781.07798681142;8126.878096828552;8134.837303253902;8232.547209903392;8233.17668233184;8317.376196785266;4933.210686290248;5044.571211447068;5101.081805275012;5108.642395032312;5164.9741751291;1719.8280171982701;1728.075479618398;1816.9818301816813;1844.3176024870884;2108.725865637488;987.4618333008527;1036.8548403223556;1072.871255449351;1151.1711567671264;1176.9293842369486;18879.235534098752;19489.122989465508;19864.60270794576;19878.304259350854;20052;990.6978371596588;1002.8796544414716;1037.4086770540719;1066;1087.6181163252452;10825.891741082489;11089.27919685218;11215.551377944954;11259.155563332783;11263.380514071805;490781;494689;506695;508099;515560;88811.55594221987;89136.5543172293;89690.55154724185;89693;94172;1048.1195795531637;1104.86741591008;1115.7712668902855;1120.6357933671588;1129.548180727699;17115.400960966308;17227.65544689074;17703.468895933143;17829.375971840924;17943.73084403761;41266.1746765057;41394;41819.58180418279;41927.58072419237;43792.34311485394;54139;57027.42972570221;57260.71369643125;57858.421415785306;57928.13107803302;8820.2061814437;9089.227415669742;9267.860982085409;9323;9475.905240947503;13558.593242202749;13772.517961871286;13815.585532434043;13965.650858728613;14268.785968210277;12165.81751273714;12216.694582635506;12565.685857853627;12571.308578028296;12589.93705031469;12074.879251207376;12120.454579543766;12278.140530162802;12430;12640.55758048464;12531.812022819482;12541.122121451775;12618.936905315782;12714.809277861024;12730.299833509245;9283.62865485373;9345.626174952926;9366.906330936603;9413.81172376535;9423.151916327564;10410.739731506774;12388.81416778767;12492.437840297027;12554.748905021666;12609.117361784587 06:44:13 INFO - PROCESS | 22131 | |3;mootools.html;1573.8583527482529;1604.6870860182266;1816.8183181681825;1890.7688927066056;1922.8557858160632;8478.703245386398;9038.638454461814;9196.172344488994;9750.512474376279;9769.413835169886;9258.67594634188;9603.039696030412;9650.855237171449;9694.757631059227;9707.126358627722;2533.809964252684;2577.0336123953516;2581.238534632288;2581.2772423721294;2584.3926677230834;2488.925332240036;2524.3941454050987;2535.1253817432957;2537.3276081838326;2539.0478570536047;2549.992752862618;2579.793616510675;2603.7656610905015;2607.530644483992;2608.5304645163865;2498.525280196766;2544.6819147606548;2563.1797824696105;2567.7945764338806;2568.0498215660327;2512.69847618287;2516.3709072731817;2524.6465494830554;2542.2373288013705;2552.374668206283;9430.858537121949;9513.619455221851;9518.190953768937;9530.046995300483;9535.189508891752;5419;5646.40712725162;5652.74562644682;5655.858603534944;5668.461496157858;3515.33208690348;3577.767445116059;3591.102224443889;3606.531150950386;3747.850085996557;1213.1023042948154;1237.2020047069589;1245.0413181849924;1247.9126461147723;1258;12690.619281421572;13122.934385328012;13168;13495.66260843477;13549.39027743744;4873.707577545359;4881.755912204376;4954.033963377107;4975.4527002029745;4978.303037574742;10527.631532896312;10613.097886679565;10616.628418005334;10714.46427678613;10715.035646791826;5577.442255774471;5648.293963254593;5649.548036157097;5656.745446454919;5673.461021202979;4629.213033784265;5129.640925135204;5285.101532739443;5285.180796976475;5320.787168513293;4115.36211887158;4123.422720819088;4169.4162817205615;4191;4195.056112374752;1202.963911082669;1236.4065248680683;1244.4337826289018;1259.1563652352945;1261.0920137500984;970.2916870684298;1036.3522798251092;1076.956921723138;1105.850710154135;1107.2083460325905;6628;6792.76225332111;6831.146106736658;6831.351021653034;6858.3141685832015;498.10092782527886;498.99750501247263;500.9223570346602;503.33308366414644;507.17583926120057;4533.818647254139;4581.40441742578;4608.815647374067;4610.792514336863;4618.907621847611;11445.942770286096;11884.702882427835;11957.222780519412;11969.640910772516;11984.161108722481;11297.71755706114;11825.46785394642;11841.703957400961;11924.582639607572;12247.877521224851;8969.730908072768;9002.86495702565;9061.64075388697;9068.183863452321;9090.54547272647;6248.875022499616;6496.447801936699;6659.733610655713;6716.328367163244;6809.625470599165;10650.360978341325;10965.50655220533;10973.670789876316;11112.777744444904;11128.88871111311;11076.833847492455;11170.888291116984;11243.66269011931;11252.043576296106;11386.089112870784;8046.155153709011;8173.591320433836;8260.380471464785;8328.625211865601;8414.116517765546;9154.404963677605;9172.633094676405;9177.632894684139;9235.58439870194;9249.583768730288;8171.591420429074;8310.667573297;8325.916740832756;8387.916120838714;8389.916100838913;7642.8089297768;7793.688252469838;7832.608369581384;7842.764717058498;7893.250141236574;7489.962550187214;7528.473006889465;7532.133804612539;7598.0502437195355;7655.50239234448;5676.659400435987;5717.085266357363;5726.169705392612;5732.168835518743;5784.190213370216;5560.277163968658;5606.2431571738925;5696.943030569807;5745.080787074048;5829.417058294137 06:44:13 INFO - PROCESS | 22131 | |4;prototype.html;357.0716138041093;359.07000867752515;362.1832767110166;362.69352397224355;364.8212375935792;5765.567582431318;5781.190633311335;5800.5649576281785;5836.2996440427205;5837.766489340422;5659.811439597689;5753.597248192628;5763.250777398943;5776.249087618604;5802.955468015755;4491.708038977472;4515.029268707227;4515.683902126852;4529.796159172829;4535.410396648431;4430.955690443103;4461.754603496806;4502.411113609671;4506.233940230169;4525.705829121097;4484;4486.487566962495;4486.528914463967;4495.820167193308;4507.729536227836;4185.665146788249;4398.494173170095;4420.182266280748;4425.09285596452;4447.2439685253585;3867.361885288952;3881;3888.3972984187494;3889.2221555688693;3905.863294784669;5538.169274608841;5559.249501317311;5586.217929489874;5589.441055894418;5608.495235428831;4949.4060712714345;5063.8987220255385;5070.2141168119;5098.821541246076;5104.310918026056;5921.61509501881;5936.198613187251;5949.6727679977585;6002.969985150046;6022.819315420545;4281.357796330544;4295.506016808075;4301.44064281755;4307.353896915488;4322.805473753657;5993.460588547052;6057.757689692407;6151.72317245725;6296.527760417987;6327.715252813635;4321.2653848845775;4364.6944713869725;4371.715838470553;4374.650027997753;4387.561243875587;4368.650507959355;4387.890302742457;4443.666724995638;4447.599716025573;4449.332600109945;4925.87685307863;5052.332730199026;5084.898302033938;5085.0338435697095;5086.796528138833;5994.7602095916545;6039.667818270037;6067.878642427127;6087.786927457518;6105.992511235597;1528.4421186266932;1539.9384024639114;1541.3834466213605;1541.6916616676485;1545.2814441284856;939.6194541210821;972.8394814855469;973.7127547373542;982.2485798364257;1005.3515482513737;5188.792448302026;5213.556847667915;5240.9475905241225;5241.9213711794355;5257.369115706139;5488.313960754906;5507.642003269774;5549.195366671891;5558.583106267046;5572.3034620672415;4873.6832105913;5291.682499050069;5302.939412117592;5359.919601205985;5371.382291036581;2906.8691908864153;2982.8508574571183;2990.818626642464;2992.730654241129;3005.3989202159655;5700.144978253213;5715.2855893013375;5723.283015095455;5738.540916726652;5769.711514424262;5934.554908381889;6409.756585195238;6417.1657684500715;6434.356564343529;6441.3880681335195;6490.870182596322;6497.805065848032;6513.580370305533;6543.149390579194;6548.181477315431;6119.032269349451;6263.96868015657;6293.96853015732;6297.7089696613;6325.810225693236;6105.725242364016;6166.753329866755;6211.844703882259;6232.189815323979;6250.281217659845;6201.844953876189;6305.842353941188;6465.935340646533;6508.60948343101;6540.37866402691;4376.562343765598;4392.934105988476;4408.58118478744;4417.226985277499;4423.668224883082;6159.384061593805;6218.502519798315;6266.154069200782;6272.18461599989;6302.369763023661;6047.460066772054;6059.151718759289;6066.484348830399;6072.362401947732;6080.300765412034;6017.338092809875;6030.668313242813;6061.39373066129;6077.301110372364;6089.421504957022;5625.315418400954;6041;6054.39456054391;6064.575479716377;6064.909026364519;6112.32764395925;6185.319614842454;6192.349803270592;6199.008158694587;6229.1657295931145;5888.330942132991;5939.792107276225;6040.640855807408;6056.152138700673;6061.484773794277 06:44:13 INFO - PROCESS | 22131 | |5;yui.html;746.2052913646966;783.5377127494777;836.9958150209249;853.9103394143614;886.8891388576428;14871.479498217564;15339.079655220681;16365.427210047666;16676.249568769403;16702;15616.21918904056;15755.212239388042;15822.841771582282;15836.366545338173;15856.52430427089;724.7970568240901;875.1948207648946;898.0525545549443;898.7079199260234;902.3908861518481;881.4931414436693;883.5184824270788;883.7083762358407;884.8805411269493;887.3167660901103;911.6991392840347;916.1113719691888;918.0498184379169;918.1461241045824;919.0166521821653;908.5366463103799;909.5361365703473;910.203571874613;911.8085202107566;914.4878867834034;672.8116127484312;673.1787219592089;673.2728653054689;673.498243808361;675.4596322941627;14668.779968300483;14900.925495372454;14939.775903361458;14973.251337433085;15278.236088195546;15180.848191518164;16171.838281617269;16733.16334183298;16988.06565638902;17011.064391458465;13195.2742599157;13372.465101395932;13383.263920484369;13404.329783510786;13690.794638080437;4026.8187931542857;4094.303968325362;4172.436721042681;4174.060836311836;4229.936550951738;73886;74658.25341746568;75409.62295188488;76462.23537764607;76550.23449765486;12123.272603643809;12217.572384966483;12262.877371226174;12279.93860030712;12294.262344259372;21428.464288392915;21519.892400537898;21596.56806863854;21629.675554866688;21737.13051477923;8696.521691307038;8903.06517815633;8912.37613367071;9028.187463128219;9048.819023619491;5196.064708352533;5247.842564723064;5289.867753306198;5307.28351672527;5413.83758487246;3831.0613899594778;3957.3470377387985;3992.261431635157;3996.500437445319;3998.1204135090234;716.4161208614962;719.7265039285038;720.0747040053611;731.5574077682925;737.7676032049887;672.0356288725596;747.9439042071866;766.6473422225838;772.4091070331201;781.8084569280448;9227.90772092284;9375;9523.809523809485;9561.330706850593;9575.377600455948;723.6634964741421;772.9961350193325;776.8485145396706;796.1163108949062;797.0297029702971;4471.7987690554;4604.953950460453;4676.3453116563705;4692.6245900327895;4739;111044.4447777756;112752.87247127424;113281;114397;114760;68942.65528672324;98956;99900.5004974985;100593.49703251437;100679.49660251799;87345;87662;87877.56061219652;89733;89801.55099224593;8842.425242359226;8879.33404994615;9021.188093071392;9168.404053736485;9354.859677104712;53035.469645303056;53461.46538534565;53988.190177146585;54637.45362546483;56508.434915650316;67754.66122669356;76929.61535192512;77303.2269677296;78978.6051069741;80073.59963200147;11929.940350298193;13360.265185414895;13490.595282141552;13827.239501827496;13890.722185556435;15061;15125;15751.530219972388;15948.122853243183;16277.61640260591;14282.143071415749;14382.85617143857;14440.927795360956;14505;15265.160416176772;13996.16023038621;14377.856221437652;14693.92653036728;14894.03188792725;15573.454929077428;13759.243241621407;13817.585472435843;14508;14782.556523304318;14835;11456.312621242752;11845.170838041255;11943.940280298542;11970.700732481757;12300.753984920073;12426.254424734545;12504.437300321326;12530.373481325714;12781.680457988625;12847.293398863152 06:44:13 INFO - PROCESS | 22131 | __end_tp_report 06:44:13 INFO - PROCESS | 22131 | __start_cc_report 06:44:13 INFO - PROCESS | 22131 | _x_x_mozilla_cycle_collect,353 06:44:13 INFO - PROCESS | 22131 | __end_cc_report 06:44:13 INFO - PROCESS | 22131 | __startTimestamp1467035053490__endTimestamp 06:44:13 INFO - PROCESS | 22131 | 06:44:13 INFO - PROCESS | 22131 | ------- Summary: start ------- 06:44:13 INFO - PROCESS | 22131 | Number of tests: 6 06:44:13 INFO - PROCESS | 22131 | 06:44:13 INFO - PROCESS | 22131 | [#0] dojo.html Cycles:165 Average:5682.14 Median:5936.73 stddev:644.94 (10.9%) stddev-sans-first:620.96 06:44:13 INFO - PROCESS | 22131 | Values: 3373.2 3377.7 3406.9 3426.8 3427.5 5571.5 5580.9 5581.6 5642.2 5713.1 5665.0 5666.6 5679.1 5681.2 5713.3 5143.4 5181.1 5187.5 5192.2 5248.1 5081.8 5109.3 5208.3 5214.9 5251.1 5160.8 5176.5 5196.7 5208.3 5211.7 5202.0 5244.5 5264.9 5265.3 5275.4 5006.5 5132.2 5158.0 5223.0 5236.1 5430.2 5512.9 5540.0 5551.4 5552.8 6104.6 6124.8 6134.7 6147.6 6161.5 6158.4 6170.2 6206.5 6207.6 6220.3 5564.2 5603.7 5652.9 5785.4 5795.4 6268.3 6278.7 6284.0 6285.9 6291.4 5936.9 6045.0 6051.2 6052.5 6054.2 5910.3 6077.2 6123.8 6126.9 6156.5 6062.8 6104.4 6121.9 6139.2 6140.9 6078.4 6084.1 6099.8 6102.2 6111.9 4551.5 4572.7 4596.3 4651.6 4681.6 4154.8 4163.9 4165.2 4191.2 4202.6 5690.5 5963.0 5969.2 5986.5 6007.1 5933.6 5994.5 5996.4 6028.9 6049.4 5857.2 5860.2 5877.3 5927.7 5945.0 5132.8 5280.5 5289.6 5290.0 5308.7 6221.5 6268.8 6288.2 6371.8 6394.5 6160.0 6163.1 6167.0 6181.2 6183.0 6221.7 6228.1 6397.7 6404.1 6408.5 5935.3 6085.5 6090.4 6103.3 6121.7 6163.7 6176.9 6188.3 6198.7 6207.2 5804.9 5926.3 5975.8 6008.2 6043.3 5965.8 6031.7 6045.9 6068.4 6080.7 5897.2 5936.7 5949.9 5950.7 5961.3 5873.1 5876.4 5939.4 5944.3 6072.5 5922.6 5924.4 5927.7 5935.8 5940.1 06:44:13 INFO - PROCESS | 22131 | 06:44:13 INFO - PROCESS | 22131 | [#1] ext.html Cycles:180 Average:62387.91 Median:42762.57 stddev:125255.94 (292.9%) stddev-sans-first:125521.33 06:44:13 INFO - PROCESS | 22131 | Values: 572.5 632.6 648.8 653.7 668.1 41897.6 46001.0 46410.3 46477.1 46642.5 47358.3 47404.8 47632.8 47895.8 47920.5 8862.1 9018.1 9072.5 9079.9 9081.9 8933.6 9062.2 9078.0 9083.3 9089.6 9076.0 9176.0 9185.7 9186.8 9190.8 8966.2 9076.2 9083.9 9084.1 9109.9 8984.7 9086.5 9098.9 9100.5 9111.6 43389.0 43483.3 43483.8 43844.6 43926.8 3743.5 3856.8 3859.8 3894.4 4333.7 33942.2 35066.1 35390.0 35446.3 35461.5 4663.9 4774.0 4814.2 4828.2 4891.6 364535.2 368002.0 368382.0 368992.0 370008.0 66144.3 66287.3 66542.3 66606.7 66816.7 39630.6 39733.8 40243.4 42278.4 42495.0 17847.2 17917.9 18032.2 18037.2 18073.3 13670.5 13771.9 13785.0 13787.3 13787.4 21417.5 21647.1 21676.8 21679.2 21686.2 7579.8 7630.2 7681.8 7799.2 7841.4 1028.1 1078.4 1097.3 1167.1 1201.0 32820.8 33005.3 33454.0 33755.7 34562.5 1148.7 1165.1 1195.7 1202.3 1261.9 17055.8 17657.7 17733.3 17741.4 17860.0 541673.0 607310.0 617404.0 645991.0 662594.0 60910.0 61353.7 61874.7 61933.0 61961.4 1499.3 1504.9 1514.9 1516.6 1542.0 32045.4 32219.0 32448.0 32991.0 32996.8 53801.7 53832.7 54504.7 54547.7 54652.0 384965.0 386922.0 389361.0 389574.0 391239.0 30160.4 30573.2 30941.8 30991.4 31230.2 49585.0 50288.0 50396.0 51070.7 51335.7 42572.8 42710.6 43417.9 43447.6 44219.8 41826.4 42938.0 43205.6 43551.0 43666.6 41742.4 42093.6 42433.0 42814.6 42929.1 36945.8 37051.3 37527.2 37995.0 38412.4 28467.0 28498.0 28518.3 28711.3 28846.3 06:44:13 INFO - PROCESS | 22131 | 06:44:13 INFO - PROCESS | 22131 | [#2] jquery.html Cycles:180 Average:29825.01 Median:13371.62 stddev:82834.20 (619.5%) stddev-sans-first:83037.15 06:44:13 INFO - PROCESS | 22131 | Values: 423.6 425.8 438.1 438.6 448.4 18295.3 19191.9 20126.8 20170.8 20287.7 17200.4 18909.0 19406.0 20292.9 20346.2 5640.0 5830.0 5878.1 5880.3 5902.2 4287.6 5808.3 5858.2 6344.5 6633.2 6530.7 6630.9 6646.8 6665.8 6681.5 6353.6 6602.8 6630.3 6638.9 6645.4 5736.9 5825.9 5855.9 5866.6 5876.9 23704.8 23963.2 24306.5 24397.3 24458.4 2436.7 2437.9 2484.4 2513.3 2544.0 10476.8 10784.9 12509.8 13706.7 14473.6 2052.4 2077.5 2117.3 2150.5 2194.7 81610.6 85103.0 85314.1 85474.6 85658.6 11693.0 11708.8 11751.6 11815.3 11921.6 16535.6 16650.9 16669.2 16698.7 16734.0 8473.8 8564.1 8628.5 8712.1 8781.1 8126.9 8134.8 8232.5 8233.2 8317.4 4933.2 5044.6 5101.1 5108.6 5165.0 1719.8 1728.1 1817.0 1844.3 2108.7 987.5 1036.9 1072.9 1151.2 1176.9 18879.2 19489.1 19864.6 19878.3 20052.0 990.7 1002.9 1037.4 1066.0 1087.6 10825.9 11089.3 11215.6 11259.2 11263.4 490781.0 494689.0 506695.0 508099.0 515560.0 88811.6 89136.6 89690.6 89693.0 94172.0 1048.1 1104.9 1115.8 1120.6 1129.5 17115.4 17227.7 17703.5 17829.4 17943.7 41266.2 41394.0 41819.6 41927.6 43792.3 54139.0 57027.4 57260.7 57858.4 57928.1 8820.2 9089.2 9267.9 9323.0 9475.9 13558.6 13772.5 13815.6 13965.7 14268.8 12165.8 12216.7 12565.7 12571.3 12589.9 12074.9 12120.5 12278.1 12430.0 12640.6 12531.8 12541.1 12618.9 12714.8 12730.3 9283.6 9345.6 9366.9 9413.8 9423.2 10410.7 12388.8 12492.4 12554.7 12609.1 06:44:13 INFO - PROCESS | 22131 | 06:44:13 INFO - PROCESS | 22131 | [#3] mootools.html Cycles:180 Average:6256.48 Median:4877.73 stddev:3564.59 (73.1%) stddev-sans-first:3557.22 06:44:13 INFO - PROCESS | 22131 | Values: 1573.9 1604.7 1816.8 1890.8 1922.9 8478.7 9038.6 9196.2 9750.5 9769.4 9258.7 9603.0 9650.9 9694.8 9707.1 2533.8 2577.0 2581.2 2581.3 2584.4 2488.9 2524.4 2535.1 2537.3 2539.0 2550.0 2579.8 2603.8 2607.5 2608.5 2498.5 2544.7 2563.2 2567.8 2568.0 2512.7 2516.4 2524.6 2542.2 2552.4 9430.9 9513.6 9518.2 9530.0 9535.2 5419.0 5646.4 5652.7 5655.9 5668.5 3515.3 3577.8 3591.1 3606.5 3747.9 1213.1 1237.2 1245.0 1247.9 1258.0 12690.6 13122.9 13168.0 13495.7 13549.4 4873.7 4881.8 4954.0 4975.5 4978.3 10527.6 10613.1 10616.6 10714.5 10715.0 5577.4 5648.3 5649.5 5656.7 5673.5 4629.2 5129.6 5285.1 5285.2 5320.8 4115.4 4123.4 4169.4 4191.0 4195.1 1203.0 1236.4 1244.4 1259.2 1261.1 970.3 1036.4 1077.0 1105.9 1107.2 6628.0 6792.8 6831.1 6831.4 6858.3 498.1 499.0 500.9 503.3 507.2 4533.8 4581.4 4608.8 4610.8 4618.9 11445.9 11884.7 11957.2 11969.6 11984.2 11297.7 11825.5 11841.7 11924.6 12247.9 8969.7 9002.9 9061.6 9068.2 9090.5 6248.9 6496.4 6659.7 6716.3 6809.6 10650.4 10965.5 10973.7 11112.8 11128.9 11076.8 11170.9 11243.7 11252.0 11386.1 8046.2 8173.6 8260.4 8328.6 8414.1 9154.4 9172.6 9177.6 9235.6 9249.6 8171.6 8310.7 8325.9 8387.9 8389.9 7642.8 7793.7 7832.6 7842.8 7893.3 7490.0 7528.5 7532.1 7598.1 7655.5 5676.7 5717.1 5726.2 5732.2 5784.2 5560.3 5606.2 5696.9 5745.1 5829.4 06:44:13 INFO - PROCESS | 22131 | 06:44:13 INFO - PROCESS | 22131 | [#4] prototype.html Cycles:180 Average:5013.23 Median:5616.91 stddev:1495.07 (26.6%) stddev-sans-first:1457.85 06:44:13 INFO - PROCESS | 22131 | Values: 357.1 359.1 362.2 362.7 364.8 5765.6 5781.2 5800.6 5836.3 5837.8 5659.8 5753.6 5763.3 5776.2 5803.0 4491.7 4515.0 4515.7 4529.8 4535.4 4431.0 4461.8 4502.4 4506.2 4525.7 4484.0 4486.5 4486.5 4495.8 4507.7 4185.7 4398.5 4420.2 4425.1 4447.2 3867.4 3881.0 3888.4 3889.2 3905.9 5538.2 5559.2 5586.2 5589.4 5608.5 4949.4 5063.9 5070.2 5098.8 5104.3 5921.6 5936.2 5949.7 6003.0 6022.8 4281.4 4295.5 4301.4 4307.4 4322.8 5993.5 6057.8 6151.7 6296.5 6327.7 4321.3 4364.7 4371.7 4374.7 4387.6 4368.7 4387.9 4443.7 4447.6 4449.3 4925.9 5052.3 5084.9 5085.0 5086.8 5994.8 6039.7 6067.9 6087.8 6106.0 1528.4 1539.9 1541.4 1541.7 1545.3 939.6 972.8 973.7 982.2 1005.4 5188.8 5213.6 5240.9 5241.9 5257.4 5488.3 5507.6 5549.2 5558.6 5572.3 4873.7 5291.7 5302.9 5359.9 5371.4 2906.9 2982.9 2990.8 2992.7 3005.4 5700.1 5715.3 5723.3 5738.5 5769.7 5934.6 6409.8 6417.2 6434.4 6441.4 6490.9 6497.8 6513.6 6543.1 6548.2 6119.0 6264.0 6294.0 6297.7 6325.8 6105.7 6166.8 6211.8 6232.2 6250.3 6201.8 6305.8 6465.9 6508.6 6540.4 4376.6 4392.9 4408.6 4417.2 4423.7 6159.4 6218.5 6266.2 6272.2 6302.4 6047.5 6059.2 6066.5 6072.4 6080.3 6017.3 6030.7 6061.4 6077.3 6089.4 5625.3 6041.0 6054.4 6064.6 6064.9 6112.3 6185.3 6192.3 6199.0 6229.2 5888.3 5939.8 6040.6 6056.2 6061.5 06:44:13 INFO - PROCESS | 22131 | 06:44:13 INFO - PROCESS | 22131 | [#5] yui.html Cycles:180 Average:21157.60 Median:4715.81 stddev:29641.41 (628.6%) stddev-sans-first:29684.94 06:44:13 INFO - PROCESS | 22131 | Values: 746.2 783.5 837.0 853.9 886.9 14871.5 15339.1 16365.4 16676.2 16702.0 15616.2 15755.2 15822.8 15836.4 15856.5 724.8 875.2 898.1 898.7 902.4 881.5 883.5 883.7 884.9 887.3 911.7 916.1 918.0 918.1 919.0 908.5 909.5 910.2 911.8 914.5 672.8 673.2 673.3 673.5 675.5 14668.8 14900.9 14939.8 14973.3 15278.2 15180.8 16171.8 16733.2 16988.1 17011.1 13195.3 13372.5 13383.3 13404.3 13690.8 4026.8 4094.3 4172.4 4174.1 4229.9 73886.0 74658.3 75409.6 76462.2 76550.2 12123.3 12217.6 12262.9 12279.9 12294.3 21428.5 21519.9 21596.6 21629.7 21737.1 8696.5 8903.1 8912.4 9028.2 9048.8 5196.1 5247.8 5289.9 5307.3 5413.8 3831.1 3957.3 3992.3 3996.5 3998.1 716.4 719.7 720.1 731.6 737.8 672.0 747.9 766.6 772.4 781.8 9227.9 9375.0 9523.8 9561.3 9575.4 723.7 773.0 776.8 796.1 797.0 4471.8 4605.0 4676.3 4692.6 4739.0 111044.4 112752.9 113281.0 114397.0 114760.0 68942.7 98956.0 99900.5 100593.5 100679.5 87345.0 87662.0 87877.6 89733.0 89801.6 8842.4 8879.3 9021.2 9168.4 9354.9 53035.5 53461.5 53988.2 54637.5 56508.4 67754.7 76929.6 77303.2 78978.6 80073.6 11929.9 13360.3 13490.6 13827.2 13890.7 15061.0 15125.0 15751.5 15948.1 16277.6 14282.1 14382.9 14440.9 14505.0 15265.2 13996.2 14377.9 14693.9 14894.0 15573.5 13759.2 13817.6 14508.0 14782.6 14835.0 11456.3 11845.2 11943.9 11970.7 12300.8 12426.3 12504.4 12530.4 12781.7 12847.3 06:44:13 INFO - PROCESS | 22131 | -------- Summary: end -------- 06:44:13 INFO - PROCESS | 22131 | 06:44:14 INFO - TEST-INFO | 22131: exit 0 06:44:14 INFO - TEST-OK | dromaeo_css | took 1110415ms 06:44:14 INFO - TEST-START | kraken 06:44:14 INFO - operating with platform_type : linux_ 06:44:14 INFO - Initialising browser for kraken test... 06:44:14 INFO - TEST-INFO | started process 22377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6x6TPp/profile http://localhost:42104/getInfo.html) 06:44:18 INFO - PROCESS | 22377 | __metrics Screen width/height:1600/1200 06:44:18 INFO - PROCESS | 22377 | colorDepth:24 06:44:18 INFO - PROCESS | 22377 | Browser inner width/height: 1024/697 06:44:18 INFO - PROCESS | 22377 | __metrics 06:44:19 ERROR - PROCESS | 22377 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 06:44:20 INFO - TEST-INFO | 22377: exit 0 06:44:20 INFO - Browser initialized. 06:44:20 INFO - Running cycle 1/1 for kraken test... 06:44:20 INFO - TEST-INFO | started process 22505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6x6TPp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:44:32 INFO - PROCESS | 22505 | RSS: Main: 155873280 06:44:32 INFO - PROCESS | 22505 | 06:44:34 INFO - PROCESS | 22505 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42104/tests/kraken/driver.html?testName=audio-beat-detection) 06:44:35 INFO - PROCESS | 22505 | RSS: Main: 161050624 06:44:35 INFO - PROCESS | 22505 | 06:44:38 INFO - PROCESS | 22505 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42104/tests/kraken/driver.html?testName=audio-dft) 06:44:38 INFO - PROCESS | 22505 | RSS: Main: 160378880 06:44:38 INFO - PROCESS | 22505 | 06:44:41 INFO - PROCESS | 22505 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42104/tests/kraken/driver.html?testName=audio-fft) 06:44:42 INFO - PROCESS | 22505 | RSS: Main: 161058816 06:44:42 INFO - PROCESS | 22505 | 06:44:44 INFO - PROCESS | 22505 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42104/tests/kraken/driver.html?testName=audio-oscillator) 06:44:44 INFO - PROCESS | 22505 | RSS: Main: 160845824 06:44:44 INFO - PROCESS | 22505 | 06:44:47 INFO - PROCESS | 22505 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42104/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:44:47 INFO - PROCESS | 22505 | RSS: Main: 160759808 06:44:47 INFO - PROCESS | 22505 | 06:44:50 INFO - PROCESS | 22505 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42104/tests/kraken/driver.html?testName=imaging-darkroom) 06:44:51 INFO - PROCESS | 22505 | RSS: Main: 160788480 06:44:51 INFO - PROCESS | 22505 | 06:44:54 INFO - PROCESS | 22505 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42104/tests/kraken/driver.html?testName=imaging-desaturate) 06:44:55 INFO - PROCESS | 22505 | RSS: Main: 161468416 06:44:55 INFO - PROCESS | 22505 | 06:44:58 INFO - PROCESS | 22505 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42104/tests/kraken/driver.html?testName=json-parse-financial) 06:44:58 INFO - PROCESS | 22505 | RSS: Main: 160882688 06:44:58 INFO - PROCESS | 22505 | 06:45:00 INFO - PROCESS | 22505 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42104/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:45:00 INFO - PROCESS | 22505 | RSS: Main: 161243136 06:45:00 INFO - PROCESS | 22505 | 06:45:02 INFO - PROCESS | 22505 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:45:03 INFO - PROCESS | 22505 | RSS: Main: 161230848 06:45:03 INFO - PROCESS | 22505 | 06:45:05 INFO - PROCESS | 22505 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:45:06 INFO - PROCESS | 22505 | RSS: Main: 161570816 06:45:06 INFO - PROCESS | 22505 | 06:45:08 INFO - PROCESS | 22505 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:45:09 INFO - PROCESS | 22505 | RSS: Main: 161484800 06:45:09 INFO - PROCESS | 22505 | 06:45:11 INFO - PROCESS | 22505 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:45:12 INFO - PROCESS | 22505 | RSS: Main: 161181696 06:45:12 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | Cycle 1(1): loaded http://localhost:42104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42104/tests/kraken/driver.html?testName=ai-astar) 06:45:14 INFO - PROCESS | 22505 | RSS: Main: 162095104 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | __start_tp_report 06:45:14 INFO - PROCESS | 22505 | _x_x_mozilla_page_load 06:45:14 INFO - PROCESS | 22505 | _x_x_mozilla_page_load_details 06:45:14 INFO - PROCESS | 22505 | |i|pagename|runs| 06:45:14 INFO - PROCESS | 22505 | |0;ai-astar;111;105;110;110;111;111;110;112;110;112 06:45:14 INFO - PROCESS | 22505 | |1;audio-beat-detection;159;135;155;174;126;158;151;125;190;125 06:45:14 INFO - PROCESS | 22505 | |2;audio-dft;162;162;162;162;165;161;162;162;164;162 06:45:14 INFO - PROCESS | 22505 | |3;audio-fft;74;76;75;178;75;76;76;75;172;76 06:45:14 INFO - PROCESS | 22505 | |4;audio-oscillator;87;88;146;85;87;88;152;87;87;142 06:45:14 INFO - PROCESS | 22505 | |5;imaging-gaussian-blur;119;117;118;117;118;117;118;117;119;118 06:45:14 INFO - PROCESS | 22505 | |6;imaging-darkroom;146;147;147;146;146;150;146;151;147;147 06:45:14 INFO - PROCESS | 22505 | |7;imaging-desaturate;97;96;97;97;96;96;96;95;95;95 06:45:14 INFO - PROCESS | 22505 | |8;json-parse-financial;51;55;53;52;56;52;54;52;55;54 06:45:14 INFO - PROCESS | 22505 | |9;json-stringify-tinderbox;60;60;63;61;60;60;60;61;66;61 06:45:14 INFO - PROCESS | 22505 | |10;stanford-crypto-aes;77;80;79;76;81;78;80;77;105;86 06:45:14 INFO - PROCESS | 22505 | |11;stanford-crypto-ccm;128;128;122;139;123;133;126;122;129;136 06:45:14 INFO - PROCESS | 22505 | |12;stanford-crypto-pbkdf2;158;169;158;160;163;161;158;164;155;156 06:45:14 INFO - PROCESS | 22505 | |13;stanford-crypto-sha256-iterative;63;64;67;62;62;68;65;66;64;65 06:45:14 INFO - PROCESS | 22505 | __end_tp_report 06:45:14 INFO - PROCESS | 22505 | __start_cc_report 06:45:14 INFO - PROCESS | 22505 | _x_x_mozilla_cycle_collect,861 06:45:14 INFO - PROCESS | 22505 | __end_cc_report 06:45:14 INFO - PROCESS | 22505 | __startTimestamp1467035114538__endTimestamp 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | ------- Summary: start ------- 06:45:14 INFO - PROCESS | 22505 | Number of tests: 14 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.99 (1.8%) stddev-sans-first:2.09 06:45:14 INFO - PROCESS | 22505 | Values: 111.0 105.0 110.0 110.0 111.0 111.0 110.0 112.0 110.0 112.0 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:156.50 stddev:22.10 (14.1%) stddev-sans-first:23.19 06:45:14 INFO - PROCESS | 22505 | Values: 159.0 135.0 155.0 174.0 126.0 158.0 151.0 125.0 190.0 125.0 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 06:45:14 INFO - PROCESS | 22505 | Values: 162.0 162.0 162.0 162.0 165.0 161.0 162.0 162.0 164.0 162.0 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.50 stddev:42.03 (55.7%) stddev-sans-first:43.87 06:45:14 INFO - PROCESS | 22505 | Values: 74.0 76.0 75.0 178.0 75.0 76.0 76.0 75.0 172.0 76.0 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:87.00 stddev:28.93 (33.3%) stddev-sans-first:29.95 06:45:14 INFO - PROCESS | 22505 | Values: 87.0 88.0 146.0 85.0 87.0 88.0 152.0 87.0 87.0 142.0 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 06:45:14 INFO - PROCESS | 22505 | Values: 119.0 117.0 118.0 117.0 118.0 117.0 118.0 117.0 119.0 118.0 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.77 (1.2%) stddev-sans-first:1.81 06:45:14 INFO - PROCESS | 22505 | Values: 146.0 147.0 147.0 146.0 146.0 150.0 146.0 151.0 147.0 147.0 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 06:45:14 INFO - PROCESS | 22505 | Values: 97.0 96.0 97.0 97.0 96.0 96.0 96.0 95.0 95.0 95.0 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:54.00 stddev:1.65 (3.0%) stddev-sans-first:1.50 06:45:14 INFO - PROCESS | 22505 | Values: 51.0 55.0 53.0 52.0 56.0 52.0 54.0 52.0 55.0 54.0 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:1.93 (3.2%) stddev-sans-first:2.00 06:45:14 INFO - PROCESS | 22505 | Values: 60.0 60.0 63.0 61.0 60.0 60.0 60.0 61.0 66.0 61.0 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:79.50 stddev:8.60 (10.8%) stddev-sans-first:8.93 06:45:14 INFO - PROCESS | 22505 | Values: 77.0 80.0 79.0 76.0 81.0 78.0 80.0 77.0 105.0 86.0 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:128.50 stddev:5.85 (4.6%) stddev-sans-first:6.20 06:45:14 INFO - PROCESS | 22505 | Values: 128.0 128.0 122.0 139.0 123.0 133.0 126.0 122.0 129.0 136.0 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.50 stddev:4.21 (2.6%) stddev-sans-first:4.39 06:45:14 INFO - PROCESS | 22505 | Values: 158.0 169.0 158.0 160.0 163.0 161.0 158.0 164.0 155.0 156.0 06:45:14 INFO - PROCESS | 22505 | 06:45:14 INFO - PROCESS | 22505 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:2.01 (3.1%) stddev-sans-first:2.05 06:45:14 INFO - PROCESS | 22505 | Values: 63.0 64.0 67.0 62.0 62.0 68.0 65.0 66.0 64.0 65.0 06:45:14 INFO - PROCESS | 22505 | -------- Summary: end -------- 06:45:14 INFO - PROCESS | 22505 | 06:45:15 INFO - TEST-INFO | 22505: exit 0 06:45:15 INFO - TEST-OK | kraken | took 61308ms 06:45:15 INFO - SUITE-END | took 1171s 06:45:15 INFO - Completed test suite (00:19:31) 06:45:15 INFO - javascript benchmark 06:45:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7680.021342933018, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3373.173572474744, 3377.746668999825, 3406.9148271293216, 3426.828658567071, 3427.503012063251, 5571.498565129143, 5580.888382232358, 5581.581381396396, 5642.181883626871, 5713.057345537981, 5664.971675141629, 5666.631668941516, 5679.062954612484, 5681.176229446728, 5713.342965558962, 5143.434222235551, 5181.145111056671, 5187.507186817246, 5192.221166824987, 5248.134057880445, 5081.79672813087, 5109.3357863477695, 5208.348956380452, 5214.921776173361, 5251.054810134175, 5160.793568257284, 5176.5341119299255, 5196.740162991854, 5208.270842082112, 5211.687298762067, 5201.973990130063, 5244.475552444763, 5264.947350526484, 5265.289185959885, 5275.419703832576, 5006.549410553068, 5132.178851383761, 5158.019976204547, 5222.97388513055, 5236.136037553799, 5430.185472179165, 5512.91730624041, 5540.0, 5551.3893471718075, 5552.77788888444, 6104.572679912408, 6124.816255512342, 6134.723937422827, 6147.631142131487, 6161.50707943368, 6158.3841615838055, 6170.167027451326, 6206.472449841769, 6207.596506227081, 6220.284667263232, 5564.165375193753, 5603.691796951166, 5652.943470565283, 5785.421457854223, 5795.362510123883, 6268.310485846553, 6278.6860656966965, 6283.968580157161, 6285.937140628626, 6291.370862913672, 5936.851578710481, 6045.0, 6051.243594550681, 6052.485538729257, 6054.212952316171, 5910.290765108214, 6077.179580756541, 6123.801220575414, 6126.877462450726, 6156.538259630545, 6062.848428789227, 6104.420080092473, 6121.868307950349, 6139.154842350747, 6140.8771824563255, 6078.422549857756, 6084.148219249309, 6099.8475038123515, 6102.176206212193, 6111.908321375183, 4551.544845515488, 4572.725636461823, 4596.264597664424, 4651.62786977041, 4681.578657920803, 4154.833806647761, 4163.916721665611, 4165.229432554987, 4191.224623444611, 4202.579742025773, 5690.5163061140265, 5963.0, 5969.2240008799445, 5986.461218490357, 6007.128966299862, 5933.643981361132, 5994.460498555151, 5996.430339117864, 6028.909566356509, 6049.3950604939155, 5857.238558987305, 5860.179574859523, 5877.324107727666, 5927.73325200367, 5945.048792193228, 5132.8460146195675, 5280.498352656491, 5289.629725919226, 5290.047791397508, 5308.734563271898, 6221.502279817604, 6268.811935641938, 6288.213973253343, 6371.808845734636, 6394.4564712, 6160.0, 6163.075538669146, 6167.0, 6181.1655426516845, 6182.969085154546, 6221.688915554295, 6228.065790131516, 6397.744090236339, 6404.135441715309, 6408.455281301141, 5935.317438494629, 6085.543584231289, 6090.3605121461605, 6103.328633850362, 6121.724522396592, 6163.741523733617, 6176.9073463897175, 6188.288346840171, 6198.690065496798, 6207.193064901534, 5804.883902321845, 5926.318473375617, 5975.820725378246, 6008.188894499187, 6043.2748070231855, 5965.761369545169, 6031.698415079316, 6045.939540604713, 6068.362821903813, 6080.665563394055, 5897.233359663216, 5936.732847021808, 5949.940500595112, 5950.672713000827, 5961.254843144607, 5873.119032145041, 5876.44173803488, 5939.4357536034, 5944.3164036136395, 6072.514198864169, 5922.555808314308, 5924.437178468039, 5927.673977931083, 5935.762569497172, 5940.138679891305], "value": 5639.298555257423, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.4504475703325, 632.6488798716716, 648.7761722205837, 653.7385045981607, 668.1080757189152, 41897.58102418975, 46001.0, 46410.303845442264, 46477.07045859085, 46642.533574664245, 47358.28962565564, 47404.76297618507, 47632.76183619086, 47895.76052119734, 47920.52079479213, 8862.069482704304, 9018.053104424007, 9072.455652660861, 9079.863802042975, 9081.863772043425, 8933.55332233389, 9062.229710474618, 9078.0, 9083.31875109366, 9089.63641454341, 9075.95462022689, 9176.036516165806, 9185.678501252458, 9186.770330741752, 9190.816183676323, 8966.193042626162, 9076.18314351705, 9083.909160908372, 9084.091590840862, 9109.908900910972, 8984.730458086267, 9086.45481271126, 9098.909010909872, 9100.544972751402, 9111.589978450986, 43389.0, 43483.34774978378, 43483.78258108689, 43844.56155438437, 43926.78036609828, 3743.494628225182, 3856.768593884348, 3859.826307816155, 3894.3963685628773, 4333.696641235115, 33942.15144621379, 35066.123346916276, 35390.0, 35446.29107417863, 35461.468077978854, 4663.860084197479, 4773.9761301193275, 4814.205656066745, 4828.179209534353, 4891.559759621616, 364535.1773241143, 368002.0, 368382.0, 368992.0, 370008.0, 66144.33855661478, 66287.33712662908, 66542.33457665361, 66606.66696666485, 66816.6659166701, 39630.60369396327, 39733.80133099316, 40243.39634905479, 42278.36582451266, 42495.0, 17847.196876140606, 17917.910410447865, 18032.188551515213, 18037.18832652534, 18073.27706891736, 13670.453181872812, 13771.931140344233, 13785.0, 13787.310634468236, 13787.448502059806, 21417.46456338604, 21647.13411463524, 21676.783232167792, 21679.241226556995, 21686.24098156557, 7579.810504737316, 7630.160682324939, 7681.7695469136015, 7799.220077992155, 7841.372690184771, 1028.141501845967, 1078.4068762180768, 1097.3470784882982, 1167.0838391862517, 1200.9759804803855, 32820.83589582085, 33005.339893202, 33454.0, 33755.66244337525, 34562.48156277658, 1148.7300484386162, 1165.1028707894873, 1195.6831439668495, 1202.2666173634077, 1261.873812618749, 17055.82944170567, 17657.735133973, 17733.290668373378, 17741.379051733387, 17860.0, 541673.0, 607310.0, 617404.0, 645991.0, 662594.0, 60910.0, 61353.69323153356, 61874.69062654658, 61933.0, 61961.38038619646, 1499.3477837140879, 1504.9473268435552, 1514.9394024239127, 1516.6132636177924, 1541.982291687481, 32045.35909281848, 32219.0, 32448.0, 32990.96794820543, 32996.83501582477, 53801.73099134479, 53832.73083634557, 54504.727476362365, 54547.72726136503, 54652.0, 384965.0, 386922.0, 389361.0, 389574.0, 391239.0, 30160.3967920636, 30573.235669107562, 30941.845290773403, 30991.380172395973, 31230.21924451907, 49585.0, 50288.0, 50396.0, 51070.74464627653, 51335.74332128315, 42572.78713606412, 42710.57289427066, 43417.91455213645, 43447.565524344354, 44219.77890110529, 41826.37260441157, 42938.0, 43205.56794432015, 43551.0, 43666.56333436625, 41742.37386439145, 42093.57906421019, 42433.0, 42814.57185428106, 42929.141417172104, 36945.81527092347, 37051.258974819815, 37527.2494550102, 37995.0, 38412.42381364226, 28467.0, 28498.0, 28518.287042823264, 28711.282217944718, 28846.278843029093], "value": 21022.958899351754, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.6376088445358, 425.83179644040626, 438.13687036538016, 438.56801050964805, 448.44840845759734, 18295.26818927243, 19191.904040479796, 20126.798732012674, 20170.798292017076, 20287.695684564707, 17200.39798607049, 18909.0, 19406.0, 20292.89853550734, 20346.18615255388, 5639.99999999999, 5829.970850145764, 5878.1476685880525, 5880.26496687914, 5902.232709747726, 4287.614114729674, 5808.273965754281, 5858.1505681676135, 6344.524160687967, 6633.237177724551, 6530.706118224692, 6630.93369066308, 6646.8005959821285, 6665.833354166136, 6681.53229273951, 6353.555251132422, 6602.768903088417, 6630.336966303379, 6638.900416493757, 6645.368689974444, 5736.942630573724, 5825.893080314727, 5855.941440585582, 5866.6480011199465, 5876.941230587725, 23704.762952370427, 23963.161289354965, 24306.513869722505, 24397.26808195739, 24458.388540286458, 2436.7319594844553, 2437.9390515237083, 2484.3789052736815, 2513.3339664988794, 2544.0, 10476.79046419075, 10784.946075269574, 12509.812352814715, 13706.65733356674, 14473.565793026226, 2052.404802607242, 2077.5013996640696, 2117.2801247575744, 2150.47313408216, 2194.7256592925883, 81610.59194704048, 85103.0, 85314.14685853124, 85474.5726271371, 85658.57170714169, 11693.0, 11708.824367634492, 11751.588694395656, 11815.291082535075, 11921.642350729491, 16535.586610334598, 16650.916745416438, 16669.166541673112, 16698.749518757228, 16734.0, 8473.788155296044, 8564.143585641386, 8628.482291062557, 8712.128787121364, 8781.07798681142, 8126.878096828552, 8134.837303253902, 8232.547209903392, 8233.17668233184, 8317.376196785266, 4933.210686290248, 5044.571211447068, 5101.081805275012, 5108.642395032312, 5164.9741751291, 1719.8280171982701, 1728.075479618398, 1816.9818301816813, 1844.3176024870884, 2108.725865637488, 987.4618333008527, 1036.8548403223556, 1072.871255449351, 1151.1711567671264, 1176.9293842369486, 18879.235534098752, 19489.122989465508, 19864.60270794576, 19878.304259350854, 20052.0, 990.6978371596588, 1002.8796544414716, 1037.4086770540719, 1066.0, 1087.6181163252452, 10825.891741082489, 11089.27919685218, 11215.551377944954, 11259.155563332783, 11263.380514071805, 490781.0, 494689.0, 506695.0, 508099.0, 515560.0, 88811.55594221987, 89136.5543172293, 89690.55154724185, 89693.0, 94172.0, 1048.1195795531637, 1104.86741591008, 1115.7712668902855, 1120.6357933671588, 1129.548180727699, 17115.400960966308, 17227.65544689074, 17703.468895933143, 17829.375971840924, 17943.73084403761, 41266.1746765057, 41394.0, 41819.58180418279, 41927.58072419237, 43792.34311485394, 54139.0, 57027.42972570221, 57260.71369643125, 57858.421415785306, 57928.13107803302, 8820.2061814437, 9089.227415669742, 9267.860982085409, 9323.0, 9475.905240947503, 13558.593242202749, 13772.517961871286, 13815.585532434043, 13965.650858728613, 14268.785968210277, 12165.81751273714, 12216.694582635506, 12565.685857853627, 12571.308578028296, 12589.93705031469, 12074.879251207376, 12120.454579543766, 12278.140530162802, 12430.0, 12640.55758048464, 12531.812022819482, 12541.122121451775, 12618.936905315782, 12714.809277861024, 12730.299833509245, 9283.62865485373, 9345.626174952926, 9366.906330936603, 9413.81172376535, 9423.151916327564, 10410.739731506774, 12388.81416778767, 12492.437840297027, 12554.748905021666, 12609.117361784587], "value": 9715.396935004006, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1573.8583527482529, 1604.6870860182266, 1816.8183181681825, 1890.7688927066056, 1922.8557858160632, 8478.703245386398, 9038.638454461814, 9196.172344488994, 9750.512474376279, 9769.413835169886, 9258.67594634188, 9603.039696030412, 9650.855237171449, 9694.757631059227, 9707.126358627722, 2533.809964252684, 2577.0336123953516, 2581.238534632288, 2581.2772423721294, 2584.3926677230834, 2488.925332240036, 2524.3941454050987, 2535.1253817432957, 2537.3276081838326, 2539.0478570536047, 2549.992752862618, 2579.793616510675, 2603.7656610905015, 2607.530644483992, 2608.5304645163865, 2498.525280196766, 2544.6819147606548, 2563.1797824696105, 2567.7945764338806, 2568.0498215660327, 2512.69847618287, 2516.3709072731817, 2524.6465494830554, 2542.2373288013705, 2552.374668206283, 9430.858537121949, 9513.619455221851, 9518.190953768937, 9530.046995300483, 9535.189508891752, 5419.0, 5646.40712725162, 5652.74562644682, 5655.858603534944, 5668.461496157858, 3515.33208690348, 3577.767445116059, 3591.102224443889, 3606.531150950386, 3747.850085996557, 1213.1023042948154, 1237.2020047069589, 1245.0413181849924, 1247.9126461147723, 1258.0, 12690.619281421572, 13122.934385328012, 13168.0, 13495.66260843477, 13549.39027743744, 4873.707577545359, 4881.755912204376, 4954.033963377107, 4975.4527002029745, 4978.303037574742, 10527.631532896312, 10613.097886679565, 10616.628418005334, 10714.46427678613, 10715.035646791826, 5577.442255774471, 5648.293963254593, 5649.548036157097, 5656.745446454919, 5673.461021202979, 4629.213033784265, 5129.640925135204, 5285.101532739443, 5285.180796976475, 5320.787168513293, 4115.36211887158, 4123.422720819088, 4169.4162817205615, 4191.0, 4195.056112374752, 1202.963911082669, 1236.4065248680683, 1244.4337826289018, 1259.1563652352945, 1261.0920137500984, 970.2916870684298, 1036.3522798251092, 1076.956921723138, 1105.850710154135, 1107.2083460325905, 6628.0, 6792.76225332111, 6831.146106736658, 6831.351021653034, 6858.3141685832015, 498.10092782527886, 498.99750501247263, 500.9223570346602, 503.33308366414644, 507.17583926120057, 4533.818647254139, 4581.40441742578, 4608.815647374067, 4610.792514336863, 4618.907621847611, 11445.942770286096, 11884.702882427835, 11957.222780519412, 11969.640910772516, 11984.161108722481, 11297.71755706114, 11825.46785394642, 11841.703957400961, 11924.582639607572, 12247.877521224851, 8969.730908072768, 9002.86495702565, 9061.64075388697, 9068.183863452321, 9090.54547272647, 6248.875022499616, 6496.447801936699, 6659.733610655713, 6716.328367163244, 6809.625470599165, 10650.360978341325, 10965.50655220533, 10973.670789876316, 11112.777744444904, 11128.88871111311, 11076.833847492455, 11170.888291116984, 11243.66269011931, 11252.043576296106, 11386.089112870784, 8046.155153709011, 8173.591320433836, 8260.380471464785, 8328.625211865601, 8414.116517765546, 9154.404963677605, 9172.633094676405, 9177.632894684139, 9235.58439870194, 9249.583768730288, 8171.591420429074, 8310.667573297, 8325.916740832756, 8387.916120838714, 8389.916100838913, 7642.8089297768, 7793.688252469838, 7832.608369581384, 7842.764717058498, 7893.250141236574, 7489.962550187214, 7528.473006889465, 7532.133804612539, 7598.0502437195355, 7655.50239234448, 5676.659400435987, 5717.085266357363, 5726.169705392612, 5732.168835518743, 5784.190213370216, 5560.277163968658, 5606.2431571738925, 5696.943030569807, 5745.080787074048, 5829.417058294137], "value": 4928.121955784756, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.0716138041093, 359.07000867752515, 362.1832767110166, 362.69352397224355, 364.8212375935792, 5765.567582431318, 5781.190633311335, 5800.5649576281785, 5836.2996440427205, 5837.766489340422, 5659.811439597689, 5753.597248192628, 5763.250777398943, 5776.249087618604, 5802.955468015755, 4491.708038977472, 4515.029268707227, 4515.683902126852, 4529.796159172829, 4535.410396648431, 4430.955690443103, 4461.754603496806, 4502.411113609671, 4506.233940230169, 4525.705829121097, 4484.0, 4486.487566962495, 4486.528914463967, 4495.820167193308, 4507.729536227836, 4185.665146788249, 4398.494173170095, 4420.182266280748, 4425.09285596452, 4447.2439685253585, 3867.361885288952, 3881.0, 3888.3972984187494, 3889.2221555688693, 3905.863294784669, 5538.169274608841, 5559.249501317311, 5586.217929489874, 5589.441055894418, 5608.495235428831, 4949.4060712714345, 5063.8987220255385, 5070.2141168119, 5098.821541246076, 5104.310918026056, 5921.61509501881, 5936.198613187251, 5949.6727679977585, 6002.969985150046, 6022.819315420545, 4281.357796330544, 4295.506016808075, 4301.44064281755, 4307.353896915488, 4322.805473753657, 5993.460588547052, 6057.757689692407, 6151.72317245725, 6296.527760417987, 6327.715252813635, 4321.2653848845775, 4364.6944713869725, 4371.715838470553, 4374.650027997753, 4387.561243875587, 4368.650507959355, 4387.890302742457, 4443.666724995638, 4447.599716025573, 4449.332600109945, 4925.87685307863, 5052.332730199026, 5084.898302033938, 5085.0338435697095, 5086.796528138833, 5994.7602095916545, 6039.667818270037, 6067.878642427127, 6087.786927457518, 6105.992511235597, 1528.4421186266932, 1539.9384024639114, 1541.3834466213605, 1541.6916616676485, 1545.2814441284856, 939.6194541210821, 972.8394814855469, 973.7127547373542, 982.2485798364257, 1005.3515482513737, 5188.792448302026, 5213.556847667915, 5240.9475905241225, 5241.9213711794355, 5257.369115706139, 5488.313960754906, 5507.642003269774, 5549.195366671891, 5558.583106267046, 5572.3034620672415, 4873.6832105913, 5291.682499050069, 5302.939412117592, 5359.919601205985, 5371.382291036581, 2906.8691908864153, 2982.8508574571183, 2990.818626642464, 2992.730654241129, 3005.3989202159655, 5700.144978253213, 5715.2855893013375, 5723.283015095455, 5738.540916726652, 5769.711514424262, 5934.554908381889, 6409.756585195238, 6417.1657684500715, 6434.356564343529, 6441.3880681335195, 6490.870182596322, 6497.805065848032, 6513.580370305533, 6543.149390579194, 6548.181477315431, 6119.032269349451, 6263.96868015657, 6293.96853015732, 6297.7089696613, 6325.810225693236, 6105.725242364016, 6166.753329866755, 6211.844703882259, 6232.189815323979, 6250.281217659845, 6201.844953876189, 6305.842353941188, 6465.935340646533, 6508.60948343101, 6540.37866402691, 4376.562343765598, 4392.934105988476, 4408.58118478744, 4417.226985277499, 4423.668224883082, 6159.384061593805, 6218.502519798315, 6266.154069200782, 6272.18461599989, 6302.369763023661, 6047.460066772054, 6059.151718759289, 6066.484348830399, 6072.362401947732, 6080.300765412034, 6017.338092809875, 6030.668313242813, 6061.39373066129, 6077.301110372364, 6089.421504957022, 5625.315418400954, 6041.0, 6054.39456054391, 6064.575479716377, 6064.909026364519, 6112.32764395925, 6185.319614842454, 6192.349803270592, 6199.008158694587, 6229.1657295931145, 5888.330942132991, 5939.792107276225, 6040.640855807408, 6056.152138700673, 6061.484773794277], "value": 4536.231812740164, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.2052913646966, 783.5377127494777, 836.9958150209249, 853.9103394143614, 886.8891388576428, 14871.479498217564, 15339.079655220681, 16365.427210047666, 16676.249568769403, 16702.0, 15616.21918904056, 15755.212239388042, 15822.841771582282, 15836.366545338173, 15856.52430427089, 724.7970568240901, 875.1948207648946, 898.0525545549443, 898.7079199260234, 902.3908861518481, 881.4931414436693, 883.5184824270788, 883.7083762358407, 884.8805411269493, 887.3167660901103, 911.6991392840347, 916.1113719691888, 918.0498184379169, 918.1461241045824, 919.0166521821653, 908.5366463103799, 909.5361365703473, 910.203571874613, 911.8085202107566, 914.4878867834034, 672.8116127484312, 673.1787219592089, 673.2728653054689, 673.498243808361, 675.4596322941627, 14668.779968300483, 14900.925495372454, 14939.775903361458, 14973.251337433085, 15278.236088195546, 15180.848191518164, 16171.838281617269, 16733.16334183298, 16988.06565638902, 17011.064391458465, 13195.2742599157, 13372.465101395932, 13383.263920484369, 13404.329783510786, 13690.794638080437, 4026.8187931542857, 4094.303968325362, 4172.436721042681, 4174.060836311836, 4229.936550951738, 73886.0, 74658.25341746568, 75409.62295188488, 76462.23537764607, 76550.23449765486, 12123.272603643809, 12217.572384966483, 12262.877371226174, 12279.93860030712, 12294.262344259372, 21428.464288392915, 21519.892400537898, 21596.56806863854, 21629.675554866688, 21737.13051477923, 8696.521691307038, 8903.06517815633, 8912.37613367071, 9028.187463128219, 9048.819023619491, 5196.064708352533, 5247.842564723064, 5289.867753306198, 5307.28351672527, 5413.83758487246, 3831.0613899594778, 3957.3470377387985, 3992.261431635157, 3996.500437445319, 3998.1204135090234, 716.4161208614962, 719.7265039285038, 720.0747040053611, 731.5574077682925, 737.7676032049887, 672.0356288725596, 747.9439042071866, 766.6473422225838, 772.4091070331201, 781.8084569280448, 9227.90772092284, 9375.0, 9523.809523809485, 9561.330706850593, 9575.377600455948, 723.6634964741421, 772.9961350193325, 776.8485145396706, 796.1163108949062, 797.0297029702971, 4471.7987690554, 4604.953950460453, 4676.3453116563705, 4692.6245900327895, 4739.0, 111044.4447777756, 112752.87247127424, 113281.0, 114397.0, 114760.0, 68942.65528672324, 98956.0, 99900.5004974985, 100593.49703251437, 100679.49660251799, 87345.0, 87662.0, 87877.56061219652, 89733.0, 89801.55099224593, 8842.425242359226, 8879.33404994615, 9021.188093071392, 9168.404053736485, 9354.859677104712, 53035.469645303056, 53461.46538534565, 53988.190177146585, 54637.45362546483, 56508.434915650316, 67754.66122669356, 76929.61535192512, 77303.2269677296, 78978.6051069741, 80073.59963200147, 11929.940350298193, 13360.265185414895, 13490.595282141552, 13827.239501827496, 13890.722185556435, 15061.0, 15125.0, 15751.530219972388, 15948.122853243183, 16277.61640260591, 14282.143071415749, 14382.85617143857, 14440.927795360956, 14505.0, 15265.160416176772, 13996.16023038621, 14377.856221437652, 14693.92653036728, 14894.03188792725, 15573.454929077428, 13759.243241621407, 13817.585472435843, 14508.0, 14782.556523304318, 14835.0, 11456.312621242752, 11845.170838041255, 11943.940280298542, 11970.700732481757, 12300.753984920073, 12426.254424734545, 12504.437300321326, 12530.373481325714, 12781.680457988625, 12847.293398863152], "value": 7968.507049120387, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 110.0, 111.0, 111.0, 110.0, 112.0, 110.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 135.0, 155.0, 174.0, 126.0, 158.0, 151.0, 125.0, 190.0, 125.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 165.0, 161.0, 162.0, 162.0, 164.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 178.0, 75.0, 76.0, 76.0, 75.0, 172.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 146.0, 85.0, 87.0, 88.0, 152.0, 87.0, 87.0, 142.0], "value": 104.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 150.0, 146.0, 151.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 55.0, 53.0, 52.0, 56.0, 52.0, 54.0, 52.0, 55.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 63.0, 61.0, 60.0, 60.0, 60.0, 61.0, 66.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 79.0, 76.0, 81.0, 78.0, 80.0, 77.0, 105.0, 86.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 122.0, 139.0, 123.0, 133.0, 126.0, 122.0, 129.0, 136.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 169.0, 158.0, 160.0, 163.0, 161.0, 158.0, 164.0, 155.0, 156.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 67.0, 62.0, 62.0, 68.0, 65.0, 66.0, 64.0, 65.0], "value": 64.6, "unit": "score"}]}]} 06:45:15 INFO - Return code: 0 06:45:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:45:15 ERROR - # TBPL SUCCESS # 06:45:15 INFO - Running post-action listener: _resource_record_post_action 06:45:15 INFO - ##### 06:45:15 INFO - ##### Finished run-tests step (success) 06:45:15 INFO - ##### 06:45:15 INFO - Running post-run listener: _resource_record_post_run 06:45:15 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 262144; Write bytes: 504930304; Read time: 20; Write time: 343960 06:45:15 INFO - TinderboxPrint: CPU usage
13.4% 06:45:15 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 20 06:45:15 INFO - TinderboxPrint: I/O write bytes / time
504,930,304 / 343,960 06:45:15 INFO - TinderboxPrint: CPU idle
8,214.8 (86.6%) 06:45:15 INFO - TinderboxPrint: CPU user
1,214.0 (12.8%) 06:45:15 INFO - TinderboxPrint: Swap in / out
0 / 0 06:45:15 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252833792; Read time: 0; Write time: 206608 06:45:15 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 252096512; Read time: 20; Write time: 137352 06:45:16 INFO - Running post-run listener: _upload_blobber_files 06:45:16 INFO - Blob upload gear active. 06:45:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:45:16 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 06:45:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:45:16 INFO - (blobuploader) - INFO - Open directory for files ... 06:45:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:45:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:45:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:17 INFO - (blobuploader) - INFO - Done attempting. 06:45:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:45:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:45:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:21 INFO - (blobuploader) - INFO - Done attempting. 06:45:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:45:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:45:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:22 INFO - (blobuploader) - INFO - Done attempting. 06:45:22 INFO - (blobuploader) - INFO - Iteration through files over. 06:45:22 INFO - Return code: 0 06:45:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:45:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:45:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f35588594593d45fbe89cdc1795b47af295256d750efbf5f84e3ebc781ee4f46ea33878a8f3fbe707e630b772cb9781e80533195fcdf95fc64fae5367bc4e552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/162c96d91faaf506b92aef34a1c6bc6dbf00c8e6fb559bc404a1d01423f3196b74bc2b05a324ebb29ca9be0a43891ac0247fb077315fd8452ce8a8dd1cacc84c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b78ba3a6c09a62c98984c416dfbd49c7a54e78806eb697d49949ea24743398ab42bcfd1c54281bfad2d01114db2c2bb8ac65cdddd5298d73e266db0362b2bc8"} 06:45:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:45:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:45:22 INFO - Contents: 06:45:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f35588594593d45fbe89cdc1795b47af295256d750efbf5f84e3ebc781ee4f46ea33878a8f3fbe707e630b772cb9781e80533195fcdf95fc64fae5367bc4e552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/162c96d91faaf506b92aef34a1c6bc6dbf00c8e6fb559bc404a1d01423f3196b74bc2b05a324ebb29ca9be0a43891ac0247fb077315fd8452ce8a8dd1cacc84c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b78ba3a6c09a62c98984c416dfbd49c7a54e78806eb697d49949ea24743398ab42bcfd1c54281bfad2d01114db2c2bb8ac65cdddd5298d73e266db0362b2bc8"} 06:45:22 INFO - Running post-run listener: copy_logs_to_upload_dir 06:45:22 INFO - Copying logs to upload dir... 06:45:22 INFO - mkdir: /builds/slave/test/build/upload/logs 06:45:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.002563 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-27 06:45:21.395421) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:45:21.398931) ========= 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=41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f35588594593d45fbe89cdc1795b47af295256d750efbf5f84e3ebc781ee4f46ea33878a8f3fbe707e630b772cb9781e80533195fcdf95fc64fae5367bc4e552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/162c96d91faaf506b92aef34a1c6bc6dbf00c8e6fb559bc404a1d01423f3196b74bc2b05a324ebb29ca9be0a43891ac0247fb077315fd8452ce8a8dd1cacc84c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b78ba3a6c09a62c98984c416dfbd49c7a54e78806eb697d49949ea24743398ab42bcfd1c54281bfad2d01114db2c2bb8ac65cdddd5298d73e266db0362b2bc8"} build_url:https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011407 build_url: 'https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f35588594593d45fbe89cdc1795b47af295256d750efbf5f84e3ebc781ee4f46ea33878a8f3fbe707e630b772cb9781e80533195fcdf95fc64fae5367bc4e552", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/162c96d91faaf506b92aef34a1c6bc6dbf00c8e6fb559bc404a1d01423f3196b74bc2b05a324ebb29ca9be0a43891ac0247fb077315fd8452ce8a8dd1cacc84c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b78ba3a6c09a62c98984c416dfbd49c7a54e78806eb697d49949ea24743398ab42bcfd1c54281bfad2d01114db2c2bb8ac65cdddd5298d73e266db0362b2bc8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:45:21.428041) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:45:21.428381) ========= 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=41a7e32711b8e08598a63237000001d6-1467033880.530178-1540556212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:45:21.513376) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:45:21.513707) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:45:21.513987) ========= ========= Total master_lag: 0.19 =========