builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1469556179.36 results: success (0) buildid: 20160726081123 builduid: d55b11d35c3148cb8ff39a91e15f3ac4 revision: ebd239b4cbfb8eff833560f72b163275ac4026d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 11:02:59.364486) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 11:02:59.364916) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 11:02:59.365189) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 11:02:59.397177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 11:02:59.397462) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 11:02:59-- 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% 219M=0s 2016-07-26 11:02:59 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101205 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 11:02:59.511984) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 11:02:59.512260) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017678 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 11:02:59.561917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 11:02:59.562253) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ebd239b4cbfb8eff833560f72b163275ac4026d3 --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 ebd239b4cbfb8eff833560f72b163275ac4026d3 --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=2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 11:02:59,642 truncating revision to first 12 chars 2016-07-26 11:02:59,642 Setting DEBUG logging. 2016-07-26 11:02:59,642 attempt 1/10 2016-07-26 11:02:59,642 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ebd239b4cbfb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 11:03:00,695 unpacking tar archive at: mozilla-aurora-ebd239b4cbfb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.462300 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 11:03:01.038095) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 11:03:01.038462) ========= script_repo_revision: ebd239b4cbfb8eff833560f72b163275ac4026d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 11:03:01.038891) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 11:03:01.039157) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 11:03:01.050222) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-26 11:03:01.050510) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:03:01 INFO - MultiFileLogger online at 20160726 11:03:01 in /builds/slave/test 11:03:01 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 11:03:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:03:01 INFO - {'append_to_log': False, 11:03:01 INFO - 'base_work_dir': '/builds/slave/test', 11:03:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:03:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:03:01 INFO - 'branch': 'Mozilla-Aurora', 11:03:01 INFO - 'buildbot_json_path': 'buildprops.json', 11:03:01 INFO - 'config_files': ('talos/linux_config.py',), 11:03:01 INFO - 'default_actions': ('clobber', 11:03:01 INFO - 'read-buildbot-config', 11:03:01 INFO - 'download-and-extract', 11:03:01 INFO - 'populate-webroot', 11:03:01 INFO - 'create-virtualenv', 11:03:01 INFO - 'install', 11:03:01 INFO - 'run-tests'), 11:03:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:03:01 INFO - 'download_minidump_stackwalk': True, 11:03:01 INFO - 'download_symbols': 'ondemand', 11:03:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:03:01 INFO - 'tooltool.py': '/tools/tooltool.py', 11:03:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:03:01 INFO - '/tools/misc-python/virtualenv.py')}, 11:03:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:03:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:03:01 INFO - 'installer_path': 'installer.exe', 11:03:01 INFO - 'log_level': 'info', 11:03:01 INFO - 'log_name': 'talos', 11:03:01 INFO - 'log_to_console': True, 11:03:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:03:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:03:01 INFO - 'opt_config_files': (), 11:03:01 INFO - 'pip_index': False, 11:03:01 INFO - 'sps_profile': False, 11:03:01 INFO - 'sps_profile_interval': 0, 11:03:01 INFO - 'suite': 'dromaeojs-e10s', 11:03:01 INFO - 'system_bits': '32', 11:03:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:03:01 INFO - 'title': 'talos-linux64-ix-012', 11:03:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:03:01 INFO - 'use_talos_json': True, 11:03:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:03:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:03:01 INFO - 'work_dir': 'build'} 11:03:01 INFO - ##### 11:03:01 INFO - ##### Running clobber step. 11:03:01 INFO - ##### 11:03:01 INFO - Running pre-action listener: _resource_record_pre_action 11:03:01 INFO - Running main action method: clobber 11:03:01 INFO - rmtree: /builds/slave/test/build 11:03:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:03:01 INFO - Running post-action listener: _resource_record_post_action 11:03:01 INFO - ##### 11:03:01 INFO - ##### Finished clobber step (success) 11:03:01 INFO - ##### 11:03:01 INFO - ##### 11:03:01 INFO - ##### Running read-buildbot-config step. 11:03:01 INFO - ##### 11:03:01 INFO - Running pre-action listener: _resource_record_pre_action 11:03:01 INFO - Running main action method: read_buildbot_config 11:03:01 INFO - Using buildbot properties: 11:03:01 INFO - { 11:03:01 INFO - "project": "", 11:03:01 INFO - "product": "firefox", 11:03:01 INFO - "script_repo_revision": "production", 11:03:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:03:01 INFO - "repository": "", 11:03:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:03:01 INFO - "buildid": "20160726081123", 11:03:01 INFO - "pgo_build": "True", 11:03:01 INFO - "basedir": "/builds/slave/test", 11:03:01 INFO - "buildnumber": 465, 11:03:01 INFO - "slavename": "talos-linux64-ix-012", 11:03:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:03:01 INFO - "platform": "ubuntu64_hw", 11:03:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:03:01 INFO - "branch": "mozilla-aurora", 11:03:01 INFO - "repo_path": "releases/mozilla-aurora", 11:03:01 INFO - "revision": "ebd239b4cbfb8eff833560f72b163275ac4026d3", 11:03:01 INFO - "stage_platform": "linux64-pgo", 11:03:01 INFO - "builduid": "d55b11d35c3148cb8ff39a91e15f3ac4", 11:03:01 INFO - "slavebuilddir": "test" 11:03:01 INFO - } 11:03:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 11:03:01 INFO - Running post-action listener: _resource_record_post_action 11:03:01 INFO - ##### 11:03:01 INFO - ##### Finished read-buildbot-config step (success) 11:03:01 INFO - ##### 11:03:01 INFO - ##### 11:03:01 INFO - ##### Running download-and-extract step. 11:03:01 INFO - ##### 11:03:01 INFO - Running pre-action listener: _resource_record_pre_action 11:03:01 INFO - Running main action method: download_and_extract 11:03:01 INFO - mkdir: /builds/slave/test/build/tests 11:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:01 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:03:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:03:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:03:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/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 11:03:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/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 11:03:03 INFO - Downloaded 1361 bytes. 11:03:03 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:03:03 INFO - Using the following test package requirements: 11:03:03 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 11:03:03 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:03:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:03:03 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:03:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:03:03 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:03:03 INFO - u'jsshell-linux-x86_64.zip'], 11:03:03 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:03:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:03:03 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 11:03:03 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:03:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:03:03 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:03:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:03:03 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:03:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:03:03 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:03:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:03:03 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:03:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:03 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:03:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:03:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:03:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/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 11:03:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/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 11:03:05 INFO - Downloaded 24494733 bytes. 11:03:05 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'] 11:03:05 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 11:03:06 INFO - Return code: 0 11:03:06 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 11:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:06 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:03:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:03:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:03:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/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 11:03:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/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 11:03:11 INFO - Downloaded 24494733 bytes. 11:03:11 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'] 11:03:11 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 11:03:12 INFO - Return code: 0 11:03: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')]} 11:03:12 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:03:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 11:03:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 11:03:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/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 11:03:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/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 11:03:13 INFO - Downloaded 10833369 bytes. 11:03:13 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'] 11:03:13 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 11:03:14 INFO - Return code: 0 11:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:14 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:03:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:03:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:03:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/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 11:03:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/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 11:03:16 INFO - Downloaded 63637001 bytes. 11:03:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:03:16 INFO - mkdir: /builds/slave/test/properties 11:03:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:03:16 INFO - Writing to file /builds/slave/test/properties/build_url 11:03:16 INFO - Contents: 11:03:16 INFO - build_url:https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:03:19 INFO - Running post-action listener: _resource_record_post_action 11:03:19 INFO - Running post-action listener: set_extra_try_arguments 11:03:19 INFO - ##### 11:03:19 INFO - ##### Finished download-and-extract step (success) 11:03:19 INFO - ##### 11:03:19 INFO - ##### 11:03:19 INFO - ##### Running populate-webroot step. 11:03:19 INFO - ##### 11:03:19 INFO - Running pre-action listener: _resource_record_pre_action 11:03:19 INFO - Running main action method: populate_webroot 11:03:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:03:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:03:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:03:19 INFO - '--tppagecycles', 11:03:19 INFO - '7'], 11:03:19 INFO - 'tests': ['tsvgm']}}, 11:03:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:03:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:03:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:03:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:03:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:03:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:03:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:19 INFO - 'talos_options': ['--disable-e10s'], 11:03:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:19 INFO - 'talos_options': ['--disable-e10s'], 11:03:19 INFO - 'tests': ['damp', 'tps']}, 11:03:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:19 INFO - 'tests': ['damp', 'tps']}, 11:03:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:03:19 INFO - 'tests': ['dromaeo_dom']}, 11:03:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:03:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:03:19 INFO - 'tests': ['a11yr', 11:03:19 INFO - 'ts_paint', 11:03:19 INFO - 'tpaint', 11:03:19 INFO - 'sessionrestore', 11:03:19 INFO - 'sessionrestore_no_auto_restore', 11:03:19 INFO - 'tabpaint']}, 11:03:19 INFO - 'other-e10s': {'tests': ['a11yr', 11:03:19 INFO - 'ts_paint', 11:03:19 INFO - 'tpaint', 11:03:19 INFO - 'sessionrestore', 11:03:19 INFO - 'sessionrestore_no_auto_restore', 11:03:19 INFO - 'tabpaint']}, 11:03:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:03:19 INFO - 'ts_paint', 11:03:19 INFO - 'tpaint', 11:03:19 INFO - 'sessionrestore', 11:03:19 INFO - 'sessionrestore_no_auto_restore', 11:03:19 INFO - 'tabpaint']}, 11:03:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:03:19 INFO - 'ts_paint', 11:03:19 INFO - 'tpaint', 11:03:19 INFO - 'sessionrestore', 11:03:19 INFO - 'sessionrestore_no_auto_restore', 11:03:19 INFO - 'tabpaint']}, 11:03:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:03:19 INFO - 'tests': ['a11yr', 11:03:19 INFO - 'ts_paint', 11:03:19 INFO - 'tpaint', 11:03:19 INFO - 'sessionrestore', 11:03:19 INFO - 'sessionrestore_no_auto_restore', 11:03:19 INFO - 'tabpaint']}, 11:03:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:03:19 INFO - 'tests': ['a11yr', 11:03:19 INFO - 'ts_paint', 11:03:19 INFO - 'tpaint', 11:03:19 INFO - 'sessionrestore', 11:03:19 INFO - 'sessionrestore_no_auto_restore', 11:03:19 INFO - 'tabpaint']}, 11:03:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:03:19 INFO - 'tests': ['tsvgx', 11:03:19 INFO - 'tsvgr_opacity', 11:03:19 INFO - 'tart', 11:03:19 INFO - 'tscrollx', 11:03:19 INFO - 'cart']}, 11:03:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:03:19 INFO - 'tsvgr_opacity', 11:03:19 INFO - 'tart', 11:03:19 INFO - 'tscrollx', 11:03:19 INFO - 'cart']}, 11:03:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:19 INFO - 'talos_options': ['--disable-e10s'], 11:03:19 INFO - 'tests': ['tp5o']}, 11:03:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:19 INFO - 'tests': ['tp5o']}, 11:03:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:19 INFO - 'talos_options': ['--disable-e10s', 11:03:19 INFO - '--xperf_path', 11:03:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:19 INFO - 'tests': ['tp5n']}, 11:03:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:19 INFO - 'talos_options': ['--xperf_path', 11:03:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:19 INFO - 'tests': ['tp5n']}}, 11:03:19 INFO - 'talos.zip': {'path': '', 11:03:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:03:19 INFO - Running post-action listener: _resource_record_post_action 11:03:19 INFO - ##### 11:03:19 INFO - ##### Finished populate-webroot step (success) 11:03:19 INFO - ##### 11:03:19 INFO - ##### 11:03:19 INFO - ##### Running create-virtualenv step. 11:03:19 INFO - ##### 11:03:19 INFO - Running pre-action listener: _resource_record_pre_action 11:03:19 INFO - Running main action method: create_virtualenv 11:03:19 INFO - Creating virtualenv /builds/slave/test/build/venv 11:03:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:03:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:03:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:03:19 INFO - Using real prefix '/usr' 11:03:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:03:20 INFO - Installing distribute.............................................................................................................................................................................................done. 11:03:22 INFO - Installing pip.................done. 11:03:22 INFO - Return code: 0 11:03:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:03: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')]} 11:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03: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')]} 11:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:22 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 0x7f7cabd24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e461c0>, '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 0x1e470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e47550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:03:22 INFO - Using env: {'DISPLAY': ':0', 11:03:22 INFO - 'HOME': '/home/cltbld', 11:03:22 INFO - 'LANG': 'en_US.UTF-8', 11:03:22 INFO - 'LANGUAGE': 'en_US:en', 11:03:22 INFO - 'LOGNAME': 'cltbld', 11:03:22 INFO - 'MAIL': '/var/mail/cltbld', 11:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:22 INFO - 'MOZ_NO_REMOTE': '1', 11:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:22 INFO - 'NO_EM_RESTART': '1', 11:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:22 INFO - 'PWD': '/builds/slave/test', 11:03:22 INFO - 'SHELL': '/bin/bash', 11:03:22 INFO - 'SHLVL': '1', 11:03:22 INFO - 'TERM': 'linux', 11:03:22 INFO - 'TMOUT': '86400', 11:03:22 INFO - 'USER': 'cltbld', 11:03:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 11:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:22 INFO - '_': '/tools/buildbot/bin/python'} 11:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:03:22 INFO - Cleaning up... 11:03:22 INFO - Return code: 0 11:03:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:03: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')]} 11:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03: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')]} 11:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:22 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 0x7f7cabd24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e461c0>, '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 0x1e470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e47550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:03:22 INFO - Using env: {'DISPLAY': ':0', 11:03:22 INFO - 'HOME': '/home/cltbld', 11:03:22 INFO - 'LANG': 'en_US.UTF-8', 11:03:22 INFO - 'LANGUAGE': 'en_US:en', 11:03:22 INFO - 'LOGNAME': 'cltbld', 11:03:22 INFO - 'MAIL': '/var/mail/cltbld', 11:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:22 INFO - 'MOZ_NO_REMOTE': '1', 11:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:22 INFO - 'NO_EM_RESTART': '1', 11:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:22 INFO - 'PWD': '/builds/slave/test', 11:03:22 INFO - 'SHELL': '/bin/bash', 11:03:22 INFO - 'SHLVL': '1', 11:03:22 INFO - 'TERM': 'linux', 11:03:22 INFO - 'TMOUT': '86400', 11:03:22 INFO - 'USER': 'cltbld', 11:03:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 11:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:22 INFO - '_': '/tools/buildbot/bin/python'} 11:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:22 INFO - Downloading/unpacking psutil>=3.1.1 11:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:03:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:24 INFO - Installing collected packages: psutil 11:03:24 INFO - Running setup.py install for psutil 11:03:24 INFO - building 'psutil._psutil_linux' extension 11:03:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:03:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:03:25 INFO - building 'psutil._psutil_posix' extension 11:03:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:03:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:03:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:25 INFO - Successfully installed psutil 11:03:25 INFO - Cleaning up... 11:03:25 INFO - Return code: 0 11:03:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:25 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 0x7f7cabd24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e461c0>, '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 0x1e470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e47550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:03:25 INFO - Using env: {'DISPLAY': ':0', 11:03:25 INFO - 'HOME': '/home/cltbld', 11:03:25 INFO - 'LANG': 'en_US.UTF-8', 11:03:25 INFO - 'LANGUAGE': 'en_US:en', 11:03:25 INFO - 'LOGNAME': 'cltbld', 11:03:25 INFO - 'MAIL': '/var/mail/cltbld', 11:03:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:25 INFO - 'MOZ_NO_REMOTE': '1', 11:03:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:25 INFO - 'NO_EM_RESTART': '1', 11:03:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:25 INFO - 'PWD': '/builds/slave/test', 11:03:25 INFO - 'SHELL': '/bin/bash', 11:03:25 INFO - 'SHLVL': '1', 11:03:25 INFO - 'TERM': 'linux', 11:03:25 INFO - 'TMOUT': '86400', 11:03:25 INFO - 'USER': 'cltbld', 11:03:25 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 11:03:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:25 INFO - '_': '/tools/buildbot/bin/python'} 11:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:03: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 11:03: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 11:03: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 11:03: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 11:03: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 11:03: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 11:03:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:03:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:03:27 INFO - Installing collected packages: mozsystemmonitor 11:03:27 INFO - Running setup.py install for mozsystemmonitor 11:03:27 INFO - Successfully installed mozsystemmonitor 11:03:27 INFO - Cleaning up... 11:03:27 INFO - Return code: 0 11:03:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:27 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 0x7f7cabd24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e461c0>, '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 0x1e470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e47550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:03:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:03:27 INFO - Using env: {'DISPLAY': ':0', 11:03:27 INFO - 'HOME': '/home/cltbld', 11:03:27 INFO - 'LANG': 'en_US.UTF-8', 11:03:27 INFO - 'LANGUAGE': 'en_US:en', 11:03:27 INFO - 'LOGNAME': 'cltbld', 11:03:27 INFO - 'MAIL': '/var/mail/cltbld', 11:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:27 INFO - 'MOZ_NO_REMOTE': '1', 11:03:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:27 INFO - 'NO_EM_RESTART': '1', 11:03:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:27 INFO - 'PWD': '/builds/slave/test', 11:03:27 INFO - 'SHELL': '/bin/bash', 11:03:27 INFO - 'SHLVL': '1', 11:03:27 INFO - 'TERM': 'linux', 11:03:27 INFO - 'TMOUT': '86400', 11:03:27 INFO - 'USER': 'cltbld', 11:03:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 11:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:27 INFO - '_': '/tools/buildbot/bin/python'} 11:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:27 INFO - Downloading/unpacking jsonschema==2.5.1 11:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:03:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:30 INFO - Downloading functools32-3.2.3-2.tar.gz 11:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:03:30 INFO - warning: no files found matching '*.txt' 11:03:30 INFO - no previously-included directories found matching 'build' 11:03:30 INFO - no previously-included directories found matching 'dist' 11:03:30 INFO - no previously-included directories found matching '.git*' 11:03:30 INFO - Installing collected packages: jsonschema, functools32 11:03:30 INFO - Running setup.py install for functools32 11:03:30 INFO - warning: no files found matching '*.txt' 11:03:30 INFO - no previously-included directories found matching 'build' 11:03:30 INFO - no previously-included directories found matching 'dist' 11:03:30 INFO - no previously-included directories found matching '.git*' 11:03:30 INFO - Successfully installed jsonschema functools32 11:03:30 INFO - Cleaning up... 11:03:30 INFO - Return code: 0 11:03:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:30 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 0x7f7cabd24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e461c0>, '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 0x1e470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e47550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:03:30 INFO - Using env: {'DISPLAY': ':0', 11:03:30 INFO - 'HOME': '/home/cltbld', 11:03:30 INFO - 'LANG': 'en_US.UTF-8', 11:03:30 INFO - 'LANGUAGE': 'en_US:en', 11:03:30 INFO - 'LOGNAME': 'cltbld', 11:03:30 INFO - 'MAIL': '/var/mail/cltbld', 11:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:30 INFO - 'MOZ_NO_REMOTE': '1', 11:03:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:30 INFO - 'NO_EM_RESTART': '1', 11:03:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:30 INFO - 'PWD': '/builds/slave/test', 11:03:30 INFO - 'SHELL': '/bin/bash', 11:03:30 INFO - 'SHLVL': '1', 11:03:30 INFO - 'TERM': 'linux', 11:03:30 INFO - 'TMOUT': '86400', 11:03:30 INFO - 'USER': 'cltbld', 11:03:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 11:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:30 INFO - '_': '/tools/buildbot/bin/python'} 11:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:30 INFO - Downloading/unpacking blobuploader==1.2.4 11:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:32 INFO - Downloading blobuploader-1.2.4.tar.gz 11:03:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:03:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:03:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:33 INFO - Downloading docopt-0.6.1.tar.gz 11:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:03:33 INFO - Installing collected packages: blobuploader, requests, docopt 11:03:33 INFO - Running setup.py install for blobuploader 11:03:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:03:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:03:33 INFO - Running setup.py install for requests 11:03:33 INFO - Running setup.py install for docopt 11:03:33 INFO - Successfully installed blobuploader requests docopt 11:03:33 INFO - Cleaning up... 11:03:33 INFO - Return code: 0 11:03:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:33 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 0x7f7cabd24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e461c0>, '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 0x1e470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e47550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:03:33 INFO - Using env: {'DISPLAY': ':0', 11:03:33 INFO - 'HOME': '/home/cltbld', 11:03:33 INFO - 'LANG': 'en_US.UTF-8', 11:03:33 INFO - 'LANGUAGE': 'en_US:en', 11:03:33 INFO - 'LOGNAME': 'cltbld', 11:03:33 INFO - 'MAIL': '/var/mail/cltbld', 11:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:33 INFO - 'MOZ_NO_REMOTE': '1', 11:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:33 INFO - 'NO_EM_RESTART': '1', 11:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:33 INFO - 'PWD': '/builds/slave/test', 11:03:33 INFO - 'SHELL': '/bin/bash', 11:03:33 INFO - 'SHLVL': '1', 11:03:33 INFO - 'TERM': 'linux', 11:03:33 INFO - 'TMOUT': '86400', 11:03:33 INFO - 'USER': 'cltbld', 11:03:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 11:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:33 INFO - '_': '/tools/buildbot/bin/python'} 11:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:34 INFO - Running setup.py (path:/tmp/pip-QhP1Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:34 INFO - Running setup.py (path:/tmp/pip-6HpwbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:34 INFO - Running setup.py (path:/tmp/pip-Fwx_YX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:34 INFO - Running setup.py (path:/tmp/pip-h4s3Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:34 INFO - Running setup.py (path:/tmp/pip-MBY2Ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:34 INFO - Running setup.py (path:/tmp/pip-4xlZhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:34 INFO - Running setup.py (path:/tmp/pip-O_j2jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:34 INFO - Running setup.py (path:/tmp/pip-xquyIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:34 INFO - Running setup.py (path:/tmp/pip-Cvrefo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:34 INFO - Running setup.py (path:/tmp/pip-83wb4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:34 INFO - Running setup.py (path:/tmp/pip-bhYN7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:34 INFO - Running setup.py (path:/tmp/pip-MISAn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:34 INFO - Running setup.py (path:/tmp/pip-EvpN1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:34 INFO - Running setup.py (path:/tmp/pip-i79LBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:35 INFO - Running setup.py (path:/tmp/pip-_ZMRLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:35 INFO - Running setup.py (path:/tmp/pip-79OsLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:35 INFO - Running setup.py (path:/tmp/pip-fH5CcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:03:35 INFO - Running setup.py install for manifestparser 11:03:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:03:35 INFO - Running setup.py install for mozcrash 11:03:35 INFO - Running setup.py install for mozdebug 11:03:35 INFO - Running setup.py install for mozdevice 11:03:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:03:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:03:35 INFO - Running setup.py install for mozfile 11:03:35 INFO - Running setup.py install for mozhttpd 11:03:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:03:35 INFO - Running setup.py install for mozinfo 11:03:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:03:35 INFO - Running setup.py install for mozInstall 11:03:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:03:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:03:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:03:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:03:36 INFO - Running setup.py install for mozleak 11:03:36 INFO - Running setup.py install for mozlog 11:03:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:03:36 INFO - Running setup.py install for moznetwork 11:03:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:03:36 INFO - Running setup.py install for mozprocess 11:03:36 INFO - Running setup.py install for mozprofile 11:03:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:03:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:03:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:03:36 INFO - Running setup.py install for mozrunner 11:03:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:03:36 INFO - Running setup.py install for mozscreenshot 11:03:36 INFO - Running setup.py install for moztest 11:03:36 INFO - Running setup.py install for mozversion 11:03:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:03:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:03:37 INFO - Cleaning up... 11:03:37 INFO - Return code: 0 11:03:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:37 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 0x7f7cabd24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e461c0>, '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 0x1e470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e47550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:03:37 INFO - Using env: {'DISPLAY': ':0', 11:03:37 INFO - 'HOME': '/home/cltbld', 11:03:37 INFO - 'LANG': 'en_US.UTF-8', 11:03:37 INFO - 'LANGUAGE': 'en_US:en', 11:03:37 INFO - 'LOGNAME': 'cltbld', 11:03:37 INFO - 'MAIL': '/var/mail/cltbld', 11:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:37 INFO - 'MOZ_NO_REMOTE': '1', 11:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:37 INFO - 'NO_EM_RESTART': '1', 11:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:37 INFO - 'PWD': '/builds/slave/test', 11:03:37 INFO - 'SHELL': '/bin/bash', 11:03:37 INFO - 'SHLVL': '1', 11:03:37 INFO - 'TERM': 'linux', 11:03:37 INFO - 'TMOUT': '86400', 11:03:37 INFO - 'USER': 'cltbld', 11:03:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 11:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:37 INFO - '_': '/tools/buildbot/bin/python'} 11:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:37 INFO - Running setup.py (path:/tmp/pip-cv0X7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:37 INFO - Running setup.py (path:/tmp/pip-vN6ux7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:37 INFO - Running setup.py (path:/tmp/pip-9EvXjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:37 INFO - Running setup.py (path:/tmp/pip-qtYk4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:37 INFO - Running setup.py (path:/tmp/pip-j0UqC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:37 INFO - Running setup.py (path:/tmp/pip-8CKdWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:37 INFO - Running setup.py (path:/tmp/pip-i2m2GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:37 INFO - Running setup.py (path:/tmp/pip-hMvCUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:37 INFO - Running setup.py (path:/tmp/pip-60DLCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:37 INFO - Running setup.py (path:/tmp/pip-Sqr37G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:38 INFO - Running setup.py (path:/tmp/pip-gpuaJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:38 INFO - Running setup.py (path:/tmp/pip-MPN5NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:38 INFO - Running setup.py (path:/tmp/pip-_53tgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:38 INFO - Running setup.py (path:/tmp/pip-THgwgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:38 INFO - Running setup.py (path:/tmp/pip-i9rmcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:38 INFO - Running setup.py (path:/tmp/pip-RJRn08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:03:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:38 INFO - Running setup.py (path:/tmp/pip-gm_g_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:03:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:40 INFO - Downloading blessings-1.6.tar.gz 11:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:03:40 INFO - Installing collected packages: blessings 11:03:40 INFO - Running setup.py install for blessings 11:03:40 INFO - Successfully installed blessings 11:03:40 INFO - Cleaning up... 11:03:40 INFO - Return code: 0 11:03:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:03:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:40 INFO - Reading from file tmpfile_stdout 11:03:40 INFO - Current package versions: 11:03:40 INFO - argparse == 1.2.1 11:03:40 INFO - blessings == 1.6 11:03:40 INFO - blobuploader == 1.2.4 11:03:40 INFO - docopt == 0.6.1 11:03:40 INFO - functools32 == 3.2.3-2 11:03:40 INFO - jsonschema == 2.5.1 11:03:40 INFO - manifestparser == 1.1 11:03:40 INFO - mozInstall == 1.12 11:03:40 INFO - mozcrash == 0.17 11:03:40 INFO - mozdebug == 0.1 11:03:40 INFO - mozdevice == 0.48 11:03:40 INFO - mozfile == 1.2 11:03:40 INFO - mozhttpd == 0.7 11:03:40 INFO - mozinfo == 0.9 11:03:40 INFO - mozleak == 0.1 11:03:40 INFO - mozlog == 3.2 11:03:40 INFO - moznetwork == 0.27 11:03:40 INFO - mozprocess == 0.23 11:03:40 INFO - mozprofile == 0.28 11:03:40 INFO - mozrunner == 6.12 11:03:40 INFO - mozscreenshot == 0.1 11:03:40 INFO - mozsystemmonitor == 0.3 11:03:40 INFO - moztest == 0.7 11:03:40 INFO - mozversion == 1.4 11:03:40 INFO - psutil == 3.1.1 11:03:40 INFO - requests == 1.2.3 11:03:40 INFO - wsgiref == 0.1.2 11:03:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:40 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 0x7f7cabd24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e461c0>, '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 0x1e470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e47550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:03:40 INFO - Using env: {'DISPLAY': ':0', 11:03:40 INFO - 'HOME': '/home/cltbld', 11:03:40 INFO - 'LANG': 'en_US.UTF-8', 11:03:40 INFO - 'LANGUAGE': 'en_US:en', 11:03:40 INFO - 'LOGNAME': 'cltbld', 11:03:40 INFO - 'MAIL': '/var/mail/cltbld', 11:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:40 INFO - 'MOZ_NO_REMOTE': '1', 11:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:40 INFO - 'NO_EM_RESTART': '1', 11:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:40 INFO - 'PWD': '/builds/slave/test', 11:03:40 INFO - 'SHELL': '/bin/bash', 11:03:40 INFO - 'SHLVL': '1', 11:03:40 INFO - 'TERM': 'linux', 11:03:40 INFO - 'TMOUT': '86400', 11:03:40 INFO - 'USER': 'cltbld', 11:03:40 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 11:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:40 INFO - '_': '/tools/buildbot/bin/python'} 11:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:03:41 INFO - Cleaning up... 11:03:41 INFO - Return code: 0 11:03:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:41 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 0x7f7cabd24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e461c0>, '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 0x1e470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e47550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:03:41 INFO - Using env: {'DISPLAY': ':0', 11:03:41 INFO - 'HOME': '/home/cltbld', 11:03:41 INFO - 'LANG': 'en_US.UTF-8', 11:03:41 INFO - 'LANGUAGE': 'en_US:en', 11:03:41 INFO - 'LOGNAME': 'cltbld', 11:03:41 INFO - 'MAIL': '/var/mail/cltbld', 11:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:41 INFO - 'MOZ_NO_REMOTE': '1', 11:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:41 INFO - 'NO_EM_RESTART': '1', 11:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:41 INFO - 'PWD': '/builds/slave/test', 11:03:41 INFO - 'SHELL': '/bin/bash', 11:03:41 INFO - 'SHLVL': '1', 11:03:41 INFO - 'TERM': 'linux', 11:03:41 INFO - 'TMOUT': '86400', 11:03:41 INFO - 'USER': 'cltbld', 11:03:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 11:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:41 INFO - '_': '/tools/buildbot/bin/python'} 11:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:03:41 INFO - Cleaning up... 11:03:41 INFO - Return code: 0 11:03:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:41 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 0x7f7cabd24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1db7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e461c0>, '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 0x1e470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e47550>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:03:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:03:41 INFO - Using env: {'DISPLAY': ':0', 11:03:41 INFO - 'HOME': '/home/cltbld', 11:03:41 INFO - 'LANG': 'en_US.UTF-8', 11:03:41 INFO - 'LANGUAGE': 'en_US:en', 11:03:41 INFO - 'LOGNAME': 'cltbld', 11:03:41 INFO - 'MAIL': '/var/mail/cltbld', 11:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:41 INFO - 'MOZ_NO_REMOTE': '1', 11:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:41 INFO - 'NO_EM_RESTART': '1', 11:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:41 INFO - 'PWD': '/builds/slave/test', 11:03:41 INFO - 'SHELL': '/bin/bash', 11:03:41 INFO - 'SHLVL': '1', 11:03:41 INFO - 'TERM': 'linux', 11:03:41 INFO - 'TMOUT': '86400', 11:03:41 INFO - 'USER': 'cltbld', 11:03:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 11:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:41 INFO - '_': '/tools/buildbot/bin/python'} 11:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:41 INFO - Downloading/unpacking flake8 11:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:03:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:03:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:03:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:03:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:03:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:03:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:03:44 INFO - no previously-included directories found matching 'docs/_build' 11:03:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:03:44 INFO - Running setup.py install for pep8 11:03:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:03:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:03:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:03:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:03:44 INFO - no previously-included directories found matching 'docs/_build' 11:03:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:03:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:03:44 INFO - Cleaning up... 11:03:44 INFO - Return code: 0 11:03:44 INFO - Running post-action listener: _resource_record_post_action 11:03:44 INFO - Running post-action listener: _start_resource_monitoring 11:03:44 INFO - Starting resource monitoring. 11:03:44 INFO - ##### 11:03:44 INFO - ##### Finished create-virtualenv step (success) 11:03:44 INFO - ##### 11:03:44 INFO - ##### 11:03:44 INFO - ##### Running install step. 11:03:44 INFO - ##### 11:03:44 INFO - Running pre-action listener: _resource_record_pre_action 11:03:44 INFO - Running main action method: install 11:03:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:44 INFO - Reading from file tmpfile_stdout 11:03:44 INFO - Detecting whether we're running mozinstall >=1.0... 11:03:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:03:44 INFO - Reading from file tmpfile_stdout 11:03:44 INFO - Output received: 11:03:44 INFO - Usage: mozinstall [options] installer 11:03:44 INFO - Options: 11:03:44 INFO - -h, --help show this help message and exit 11:03:44 INFO - -d DEST, --destination=DEST 11:03:44 INFO - Directory to install application into. [default: 11:03:44 INFO - "/builds/slave/test"] 11:03:44 INFO - --app=APP Application being installed. [default: firefox] 11:03:44 INFO - mkdir: /builds/slave/test/build/application 11:03:44 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'] 11:03:44 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 11:04:00 INFO - Reading from file tmpfile_stdout 11:04:00 INFO - Output received: 11:04:00 INFO - /builds/slave/test/build/application/firefox/firefox 11:04:00 INFO - Running post-action listener: _resource_record_post_action 11:04:00 INFO - ##### 11:04:00 INFO - ##### Finished install step (success) 11:04:00 INFO - ##### 11:04:00 INFO - ##### 11:04:00 INFO - ##### Running run-tests step. 11:04:00 INFO - ##### 11:04:00 INFO - Running pre-action listener: _resource_record_pre_action 11:04:00 INFO - Running main action method: run_tests 11:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:04:00 INFO - Python 2.7.3 11:04:00 INFO - Return code: 0 11:04:00 INFO - grabbing minidump binary from tooltool 11:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:00 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 0x1e461c0>, '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 0x1e470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e47550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:04:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:04:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:04:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:04:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:04:00 INFO - Return code: 0 11:04:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:04:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:04:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:04:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:04:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:04:01 INFO - Return code: 0 11:04:01 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/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:04:01 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/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:04:01 INFO - Using env: {'DISPLAY': ':0', 11:04:01 INFO - 'HOME': '/home/cltbld', 11:04:01 INFO - 'LANG': 'en_US.UTF-8', 11:04:01 INFO - 'LANGUAGE': 'en_US:en', 11:04:01 INFO - 'LOGNAME': 'cltbld', 11:04:01 INFO - 'MAIL': '/var/mail/cltbld', 11:04:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:04:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:01 INFO - 'MOZ_NO_REMOTE': '1', 11:04:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:04:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:01 INFO - 'NO_EM_RESTART': '1', 11:04:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:04:01 INFO - 'PWD': '/builds/slave/test', 11:04:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:04:01 INFO - 'SHELL': '/bin/bash', 11:04:01 INFO - 'SHLVL': '1', 11:04:01 INFO - 'TERM': 'linux', 11:04:01 INFO - 'TMOUT': '86400', 11:04:01 INFO - 'USER': 'cltbld', 11:04:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318', 11:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:01 INFO - '_': '/tools/buildbot/bin/python'} 11:04:01 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/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:04:01 INFO - mozversion application_buildid: 20160726081123 11:04:01 INFO - mozversion application_changeset: ebd239b4cbfb8eff833560f72b163275ac4026d3 11:04:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:04:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:04:01 INFO - mozversion application_name: Firefox 11:04:01 INFO - mozversion application_remotingname: firefox-dev 11:04:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:04:01 INFO - mozversion application_vendor: Mozilla 11:04:01 INFO - mozversion application_version: 49.0a2 11:04:01 INFO - mozversion platform_buildid: 20160726081123 11:04:01 INFO - mozversion platform_changeset: ebd239b4cbfb8eff833560f72b163275ac4026d3 11:04:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:04:01 INFO - mozversion platform_version: 49.0a2 11:04:01 INFO - using testdate: 1469556241 11:04:01 INFO - actual date: 1469556241 11:04:01 INFO - starting webserver on 'localhost:50425' 11:04:01 INFO - SUITE-START | Running 2 tests 11:04:01 INFO - TEST-START | dromaeo_css 11:04:01 INFO - operating with platform_type : linux_ 11:04:01 INFO - Initialising browser for dromaeo_css test... 11:04:01 INFO - TEST-INFO | started process 8114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLChgOk/profile http://localhost:50425/getInfo.html) 11:04:05 INFO - PROCESS | 8114 | __metrics Screen width/height:1600/1200 11:04:05 INFO - PROCESS | 8114 | colorDepth:24 11:04:05 INFO - PROCESS | 8114 | Browser inner width/height: 1024/697 11:04:05 INFO - PROCESS | 8114 | __metrics 11:04:06 ERROR - PROCESS | 8114 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:04:07 INFO - TEST-INFO | 8114: exit 0 11:04:07 INFO - Browser initialized. 11:04:07 INFO - Running cycle 1/1 for dromaeo_css test... 11:04:07 INFO - TEST-INFO | started process 8243 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLChgOk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:04:19 INFO - PROCESS | 8243 | RSS: Main: 156164096 11:04:19 INFO - PROCESS | 8243 | 11:05:08 INFO - PROCESS | 8243 | 1469556308602 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:07:17 INFO - PROCESS | 8243 | Cycle 1(1): loaded http://localhost:50425/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50425/tests/dromaeo/cssquery-ext.html) 11:07:18 INFO - PROCESS | 8243 | RSS: Main: 159580160 11:07:18 INFO - PROCESS | 8243 | 11:10:20 INFO - PROCESS | 8243 | Cycle 1(1): loaded http://localhost:50425/tests/dromaeo/cssquery-ext.html (next: http://localhost:50425/tests/dromaeo/cssquery-jquery.html) 11:10:20 INFO - PROCESS | 8243 | RSS: Main: 157319168 11:10:20 INFO - PROCESS | 8243 | 11:13:22 INFO - PROCESS | 8243 | Cycle 1(1): loaded http://localhost:50425/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50425/tests/dromaeo/cssquery-mootools.html) 11:13:23 INFO - PROCESS | 8243 | RSS: Main: 156880896 11:13:23 INFO - PROCESS | 8243 | 11:16:24 INFO - PROCESS | 8243 | Cycle 1(1): loaded http://localhost:50425/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50425/tests/dromaeo/cssquery-prototype.html) 11:16:25 INFO - PROCESS | 8243 | RSS: Main: 157016064 11:16:25 INFO - PROCESS | 8243 | 11:19:27 INFO - PROCESS | 8243 | Cycle 1(1): loaded http://localhost:50425/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50425/tests/dromaeo/cssquery-yui.html) 11:19:28 INFO - PROCESS | 8243 | RSS: Main: 159080448 11:19:28 INFO - PROCESS | 8243 | 11:22:30 INFO - PROCESS | 8243 | Cycle 1(1): loaded http://localhost:50425/tests/dromaeo/cssquery-yui.html (next: http://localhost:50425/tests/dromaeo/cssquery-dojo.html) 11:22:30 INFO - PROCESS | 8243 | RSS: Main: 159133696 11:22:30 INFO - PROCESS | 8243 | 11:22:30 INFO - PROCESS | 8243 | __start_tp_report 11:22:30 INFO - PROCESS | 8243 | _x_x_mozilla_page_load 11:22:30 INFO - PROCESS | 8243 | _x_x_mozilla_page_load_details 11:22:30 INFO - PROCESS | 8243 | |i|pagename|runs| 11:22:30 INFO - PROCESS | 8243 | |0;dojo.html;3371.022403502984;3454.360943225502;3459.4637831136183;3461.46347316166;3493.12671832042;5727.427257274276;5728.112142617901;5735;5738.225339579156;5768.538516918647;5676.517496012833;5686.459786320293;5752.683602401867;5754.942450575493;5769.538436925036;5207.583393328544;5214.634975551713;5259.368875734917;5286.577073834103;5289.127293996486;5132.332796736419;5144.768485418165;5191.143461328877;5294.10000299948;5318.813841515548;5267;5328.520433161015;5367.892642147155;5374.7043912584795;5388.622796404254;5238.764255608468;5258.50044245796;5301.151815709506;5306.018386598453;5306.814261500829;5164.302819119408;5202.0896343140175;5270.945810837848;5281.973590132025;5282.683039017671;5463.2078348639225;5487.122060470306;5537.1140617501405;5622.662640241599;5634.04221282383;6124.2650881894015;6126.142340072393;6149.661768602725;6151.569390142692;6161.630302181883;5952;6205.87588248237;6215;6218.626882387071;6223;5664.122061080539;5696.3733989261145;5724;5748.770049198069;5763.279590051244;6248.125262463259;6253.46845518127;6254.468370188585;6270.905936410957;6279.874402511924;5809.738561764731;5958.344582095966;6018.578699491081;6021.608595441282;6055.455009049207;6056.031035034373;6132.846678833065;6134.355892631299;6137.693115344215;6146.600470969463;6105.45050945417;6118.571699980958;6120.877582448326;6121.510279177655;6127.693615319216;5974.462298393166;6054.666993315322;6068.150458935753;6124.203853499017;6131.448169664752;4692.483826779052;4695.178343789823;4695.95304046962;4727.527247275314;4733.928991065137;4194.601512856274;4218.17745539623;4219.156168766259;4226.344916537942;4242;5888.293404791452;5897.616654917417;5946.137810017523;5955.225820643375;5972;5980.790672326535;6158.076288556752;6203.7828675996125;6208.689565521796;6274.529410294246;6038.788642397495;6041.848953776191;6051.062085376773;6054.3642917493025;6076.058210977306;5125.923111153335;5244.160934250502;5266.631335806457;5320.574354051667;5330;6368.42684158428;6387.233531976192;6402.775902843378;6412.935870641327;6441.61350318973;5899.439553242435;6179.876402472015;6199.814005579839;6203.8138855833495;6206.968965155145;6411.743530258737;6442.806715798533;6481.060246264359;6510.7721229756735;6530.08578798959;6088.056351265561;6121.663308518075;6136.202293701969;6146.938530614637;6147.600405973598;6018.939810601838;6116.42707509198;6217.378262173927;6264.467520260829;6269.49844012487;6089.48239399656;6122.051082082285;6130.325664177026;6132.17215675878;6149;5998.550108741774;6062.090686397076;6067.817965460867;6088.178095956989;6090.025595904634;5700.087985922232;5764.769409223584;5858.443447872445;5907.409259074058;6008.729607167776;6043.123747056564;6045.697715114139;6046.758129674764;6047.9395206047375;6055.6063855849225;5854.092615644582;5881.735321910439;5889.646621202742;5918.141869428995;5930.733117009659 11:22:30 INFO - PROCESS | 8243 | |1;ext.html;569.5159114752461;642.1267076775581;655.7213184396632;656.1994366872417;671.6910221298202;36508.26983460329;39531.40702889459;46390.07219855605;47440.288395674004;47564.76217618907;49010.50989490104;49111.26333104997;49408.25887611689;49558.25662615055;49564;8962.37263391563;8986.326025548078;9064.365494415393;9067.773305667379;9093.136152065543;9040.8643870342;9087.363884528086;9127.908720912772;9145.131212534798;9180.403273787217;9072.31957603179;9157.862632060524;9161.862572061424;9172.082791720808;9202.76993075175;9030;9150.908490915072;9156.359054866161;9164.312676549285;9166.67916622915;9143.634254629807;9152.588133534007;9170.67902623405;9198.770030749285;9199.908000920039;44418;44896.3265551017;44920.326195107096;44995;45111.77444112791;3903.590123037097;4394.670399720002;4481.708688935209;4573.176828170928;4612.677112602119;34104.14739631504;34496.6550334496;34570.48144277838;35045.299094018235;35971.28057438863;4454.443194600675;4463.308187230984;4489.371487991683;4526.705764125321;4527.366168736379;386281;386457;386706;387376;389857.99999999715;36131.277374452366;37278.62721372806;66070.33929660737;66238.66880665663;66810.66594667092;37078;37094.62905370966;37287.81356093202;37297.813510932814;37338.43992340117;15769.763453548207;15787.210639467981;15817.288222030036;15831.208439577975;15888.046717197005;14226.430942762381;14232.786508202385;14241.287935603179;14254.643633909236;14268.072575282573;9175.678851240174;9229.769255768659;9240.676576319796;9258.675946341846;9304.767380815534;3500.5974312953826;3516.49010893419;3534.823258837048;3537.9292414152087;3580.051286409104;1102.5644870276196;1143.857017872766;1146.1003112556602;1169.8830116988233;1225.5649244518067;33655.83172084124;33792.66207337944;34043.31913361719;34119;34212.65787342095;1204.3015051270243;1214.7388311513066;1217.8538575371012;1225.3689349984766;1334.7197088611501;16738.91630541864;17059.829401706073;17209.397671081453;17439.65120697579;17468;598646;604775;609038;610774;612761;66043;66084.66957665181;66236.66881665657;66256.33743662598;66419.33580664228;1498.2658497336226;1514.258013573341;1539.0919357579082;1547.5280039588033;1549.4112237349734;32251.35497290088;32401.51397729083;32468.675313246564;32682.83658581692;33273.833630831694;55523.16715249355;56456.717716411156;56514;56582.434175659364;56796.29611111673;487247;488371;489145;491867;492316;30412.239694007825;30588.694113058584;30823.845880770452;30988.91538796131;30995.225119372197;52073;52169.21746173887;53648.46351536591;54488.45511544834;54719.17921231264;45627.315590265505;46726;47202.29196562123;47604.7619761899;47744.04511909812;45379.319310209714;45856.08287834292;46263.306050408595;46620;46677.76661116673;44952.550474494834;45227.54772452233;45660;46346.768266158455;48508.5149148504;38466;39413.802930986305;39668.40497392599;39839.2032159361;40173.598264018154;30196.54705179468;30374.69625303807;30574;30912.726182144816;31290.843545783035 11:22:30 INFO - PROCESS | 8243 | |2;jquery.html;432.48750230976276;433.2591268930131;436.8864095335214;439.18750311922946;444.65761363749914;17660.38188663397;18795.62408751826;19561;20180.091895864683;20236.8988155059;16575.088370139638;18037.458876233733;19460.026998650046;19796.50508737282;19816.306429274977;5519.917201241985;5826.912596311059;5867.11993201019;5894.823155305347;5894.941050589504;5565.193047008182;5684.488396044355;5798.9130163047585;5804.2744656917885;5835.766569337221;5731.054376027951;5741.712914354286;5765.5099316557935;5774.740136693859;5795.2466179396615;5562.972185139049;5635.6618602883755;5741.971290143564;5752.367239603661;5763.1355296705415;5054.267131265982;5067.847964561069;5096;5097.6941383517105;5123.462036486189;21817.890910545506;23089.53820923572;23348.649770253458;23397.88301058484;23584.528309433714;2577.756504223139;2648.7880969522394;2680.6917204521533;2735.9452810943867;3139.9481173806803;10190.592376305012;10331.94834025825;10702.892971070267;10798.73003174927;10982.06652434544;2016.8184863362367;2070.4306315763133;2086.5201003769066;2105.4210092224607;2117.4706323419146;80299.19700802976;80386.59806700988;81390.21387522377;81790.18209817944;83176;11607.477663505162;11858.110641701907;12011.279323240633;12054.879451205552;12084.577039803564;16759.66480670404;17020.574485637957;17026.489205323862;17062.82937170637;17099.316027359015;8894.911050889537;8926.598303076376;8979.416337938013;9068.410553314014;9138.268938484905;8602.526861022703;8649.264812491008;8736.737897863075;8856.512891791013;8897.199252067216;5061.082894297414;5141.020707027821;5194.506521880416;5235.712035837989;5254.3169387979315;1926.2391355414534;1928.305809908432;1950.4733721895009;1973.1515448357056;1993.1031036033842;1024.3802499487704;1054.6572363981736;1091.307020042263;1134.7446824464594;1201.567435723139;19057.428277151706;19109.617807643768;20032.298869539787;20174.386049116034;20257.088431020344;1080.7460246842143;1095.2169199022578;1154.1978325064;1160.9709757256137;1163.116031815826;11021.338719676845;11112.666620001413;11152.996230339308;11398.94300528492;11402.600908968147;355354;414124;417419;424341;529841;100005.49997249967;101705;101880;102883;104334.4783276094;1080.6001779341536;1087.9673609791719;1132.5809450503202;1143.382573410349;1144.4964215745213;18298.26806927708;18420.35528756487;18448.26206951707;18639.440816775517;18737.1568279425;41714.37428438515;42748;43492.782536087114;43517.56482435135;44815.327770082826;57630.4236957625;59825.40174598198;60601.39398605958;60931.69534152301;61077.694611526655;8998.14517620825;9056.63773449081;9098.818023639358;9116.544172791466;9448.338616296793;9776.169025632616;12949.741005180033;13287.867121328663;13462.596122116352;13643.590692279247;11441.942790285995;11442.427878606202;11545.48045337945;11637.127215459044;11662.650120496399;11408.429578521207;11432.542698291974;11639.836016398292;11899.405029748305;12056.63830085099;11699.415029248334;11738.119641026786;11771.23486973344;11972.461239244081;11979.28124312544;7162.785116446515;7860.449768516149;8370.916290837014;8872.911270887467;9120.042395548637;8653.437526560754;10677.46612669379;10820.4048777318;10859.83710244331;11161.441927903736 11:22:30 INFO - PROCESS | 8243 | |3;mootools.html;1573.3785154863829;1624.2853144616367;1824.5438640339914;1933.6132773445315;1947.2503086311765;8498.405111642187;9058.682946096887;9220.400673956197;9783.412995220282;9812.852807207888;9405.294602904776;9496.715098547038;9606;9607.951960240207;9612.567434465449;2438.110089817217;2462.3967128053564;2464.346948058766;2464.8890799913956;2465.272744540365;2341.3610472669116;2452.4849781545895;2452.7056753189554;2454.1533171055958;2459.2007597530874;2279.2592407467555;2282.9086836526517;2320.582295186866;2344.5779759643256;2345.413646588353;2437.9882348825217;2457.8648174350405;2481.2308184462695;2510.9454029307735;2517.7104632967166;2403.25499095281;2428.538577670237;2432.3554258121612;2443.0960544598433;2449.6570480132796;9583.424994500352;9595;9605;9631.566579503939;9634.421934683942;5796.710164491758;5821.941780582182;5905.970470147622;5937.821865344046;5962.07587823888;3717.888463346104;3718.6467285607823;3729.7575657582443;3768.7550309230087;3823.5220597425323;1118.6867677050438;1125.9380734059623;1141;1155.5608868629952;1162.7790719763218;13654.726905461835;13767.036307458382;13772.10481318711;13795.310234488235;13808.930955345159;5030.3963524377305;5212.661177023481;5221.947780522222;5283.392409872837;5285.709285989307;11317.943410282896;11386.658400248005;11433;11484.19610627248;11484.655460336204;5830.416958304136;5856.619319744203;5916.112583112567;5937.821865344046;5962.970185149046;4734.171519983989;5141.203113517411;5356.062689029404;5362.839114826562;5388.407275199725;4377.080813029236;4388.824447022083;4499.955000450019;4523.095380923828;4530.207213737583;1416.5821082780606;1433.2976841347872;1458.0741229319458;1463.0636392708675;1468.7136008478244;1060.6181774561153;1062.2935747727674;1078.6009176604707;1079.5357996061769;1089.4716062709579;6372.522060845455;6453.838654033687;6562.2193393872485;6632.2372927114;6661.100751398596;481.8843477565429;492.4632150955476;508.58296197118005;512.9256257842667;514.2851436503263;4408.4930233023615;4425.358323043205;4429.335599660077;4446.444194475691;4447.822087116479;11772.705002449724;12158.452869620889;12280.508779648713;12334.321612311409;12339.568115115928;11995.88004119965;12186.146969712036;12205.20666156697;12220.633380998584;12234.877651223553;8642.30861531076;8941.642334306685;8954.820903582022;9040.321975851837;9180.31147663928;6554.868902622016;6722.865542689216;6759.188897332351;6788.96605516989;6791.3548212919695;10632.149428045892;11333.546658133582;11351.205415620827;11399.658010259705;11517.712057198301;11262.04272636835;11497.137714671266;11517.308961462339;11550.133739969704;11606.419679016184;8249.83500330002;8309.418340716093;8420.663173472993;8470.745877623682;8484.575771211292;9275.814483710154;9314.767130821783;9355.719328420158;9398.248140148908;9433.952830235805;8008.719694810887;8174.386920980831;8237.670493180445;8360.372972027;8369.204925532065;7846.725364612439;7856.096548896721;7992.080910695345;8044.35645148375;8116.553589552631;7689.307962283421;7727.729529466442;7769.53382797034;7787.493812902143;7802.765917022499;5708.457696518824;5736.71316434185;5787.536997040311;5814.476697097281;5853.882922341614;5593.216949626974;5617.747201375866;5633.8309850704545;5636.436356364495;5765.4522820332 11:22:31 INFO - PROCESS | 8243 | |4;prototype.html;357.6048466444579;358.449779588332;360.27404779369556;364.8978286079897;370.82756518219026;5692.658440493563;5693.629914055584;5715.514181294595;5751.820876720268;5758.30900291965;5369.650972686773;5604.299462567179;5623.578231632634;5647.887042259153;5658.292713410824;4405.977970110145;4406.206882761102;4406.933895991563;4407.206702793496;4438.423005009352;4393;4405.8237670493145;4413.801378937956;4413.955860441387;4441.844535441261;4299.914001719963;4387.846425375113;4392.736435813846;4403.9430536671125;4410.514843367227;4294.09823936972;4366.759828209447;4380.7152535085115;4391.692581519295;4417;3804.828782704757;3850.3251085777774;3855.267499175148;3858.903527411809;3867.400552914303;5460.945390546123;5468;5488.1493368527945;5500.202470641734;5542.91685624716;4941.950580494185;5043.579082040605;5071.822486212965;5077;5107.948920510785;5918.171455996164;5925.34821169671;5961.8807623847715;5989.490893274077;6013.398660133996;4220.767857767822;4286.699931004831;4302.935455968163;4312.547182545819;4337.067530480962;6051.818445446644;6086.6348019119;6181.938180618181;6189.597676151081;6284.402981716729;4263.104748002892;4282.164977829356;4283.978580107079;4299.419578356944;4299.78501074945;4297.290946993711;4348.478182618106;4352.542982986804;4357.477102747691;4369.060651959844;4923.655344125877;4968.130577148984;4999.550040496373;5007.599392048627;5044;5904.911426328608;5930.970345148246;5944.494717948936;5946.256717910262;5966.49284810796;1498.3482185249234;1514.7122046811292;1532.1190315568592;1539.6150962259435;1540.8305086440482;916.7158180963922;953.7758626722715;957.3824882950458;971.8347880860271;974.3812678948918;5121.667091639031;5248.606354523426;5264.5525130363585;5269.1569348903995;5304.151335786333;5396.271503347077;5454.036546843134;5534.75093620788;5598.4961353477565;5602.439756024365;4790.5568160237835;5192.350956130484;5198.818041368534;5208.635395522277;5307.787688492494;2876.3096856754646;2886.826790392583;2936;2942.7792915531422;2947.6168098147105;5609.971950140223;5654.3884992777685;5666.688332141772;5707.8858422832145;5746.50590846383;5880.323762767251;6305.684715764193;6368.172137622079;6371.267304260069;6387.169667943138;6379.71291291893;6411.3909178627955;6415.871682566322;6440.516961227927;6488.28628850826;6027.758889644365;6131.84670383244;6202.503799695924;6216.1405753353965;6263.4362907338555;6121.663308518075;6122.204113465221;6159.414855588712;6165.660888651168;6172.321044684992;6111.083337499411;6224.37756224374;6302.558820882494;6331.493480521639;6361.586496877688;4283.443152390294;4316.956830431655;4343.543927887653;4350.891227719206;4354.477462704495;5927.792527261525;6180.805813935988;6201.751929922933;6214.875702485834;6229.345918678474;5994.28068631767;6011.849703757441;6014;6037.547183961308;6042.728077236447;5948.018576934757;6000.5799594028;6010.308814486215;6050.969745151246;6078.604890682268;5676.035074037506;5926.170336152856;5947.91078133837;5949.315828679584;5961.165436838933;6004.699765011645;6064.4541991221;6082.6046306991675;6094.7257373417415;6162.07568864656;5649.830505084854;5916.171735957056;5927.881442371042;5976.073708575178;5976.462118409364 11:22:31 INFO - PROCESS | 8243 | |5;yui.html;799.1968072087554;841.7037761846752;864.7319331007388;881.2905610983156;889.6930558957157;15201.543953681394;16255.837441625596;16321.510354689348;16390.83609163908;16399.50801475956;13904.374303156357;14773.556793296191;14949.775753363681;15004.324805383756;15106.773398399006;861.9570319912897;880.3177537408495;881.0440671871028;881.960311785968;883.8188171424874;874.9387542872001;877.1491653096518;878.6792820620459;879.7272845417909;881.9162179592961;932.7015355086376;934.3459578295186;935.4387367579432;936.5738588942015;937.9671711490099;917.2020342302174;925.8981512033671;925.9212966897821;926.4348747264163;927.2118699105773;672.5628341578014;678.3420082519948;682.4233522673383;682.8634273145341;683.1255992329826;14595.197264150467;14835.25823708821;14836.480723174636;14852.405903763836;15195.848041519665;15232.162231077285;15752;16002.359905603762;16397.754033689504;16667.166641667867;12677.809832852514;13046.869531304661;13053.04690055818;13109.672258193621;13111;4037.4895530703952;4091.1204091120553;4103.774292413916;4108.630223279919;4115.300398932189;83773;84001.57999210026;84137.57931210365;85269.14730852674;85509.57245213796;12258;12401.62795116148;12499.750004999849;12584.874151258553;12713.618591442271;22680.43298917507;22722.886385567966;22745.317640470814;22821.657675134888;22836.885815570815;8771.342149338825;8804.163604457566;8937.865932011026;9037.141471560191;9300.162985331353;5134.229865520202;5180.6891586504935;5196.9740151299;5239.6376941994595;5251.816186433456;4097.528784189797;4230.788460576959;4241.27898257297;4251.723637963522;4260.360945858146;695.9408450281783;705.2947052947053;715.8103102677794;717.7631381644045;722.2344315026089;750.6772088002211;771.4946709905021;809.7327881798992;814.4380377539479;830.1532436914314;10626.415547144981;10795.082417994401;11113.166512511594;11305.943470282597;11531.538738450536;736.5985537881867;788.341734651561;800.2917418085036;806.2461598405392;808.2321794295443;4639.559241872017;4724.787384567703;4736.976315118402;4757.001029783784;4798.520147985174;99578;114603.42698286455;117826;118032.40983795197;119183;66521.6673916637;77531;97877;98263;101366.49316753368;87706;87802;88653.55673221593;88688;89011;9861.013898610081;9973.60105595797;10145.18838492904;10206.285560010729;10237;51819.740901295256;52775.20837187522;53019.20471192858;53759.73120134374;54201.728991354794;68547;77327;77910.22089779029;78323.60838195773;78450.6077469609;12807.231566106064;12931.353432328158;12950.287734174333;13011.349432528146;13399.12905661129;13887.444502219798;14677.706445871236;15109.47116850905;15141.318640660977;15141.470048548248;14020.158790472604;14050.227237502035;14168.504102356368;14401.207933563755;14828.258587070819;13326.86673133295;13817.585472435843;14204.005719599942;14381.209033503257;14382.928085359506;12176.0867934907;12359.62921112368;13049.673758156123;13054.282014489294;13090.14914030585;10748.408837514013;11125.276857004268;11447.713807154887;11522.251053681484;11822.763544729229;11637.76724465523;11915;11932.343721095423;11975.221610595283;12169.087318450975 11:22:31 INFO - PROCESS | 8243 | __end_tp_report 11:22:31 INFO - PROCESS | 8243 | __start_cc_report 11:22:31 INFO - PROCESS | 8243 | _x_x_mozilla_cycle_collect,333 11:22:31 INFO - PROCESS | 8243 | __end_cc_report 11:22:31 INFO - PROCESS | 8243 | __startTimestamp1469557350993__endTimestamp 11:22:31 INFO - PROCESS | 8243 | 11:22:31 INFO - PROCESS | 8243 | ------- Summary: start ------- 11:22:31 INFO - PROCESS | 8243 | Number of tests: 6 11:22:31 INFO - PROCESS | 8243 | 11:22:31 INFO - PROCESS | 8243 | [#0] dojo.html Cycles:165 Average:5727.38 Median:5972.00 stddev:638.31 (10.7%) stddev-sans-first:612.92 11:22:31 INFO - PROCESS | 8243 | Values: 3371.0 3454.4 3459.5 3461.5 3493.1 5727.4 5728.1 5735.0 5738.2 5768.5 5676.5 5686.5 5752.7 5754.9 5769.5 5207.6 5214.6 5259.4 5286.6 5289.1 5132.3 5144.8 5191.1 5294.1 5318.8 5267.0 5328.5 5367.9 5374.7 5388.6 5238.8 5258.5 5301.2 5306.0 5306.8 5164.3 5202.1 5270.9 5282.0 5282.7 5463.2 5487.1 5537.1 5622.7 5634.0 6124.3 6126.1 6149.7 6151.6 6161.6 5952.0 6205.9 6215.0 6218.6 6223.0 5664.1 5696.4 5724.0 5748.8 5763.3 6248.1 6253.5 6254.5 6270.9 6279.9 5809.7 5958.3 6018.6 6021.6 6055.5 6056.0 6132.8 6134.4 6137.7 6146.6 6105.5 6118.6 6120.9 6121.5 6127.7 5974.5 6054.7 6068.2 6124.2 6131.4 4692.5 4695.2 4696.0 4727.5 4733.9 4194.6 4218.2 4219.2 4226.3 4242.0 5888.3 5897.6 5946.1 5955.2 5972.0 5980.8 6158.1 6203.8 6208.7 6274.5 6038.8 6041.8 6051.1 6054.4 6076.1 5125.9 5244.2 5266.6 5320.6 5330.0 6368.4 6387.2 6402.8 6412.9 6441.6 5899.4 6179.9 6199.8 6203.8 6207.0 6411.7 6442.8 6481.1 6510.8 6530.1 6088.1 6121.7 6136.2 6146.9 6147.6 6018.9 6116.4 6217.4 6264.5 6269.5 6089.5 6122.1 6130.3 6132.2 6149.0 5998.6 6062.1 6067.8 6088.2 6090.0 5700.1 5764.8 5858.4 5907.4 6008.7 6043.1 6045.7 6046.8 6047.9 6055.6 5854.1 5881.7 5889.6 5918.1 5930.7 11:22:31 INFO - PROCESS | 8243 | 11:22:31 INFO - PROCESS | 8243 | [#1] ext.html Cycles:180 Average:65290.62 Median:45169.66 stddev:133828.53 (296.3%) stddev-sans-first:134115.74 11:22:31 INFO - PROCESS | 8243 | Values: 569.5 642.1 655.7 656.2 671.7 36508.3 39531.4 46390.1 47440.3 47564.8 49010.5 49111.3 49408.3 49558.3 49564.0 8962.4 8986.3 9064.4 9067.8 9093.1 9040.9 9087.4 9127.9 9145.1 9180.4 9072.3 9157.9 9161.9 9172.1 9202.8 9030.0 9150.9 9156.4 9164.3 9166.7 9143.6 9152.6 9170.7 9198.8 9199.9 44418.0 44896.3 44920.3 44995.0 45111.8 3903.6 4394.7 4481.7 4573.2 4612.7 34104.1 34496.7 34570.5 35045.3 35971.3 4454.4 4463.3 4489.4 4526.7 4527.4 386281.0 386457.0 386706.0 387376.0 389858.0 36131.3 37278.6 66070.3 66238.7 66810.7 37078.0 37094.6 37287.8 37297.8 37338.4 15769.8 15787.2 15817.3 15831.2 15888.0 14226.4 14232.8 14241.3 14254.6 14268.1 9175.7 9229.8 9240.7 9258.7 9304.8 3500.6 3516.5 3534.8 3537.9 3580.1 1102.6 1143.9 1146.1 1169.9 1225.6 33655.8 33792.7 34043.3 34119.0 34212.7 1204.3 1214.7 1217.9 1225.4 1334.7 16738.9 17059.8 17209.4 17439.7 17468.0 598646.0 604775.0 609038.0 610774.0 612761.0 66043.0 66084.7 66236.7 66256.3 66419.3 1498.3 1514.3 1539.1 1547.5 1549.4 32251.4 32401.5 32468.7 32682.8 33273.8 55523.2 56456.7 56514.0 56582.4 56796.3 487247.0 488371.0 489145.0 491867.0 492316.0 30412.2 30588.7 30823.8 30988.9 30995.2 52073.0 52169.2 53648.5 54488.5 54719.2 45627.3 46726.0 47202.3 47604.8 47744.0 45379.3 45856.1 46263.3 46620.0 46677.8 44952.6 45227.5 45660.0 46346.8 48508.5 38466.0 39413.8 39668.4 39839.2 40173.6 30196.5 30374.7 30574.0 30912.7 31290.8 11:22:31 INFO - PROCESS | 8243 | 11:22:31 INFO - PROCESS | 8243 | [#2] jquery.html Cycles:180 Average:27839.67 Median:2095.97 stddev:71897.24 (3430.3%) stddev-sans-first:72069.48 11:22:31 INFO - PROCESS | 8243 | Values: 432.5 433.3 436.9 439.2 444.7 17660.4 18795.6 19561.0 20180.1 20236.9 16575.1 18037.5 19460.0 19796.5 19816.3 5519.9 5826.9 5867.1 5894.8 5894.9 5565.2 5684.5 5798.9 5804.3 5835.8 5731.1 5741.7 5765.5 5774.7 5795.2 5563.0 5635.7 5742.0 5752.4 5763.1 5054.3 5067.8 5096.0 5097.7 5123.5 21817.9 23089.5 23348.6 23397.9 23584.5 2577.8 2648.8 2680.7 2735.9 3139.9 10190.6 10331.9 10702.9 10798.7 10982.1 2016.8 2070.4 2086.5 2105.4 2117.5 80299.2 80386.6 81390.2 81790.2 83176.0 11607.5 11858.1 12011.3 12054.9 12084.6 16759.7 17020.6 17026.5 17062.8 17099.3 8894.9 8926.6 8979.4 9068.4 9138.3 8602.5 8649.3 8736.7 8856.5 8897.2 5061.1 5141.0 5194.5 5235.7 5254.3 1926.2 1928.3 1950.5 1973.2 1993.1 1024.4 1054.7 1091.3 1134.7 1201.6 19057.4 19109.6 20032.3 20174.4 20257.1 1080.7 1095.2 1154.2 1161.0 1163.1 11021.3 11112.7 11153.0 11398.9 11402.6 355354.0 414124.0 417419.0 424341.0 529841.0 100005.5 101705.0 101880.0 102883.0 104334.5 1080.6 1088.0 1132.6 1143.4 1144.5 18298.3 18420.4 18448.3 18639.4 18737.2 41714.4 42748.0 43492.8 43517.6 44815.3 57630.4 59825.4 60601.4 60931.7 61077.7 8998.1 9056.6 9098.8 9116.5 9448.3 9776.2 12949.7 13287.9 13462.6 13643.6 11441.9 11442.4 11545.5 11637.1 11662.7 11408.4 11432.5 11639.8 11899.4 12056.6 11699.4 11738.1 11771.2 11972.5 11979.3 7162.8 7860.4 8370.9 8872.9 9120.0 8653.4 10677.5 10820.4 10859.8 11161.4 11:22:31 INFO - PROCESS | 8243 | 11:22:31 INFO - PROCESS | 8243 | [#3] mootools.html Cycles:180 Average:6359.18 Median:2608.03 stddev:3684.94 (141.3%) stddev-sans-first:3677.73 11:22:31 INFO - PROCESS | 8243 | Values: 1573.4 1624.3 1824.5 1933.6 1947.3 8498.4 9058.7 9220.4 9783.4 9812.9 9405.3 9496.7 9606.0 9608.0 9612.6 2438.1 2462.4 2464.3 2464.9 2465.3 2341.4 2452.5 2452.7 2454.2 2459.2 2279.3 2282.9 2320.6 2344.6 2345.4 2438.0 2457.9 2481.2 2510.9 2517.7 2403.3 2428.5 2432.4 2443.1 2449.7 9583.4 9595.0 9605.0 9631.6 9634.4 5796.7 5821.9 5906.0 5937.8 5962.1 3717.9 3718.6 3729.8 3768.8 3823.5 1118.7 1125.9 1141.0 1155.6 1162.8 13654.7 13767.0 13772.1 13795.3 13808.9 5030.4 5212.7 5221.9 5283.4 5285.7 11317.9 11386.7 11433.0 11484.2 11484.7 5830.4 5856.6 5916.1 5937.8 5963.0 4734.2 5141.2 5356.1 5362.8 5388.4 4377.1 4388.8 4500.0 4523.1 4530.2 1416.6 1433.3 1458.1 1463.1 1468.7 1060.6 1062.3 1078.6 1079.5 1089.5 6372.5 6453.8 6562.2 6632.2 6661.1 481.9 492.5 508.6 512.9 514.3 4408.5 4425.4 4429.3 4446.4 4447.8 11772.7 12158.5 12280.5 12334.3 12339.6 11995.9 12186.1 12205.2 12220.6 12234.9 8642.3 8941.6 8954.8 9040.3 9180.3 6554.9 6722.9 6759.2 6789.0 6791.4 10632.1 11333.5 11351.2 11399.7 11517.7 11262.0 11497.1 11517.3 11550.1 11606.4 8249.8 8309.4 8420.7 8470.7 8484.6 9275.8 9314.8 9355.7 9398.2 9434.0 8008.7 8174.4 8237.7 8360.4 8369.2 7846.7 7856.1 7992.1 8044.4 8116.6 7689.3 7727.7 7769.5 7787.5 7802.8 5708.5 5736.7 5787.5 5814.5 5853.9 5593.2 5617.7 5633.8 5636.4 5765.5 11:22:31 INFO - PROCESS | 8243 | 11:22:31 INFO - PROCESS | 8243 | [#4] prototype.html Cycles:180 Average:4950.75 Median:5603.37 stddev:1477.89 (26.4%) stddev-sans-first:1441.26 11:22:31 INFO - PROCESS | 8243 | Values: 357.6 358.4 360.3 364.9 370.8 5692.7 5693.6 5715.5 5751.8 5758.3 5369.7 5604.3 5623.6 5647.9 5658.3 4406.0 4406.2 4406.9 4407.2 4438.4 4393.0 4405.8 4413.8 4414.0 4441.8 4299.9 4387.8 4392.7 4403.9 4410.5 4294.1 4366.8 4380.7 4391.7 4417.0 3804.8 3850.3 3855.3 3858.9 3867.4 5460.9 5468.0 5488.1 5500.2 5542.9 4942.0 5043.6 5071.8 5077.0 5107.9 5918.2 5925.3 5961.9 5989.5 6013.4 4220.8 4286.7 4302.9 4312.5 4337.1 6051.8 6086.6 6181.9 6189.6 6284.4 4263.1 4282.2 4284.0 4299.4 4299.8 4297.3 4348.5 4352.5 4357.5 4369.1 4923.7 4968.1 4999.6 5007.6 5044.0 5904.9 5931.0 5944.5 5946.3 5966.5 1498.3 1514.7 1532.1 1539.6 1540.8 916.7 953.8 957.4 971.8 974.4 5121.7 5248.6 5264.6 5269.2 5304.2 5396.3 5454.0 5534.8 5598.5 5602.4 4790.6 5192.4 5198.8 5208.6 5307.8 2876.3 2886.8 2936.0 2942.8 2947.6 5610.0 5654.4 5666.7 5707.9 5746.5 5880.3 6305.7 6368.2 6371.3 6387.2 6379.7 6411.4 6415.9 6440.5 6488.3 6027.8 6131.8 6202.5 6216.1 6263.4 6121.7 6122.2 6159.4 6165.7 6172.3 6111.1 6224.4 6302.6 6331.5 6361.6 4283.4 4317.0 4343.5 4350.9 4354.5 5927.8 6180.8 6201.8 6214.9 6229.3 5994.3 6011.8 6014.0 6037.5 6042.7 5948.0 6000.6 6010.3 6051.0 6078.6 5676.0 5926.2 5947.9 5949.3 5961.2 6004.7 6064.5 6082.6 6094.7 6162.1 5649.8 5916.2 5927.9 5976.1 5976.5 11:22:31 INFO - PROCESS | 8243 | 11:22:31 INFO - PROCESS | 8243 | [#5] yui.html Cycles:180 Average:21173.02 Median:4246.50 stddev:29835.47 (702.6%) stddev-sans-first:29879.95 11:22:31 INFO - PROCESS | 8243 | Values: 799.2 841.7 864.7 881.3 889.7 15201.5 16255.8 16321.5 16390.8 16399.5 13904.4 14773.6 14949.8 15004.3 15106.8 862.0 880.3 881.0 882.0 883.8 874.9 877.1 878.7 879.7 881.9 932.7 934.3 935.4 936.6 938.0 917.2 925.9 925.9 926.4 927.2 672.6 678.3 682.4 682.9 683.1 14595.2 14835.3 14836.5 14852.4 15195.8 15232.2 15752.0 16002.4 16397.8 16667.2 12677.8 13046.9 13053.0 13109.7 13111.0 4037.5 4091.1 4103.8 4108.6 4115.3 83773.0 84001.6 84137.6 85269.1 85509.6 12258.0 12401.6 12499.8 12584.9 12713.6 22680.4 22722.9 22745.3 22821.7 22836.9 8771.3 8804.2 8937.9 9037.1 9300.2 5134.2 5180.7 5197.0 5239.6 5251.8 4097.5 4230.8 4241.3 4251.7 4260.4 695.9 705.3 715.8 717.8 722.2 750.7 771.5 809.7 814.4 830.2 10626.4 10795.1 11113.2 11305.9 11531.5 736.6 788.3 800.3 806.2 808.2 4639.6 4724.8 4737.0 4757.0 4798.5 99578.0 114603.4 117826.0 118032.4 119183.0 66521.7 77531.0 97877.0 98263.0 101366.5 87706.0 87802.0 88653.6 88688.0 89011.0 9861.0 9973.6 10145.2 10206.3 10237.0 51819.7 52775.2 53019.2 53759.7 54201.7 68547.0 77327.0 77910.2 78323.6 78450.6 12807.2 12931.4 12950.3 13011.3 13399.1 13887.4 14677.7 15109.5 15141.3 15141.5 14020.2 14050.2 14168.5 14401.2 14828.3 13326.9 13817.6 14204.0 14381.2 14382.9 12176.1 12359.6 13049.7 13054.3 13090.1 10748.4 11125.3 11447.7 11522.3 11822.8 11637.8 11915.0 11932.3 11975.2 12169.1 11:22:31 INFO - PROCESS | 8243 | -------- Summary: end -------- 11:22:31 INFO - PROCESS | 8243 | 11:22:31 INFO - TEST-INFO | 8243: exit 0 11:22:31 INFO - TEST-OK | dromaeo_css | took 1109811ms 11:22:31 INFO - TEST-START | kraken 11:22:31 INFO - operating with platform_type : linux_ 11:22:31 INFO - Initialising browser for kraken test... 11:22:31 INFO - TEST-INFO | started process 8484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZbGWK1/profile http://localhost:50425/getInfo.html) 11:22:35 INFO - PROCESS | 8484 | __metrics Screen width/height:1600/1200 11:22:35 INFO - PROCESS | 8484 | colorDepth:24 11:22:35 INFO - PROCESS | 8484 | Browser inner width/height: 1024/697 11:22:35 INFO - PROCESS | 8484 | __metrics 11:22:36 ERROR - PROCESS | 8484 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:22:36 INFO - TEST-INFO | 8484: exit 0 11:22:36 INFO - Browser initialized. 11:22:36 INFO - Running cycle 1/1 for kraken test... 11:22:36 INFO - TEST-INFO | started process 8614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZbGWK1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:48 INFO - PROCESS | 8614 | RSS: Main: 156119040 11:22:48 INFO - PROCESS | 8614 | 11:22:51 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:50425/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50425/tests/kraken/driver.html?testName=audio-beat-detection) 11:22:52 INFO - PROCESS | 8614 | RSS: Main: 161005568 11:22:52 INFO - PROCESS | 8614 | 11:22:54 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:50425/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50425/tests/kraken/driver.html?testName=audio-dft) 11:22:55 INFO - PROCESS | 8614 | RSS: Main: 160227328 11:22:55 INFO - PROCESS | 8614 | 11:22:58 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:50425/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50425/tests/kraken/driver.html?testName=audio-fft) 11:22:58 INFO - PROCESS | 8614 | RSS: Main: 160804864 11:22:58 INFO - PROCESS | 8614 | 11:23:00 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:50425/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50425/tests/kraken/driver.html?testName=audio-oscillator) 11:23:01 INFO - PROCESS | 8614 | RSS: Main: 160800768 11:23:01 INFO - PROCESS | 8614 | 11:23:03 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:50425/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50425/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:23:04 INFO - PROCESS | 8614 | RSS: Main: 160145408 11:23:04 INFO - PROCESS | 8614 | 11:23:07 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:50425/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50425/tests/kraken/driver.html?testName=imaging-darkroom) 11:23:07 INFO - PROCESS | 8614 | RSS: Main: 159944704 11:23:07 INFO - PROCESS | 8614 | 11:23:11 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:50425/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50425/tests/kraken/driver.html?testName=imaging-desaturate) 11:23:12 INFO - PROCESS | 8614 | RSS: Main: 156696576 11:23:12 INFO - PROCESS | 8614 | 11:23:14 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:50425/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50425/tests/kraken/driver.html?testName=json-parse-financial) 11:23:15 INFO - PROCESS | 8614 | RSS: Main: 158433280 11:23:15 INFO - PROCESS | 8614 | 11:23:17 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:50425/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50425/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:23:17 INFO - PROCESS | 8614 | RSS: Main: 158892032 11:23:17 INFO - PROCESS | 8614 | 11:23:19 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:50425/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50425/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:23:20 INFO - PROCESS | 8614 | RSS: Main: 158785536 11:23:20 INFO - PROCESS | 8614 | 11:23:22 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:50425/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50425/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:23:22 INFO - PROCESS | 8614 | RSS: Main: 159465472 11:23:22 INFO - PROCESS | 8614 | 11:23:25 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:50425/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:23:25 INFO - PROCESS | 8614 | RSS: Main: 159395840 11:23:25 INFO - PROCESS | 8614 | 11:23:28 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:50425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:23:29 INFO - PROCESS | 8614 | RSS: Main: 159367168 11:23:29 INFO - PROCESS | 8614 | 11:23:30 INFO - PROCESS | 8614 | Cycle 1(1): loaded http://localhost:50425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50425/tests/kraken/driver.html?testName=ai-astar) 11:23:31 INFO - PROCESS | 8614 | RSS: Main: 160186368 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | __start_tp_report 11:23:31 INFO - PROCESS | 8614 | _x_x_mozilla_page_load 11:23:31 INFO - PROCESS | 8614 | _x_x_mozilla_page_load_details 11:23:31 INFO - PROCESS | 8614 | |i|pagename|runs| 11:23:31 INFO - PROCESS | 8614 | |0;ai-astar;111;103;110;110;113;110;111;111;110;108 11:23:31 INFO - PROCESS | 8614 | |1;audio-beat-detection;151;125;153;177;127;151;148;129;188;125 11:23:31 INFO - PROCESS | 8614 | |2;audio-dft;163;162;163;159;162;161;163;164;162;161 11:23:31 INFO - PROCESS | 8614 | |3;audio-fft;75;75;75;170;77;77;76;75;165;75 11:23:31 INFO - PROCESS | 8614 | |4;audio-oscillator;84;84;145;85;85;84;133;85;84;146 11:23:31 INFO - PROCESS | 8614 | |5;imaging-gaussian-blur;118;117;118;118;118;118;117;117;117;117 11:23:31 INFO - PROCESS | 8614 | |6;imaging-darkroom;147;147;148;147;147;148;147;147;147;146 11:23:31 INFO - PROCESS | 8614 | |7;imaging-desaturate;95;96;97;96;97;95;96;95;95;95 11:23:31 INFO - PROCESS | 8614 | |8;json-parse-financial;53;52;56;55;53;52;52;53;52;56 11:23:31 INFO - PROCESS | 8614 | |9;json-stringify-tinderbox;60;61;61;61;62;61;61;60;61;61 11:23:31 INFO - PROCESS | 8614 | |10;stanford-crypto-aes;81;77;74;81;78;76;77;77;112;87 11:23:31 INFO - PROCESS | 8614 | |11;stanford-crypto-ccm;125;116;125;118;116;133;119;119;122;125 11:23:31 INFO - PROCESS | 8614 | |12;stanford-crypto-pbkdf2;154;153;156;158;156;159;168;152;151;152 11:23:31 INFO - PROCESS | 8614 | |13;stanford-crypto-sha256-iterative;65;63;61;64;62;63;61;63;61;59 11:23:31 INFO - PROCESS | 8614 | __end_tp_report 11:23:31 INFO - PROCESS | 8614 | __start_cc_report 11:23:31 INFO - PROCESS | 8614 | _x_x_mozilla_cycle_collect,862 11:23:31 INFO - PROCESS | 8614 | __end_cc_report 11:23:31 INFO - PROCESS | 8614 | __startTimestamp1469557411141__endTimestamp 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | ------- Summary: start ------- 11:23:31 INFO - PROCESS | 8614 | Number of tests: 14 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.67 (2.4%) stddev-sans-first:2.79 11:23:31 INFO - PROCESS | 8614 | Values: 111.0 103.0 110.0 110.0 113.0 110.0 111.0 111.0 110.0 108.0 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:151.00 stddev:21.96 (14.5%) stddev-sans-first:23.25 11:23:31 INFO - PROCESS | 8614 | Values: 151.0 125.0 153.0 177.0 127.0 151.0 148.0 129.0 188.0 125.0 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.41 (0.9%) stddev-sans-first:1.45 11:23:31 INFO - PROCESS | 8614 | Values: 163.0 162.0 163.0 159.0 162.0 161.0 163.0 164.0 162.0 161.0 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:38.76 (51.7%) stddev-sans-first:40.50 11:23:31 INFO - PROCESS | 8614 | Values: 75.0 75.0 75.0 170.0 77.0 77.0 76.0 75.0 165.0 75.0 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:84.00 stddev:27.70 (33.0%) stddev-sans-first:28.65 11:23:31 INFO - PROCESS | 8614 | Values: 84.0 84.0 145.0 85.0 85.0 84.0 133.0 85.0 84.0 146.0 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:23:31 INFO - PROCESS | 8614 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 117.0 117.0 117.0 117.0 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 11:23:31 INFO - PROCESS | 8614 | Values: 147.0 147.0 148.0 147.0 147.0 148.0 147.0 147.0 147.0 146.0 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 11:23:31 INFO - PROCESS | 8614 | Values: 95.0 96.0 97.0 96.0 97.0 95.0 96.0 95.0 95.0 95.0 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.65 (3.1%) stddev-sans-first:1.74 11:23:31 INFO - PROCESS | 8614 | Values: 53.0 52.0 56.0 55.0 53.0 52.0 52.0 53.0 52.0 56.0 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 11:23:31 INFO - PROCESS | 8614 | Values: 60.0 61.0 61.0 61.0 62.0 61.0 61.0 60.0 61.0 61.0 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:77.50 stddev:11.15 (14.4%) stddev-sans-first:11.82 11:23:31 INFO - PROCESS | 8614 | Values: 81.0 77.0 74.0 81.0 78.0 76.0 77.0 77.0 112.0 87.0 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:123.50 stddev:5.31 (4.3%) stddev-sans-first:5.50 11:23:31 INFO - PROCESS | 8614 | Values: 125.0 116.0 125.0 118.0 116.0 133.0 119.0 119.0 122.0 125.0 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:156.00 stddev:5.02 (3.2%) stddev-sans-first:5.28 11:23:31 INFO - PROCESS | 8614 | Values: 154.0 153.0 156.0 158.0 156.0 159.0 168.0 152.0 151.0 152.0 11:23:31 INFO - PROCESS | 8614 | 11:23:31 INFO - PROCESS | 8614 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:63.00 stddev:1.75 (2.8%) stddev-sans-first:1.54 11:23:31 INFO - PROCESS | 8614 | Values: 65.0 63.0 61.0 64.0 62.0 63.0 61.0 63.0 61.0 59.0 11:23:31 INFO - PROCESS | 8614 | -------- Summary: end -------- 11:23:31 INFO - PROCESS | 8614 | 11:23:32 INFO - TEST-INFO | 8614: exit 0 11:23:32 INFO - TEST-OK | kraken | took 60489ms 11:23:32 INFO - SUITE-END | took 1170s 11:23:32 INFO - Completed test suite (00:19:30) 11:23:32 INFO - javascript benchmark 11:23:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7626.470294465041, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3371.022403502984, 3454.360943225502, 3459.4637831136183, 3461.46347316166, 3493.12671832042, 5727.427257274276, 5728.112142617901, 5735.0, 5738.225339579156, 5768.538516918647, 5676.517496012833, 5686.459786320293, 5752.683602401867, 5754.942450575493, 5769.538436925036, 5207.583393328544, 5214.634975551713, 5259.368875734917, 5286.577073834103, 5289.127293996486, 5132.332796736419, 5144.768485418165, 5191.143461328877, 5294.10000299948, 5318.813841515548, 5267.0, 5328.520433161015, 5367.892642147155, 5374.7043912584795, 5388.622796404254, 5238.764255608468, 5258.50044245796, 5301.151815709506, 5306.018386598453, 5306.814261500829, 5164.302819119408, 5202.0896343140175, 5270.945810837848, 5281.973590132025, 5282.683039017671, 5463.2078348639225, 5487.122060470306, 5537.1140617501405, 5622.662640241599, 5634.04221282383, 6124.2650881894015, 6126.142340072393, 6149.661768602725, 6151.569390142692, 6161.630302181883, 5952.0, 6205.87588248237, 6215.0, 6218.626882387071, 6223.0, 5664.122061080539, 5696.3733989261145, 5724.0, 5748.770049198069, 5763.279590051244, 6248.125262463259, 6253.46845518127, 6254.468370188585, 6270.905936410957, 6279.874402511924, 5809.738561764731, 5958.344582095966, 6018.578699491081, 6021.608595441282, 6055.455009049207, 6056.031035034373, 6132.846678833065, 6134.355892631299, 6137.693115344215, 6146.600470969463, 6105.45050945417, 6118.571699980958, 6120.877582448326, 6121.510279177655, 6127.693615319216, 5974.462298393166, 6054.666993315322, 6068.150458935753, 6124.203853499017, 6131.448169664752, 4692.483826779052, 4695.178343789823, 4695.95304046962, 4727.527247275314, 4733.928991065137, 4194.601512856274, 4218.17745539623, 4219.156168766259, 4226.344916537942, 4242.0, 5888.293404791452, 5897.616654917417, 5946.137810017523, 5955.225820643375, 5972.0, 5980.790672326535, 6158.076288556752, 6203.7828675996125, 6208.689565521796, 6274.529410294246, 6038.788642397495, 6041.848953776191, 6051.062085376773, 6054.3642917493025, 6076.058210977306, 5125.923111153335, 5244.160934250502, 5266.631335806457, 5320.574354051667, 5330.0, 6368.42684158428, 6387.233531976192, 6402.775902843378, 6412.935870641327, 6441.61350318973, 5899.439553242435, 6179.876402472015, 6199.814005579839, 6203.8138855833495, 6206.968965155145, 6411.743530258737, 6442.806715798533, 6481.060246264359, 6510.7721229756735, 6530.08578798959, 6088.056351265561, 6121.663308518075, 6136.202293701969, 6146.938530614637, 6147.600405973598, 6018.939810601838, 6116.42707509198, 6217.378262173927, 6264.467520260829, 6269.49844012487, 6089.48239399656, 6122.051082082285, 6130.325664177026, 6132.17215675878, 6149.0, 5998.550108741774, 6062.090686397076, 6067.817965460867, 6088.178095956989, 6090.025595904634, 5700.087985922232, 5764.769409223584, 5858.443447872445, 5907.409259074058, 6008.729607167776, 6043.123747056564, 6045.697715114139, 6046.758129674764, 6047.9395206047375, 6055.6063855849225, 5854.092615644582, 5881.735321910439, 5889.646621202742, 5918.141869428995, 5930.733117009659], "value": 5685.79519236483, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.5159114752461, 642.1267076775581, 655.7213184396632, 656.1994366872417, 671.6910221298202, 36508.26983460329, 39531.40702889459, 46390.07219855605, 47440.288395674004, 47564.76217618907, 49010.50989490104, 49111.26333104997, 49408.25887611689, 49558.25662615055, 49564.0, 8962.37263391563, 8986.326025548078, 9064.365494415393, 9067.773305667379, 9093.136152065543, 9040.8643870342, 9087.363884528086, 9127.908720912772, 9145.131212534798, 9180.403273787217, 9072.31957603179, 9157.862632060524, 9161.862572061424, 9172.082791720808, 9202.76993075175, 9030.0, 9150.908490915072, 9156.359054866161, 9164.312676549285, 9166.67916622915, 9143.634254629807, 9152.588133534007, 9170.67902623405, 9198.770030749285, 9199.908000920039, 44418.0, 44896.3265551017, 44920.326195107096, 44995.0, 45111.77444112791, 3903.590123037097, 4394.670399720002, 4481.708688935209, 4573.176828170928, 4612.677112602119, 34104.14739631504, 34496.6550334496, 34570.48144277838, 35045.299094018235, 35971.28057438863, 4454.443194600675, 4463.308187230984, 4489.371487991683, 4526.705764125321, 4527.366168736379, 386281.0, 386457.0, 386706.0, 387376.0, 389857.99999999715, 36131.277374452366, 37278.62721372806, 66070.33929660737, 66238.66880665663, 66810.66594667092, 37078.0, 37094.62905370966, 37287.81356093202, 37297.813510932814, 37338.43992340117, 15769.763453548207, 15787.210639467981, 15817.288222030036, 15831.208439577975, 15888.046717197005, 14226.430942762381, 14232.786508202385, 14241.287935603179, 14254.643633909236, 14268.072575282573, 9175.678851240174, 9229.769255768659, 9240.676576319796, 9258.675946341846, 9304.767380815534, 3500.5974312953826, 3516.49010893419, 3534.823258837048, 3537.9292414152087, 3580.051286409104, 1102.5644870276196, 1143.857017872766, 1146.1003112556602, 1169.8830116988233, 1225.5649244518067, 33655.83172084124, 33792.66207337944, 34043.31913361719, 34119.0, 34212.65787342095, 1204.3015051270243, 1214.7388311513066, 1217.8538575371012, 1225.3689349984766, 1334.7197088611501, 16738.91630541864, 17059.829401706073, 17209.397671081453, 17439.65120697579, 17468.0, 598646.0, 604775.0, 609038.0, 610774.0, 612761.0, 66043.0, 66084.66957665181, 66236.66881665657, 66256.33743662598, 66419.33580664228, 1498.2658497336226, 1514.258013573341, 1539.0919357579082, 1547.5280039588033, 1549.4112237349734, 32251.35497290088, 32401.51397729083, 32468.675313246564, 32682.83658581692, 33273.833630831694, 55523.16715249355, 56456.717716411156, 56514.0, 56582.434175659364, 56796.29611111673, 487247.0, 488371.0, 489145.0, 491867.0, 492316.0, 30412.239694007825, 30588.694113058584, 30823.845880770452, 30988.91538796131, 30995.225119372197, 52073.0, 52169.21746173887, 53648.46351536591, 54488.45511544834, 54719.17921231264, 45627.315590265505, 46726.0, 47202.29196562123, 47604.7619761899, 47744.04511909812, 45379.319310209714, 45856.08287834292, 46263.306050408595, 46620.0, 46677.76661116673, 44952.550474494834, 45227.54772452233, 45660.0, 46346.768266158455, 48508.5149148504, 38466.0, 39413.802930986305, 39668.40497392599, 39839.2032159361, 40173.598264018154, 30196.54705179468, 30374.69625303807, 30574.0, 30912.726182144816, 31290.843545783035], "value": 20412.579797380207, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.48750230976276, 433.2591268930131, 436.8864095335214, 439.18750311922946, 444.65761363749914, 17660.38188663397, 18795.62408751826, 19561.0, 20180.091895864683, 20236.8988155059, 16575.088370139638, 18037.458876233733, 19460.026998650046, 19796.50508737282, 19816.306429274977, 5519.917201241985, 5826.912596311059, 5867.11993201019, 5894.823155305347, 5894.941050589504, 5565.193047008182, 5684.488396044355, 5798.9130163047585, 5804.2744656917885, 5835.766569337221, 5731.054376027951, 5741.712914354286, 5765.5099316557935, 5774.740136693859, 5795.2466179396615, 5562.972185139049, 5635.6618602883755, 5741.971290143564, 5752.367239603661, 5763.1355296705415, 5054.267131265982, 5067.847964561069, 5096.0, 5097.6941383517105, 5123.462036486189, 21817.890910545506, 23089.53820923572, 23348.649770253458, 23397.88301058484, 23584.528309433714, 2577.756504223139, 2648.7880969522394, 2680.6917204521533, 2735.9452810943867, 3139.9481173806803, 10190.592376305012, 10331.94834025825, 10702.892971070267, 10798.73003174927, 10982.06652434544, 2016.8184863362367, 2070.4306315763133, 2086.5201003769066, 2105.4210092224607, 2117.4706323419146, 80299.19700802976, 80386.59806700988, 81390.21387522377, 81790.18209817944, 83176.0, 11607.477663505162, 11858.110641701907, 12011.279323240633, 12054.879451205552, 12084.577039803564, 16759.66480670404, 17020.574485637957, 17026.489205323862, 17062.82937170637, 17099.316027359015, 8894.911050889537, 8926.598303076376, 8979.416337938013, 9068.410553314014, 9138.268938484905, 8602.526861022703, 8649.264812491008, 8736.737897863075, 8856.512891791013, 8897.199252067216, 5061.082894297414, 5141.020707027821, 5194.506521880416, 5235.712035837989, 5254.3169387979315, 1926.2391355414534, 1928.305809908432, 1950.4733721895009, 1973.1515448357056, 1993.1031036033842, 1024.3802499487704, 1054.6572363981736, 1091.307020042263, 1134.7446824464594, 1201.567435723139, 19057.428277151706, 19109.617807643768, 20032.298869539787, 20174.386049116034, 20257.088431020344, 1080.7460246842143, 1095.2169199022578, 1154.1978325064, 1160.9709757256137, 1163.116031815826, 11021.338719676845, 11112.666620001413, 11152.996230339308, 11398.94300528492, 11402.600908968147, 355354.0, 414124.0, 417419.0, 424341.0, 529841.0, 100005.49997249967, 101705.0, 101880.0, 102883.0, 104334.4783276094, 1080.6001779341536, 1087.9673609791719, 1132.5809450503202, 1143.382573410349, 1144.4964215745213, 18298.26806927708, 18420.35528756487, 18448.26206951707, 18639.440816775517, 18737.1568279425, 41714.37428438515, 42748.0, 43492.782536087114, 43517.56482435135, 44815.327770082826, 57630.4236957625, 59825.40174598198, 60601.39398605958, 60931.69534152301, 61077.694611526655, 8998.14517620825, 9056.63773449081, 9098.818023639358, 9116.544172791466, 9448.338616296793, 9776.169025632616, 12949.741005180033, 13287.867121328663, 13462.596122116352, 13643.590692279247, 11441.942790285995, 11442.427878606202, 11545.48045337945, 11637.127215459044, 11662.650120496399, 11408.429578521207, 11432.542698291974, 11639.836016398292, 11899.405029748305, 12056.63830085099, 11699.415029248334, 11738.119641026786, 11771.23486973344, 11972.461239244081, 11979.28124312544, 7162.785116446515, 7860.449768516149, 8370.916290837014, 8872.911270887467, 9120.042395548637, 8653.437526560754, 10677.46612669379, 10820.4048777318, 10859.83710244331, 11161.441927903736], "value": 9515.554859916016, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1573.3785154863829, 1624.2853144616367, 1824.5438640339914, 1933.6132773445315, 1947.2503086311765, 8498.405111642187, 9058.682946096887, 9220.400673956197, 9783.412995220282, 9812.852807207888, 9405.294602904776, 9496.715098547038, 9606.0, 9607.951960240207, 9612.567434465449, 2438.110089817217, 2462.3967128053564, 2464.346948058766, 2464.8890799913956, 2465.272744540365, 2341.3610472669116, 2452.4849781545895, 2452.7056753189554, 2454.1533171055958, 2459.2007597530874, 2279.2592407467555, 2282.9086836526517, 2320.582295186866, 2344.5779759643256, 2345.413646588353, 2437.9882348825217, 2457.8648174350405, 2481.2308184462695, 2510.9454029307735, 2517.7104632967166, 2403.25499095281, 2428.538577670237, 2432.3554258121612, 2443.0960544598433, 2449.6570480132796, 9583.424994500352, 9595.0, 9605.0, 9631.566579503939, 9634.421934683942, 5796.710164491758, 5821.941780582182, 5905.970470147622, 5937.821865344046, 5962.07587823888, 3717.888463346104, 3718.6467285607823, 3729.7575657582443, 3768.7550309230087, 3823.5220597425323, 1118.6867677050438, 1125.9380734059623, 1141.0, 1155.5608868629952, 1162.7790719763218, 13654.726905461835, 13767.036307458382, 13772.10481318711, 13795.310234488235, 13808.930955345159, 5030.3963524377305, 5212.661177023481, 5221.947780522222, 5283.392409872837, 5285.709285989307, 11317.943410282896, 11386.658400248005, 11433.0, 11484.19610627248, 11484.655460336204, 5830.416958304136, 5856.619319744203, 5916.112583112567, 5937.821865344046, 5962.970185149046, 4734.171519983989, 5141.203113517411, 5356.062689029404, 5362.839114826562, 5388.407275199725, 4377.080813029236, 4388.824447022083, 4499.955000450019, 4523.095380923828, 4530.207213737583, 1416.5821082780606, 1433.2976841347872, 1458.0741229319458, 1463.0636392708675, 1468.7136008478244, 1060.6181774561153, 1062.2935747727674, 1078.6009176604707, 1079.5357996061769, 1089.4716062709579, 6372.522060845455, 6453.838654033687, 6562.2193393872485, 6632.2372927114, 6661.100751398596, 481.8843477565429, 492.4632150955476, 508.58296197118005, 512.9256257842667, 514.2851436503263, 4408.4930233023615, 4425.358323043205, 4429.335599660077, 4446.444194475691, 4447.822087116479, 11772.705002449724, 12158.452869620889, 12280.508779648713, 12334.321612311409, 12339.568115115928, 11995.88004119965, 12186.146969712036, 12205.20666156697, 12220.633380998584, 12234.877651223553, 8642.30861531076, 8941.642334306685, 8954.820903582022, 9040.321975851837, 9180.31147663928, 6554.868902622016, 6722.865542689216, 6759.188897332351, 6788.96605516989, 6791.3548212919695, 10632.149428045892, 11333.546658133582, 11351.205415620827, 11399.658010259705, 11517.712057198301, 11262.04272636835, 11497.137714671266, 11517.308961462339, 11550.133739969704, 11606.419679016184, 8249.83500330002, 8309.418340716093, 8420.663173472993, 8470.745877623682, 8484.575771211292, 9275.814483710154, 9314.767130821783, 9355.719328420158, 9398.248140148908, 9433.952830235805, 8008.719694810887, 8174.386920980831, 8237.670493180445, 8360.372972027, 8369.204925532065, 7846.725364612439, 7856.096548896721, 7992.080910695345, 8044.35645148375, 8116.553589552631, 7689.307962283421, 7727.729529466442, 7769.53382797034, 7787.493812902143, 7802.765917022499, 5708.457696518824, 5736.71316434185, 5787.536997040311, 5814.476697097281, 5853.882922341614, 5593.216949626974, 5617.747201375866, 5633.8309850704545, 5636.436356364495, 5765.4522820332], "value": 4975.172267873712, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.6048466444579, 358.449779588332, 360.27404779369556, 364.8978286079897, 370.82756518219026, 5692.658440493563, 5693.629914055584, 5715.514181294595, 5751.820876720268, 5758.30900291965, 5369.650972686773, 5604.299462567179, 5623.578231632634, 5647.887042259153, 5658.292713410824, 4405.977970110145, 4406.206882761102, 4406.933895991563, 4407.206702793496, 4438.423005009352, 4393.0, 4405.8237670493145, 4413.801378937956, 4413.955860441387, 4441.844535441261, 4299.914001719963, 4387.846425375113, 4392.736435813846, 4403.9430536671125, 4410.514843367227, 4294.09823936972, 4366.759828209447, 4380.7152535085115, 4391.692581519295, 4417.0, 3804.828782704757, 3850.3251085777774, 3855.267499175148, 3858.903527411809, 3867.400552914303, 5460.945390546123, 5468.0, 5488.1493368527945, 5500.202470641734, 5542.91685624716, 4941.950580494185, 5043.579082040605, 5071.822486212965, 5077.0, 5107.948920510785, 5918.171455996164, 5925.34821169671, 5961.8807623847715, 5989.490893274077, 6013.398660133996, 4220.767857767822, 4286.699931004831, 4302.935455968163, 4312.547182545819, 4337.067530480962, 6051.818445446644, 6086.6348019119, 6181.938180618181, 6189.597676151081, 6284.402981716729, 4263.104748002892, 4282.164977829356, 4283.978580107079, 4299.419578356944, 4299.78501074945, 4297.290946993711, 4348.478182618106, 4352.542982986804, 4357.477102747691, 4369.060651959844, 4923.655344125877, 4968.130577148984, 4999.550040496373, 5007.599392048627, 5044.0, 5904.911426328608, 5930.970345148246, 5944.494717948936, 5946.256717910262, 5966.49284810796, 1498.3482185249234, 1514.7122046811292, 1532.1190315568592, 1539.6150962259435, 1540.8305086440482, 916.7158180963922, 953.7758626722715, 957.3824882950458, 971.8347880860271, 974.3812678948918, 5121.667091639031, 5248.606354523426, 5264.5525130363585, 5269.1569348903995, 5304.151335786333, 5396.271503347077, 5454.036546843134, 5534.75093620788, 5598.4961353477565, 5602.439756024365, 4790.5568160237835, 5192.350956130484, 5198.818041368534, 5208.635395522277, 5307.787688492494, 2876.3096856754646, 2886.826790392583, 2936.0, 2942.7792915531422, 2947.6168098147105, 5609.971950140223, 5654.3884992777685, 5666.688332141772, 5707.8858422832145, 5746.50590846383, 5880.323762767251, 6305.684715764193, 6368.172137622079, 6371.267304260069, 6387.169667943138, 6379.71291291893, 6411.3909178627955, 6415.871682566322, 6440.516961227927, 6488.28628850826, 6027.758889644365, 6131.84670383244, 6202.503799695924, 6216.1405753353965, 6263.4362907338555, 6121.663308518075, 6122.204113465221, 6159.414855588712, 6165.660888651168, 6172.321044684992, 6111.083337499411, 6224.37756224374, 6302.558820882494, 6331.493480521639, 6361.586496877688, 4283.443152390294, 4316.956830431655, 4343.543927887653, 4350.891227719206, 4354.477462704495, 5927.792527261525, 6180.805813935988, 6201.751929922933, 6214.875702485834, 6229.345918678474, 5994.28068631767, 6011.849703757441, 6014.0, 6037.547183961308, 6042.728077236447, 5948.018576934757, 6000.5799594028, 6010.308814486215, 6050.969745151246, 6078.604890682268, 5676.035074037506, 5926.170336152856, 5947.91078133837, 5949.315828679584, 5961.165436838933, 6004.699765011645, 6064.4541991221, 6082.6046306991675, 6094.7257373417415, 6162.07568864656, 5649.830505084854, 5916.171735957056, 5927.881442371042, 5976.073708575178, 5976.462118409364], "value": 4480.395060289733, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.1968072087554, 841.7037761846752, 864.7319331007388, 881.2905610983156, 889.6930558957157, 15201.543953681394, 16255.837441625596, 16321.510354689348, 16390.83609163908, 16399.50801475956, 13904.374303156357, 14773.556793296191, 14949.775753363681, 15004.324805383756, 15106.773398399006, 861.9570319912897, 880.3177537408495, 881.0440671871028, 881.960311785968, 883.8188171424874, 874.9387542872001, 877.1491653096518, 878.6792820620459, 879.7272845417909, 881.9162179592961, 932.7015355086376, 934.3459578295186, 935.4387367579432, 936.5738588942015, 937.9671711490099, 917.2020342302174, 925.8981512033671, 925.9212966897821, 926.4348747264163, 927.2118699105773, 672.5628341578014, 678.3420082519948, 682.4233522673383, 682.8634273145341, 683.1255992329826, 14595.197264150467, 14835.25823708821, 14836.480723174636, 14852.405903763836, 15195.848041519665, 15232.162231077285, 15752.0, 16002.359905603762, 16397.754033689504, 16667.166641667867, 12677.809832852514, 13046.869531304661, 13053.04690055818, 13109.672258193621, 13111.0, 4037.4895530703952, 4091.1204091120553, 4103.774292413916, 4108.630223279919, 4115.300398932189, 83773.0, 84001.57999210026, 84137.57931210365, 85269.14730852674, 85509.57245213796, 12258.0, 12401.62795116148, 12499.750004999849, 12584.874151258553, 12713.618591442271, 22680.43298917507, 22722.886385567966, 22745.317640470814, 22821.657675134888, 22836.885815570815, 8771.342149338825, 8804.163604457566, 8937.865932011026, 9037.141471560191, 9300.162985331353, 5134.229865520202, 5180.6891586504935, 5196.9740151299, 5239.6376941994595, 5251.816186433456, 4097.528784189797, 4230.788460576959, 4241.27898257297, 4251.723637963522, 4260.360945858146, 695.9408450281783, 705.2947052947053, 715.8103102677794, 717.7631381644045, 722.2344315026089, 750.6772088002211, 771.4946709905021, 809.7327881798992, 814.4380377539479, 830.1532436914314, 10626.415547144981, 10795.082417994401, 11113.166512511594, 11305.943470282597, 11531.538738450536, 736.5985537881867, 788.341734651561, 800.2917418085036, 806.2461598405392, 808.2321794295443, 4639.559241872017, 4724.787384567703, 4736.976315118402, 4757.001029783784, 4798.520147985174, 99578.0, 114603.42698286455, 117826.0, 118032.40983795197, 119183.0, 66521.6673916637, 77531.0, 97877.0, 98263.0, 101366.49316753368, 87706.0, 87802.0, 88653.55673221593, 88688.0, 89011.0, 9861.013898610081, 9973.60105595797, 10145.18838492904, 10206.285560010729, 10237.0, 51819.740901295256, 52775.20837187522, 53019.20471192858, 53759.73120134374, 54201.728991354794, 68547.0, 77327.0, 77910.22089779029, 78323.60838195773, 78450.6077469609, 12807.231566106064, 12931.353432328158, 12950.287734174333, 13011.349432528146, 13399.12905661129, 13887.444502219798, 14677.706445871236, 15109.47116850905, 15141.318640660977, 15141.470048548248, 14020.158790472604, 14050.227237502035, 14168.504102356368, 14401.207933563755, 14828.258587070819, 13326.86673133295, 13817.585472435843, 14204.005719599942, 14381.209033503257, 14382.928085359506, 12176.0867934907, 12359.62921112368, 13049.673758156123, 13054.282014489294, 13090.14914030585, 10748.408837514013, 11125.276857004268, 11447.713807154887, 11522.251053681484, 11822.763544729229, 11637.76724465523, 11915.0, 11932.343721095423, 11975.221610595283, 12169.087318450975], "value": 7991.966596535942, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 103.0, 110.0, 110.0, 113.0, 110.0, 111.0, 111.0, 110.0, 108.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 153.0, 177.0, 127.0, 151.0, 148.0, 129.0, 188.0, 125.0], "value": 147.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 159.0, 162.0, 161.0, 163.0, 164.0, 162.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 170.0, 77.0, 77.0, 76.0, 75.0, 165.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 145.0, 85.0, 85.0, 84.0, 133.0, 85.0, 84.0, 146.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 97.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 56.0, 55.0, 53.0, 52.0, 52.0, 53.0, 52.0, 56.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 60.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 77.0, 74.0, 81.0, 78.0, 76.0, 77.0, 77.0, 112.0, 87.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 116.0, 125.0, 118.0, 116.0, 133.0, 119.0, 119.0, 122.0, 125.0], "value": 121.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 156.0, 158.0, 156.0, 159.0, 168.0, 152.0, 151.0, 152.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 61.0, 64.0, 62.0, 63.0, 61.0, 63.0, 61.0, 59.0], "value": 62.2, "unit": "score"}]}]} 11:23:32 INFO - Return code: 0 11:23:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:23:32 ERROR - # TBPL SUCCESS # 11:23:32 INFO - Running post-action listener: _resource_record_post_action 11:23:32 INFO - ##### 11:23:32 INFO - ##### Finished run-tests step (success) 11:23:32 INFO - ##### 11:23:32 INFO - Running post-run listener: _resource_record_post_run 11:23:32 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 483328; Write bytes: 490459136; Read time: 64; Write time: 304184 11:23:32 INFO - TinderboxPrint: CPU usage
13.3% 11:23:32 INFO - TinderboxPrint: I/O read bytes / time
483,328 / 64 11:23:32 INFO - TinderboxPrint: I/O write bytes / time
490,459,136 / 304,184 11:23:32 INFO - TinderboxPrint: CPU idle
8,204.7 (86.6%) 11:23:32 INFO - TinderboxPrint: CPU user
1,212.2 (12.8%) 11:23:32 INFO - TinderboxPrint: Swap in / out
0 / 0 11:23:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 117923840; Read time: 0; Write time: 97904 11:23:32 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 458752; Write bytes: 255180800; Read time: 52; Write time: 112968 11:23:33 INFO - Running post-run listener: _upload_blobber_files 11:23:33 INFO - Blob upload gear active. 11:23:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:23:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:23:33 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'] 11:23:33 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 11:23:33 INFO - (blobuploader) - INFO - Open directory for files ... 11:23:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:23:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:23:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:34 INFO - (blobuploader) - INFO - Done attempting. 11:23:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:23:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:23:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:37 INFO - (blobuploader) - INFO - Done attempting. 11:23:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:23:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:23:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:38 INFO - (blobuploader) - INFO - Done attempting. 11:23:38 INFO - (blobuploader) - INFO - Iteration through files over. 11:23:38 INFO - Return code: 0 11:23:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:23:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:23:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fcae40df13980c0cb4fe6760978e05dbff1aae0e8c4354120089abcb29d571fe84aa789dad021569fca7a9308fe2da69adbd80b8d00527eb35cff96cdb6a84e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/597b11df53d6b3c1f863e9c30b6c476fff0cc0fe5c0fc0c72e012850d19da4977cff22e4854be5b0fb99d3ee965d058e79d7d66cd6ec86d0b0a7a8241071330b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6c3943cb403348c5acbb230673c2a81c80e034b1a5956c823a8a1b91a0bc8417d9d6f0b3ba5c685fcb9053439d18d74e2d5cef1f2724d3147c1054094542369"} 11:23:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:23:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:23:38 INFO - Contents: 11:23:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5fcae40df13980c0cb4fe6760978e05dbff1aae0e8c4354120089abcb29d571fe84aa789dad021569fca7a9308fe2da69adbd80b8d00527eb35cff96cdb6a84e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/597b11df53d6b3c1f863e9c30b6c476fff0cc0fe5c0fc0c72e012850d19da4977cff22e4854be5b0fb99d3ee965d058e79d7d66cd6ec86d0b0a7a8241071330b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6c3943cb403348c5acbb230673c2a81c80e034b1a5956c823a8a1b91a0bc8417d9d6f0b3ba5c685fcb9053439d18d74e2d5cef1f2724d3147c1054094542369"} 11:23:38 INFO - Running post-run listener: copy_logs_to_upload_dir 11:23:38 INFO - Copying logs to upload dir... 11:23:38 INFO - mkdir: /builds/slave/test/build/upload/logs 11:23:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.559387 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-26 11:23:38.625932) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 11:23:38.629764) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318 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/5fcae40df13980c0cb4fe6760978e05dbff1aae0e8c4354120089abcb29d571fe84aa789dad021569fca7a9308fe2da69adbd80b8d00527eb35cff96cdb6a84e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/597b11df53d6b3c1f863e9c30b6c476fff0cc0fe5c0fc0c72e012850d19da4977cff22e4854be5b0fb99d3ee965d058e79d7d66cd6ec86d0b0a7a8241071330b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6c3943cb403348c5acbb230673c2a81c80e034b1a5956c823a8a1b91a0bc8417d9d6f0b3ba5c685fcb9053439d18d74e2d5cef1f2724d3147c1054094542369"} build_url:https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011386 build_url: 'https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/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/5fcae40df13980c0cb4fe6760978e05dbff1aae0e8c4354120089abcb29d571fe84aa789dad021569fca7a9308fe2da69adbd80b8d00527eb35cff96cdb6a84e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/597b11df53d6b3c1f863e9c30b6c476fff0cc0fe5c0fc0c72e012850d19da4977cff22e4854be5b0fb99d3ee965d058e79d7d66cd6ec86d0b0a7a8241071330b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6c3943cb403348c5acbb230673c2a81c80e034b1a5956c823a8a1b91a0bc8417d9d6f0b3ba5c685fcb9053439d18d74e2d5cef1f2724d3147c1054094542369"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 11:23:38.658523) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 11:23:38.658867) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1469555480.340133-2031994318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 11:23:38.742070) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 11:23:38.742486) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 11:23:38.742782) ========= ========= Total master_lag: 0.17 =========