builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1469024680.47 results: success (0) buildid: 20160720045220 builduid: 783ddad481234adeb84dd4dc648fe0ea revision: 8c9f7b5974300cff726db32d613b854193b7477a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 07:24:40.470727) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 07:24:40.471188) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 07:24:40.471487) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 07:24:40.485834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:24:40.486147) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 07:24:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-07-20 07:24:41 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081371 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:24:40.582264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:24:40.582670) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017575 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:24:40.632277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:24:40.632894) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8c9f7b5974300cff726db32d613b854193b7477a --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 8c9f7b5974300cff726db32d613b854193b7477a --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=3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 07:24:41,569 truncating revision to first 12 chars 2016-07-20 07:24:41,569 Setting DEBUG logging. 2016-07-20 07:24:41,569 attempt 1/10 2016-07-20 07:24:41,569 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8c9f7b597430?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 07:24:41,887 unpacking tar archive at: mozilla-aurora-8c9f7b597430/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661891 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:24:41.308814) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 07:24:41.309155) ========= script_repo_revision: 8c9f7b5974300cff726db32d613b854193b7477a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 07:24:41.309669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 07:24:41.309941) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 07:24:41.318786) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-20 07:24:41.319143) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:24:42 INFO - MultiFileLogger online at 20160720 07:24:42 in /builds/slave/test 07:24:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:24:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:24:42 INFO - {'append_to_log': False, 07:24:42 INFO - 'base_work_dir': '/builds/slave/test', 07:24:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:24:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:24:42 INFO - 'branch': 'Mozilla-Aurora', 07:24:42 INFO - 'buildbot_json_path': 'buildprops.json', 07:24:42 INFO - 'config_files': ('talos/linux_config.py',), 07:24:42 INFO - 'default_actions': ('clobber', 07:24:42 INFO - 'read-buildbot-config', 07:24:42 INFO - 'download-and-extract', 07:24:42 INFO - 'populate-webroot', 07:24:42 INFO - 'create-virtualenv', 07:24:42 INFO - 'install', 07:24:42 INFO - 'run-tests'), 07:24:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:24:42 INFO - 'download_minidump_stackwalk': True, 07:24:42 INFO - 'download_symbols': 'ondemand', 07:24:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:24:42 INFO - 'tooltool.py': '/tools/tooltool.py', 07:24:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:24:42 INFO - '/tools/misc-python/virtualenv.py')}, 07:24:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:24:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:24:42 INFO - 'installer_path': 'installer.exe', 07:24:42 INFO - 'log_level': 'info', 07:24:42 INFO - 'log_name': 'talos', 07:24:42 INFO - 'log_to_console': True, 07:24:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:24:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:24:42 INFO - 'opt_config_files': (), 07:24:42 INFO - 'pip_index': False, 07:24:42 INFO - 'sps_profile': False, 07:24:42 INFO - 'sps_profile_interval': 0, 07:24:42 INFO - 'suite': 'dromaeojs', 07:24:42 INFO - 'system_bits': '32', 07:24:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:24:42 INFO - 'title': 'talos-linux64-ix-059', 07:24:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:24:42 INFO - 'use_talos_json': True, 07:24:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:24:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:24:42 INFO - 'work_dir': 'build'} 07:24:42 INFO - ##### 07:24:42 INFO - ##### Running clobber step. 07:24:42 INFO - ##### 07:24:42 INFO - Running pre-action listener: _resource_record_pre_action 07:24:42 INFO - Running main action method: clobber 07:24:42 INFO - rmtree: /builds/slave/test/build 07:24:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:24:42 INFO - Running post-action listener: _resource_record_post_action 07:24:42 INFO - ##### 07:24:42 INFO - ##### Finished clobber step (success) 07:24:42 INFO - ##### 07:24:42 INFO - ##### 07:24:42 INFO - ##### Running read-buildbot-config step. 07:24:42 INFO - ##### 07:24:42 INFO - Running pre-action listener: _resource_record_pre_action 07:24:42 INFO - Running main action method: read_buildbot_config 07:24:42 INFO - Using buildbot properties: 07:24:42 INFO - { 07:24:42 INFO - "project": "", 07:24:42 INFO - "product": "firefox", 07:24:42 INFO - "script_repo_revision": "production", 07:24:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:24:42 INFO - "repository": "", 07:24:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:24:42 INFO - "buildid": "20160720045220", 07:24:42 INFO - "pgo_build": "True", 07:24:42 INFO - "basedir": "/builds/slave/test", 07:24:42 INFO - "buildnumber": 617, 07:24:42 INFO - "slavename": "talos-linux64-ix-059", 07:24:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:24:42 INFO - "platform": "ubuntu64_hw", 07:24:42 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:24:42 INFO - "branch": "mozilla-aurora", 07:24:42 INFO - "repo_path": "releases/mozilla-aurora", 07:24:42 INFO - "revision": "8c9f7b5974300cff726db32d613b854193b7477a", 07:24:42 INFO - "stage_platform": "linux64-pgo", 07:24:42 INFO - "builduid": "783ddad481234adeb84dd4dc648fe0ea", 07:24:42 INFO - "slavebuilddir": "test" 07:24:42 INFO - } 07:24:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 07:24:42 INFO - Running post-action listener: _resource_record_post_action 07:24:42 INFO - ##### 07:24:42 INFO - ##### Finished read-buildbot-config step (success) 07:24:42 INFO - ##### 07:24:42 INFO - ##### 07:24:42 INFO - ##### Running download-and-extract step. 07:24:42 INFO - ##### 07:24:42 INFO - Running pre-action listener: _resource_record_pre_action 07:24:42 INFO - Running main action method: download_and_extract 07:24:42 INFO - mkdir: /builds/slave/test/build/tests 07:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:42 INFO - https://queue.taskcluster.net/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:24:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:24:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:24:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/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 07:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/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 07:24:43 INFO - Downloaded 1361 bytes. 07:24:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 07:24:43 INFO - Using the following test package requirements: 07:24:43 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 07:24:43 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:24:43 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:24:43 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:24:43 INFO - u'jsshell-linux-x86_64.zip'], 07:24:43 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:24:43 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 07:24:43 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:24:43 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:24:43 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:24:43 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 07:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:24:43 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:24:43 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')]} 07:24:43 INFO - https://queue.taskcluster.net/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/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 07:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/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 07:24:44 INFO - Downloaded 24490836 bytes. 07:24:44 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'] 07:24:44 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 07:24:45 INFO - Return code: 0 07:24:45 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 07:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:45 INFO - https://queue.taskcluster.net/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 07:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/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 07:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/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 07:24:46 INFO - Downloaded 24490836 bytes. 07:24:46 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'] 07:24:46 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 07:24:48 INFO - Return code: 0 07:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:48 INFO - https://queue.taskcluster.net/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:24:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 07:24:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 07:24:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/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 07:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/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 07:24:49 INFO - Downloaded 10833369 bytes. 07:24:49 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'] 07:24:49 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 07:24:49 INFO - Return code: 0 07:24:49 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')]} 07:24:49 INFO - https://queue.taskcluster.net/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:24:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:24:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:24:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/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 07:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H7HMVwKvQGGvyfFnpsMy_A/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 07:24:50 INFO - Downloaded 63637553 bytes. 07:24:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:24:50 INFO - mkdir: /builds/slave/test/properties 07:24:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:24:50 INFO - Writing to file /builds/slave/test/properties/build_url 07:24:50 INFO - Contents: 07:24:50 INFO - build_url:https://queue.taskcluster.net/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 07:24:51 INFO - Running post-action listener: _resource_record_post_action 07:24:51 INFO - Running post-action listener: set_extra_try_arguments 07:24:51 INFO - ##### 07:24:51 INFO - ##### Finished download-and-extract step (success) 07:24:51 INFO - ##### 07:24:51 INFO - ##### 07:24:51 INFO - ##### Running populate-webroot step. 07:24:51 INFO - ##### 07:24:51 INFO - Running pre-action listener: _resource_record_pre_action 07:24:51 INFO - Running main action method: populate_webroot 07:24:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:24:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:24:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:24:51 INFO - '--tppagecycles', 07:24:51 INFO - '7'], 07:24:51 INFO - 'tests': ['tsvgm']}}, 07:24:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:24:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:24:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:24:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:24:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:24:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:24:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:51 INFO - 'talos_options': ['--disable-e10s'], 07:24:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:24:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:24:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:51 INFO - 'talos_options': ['--disable-e10s'], 07:24:51 INFO - 'tests': ['damp', 'tps']}, 07:24:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:51 INFO - 'tests': ['damp', 'tps']}, 07:24:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:24:51 INFO - 'tests': ['dromaeo_dom']}, 07:24:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:24:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:24:51 INFO - 'tests': ['a11yr', 07:24:51 INFO - 'ts_paint', 07:24:51 INFO - 'tpaint', 07:24:51 INFO - 'sessionrestore', 07:24:51 INFO - 'sessionrestore_no_auto_restore', 07:24:51 INFO - 'tabpaint']}, 07:24:51 INFO - 'other-e10s': {'tests': ['a11yr', 07:24:51 INFO - 'ts_paint', 07:24:51 INFO - 'tpaint', 07:24:51 INFO - 'sessionrestore', 07:24:51 INFO - 'sessionrestore_no_auto_restore', 07:24:51 INFO - 'tabpaint']}, 07:24:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:24:51 INFO - 'ts_paint', 07:24:51 INFO - 'tpaint', 07:24:51 INFO - 'sessionrestore', 07:24:51 INFO - 'sessionrestore_no_auto_restore', 07:24:51 INFO - 'tabpaint']}, 07:24:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:24:51 INFO - 'ts_paint', 07:24:51 INFO - 'tpaint', 07:24:51 INFO - 'sessionrestore', 07:24:51 INFO - 'sessionrestore_no_auto_restore', 07:24:51 INFO - 'tabpaint']}, 07:24:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:24:51 INFO - 'tests': ['a11yr', 07:24:51 INFO - 'ts_paint', 07:24:51 INFO - 'tpaint', 07:24:51 INFO - 'sessionrestore', 07:24:51 INFO - 'sessionrestore_no_auto_restore', 07:24:51 INFO - 'tabpaint']}, 07:24:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:24:51 INFO - 'tests': ['a11yr', 07:24:51 INFO - 'ts_paint', 07:24:51 INFO - 'tpaint', 07:24:51 INFO - 'sessionrestore', 07:24:51 INFO - 'sessionrestore_no_auto_restore', 07:24:51 INFO - 'tabpaint']}, 07:24:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:24:51 INFO - 'tests': ['tsvgx', 07:24:51 INFO - 'tsvgr_opacity', 07:24:51 INFO - 'tart', 07:24:51 INFO - 'tscrollx', 07:24:51 INFO - 'cart']}, 07:24:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:24:51 INFO - 'tsvgr_opacity', 07:24:51 INFO - 'tart', 07:24:51 INFO - 'tscrollx', 07:24:51 INFO - 'cart']}, 07:24:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:51 INFO - 'talos_options': ['--disable-e10s'], 07:24:51 INFO - 'tests': ['tp5o']}, 07:24:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:51 INFO - 'tests': ['tp5o']}, 07:24:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:51 INFO - 'talos_options': ['--disable-e10s', 07:24:51 INFO - '--xperf_path', 07:24:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:24:51 INFO - 'tests': ['tp5n']}, 07:24:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:51 INFO - 'talos_options': ['--xperf_path', 07:24:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:24:51 INFO - 'tests': ['tp5n']}}, 07:24:51 INFO - 'talos.zip': {'path': '', 07:24:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:24:51 INFO - Running post-action listener: _resource_record_post_action 07:24:51 INFO - ##### 07:24:51 INFO - ##### Finished populate-webroot step (success) 07:24:51 INFO - ##### 07:24:51 INFO - ##### 07:24:51 INFO - ##### Running create-virtualenv step. 07:24:51 INFO - ##### 07:24:51 INFO - Running pre-action listener: _resource_record_pre_action 07:24:51 INFO - Running main action method: create_virtualenv 07:24:51 INFO - Creating virtualenv /builds/slave/test/build/venv 07:24:51 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 07:24:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:24:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:24:51 INFO - Using real prefix '/usr' 07:24:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:24:52 INFO - Installing distribute.............................................................................................................................................................................................done. 07:24:54 INFO - Installing pip.................done. 07:24:54 INFO - Return code: 0 07:24:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b4e678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f1c0>, '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 0x1b800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b80550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', '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 07:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:24:54 INFO - Using env: {'DISPLAY': ':0', 07:24:54 INFO - 'HOME': '/home/cltbld', 07:24:54 INFO - 'LANG': 'en_US.UTF-8', 07:24:54 INFO - 'LANGUAGE': 'en_US:en', 07:24:54 INFO - 'LOGNAME': 'cltbld', 07:24:54 INFO - 'MAIL': '/var/mail/cltbld', 07:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:54 INFO - 'MOZ_NO_REMOTE': '1', 07:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:54 INFO - 'NO_EM_RESTART': '1', 07:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:54 INFO - 'PWD': '/builds/slave/test', 07:24:54 INFO - 'SHELL': '/bin/bash', 07:24:54 INFO - 'SHLVL': '1', 07:24:54 INFO - 'TERM': 'linux', 07:24:54 INFO - 'TMOUT': '86400', 07:24:54 INFO - 'USER': 'cltbld', 07:24:54 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', 07:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:54 INFO - '_': '/tools/buildbot/bin/python'} 07:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:54 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 07:24:54 INFO - Cleaning up... 07:24:54 INFO - Return code: 0 07:24:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4b4e678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f1c0>, '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 0x1b800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b80550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', '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 07:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:24:54 INFO - Using env: {'DISPLAY': ':0', 07:24:54 INFO - 'HOME': '/home/cltbld', 07:24:54 INFO - 'LANG': 'en_US.UTF-8', 07:24:54 INFO - 'LANGUAGE': 'en_US:en', 07:24:54 INFO - 'LOGNAME': 'cltbld', 07:24:54 INFO - 'MAIL': '/var/mail/cltbld', 07:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:54 INFO - 'MOZ_NO_REMOTE': '1', 07:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:54 INFO - 'NO_EM_RESTART': '1', 07:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:54 INFO - 'PWD': '/builds/slave/test', 07:24:54 INFO - 'SHELL': '/bin/bash', 07:24:54 INFO - 'SHLVL': '1', 07:24:54 INFO - 'TERM': 'linux', 07:24:54 INFO - 'TMOUT': '86400', 07:24:54 INFO - 'USER': 'cltbld', 07:24:54 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', 07:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:54 INFO - '_': '/tools/buildbot/bin/python'} 07:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:54 INFO - Downloading/unpacking psutil>=3.1.1 07:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:24:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:24:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:24:56 INFO - Installing collected packages: psutil 07:24:56 INFO - Running setup.py install for psutil 07:24:56 INFO - building 'psutil._psutil_linux' extension 07:24:56 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 07:24:56 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 07:24:56 INFO - building 'psutil._psutil_posix' extension 07:24:56 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 07:24:57 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 07:24:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:24:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:24:57 INFO - Successfully installed psutil 07:24:57 INFO - Cleaning up... 07:24:57 INFO - Return code: 0 07:24:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b4e678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f1c0>, '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 0x1b800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b80550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', '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 07:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:24:57 INFO - Using env: {'DISPLAY': ':0', 07:24:57 INFO - 'HOME': '/home/cltbld', 07:24:57 INFO - 'LANG': 'en_US.UTF-8', 07:24:57 INFO - 'LANGUAGE': 'en_US:en', 07:24:57 INFO - 'LOGNAME': 'cltbld', 07:24:57 INFO - 'MAIL': '/var/mail/cltbld', 07:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:57 INFO - 'MOZ_NO_REMOTE': '1', 07:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:57 INFO - 'NO_EM_RESTART': '1', 07:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:57 INFO - 'PWD': '/builds/slave/test', 07:24:57 INFO - 'SHELL': '/bin/bash', 07:24:57 INFO - 'SHLVL': '1', 07:24:57 INFO - 'TERM': 'linux', 07:24:57 INFO - 'TMOUT': '86400', 07:24:57 INFO - 'USER': 'cltbld', 07:24:57 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', 07:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:57 INFO - '_': '/tools/buildbot/bin/python'} 07:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:24:59 INFO - Installing collected packages: mozsystemmonitor 07:24:59 INFO - Running setup.py install for mozsystemmonitor 07:24:59 INFO - Successfully installed mozsystemmonitor 07:24:59 INFO - Cleaning up... 07:24:59 INFO - Return code: 0 07:24:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:59 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 0x7f4b4e678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f1c0>, '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 0x1b800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b80550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', '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 07:24:59 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 07:24:59 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 07:24:59 INFO - Using env: {'DISPLAY': ':0', 07:24:59 INFO - 'HOME': '/home/cltbld', 07:24:59 INFO - 'LANG': 'en_US.UTF-8', 07:24:59 INFO - 'LANGUAGE': 'en_US:en', 07:24:59 INFO - 'LOGNAME': 'cltbld', 07:24:59 INFO - 'MAIL': '/var/mail/cltbld', 07:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:59 INFO - 'MOZ_NO_REMOTE': '1', 07:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:59 INFO - 'NO_EM_RESTART': '1', 07:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:59 INFO - 'PWD': '/builds/slave/test', 07:24:59 INFO - 'SHELL': '/bin/bash', 07:24:59 INFO - 'SHLVL': '1', 07:24:59 INFO - 'TERM': 'linux', 07:24:59 INFO - 'TMOUT': '86400', 07:24:59 INFO - 'USER': 'cltbld', 07:24:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', 07:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:59 INFO - '_': '/tools/buildbot/bin/python'} 07:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:59 INFO - Downloading/unpacking jsonschema==2.5.1 07:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:25:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:25:01 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 07:25:01 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 07:25:01 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 07:25:01 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 07:25:01 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 07:25:01 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 07:25:01 INFO - Downloading functools32-3.2.3-2.tar.gz 07:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:25:01 INFO - warning: no files found matching '*.txt' 07:25:01 INFO - no previously-included directories found matching 'build' 07:25:01 INFO - no previously-included directories found matching 'dist' 07:25:01 INFO - no previously-included directories found matching '.git*' 07:25:01 INFO - Installing collected packages: jsonschema, functools32 07:25:02 INFO - Running setup.py install for functools32 07:25:02 INFO - warning: no files found matching '*.txt' 07:25:02 INFO - no previously-included directories found matching 'build' 07:25:02 INFO - no previously-included directories found matching 'dist' 07:25:02 INFO - no previously-included directories found matching '.git*' 07:25:02 INFO - Successfully installed jsonschema functools32 07:25:02 INFO - Cleaning up... 07:25:02 INFO - Return code: 0 07:25:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:02 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 0x7f4b4e678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f1c0>, '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 0x1b800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b80550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', '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 07:25:02 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 07:25:02 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 07:25:02 INFO - Using env: {'DISPLAY': ':0', 07:25:02 INFO - 'HOME': '/home/cltbld', 07:25:02 INFO - 'LANG': 'en_US.UTF-8', 07:25:02 INFO - 'LANGUAGE': 'en_US:en', 07:25:02 INFO - 'LOGNAME': 'cltbld', 07:25:02 INFO - 'MAIL': '/var/mail/cltbld', 07:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:02 INFO - 'MOZ_NO_REMOTE': '1', 07:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:02 INFO - 'NO_EM_RESTART': '1', 07:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:02 INFO - 'PWD': '/builds/slave/test', 07:25:02 INFO - 'SHELL': '/bin/bash', 07:25:02 INFO - 'SHLVL': '1', 07:25:02 INFO - 'TERM': 'linux', 07:25:02 INFO - 'TMOUT': '86400', 07:25:02 INFO - 'USER': 'cltbld', 07:25:02 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', 07:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:02 INFO - '_': '/tools/buildbot/bin/python'} 07:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:02 INFO - Downloading/unpacking blobuploader==1.2.4 07:25:02 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 07:25:02 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 07:25:02 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 07:25:02 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 07:25:02 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 07:25:02 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 07:25:04 INFO - Downloading blobuploader-1.2.4.tar.gz 07:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:25:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:25:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:05 INFO - Downloading docopt-0.6.1.tar.gz 07:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:25:05 INFO - Installing collected packages: blobuploader, requests, docopt 07:25:05 INFO - Running setup.py install for blobuploader 07:25:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:25:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:25:05 INFO - Running setup.py install for requests 07:25:05 INFO - Running setup.py install for docopt 07:25:05 INFO - Successfully installed blobuploader requests docopt 07:25:05 INFO - Cleaning up... 07:25:05 INFO - Return code: 0 07:25:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:05 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')]} 07:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:05 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')]} 07:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:05 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 0x7f4b4e678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f1c0>, '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 0x1b800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b80550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', '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 07:25:05 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 07:25:05 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 07:25:05 INFO - Using env: {'DISPLAY': ':0', 07:25:05 INFO - 'HOME': '/home/cltbld', 07:25:05 INFO - 'LANG': 'en_US.UTF-8', 07:25:05 INFO - 'LANGUAGE': 'en_US:en', 07:25:05 INFO - 'LOGNAME': 'cltbld', 07:25:05 INFO - 'MAIL': '/var/mail/cltbld', 07:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:05 INFO - 'MOZ_NO_REMOTE': '1', 07:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:05 INFO - 'NO_EM_RESTART': '1', 07:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:05 INFO - 'PWD': '/builds/slave/test', 07:25:05 INFO - 'SHELL': '/bin/bash', 07:25:05 INFO - 'SHLVL': '1', 07:25:05 INFO - 'TERM': 'linux', 07:25:05 INFO - 'TMOUT': '86400', 07:25:05 INFO - 'USER': 'cltbld', 07:25:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', 07:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:05 INFO - '_': '/tools/buildbot/bin/python'} 07:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:06 INFO - Running setup.py (path:/tmp/pip-PMdxY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:06 INFO - Running setup.py (path:/tmp/pip-HdcnL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:06 INFO - Running setup.py (path:/tmp/pip-SFabCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:06 INFO - Running setup.py (path:/tmp/pip-R22qZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:06 INFO - Running setup.py (path:/tmp/pip-NfQ8iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:06 INFO - Running setup.py (path:/tmp/pip-T8BSQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:06 INFO - Running setup.py (path:/tmp/pip-q28hBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:06 INFO - Running setup.py (path:/tmp/pip-pT3L38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:06 INFO - Running setup.py (path:/tmp/pip-Tq_Gj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:06 INFO - Running setup.py (path:/tmp/pip-RwjYhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:06 INFO - Running setup.py (path:/tmp/pip-ph77ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:06 INFO - Running setup.py (path:/tmp/pip-lAM3SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:06 INFO - Running setup.py (path:/tmp/pip-BM8U3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:07 INFO - Running setup.py (path:/tmp/pip-d9l8Hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:07 INFO - Running setup.py (path:/tmp/pip-nDD6gA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:07 INFO - Running setup.py (path:/tmp/pip-ID7Y3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:07 INFO - Running setup.py (path:/tmp/pip-DYtCwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:25:07 INFO - Running setup.py install for manifestparser 07:25:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:25:07 INFO - Running setup.py install for mozcrash 07:25:07 INFO - Running setup.py install for mozdebug 07:25:07 INFO - Running setup.py install for mozdevice 07:25:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:25:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:25:07 INFO - Running setup.py install for mozfile 07:25:07 INFO - Running setup.py install for mozhttpd 07:25:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:25:07 INFO - Running setup.py install for mozinfo 07:25:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:25:08 INFO - Running setup.py install for mozInstall 07:25:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:25:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:25:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:25:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:25:08 INFO - Running setup.py install for mozleak 07:25:08 INFO - Running setup.py install for mozlog 07:25:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:25:08 INFO - Running setup.py install for moznetwork 07:25:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:25:08 INFO - Running setup.py install for mozprocess 07:25:08 INFO - Running setup.py install for mozprofile 07:25:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:25:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:25:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:25:08 INFO - Running setup.py install for mozrunner 07:25:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:25:08 INFO - Running setup.py install for mozscreenshot 07:25:08 INFO - Running setup.py install for moztest 07:25:08 INFO - Running setup.py install for mozversion 07:25:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:25:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:25:09 INFO - Cleaning up... 07:25:09 INFO - Return code: 0 07:25:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:09 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 0x7f4b4e678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f1c0>, '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 0x1b800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b80550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', '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 07:25:09 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 07:25:09 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 07:25:09 INFO - Using env: {'DISPLAY': ':0', 07:25:09 INFO - 'HOME': '/home/cltbld', 07:25:09 INFO - 'LANG': 'en_US.UTF-8', 07:25:09 INFO - 'LANGUAGE': 'en_US:en', 07:25:09 INFO - 'LOGNAME': 'cltbld', 07:25:09 INFO - 'MAIL': '/var/mail/cltbld', 07:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:09 INFO - 'MOZ_NO_REMOTE': '1', 07:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:09 INFO - 'NO_EM_RESTART': '1', 07:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:09 INFO - 'PWD': '/builds/slave/test', 07:25:09 INFO - 'SHELL': '/bin/bash', 07:25:09 INFO - 'SHLVL': '1', 07:25:09 INFO - 'TERM': 'linux', 07:25:09 INFO - 'TMOUT': '86400', 07:25:09 INFO - 'USER': 'cltbld', 07:25:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', 07:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:09 INFO - '_': '/tools/buildbot/bin/python'} 07:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:09 INFO - Running setup.py (path:/tmp/pip-8wi6rR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:09 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)) 07:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:09 INFO - Running setup.py (path:/tmp/pip-DTxsus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:09 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)) 07:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:09 INFO - Running setup.py (path:/tmp/pip-Wnqjgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:09 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)) 07:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:09 INFO - Running setup.py (path:/tmp/pip-CM5lcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:09 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)) 07:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:09 INFO - Running setup.py (path:/tmp/pip-wCqXI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:09 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)) 07:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:09 INFO - Running setup.py (path:/tmp/pip-38ybNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:09 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)) 07:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:09 INFO - Running setup.py (path:/tmp/pip-31D0MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:09 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)) 07:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:09 INFO - Running setup.py (path:/tmp/pip-UENdhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:09 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)) 07:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:09 INFO - Running setup.py (path:/tmp/pip-J5uv6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:09 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)) 07:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:10 INFO - Running setup.py (path:/tmp/pip-q41ZJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:10 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)) 07:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:10 INFO - Running setup.py (path:/tmp/pip-G49K4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:10 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)) 07:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:10 INFO - Running setup.py (path:/tmp/pip-W8YTQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:10 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)) 07:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:10 INFO - Running setup.py (path:/tmp/pip-fpaGbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:10 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)) 07:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:10 INFO - Running setup.py (path:/tmp/pip-XeXCy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:10 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)) 07:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:10 INFO - Running setup.py (path:/tmp/pip-vE7JHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:10 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)) 07:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:10 INFO - Running setup.py (path:/tmp/pip-5DZZ35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:10 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)) 07:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:10 INFO - Running setup.py (path:/tmp/pip-WWDN74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:10 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)) 07:25:10 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)) 07:25:10 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)) 07:25:10 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)) 07:25:10 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)) 07:25:10 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)) 07:25:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:12 INFO - Downloading blessings-1.6.tar.gz 07:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:25:12 INFO - Installing collected packages: blessings 07:25:12 INFO - Running setup.py install for blessings 07:25:12 INFO - Successfully installed blessings 07:25:12 INFO - Cleaning up... 07:25:12 INFO - Return code: 0 07:25:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:12 INFO - Reading from file tmpfile_stdout 07:25:12 INFO - Current package versions: 07:25:12 INFO - argparse == 1.2.1 07:25:12 INFO - blessings == 1.6 07:25:12 INFO - blobuploader == 1.2.4 07:25:12 INFO - docopt == 0.6.1 07:25:12 INFO - functools32 == 3.2.3-2 07:25:12 INFO - jsonschema == 2.5.1 07:25:12 INFO - manifestparser == 1.1 07:25:12 INFO - mozInstall == 1.12 07:25:12 INFO - mozcrash == 0.17 07:25:12 INFO - mozdebug == 0.1 07:25:12 INFO - mozdevice == 0.48 07:25:12 INFO - mozfile == 1.2 07:25:12 INFO - mozhttpd == 0.7 07:25:12 INFO - mozinfo == 0.9 07:25:12 INFO - mozleak == 0.1 07:25:12 INFO - mozlog == 3.2 07:25:12 INFO - moznetwork == 0.27 07:25:12 INFO - mozprocess == 0.23 07:25:12 INFO - mozprofile == 0.28 07:25:12 INFO - mozrunner == 6.12 07:25:12 INFO - mozscreenshot == 0.1 07:25:12 INFO - mozsystemmonitor == 0.3 07:25:12 INFO - moztest == 0.7 07:25:12 INFO - mozversion == 1.4 07:25:12 INFO - psutil == 3.1.1 07:25:12 INFO - requests == 1.2.3 07:25:12 INFO - wsgiref == 0.1.2 07:25:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:12 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 0x7f4b4e678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f1c0>, '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 0x1b800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b80550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', '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 07:25:12 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 07:25:12 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 07:25:12 INFO - Using env: {'DISPLAY': ':0', 07:25:12 INFO - 'HOME': '/home/cltbld', 07:25:12 INFO - 'LANG': 'en_US.UTF-8', 07:25:12 INFO - 'LANGUAGE': 'en_US:en', 07:25:12 INFO - 'LOGNAME': 'cltbld', 07:25:12 INFO - 'MAIL': '/var/mail/cltbld', 07:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:12 INFO - 'MOZ_NO_REMOTE': '1', 07:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:12 INFO - 'NO_EM_RESTART': '1', 07:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:12 INFO - 'PWD': '/builds/slave/test', 07:25:12 INFO - 'SHELL': '/bin/bash', 07:25:12 INFO - 'SHLVL': '1', 07:25:12 INFO - 'TERM': 'linux', 07:25:12 INFO - 'TMOUT': '86400', 07:25:12 INFO - 'USER': 'cltbld', 07:25:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', 07:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:12 INFO - '_': '/tools/buildbot/bin/python'} 07:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:13 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)) 07:25:13 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)) 07:25:13 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)) 07:25:13 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)) 07:25:13 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)) 07:25:13 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)) 07:25:13 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)) 07:25:13 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)) 07:25:13 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)) 07:25:13 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)) 07:25:13 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)) 07:25:13 INFO - Cleaning up... 07:25:13 INFO - Return code: 0 07:25:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b4e678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f1c0>, '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 0x1b800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b80550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', '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 07:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:25:13 INFO - Using env: {'DISPLAY': ':0', 07:25:13 INFO - 'HOME': '/home/cltbld', 07:25:13 INFO - 'LANG': 'en_US.UTF-8', 07:25:13 INFO - 'LANGUAGE': 'en_US:en', 07:25:13 INFO - 'LOGNAME': 'cltbld', 07:25:13 INFO - 'MAIL': '/var/mail/cltbld', 07:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:13 INFO - 'MOZ_NO_REMOTE': '1', 07:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:13 INFO - 'NO_EM_RESTART': '1', 07:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:13 INFO - 'PWD': '/builds/slave/test', 07:25:13 INFO - 'SHELL': '/bin/bash', 07:25:13 INFO - 'SHLVL': '1', 07:25:13 INFO - 'TERM': 'linux', 07:25:13 INFO - 'TMOUT': '86400', 07:25:13 INFO - 'USER': 'cltbld', 07:25:13 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', 07:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:13 INFO - '_': '/tools/buildbot/bin/python'} 07:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:25:13 INFO - Cleaning up... 07:25:13 INFO - Return code: 0 07:25:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b4e678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f1c0>, '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 0x1b800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b80550>, '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': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', '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 07:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:25:13 INFO - Using env: {'DISPLAY': ':0', 07:25:13 INFO - 'HOME': '/home/cltbld', 07:25:13 INFO - 'LANG': 'en_US.UTF-8', 07:25:13 INFO - 'LANGUAGE': 'en_US:en', 07:25:13 INFO - 'LOGNAME': 'cltbld', 07:25:13 INFO - 'MAIL': '/var/mail/cltbld', 07:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:13 INFO - 'MOZ_NO_REMOTE': '1', 07:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:13 INFO - 'NO_EM_RESTART': '1', 07:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:13 INFO - 'PWD': '/builds/slave/test', 07:25:13 INFO - 'SHELL': '/bin/bash', 07:25:13 INFO - 'SHLVL': '1', 07:25:13 INFO - 'TERM': 'linux', 07:25:13 INFO - 'TMOUT': '86400', 07:25:13 INFO - 'USER': 'cltbld', 07:25:13 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', 07:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:13 INFO - '_': '/tools/buildbot/bin/python'} 07:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:13 INFO - Downloading/unpacking flake8 07:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:25:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:25:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:16 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 07:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:25:16 INFO - no previously-included directories found matching 'docs/_build' 07:25:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:25:16 INFO - Running setup.py install for pep8 07:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:25:16 INFO - no previously-included directories found matching 'docs/_build' 07:25:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:25:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:25:16 INFO - Cleaning up... 07:25:16 INFO - Return code: 0 07:25:16 INFO - Running post-action listener: _resource_record_post_action 07:25:16 INFO - Running post-action listener: _start_resource_monitoring 07:25:16 INFO - Starting resource monitoring. 07:25:16 INFO - ##### 07:25:16 INFO - ##### Finished create-virtualenv step (success) 07:25:16 INFO - ##### 07:25:16 INFO - ##### 07:25:16 INFO - ##### Running install step. 07:25:16 INFO - ##### 07:25:16 INFO - Running pre-action listener: _resource_record_pre_action 07:25:16 INFO - Running main action method: install 07:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:16 INFO - Reading from file tmpfile_stdout 07:25:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:25:16 INFO - Reading from file tmpfile_stdout 07:25:16 INFO - Output received: 07:25:16 INFO - Usage: mozinstall [options] installer 07:25:16 INFO - Options: 07:25:16 INFO - -h, --help show this help message and exit 07:25:16 INFO - -d DEST, --destination=DEST 07:25:16 INFO - Directory to install application into. [default: 07:25:16 INFO - "/builds/slave/test"] 07:25:16 INFO - --app=APP Application being installed. [default: firefox] 07:25:16 INFO - mkdir: /builds/slave/test/build/application 07:25:16 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'] 07:25:16 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 07:25:32 INFO - Reading from file tmpfile_stdout 07:25:32 INFO - Output received: 07:25:32 INFO - /builds/slave/test/build/application/firefox/firefox 07:25:32 INFO - Running post-action listener: _resource_record_post_action 07:25:32 INFO - ##### 07:25:32 INFO - ##### Finished install step (success) 07:25:32 INFO - ##### 07:25:32 INFO - ##### 07:25:32 INFO - ##### Running run-tests step. 07:25:32 INFO - ##### 07:25:32 INFO - Running pre-action listener: _resource_record_pre_action 07:25:32 INFO - Running main action method: run_tests 07:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:25:32 INFO - Python 2.7.3 07:25:32 INFO - Return code: 0 07:25:32 INFO - grabbing minidump binary from tooltool 07:25:32 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')]} 07:25:32 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 0x1b7f1c0>, '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 0x1b800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b80550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:25:32 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 07:25:32 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 07:25:32 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 07:25:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:25:32 INFO - Return code: 0 07:25:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:25:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:25:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:25:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:25:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:25:33 INFO - Return code: 0 07:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:25:33 INFO - Using env: {'DISPLAY': ':0', 07:25:33 INFO - 'HOME': '/home/cltbld', 07:25:33 INFO - 'LANG': 'en_US.UTF-8', 07:25:33 INFO - 'LANGUAGE': 'en_US:en', 07:25:33 INFO - 'LOGNAME': 'cltbld', 07:25:33 INFO - 'MAIL': '/var/mail/cltbld', 07:25:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:25:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:33 INFO - 'MOZ_NO_REMOTE': '1', 07:25:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:33 INFO - 'NO_EM_RESTART': '1', 07:25:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:33 INFO - 'PWD': '/builds/slave/test', 07:25:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:25:33 INFO - 'SHELL': '/bin/bash', 07:25:33 INFO - 'SHLVL': '1', 07:25:33 INFO - 'TERM': 'linux', 07:25:33 INFO - 'TMOUT': '86400', 07:25:33 INFO - 'USER': 'cltbld', 07:25:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447', 07:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:33 INFO - '_': '/tools/buildbot/bin/python'} 07:25:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:25:33 INFO - mozversion application_buildid: 20160720045220 07:25:33 INFO - mozversion application_changeset: 8c9f7b5974300cff726db32d613b854193b7477a 07:25:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:25:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:25:33 INFO - mozversion application_name: Firefox 07:25:33 INFO - mozversion application_remotingname: firefox-dev 07:25:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:25:33 INFO - mozversion application_vendor: Mozilla 07:25:33 INFO - mozversion application_version: 49.0a2 07:25:33 INFO - mozversion platform_buildid: 20160720045220 07:25:33 INFO - mozversion platform_changeset: 8c9f7b5974300cff726db32d613b854193b7477a 07:25:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:25:33 INFO - mozversion platform_version: 49.0a2 07:25:33 INFO - using testdate: 1469024733 07:25:33 INFO - actual date: 1469024733 07:25:33 INFO - starting webserver on 'localhost:45423' 07:25:33 INFO - SUITE-START | Running 2 tests 07:25:33 INFO - TEST-START | dromaeo_css 07:25:33 INFO - operating with platform_type : linux_ 07:25:33 INFO - Initialising browser for dromaeo_css test... 07:25:33 INFO - TEST-INFO | started process 29462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXMtwfT/profile http://localhost:45423/getInfo.html) 07:25:37 INFO - PROCESS | 29462 | __metrics Screen width/height:1600/1200 07:25:37 INFO - PROCESS | 29462 | colorDepth:24 07:25:37 INFO - PROCESS | 29462 | Browser inner width/height: 1024/697 07:25:37 INFO - PROCESS | 29462 | __metrics 07:25:38 INFO - PROCESS | 29462 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:25:38 ERROR - PROCESS | 29462 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:25:39 INFO - TEST-INFO | 29462: exit 0 07:25:39 INFO - Browser initialized. 07:25:39 INFO - Running cycle 1/1 for dromaeo_css test... 07:25:39 INFO - TEST-INFO | started process 29552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXMtwfT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:51 INFO - PROCESS | 29552 | RSS: Main: 144990208 07:25:51 INFO - PROCESS | 29552 | 07:26:42 INFO - PROCESS | 29552 | 1469024802638 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] 07:28:50 INFO - PROCESS | 29552 | Cycle 1(1): loaded http://localhost:45423/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45423/tests/dromaeo/cssquery-ext.html) 07:28:51 INFO - PROCESS | 29552 | RSS: Main: 252219392 07:28:51 INFO - PROCESS | 29552 | 07:31:53 INFO - PROCESS | 29552 | Cycle 1(1): loaded http://localhost:45423/tests/dromaeo/cssquery-ext.html (next: http://localhost:45423/tests/dromaeo/cssquery-jquery.html) 07:31:54 INFO - PROCESS | 29552 | RSS: Main: 227770368 07:31:54 INFO - PROCESS | 29552 | 07:34:56 INFO - PROCESS | 29552 | Cycle 1(1): loaded http://localhost:45423/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45423/tests/dromaeo/cssquery-mootools.html) 07:34:56 INFO - PROCESS | 29552 | RSS: Main: 223580160 07:34:56 INFO - PROCESS | 29552 | 07:37:58 INFO - PROCESS | 29552 | Cycle 1(1): loaded http://localhost:45423/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45423/tests/dromaeo/cssquery-prototype.html) 07:37:59 INFO - PROCESS | 29552 | RSS: Main: 219828224 07:37:59 INFO - PROCESS | 29552 | 07:41:02 INFO - PROCESS | 29552 | Cycle 1(1): loaded http://localhost:45423/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45423/tests/dromaeo/cssquery-yui.html) 07:41:02 INFO - PROCESS | 29552 | RSS: Main: 203988992 07:41:02 INFO - PROCESS | 29552 | 07:44:04 INFO - PROCESS | 29552 | Cycle 1(1): loaded http://localhost:45423/tests/dromaeo/cssquery-yui.html (next: http://localhost:45423/tests/dromaeo/cssquery-dojo.html) 07:44:05 INFO - PROCESS | 29552 | RSS: Main: 239202304 07:44:05 INFO - PROCESS | 29552 | 07:44:05 INFO - PROCESS | 29552 | __start_tp_report 07:44:05 INFO - PROCESS | 29552 | _x_x_mozilla_page_load 07:44:05 INFO - PROCESS | 29552 | _x_x_mozilla_page_load_details 07:44:05 INFO - PROCESS | 29552 | |i|pagename|runs| 07:44:05 INFO - PROCESS | 29552 | |0;dojo.html;3298.1919429739714;3305.983470082649;3311.9337613247735;3336.4995250712404;3350.396928552861;5377.247185394048;5419.187121931712;5442.482964118407;5445.292112025431;5469.781208751645;5454.400015998237;5520.889582208353;5529.0324193266115;5529.917051244234;5553.222548843165;4782.258749893772;4822.951770482286;4960.950390496103;4965.776540055688;4999.150144475429;4851.781669824866;4875.70745755254;4891.241857512091;4934.407871055479;4938.160512712848;4894.5594896459315;4972;5004.949950500485;5022.296878437021;5037.042961837239;5093.643444958854;5095.949040509585;5102.464241254671;5107.923381149286;5131.794728210848;4796.688215265996;4842;4887.7311747853855;5021.07110184617;5030.471800460972;5272.973635131838;5305.257263983045;5305.628605997582;5343.839684809462;5344.465553444663;5814.47669709724;5887.175795388649;5888.087346461305;5890.204822348971;5892.204552385416;5807.709614519299;5850.5612079094235;5861.267341582302;5901.557383196277;5911.349751527328;5486.149646804752;5517.089680202762;5526.115821468546;5530.2810634618045;5532.30846144232;5816.88366232673;6015.368386319461;6020.488258498077;6029.577929544977;6035.758569657252;5633.718314084362;5677.460641239159;5685.147227915846;5697.373288938214;5711.143328500758;5797.36229014808;5807.245058142415;5817.127430885401;5822.0684690449325;5824.184614154022;5678.063119585222;5678.233438485834;5793.826185214366;5803.303603567514;5810.302763668386;5718.428157184248;5769.711514424346;5770.769169233267;5788.942110578924;5798.971005144947;4463.285874260103;4475.641948644101;4477.552244775561;4482.8206871725415;4501.774911254424;3981.462502562117;3982.203559288154;4023.155137421116;4023.8189281482405;4064.207479541461;5559.805406810742;5589.74846131925;5590.97204513983;5593.580481463907;5604.747786349542;5856.560757943086;5858.238429004202;5864.677442740605;5868.149118377897;5899.852503687443;5390.757415916293;5496.1755736639825;5522.282103326622;5546.112621980464;5583.804566840141;4969.329140566049;4991.051700176955;4998.800047998112;5004.524570165829;5006.148954677641;5863.560232982543;5935.851603709942;5937.940620593825;5943.970280148658;5962.791302304398;5701.572382071278;5724.856878578069;5733.0540460823495;5734.885302294014;5848.883022339614;5867.618604790675;5875.882482350415;5877.147813567094;5879.529637628894;5882.735276912635;5679.517241034393;5687.744051517774;5688.77244910199;5688.829335119953;5694.629849059798;5652.886942261214;5742.3109226891365;5778.913316300175;5789.536837052941;5821.592488525763;5703.600747947604;5708.771649133988;5709;5709.486146246858;5713.371529131875;5519.31008623922;5674.77300907959;5679.886402271849;5679.977604031314;5683.60214784961;5555.777768889199;5586.832395028156;5614.7192640367;5654.745536450787;5655.604107712586;5728.312602487728;5768.3078030634915;5804.912926306024;5816.389279125631;5817.738201780845;5461.399246083007;5556.083246264321;5680.40355762639;5680.829575112753;5696.629719068247 07:44:05 INFO - PROCESS | 29552 | |1;ext.html;606.3845197124919;648.8604949935764;652.8792173447913;655.243194110802;665.3147258323928;32444.513332300005;35107.82446087766;35135.64864351356;35149.824250878744;35158;36291.81854090733;46825;47897.52102478983;47924.520754792444;51861.74069129658;9057.864132038041;9176;9176.908230917672;9186.632534698603;9186.908130918706;8210.83578328433;9029.23251523618;9123.315751318678;9136.177744003038;9136.6802161924;10709.036186743191;10962.068224200952;10969.561217551329;11350.886491135065;11368.261063030877;10717.83923241152;10719.19606029551;10784.676459706221;10853.837192442119;10866.782664346709;8295.170482951717;10617;10725.410102444363;10804.891951080546;10979.725506862313;41327.1734565307;45130.77434612839;45257.773711131566;45289.320660190126;45361.77319113416;3831.7892515911612;3915.745476544044;3918.8432462701458;3980.44273801668;4110.445089912883;35577.64422355769;35777.82111089428;36033.63966360355;36236.275274494365;37245.627543724484;4729.763511824395;4769.594584460325;4786.138495070886;4850.054239423313;4896.828610998634;419081;425297;425960;426207;427948;70716.64641676862;70767.64616176886;70941.64529177321;71033.64483177551;71484;76787.61606191934;76939;77267.61366193133;77378;77408;19654.410367688994;20303.796962030487;20312;20327.491812704506;20339.593208135753;15429.845701542841;15605.297761600756;15657.217139142997;15666.138362390178;15669.843301567067;19098;21302.467438313855;21596;21848.453788655093;21965;7377.446691498052;7454.658161530977;7615.466917315845;7700.807479812937;7870.842583148419;1010.2271762101998;1034.9534270957674;1051.8001579699833;1063.9627613033506;1120.2326406411635;34597.481037784455;34829.82585087109;34955;34980;35079;1144;1156.034711016294;1160.9013233875214;1219.0978675779859;1238.7646347194004;18060.819391806177;18306.816931830777;18344.266229350942;18345.633087338178;18426.355077572487;634367;635753;638415;641428;641546;65346;65794.34205657979;65882;65976.34023659799;65998.34001659922;1382.4539306973688;1408.0847449157925;1410.4569740649924;1450.3400952566558;1452.4262916148061;31479;35533.38066051397;35540.82229588939;35824.10439739027;36005.27989440249;55492;60684.696576516835;61311;61439.692801535704;67668.66165669337;541675;542124;545370;548608;549444;27283;29918.102456926328;30343.696563034086;31613.52579711352;32128;51647.483525164265;52091.73954130205;52520.21219681631;52688.73655631697;53652.73173634263;41986.37020444757;43205.56794432141;44203.778981104886;44379.33430998473;44503;41895.7905210472;42246.57753422549;42843.14313713646;42920.141597168506;44100.55899440964;43694;44864.32703509385;45180.77409612931;45254.32118518159;45407.772961134986;36964.6303536972;37309;37535.43696844495;37973.240535189696;38408.42387364136;29966.400671986874;30021.69978300189;30153.246168845955;30205.69794302029;30434.239144021576 07:44:05 INFO - PROCESS | 29552 | |2;jquery.html;414.08900419078014;418.32649434410604;423.60181429456287;426.7972712961343;435.7363794904083;18601.441956741302;19169.808301916975;20252.797472025275;20421.08105135269;20451.693224601644;17811.910940445312;17886.37397691081;17893.552661183476;17908.37320693776;19430.902845485787;5483.8080667176655;5645.294338207724;5856.121581762727;5866.472017518422;5869.442402971711;5504.284443022401;5682.636167319854;5747.080467125261;5758.251427314443;5758.280214973129;5646.040173170551;5650.378458369576;5686.971565142168;5688.288963879515;5688.488036076752;5463.453654634544;5650.237217975582;5658.830235092933;5665.150227465892;5705.144228365778;5113.872153196163;5153.871153221199;5154.92267615986;5155.871103222412;5167.147420675622;21773.34679959604;22397.66403503949;22535.323940281818;22707;22771.31686049421;2351.905923763047;2358.563665721847;2421.285720712394;2443.230382429529;2500.3999040230215;13914.93042534791;14587.562373128823;14873.925630371887;14901.403943842233;14988.400463981428;2017.1729590867674;2029;2033.1562401603464;2052.7126202331688;2062.958206105907;74670.62664686696;79244.60377698133;79290.20709792885;79443.60278198573;79597;11250.606228782117;11633.302001879914;11734.589289374831;11839;11937.701557461132;16736.16319184036;16835.579110522336;16837.242324095445;16882.74675879863;16885.24016419264;8884.244839188741;8951.955240223757;9003.729888103368;9130.81738365229;9141.81716365669;8686.174813392718;8727.996280427706;8730.519821409756;8785.560721963877;8968.148025937526;5010.448850626428;5028;5067.265246539231;5069.493050694975;5107.846764597068;1884.5288677830542;1906.1993962535769;1911.149538455374;2044.5483706568207;2054.4042227754085;756.1417790807474;923.3951761596165;966.0100193601064;1101.542859713226;1107.0921844087932;18509.167087481095;18921.243150273836;19006.61986760257;19249.13378897953;19333.51666208356;1010.3281317923645;1020.882598501167;1026.1790567545934;1042.3224903812431;1053.6312290698195;10542;10570.048695617432;10881;11011.00900918921;11061.17291444718;544012;544676;549065;549131.0173796501;549217;63188;98516;102539.9999999985;108335;109680.4515977415;1104.5250542266742;1116.821308590638;1126.5606413498742;1126.881677423875;1143.056977993159;17479.213435395184;17595.912020439817;17612.383566575107;17759.467215983543;17978.640427191644;42301.36547951722;43398.78300608477;44043.779781100886;44970.325445119;46051.07897841957;62762.372376275656;62922;63160;64781.35218647942;64866.67566662136;6336.461400780985;8255.133211012997;8335.083140854622;8523.573821309034;8529.061803201766;12348.444320005441;12805.295708735735;12850.228986260854;13014.609561713163;13213.801792972921;11446.313221206754;11468.598599048993;11479.540818367506;11530.423478825858;11779.705507362385;10989.890101098887;11399.601013964471;11459.885401145882;11527;11760.470778814803;11298.209125361474;11770.470328835394;11790.351530665552;11898.583549575724;12016.879831201577;7225.421966242583;7919.524828510308;8491.235788778793;8651.95674021626;8752.124787521198;11848.407579620813;11886.16796824214;11972.221805582609;12080.818787718015;12146.514139434325 07:44:05 INFO - PROCESS | 29552 | |3;mootools.html;1359.5785306554974;1484.480431848853;1522.2617030740091;1698.9830101698988;1828.9542761430962;8325.458845175068;8667.263282620977;8725.432846864956;8937.597808098635;8946.418482798614;8673.566321683922;8876.112388761137;8881;8881.60032798524;8881.91118088819;2017.4452025692906;2295.735990361113;2368.3723813189517;2411.2284069097896;2436.5248776488593;2387.128698025217;2395.4490467192554;2395.772401621843;2401.0635852017726;2401.7238017628024;2369.6800931874236;2378.9048438062455;2406.614941609343;2406.7232268289195;2415.7825795678386;2050.0569737920573;2110.7150534677776;2116.185268671557;2276.066812606823;2345.8592484450987;2361.9055237790467;2402.315340128055;2403.086827005744;2405.7971014492755;2410;8723.345749068782;8769.254613357873;8769.429987050886;8776.780580485474;8785.428947118417;5168.2764412982215;5314.1497360422145;5315.760790764425;5317.41508434072;5317.867053323659;3447.896563103111;3504.9474257886154;3550.5384300041087;3616.2405894762132;3623.836927338276;1202.3327053485311;1216.1183142221907;1217.9878201218053;1243.8507379114565;1249.450241893564;11917;11938.164328497009;11954.581589644407;11959.162858599902;11960.34218118003;4694.6009589185305;4759.190937540627;4831.613470922318;4836.492168322346;4849.684770489906;10146.492675366202;10185;10202.285839991278;10208.336458130198;10212.387256764618;5114.053900028507;5135.743212839343;5141.562967147759;5142.202958541432;5149.948500515022;4427.335899615019;4805.207140821725;4879.56083952446;4944.90110197794;4986.476419975923;4133.689973252018;4142.565030671736;4178.289690752579;4187;4219.641330486882;1288.400893584469;1320.8877245434053;1337.5786627212397;1342.6039318401095;1343.6372179511477;909.3270979475141;994.2344394815951;995.4475266227313;1011.2466212671607;1017.1455976979373;5849.941500585025;5958.6722730249385;6037.094435834572;6076.058210977306;6131.570790044654;475.8382150068993;491.3734987890397;494.4486897109697;499.997505002475;510.1658787881766;4182.665386769051;4231.492220933507;4233.894152646147;4250.298700714409;4269.423627810268;10404.895951040544;10545.156387489136;10738.78522429547;10742.892571074346;10794;10503.159747220205;10571.62999295021;10578.471076446147;10593.258471906893;10631.255812093234;7788.805279868048;7851.05787305527;7856.332211762065;7870.44906856526;8147.103818579952;5845.912311315419;5879.617824841372;5904.586678932434;5962.880742385041;5976.701164941823;9722.31943763958;10007.849882251918;10247.795044099226;10259.076683098558;10386.74033149147;10094;10470.11004064663;10496.265261431932;10504.947475262576;10508.947455262674;6947.3747362737595;7685.846283074419;7801.648925798239;7933.444658874054;8099.554524501209;8809.339299552686;8822.735317940473;8841.248493877834;8891.333150013905;8893.510856902674;7445.478816482794;7670.386369090571;7687.500312479671;7809.180036096128;8085.393595480245;7580.886286705814;7611.847763044819;7634.618269086634;7670.156282808775;7804.6878124874365;7246;7273;7302.3792977597495;7317.414606831547;7317.780466586011;4969.254611808257;4985.8005679772405;5051.217061355495;5167.354080739908;5224.660397074178;5320.441353657965;5345.65253258537;5347.839564813062;5369.704666243238;5474.835754927359 07:44:05 INFO - PROCESS | 29552 | |4;prototype.html;332.1844870842083;344.9827508624569;351.1554710920238;352.3850880214025;353.0098074899906;5280.630355875091;5355.732213389334;5397.892042159155;5423.728813559321;5442.292501974747;5332.893342133165;5341.145416733323;5354.625176237665;5368.248445217663;5374;4009.4386785850006;4231.196072746184;4252.808623611945;4264.083222107246;4283.721558098714;3853.903652408684;4072.60509547808;4175;4202.831886724527;4218.240716670998;4153.231652144348;4154.649738834875;4161.979190104045;4168.978600242945;4182.05903671673;4004;4160.084781348099;4168.97915510422;4174.24863524567;4188.518320393133;3601.873934412283;3715.9442608360896;3731.6641502264924;3737.6449237322413;3752.43713442983;5090.669106508065;5114.923276150861;5115.2327150927285;5167.48325167484;5219.660722053054;4670.789814458358;4815.5906747926465;4818.277258411232;4852.56326930578;4864.635152363587;5483.928999760147;5570;5576.302962129734;5579.776808927638;5582.720863956826;4120.269486815545;4123.649489793341;4128.401381799652;4129.566395528486;4154.709170358076;5496.4503549645515;5840.269966254218;5851.736671849777;5864.1203819427;5870.706464676749;4125.257453658311;4149.419081328617;4155.958440415618;4168.687348448879;4175.55729898013;4210.115875666083;4214.852480163179;4216.451861258017;4221.155768846243;4227.915441691149;4811.735354555463;4822.565969062801;4822.68652537584;4836.12949669063;4844;5459.153831156177;5573.5819813513335;5586.608937374344;5602;5612.775488980476;1424.2380326525467;1449.521657852906;1452.4771082410323;1454.978175327371;1462.7732701431296;898.9730308090768;931.5156118818177;944.5702205496483;954.3176628710505;958.1376760915232;4979.203327467588;4981.203007518852;5291.550218231493;5369.221462887859;5574;5789.2763404574425;5792;5801.026296986578;5801.88396232073;5803.47768700819;5465.6335916021;5495.148252020943;5534.75093620788;5542.501174894279;5576.97211513948;2913.606663100454;3050.1916991997136;3081.6147981502313;3097.659257481675;3111.766617503651;5885.382034886361;5890;5915.497182739429;5959.612625179349;5981.79063732776;5641.52047075995;5951.166836642873;5953.732082056318;5960.552958528127;5960.821175364746;5923.933691935406;5943.157621137461;5943.227380440601;5952.9107063394085;5956.672383018976;5644.717764111861;5853.94146058551;5880.735366908414;5889.705514724333;5917.497012753792;5697.971510142423;5734.541236701138;5750.8849823002465;5767.192593037062;5790.131480277992;5905.645661260338;5960.642361458326;5971.104334349882;5972;5998.940010599838;4036.766233637656;4131.752094874317;4161.313383291723;4176.91646167081;4195.286801243735;5822.388649191774;5846.824595262149;5857.736401862012;5864.970675146597;5910.704464776658;5648.689322087324;5703.971480142573;5708.400617935223;5771.422857714195;5783.884322313446;5530.336359636869;5574.219609254626;5579.860503487445;5579.879645734757;5584.246126772996;5505.642133261325;5537.784886045614;5540.667559946416;5549.056660367828;5562.610617256753;5464.781408743765;5547.583931205257;5702;5714.3999880012;5733.913991290217;5556.722163891708;5567.972160139173;5571.721413929368;5588.77644894216;5596.692181930033 07:44:05 INFO - PROCESS | 29552 | |5;yui.html;835.8704400817871;848.5248260973851;853.117023880284;856.9442986205897;883.4257732473893;14260.57218283452;14291.428342866298;14320.21238831865;14340.856591434083;14357.353919073641;14336.56990290293;14381.78427323591;14386.712265754679;14388.280585970711;14392;722.3967986731086;831.9459235149695;852.654674856684;856.7130011446142;864.6022829498438;863.5595846118493;865.8051938313891;868.7089824908663;869.6608322754131;870.9346798990069;916.6883259691704;918.6279556779515;919.2278486071698;920.3419555018161;920.3695468603994;763.2253262938123;900.2527901841456;919.1865199298602;920.2821798996794;921.6774129054844;674.4435840431663;674.8380388706724;675.2167485716594;675.2336098528157;675.4427597232254;16147.111908845009;16174.676506469923;16184.83815161857;16189.83810161895;16286.918565407215;15224.543263701997;15420.768688469681;15468.381264749396;15619.375224990987;15884.444044458503;13339;13713.931430342784;13797.931010344984;14099.295035248197;14194.077384970047;4508.504064552896;4510.729356238636;4532.864014079583;4561.384213131251;4562.110388474249;77251.61374193092;78514.60742696308;78869;79195;79417.20582794157;12002.699932501582;12024.939875300568;12027.09796765246;12157.027437804954;12221.144519883701;23244.883775581013;23291.534169316517;23326.7667323328;23413.297601071994;23436;8752.256058235122;8914.643414263357;8972.596233169523;9143.405678630868;9305.25557955362;5083.974580127149;5137.51193636604;5194.168932970707;5229.267902493654;5299.708516031578;3563.429851223792;3642.0348607619003;3647.452882067711;3659.6340365963724;3670.100825297766;611.6941529235382;613.9693015349214;626.7586979013113;628.0892705576932;630.5554584018348;627.541894417069;635.4154178156108;646.15676542113;657.0472814419112;665.9966700166565;9355.111264429868;10013.79972400548;10127.088562029452;10168.170897993614;10538.743923008296;627.626562195493;707.7133760826873;709.2623671381808;747.4767662636176;781.5268219406346;4490.865274041784;4572.908541829145;4647.140279048387;4656;4718.504557021463;111757.88242117474;119128.40435797766;119852.40073799575;119898;120045;85285;101671;101975.49012254892;102524.92425227255;103827;62497.68751156215;73756.63121684357;86467.56766216255;86786.56606716926;87575.56212218897;9646.42121472714;10133.797324053625;10284.074433301039;10339.741506462098;10390.740231494274;54482.455175447736;54603.72698136484;54710.452895472125;56317.71841140768;56591.71704141453;71183;78333.60833195798;78647.60676196583;78688.60655696684;79462.20537794779;14060.156390616596;14072.279527460643;14087.577372678836;14241.786373204617;14265.500707475188;13284.802562741887;13538.93230533841;13935;14096;14509.347079381241;13629;13809;13976.301184940916;14697.779533306795;14817.925910370379;13070.085094043327;13074;13623.523176689165;13786.862131378557;14559.19924404168;13287.80068298957;13502.594922152352;13795.2412617303;13866.514671986431;13949.790753138508;11026.173037022096;11113.333200008025;11165.97902911857;11254.21220514556;11362.94318528402;11436.485358158736;11485.82771258415;12017.699557511132;12041.397930103285;12090 07:44:05 INFO - PROCESS | 29552 | __end_tp_report 07:44:05 INFO - PROCESS | 29552 | __start_cc_report 07:44:05 INFO - PROCESS | 29552 | _x_x_mozilla_cycle_collect,893 07:44:05 INFO - PROCESS | 29552 | __end_cc_report 07:44:05 INFO - PROCESS | 29552 | __startTimestamp1469025845223__endTimestamp 07:44:05 INFO - PROCESS | 29552 | 07:44:05 INFO - PROCESS | 29552 | ------- Summary: start ------- 07:44:05 INFO - PROCESS | 29552 | Number of tests: 6 07:44:05 INFO - PROCESS | 29552 | 07:44:05 INFO - PROCESS | 29552 | [#0] dojo.html Cycles:165 Average:5408.51 Median:5652.89 stddev:582.78 (10.3%) stddev-sans-first:560.56 07:44:05 INFO - PROCESS | 29552 | Values: 3298.2 3306.0 3311.9 3336.5 3350.4 5377.2 5419.2 5442.5 5445.3 5469.8 5454.4 5520.9 5529.0 5529.9 5553.2 4782.3 4823.0 4961.0 4965.8 4999.2 4851.8 4875.7 4891.2 4934.4 4938.2 4894.6 4972.0 5004.9 5022.3 5037.0 5093.6 5095.9 5102.5 5107.9 5131.8 4796.7 4842.0 4887.7 5021.1 5030.5 5273.0 5305.3 5305.6 5343.8 5344.5 5814.5 5887.2 5888.1 5890.2 5892.2 5807.7 5850.6 5861.3 5901.6 5911.3 5486.1 5517.1 5526.1 5530.3 5532.3 5816.9 6015.4 6020.5 6029.6 6035.8 5633.7 5677.5 5685.1 5697.4 5711.1 5797.4 5807.2 5817.1 5822.1 5824.2 5678.1 5678.2 5793.8 5803.3 5810.3 5718.4 5769.7 5770.8 5788.9 5799.0 4463.3 4475.6 4477.6 4482.8 4501.8 3981.5 3982.2 4023.2 4023.8 4064.2 5559.8 5589.7 5591.0 5593.6 5604.7 5856.6 5858.2 5864.7 5868.1 5899.9 5390.8 5496.2 5522.3 5546.1 5583.8 4969.3 4991.1 4998.8 5004.5 5006.1 5863.6 5935.9 5937.9 5944.0 5962.8 5701.6 5724.9 5733.1 5734.9 5848.9 5867.6 5875.9 5877.1 5879.5 5882.7 5679.5 5687.7 5688.8 5688.8 5694.6 5652.9 5742.3 5778.9 5789.5 5821.6 5703.6 5708.8 5709.0 5709.5 5713.4 5519.3 5674.8 5679.9 5680.0 5683.6 5555.8 5586.8 5614.7 5654.7 5655.6 5728.3 5768.3 5804.9 5816.4 5817.7 5461.4 5556.1 5680.4 5680.8 5696.6 07:44:05 INFO - PROCESS | 29552 | 07:44:05 INFO - PROCESS | 29552 | [#1] ext.html Cycles:180 Average:70642.71 Median:41611.48 stddev:144531.00 (347.3%) stddev-sans-first:144840.79 07:44:05 INFO - PROCESS | 29552 | Values: 606.4 648.9 652.9 655.2 665.3 32444.5 35107.8 35135.6 35149.8 35158.0 36291.8 46825.0 47897.5 47924.5 51861.7 9057.9 9176.0 9176.9 9186.6 9186.9 8210.8 9029.2 9123.3 9136.2 9136.7 10709.0 10962.1 10969.6 11350.9 11368.3 10717.8 10719.2 10784.7 10853.8 10866.8 8295.2 10617.0 10725.4 10804.9 10979.7 41327.2 45130.8 45257.8 45289.3 45361.8 3831.8 3915.7 3918.8 3980.4 4110.4 35577.6 35777.8 36033.6 36236.3 37245.6 4729.8 4769.6 4786.1 4850.1 4896.8 419081.0 425297.0 425960.0 426207.0 427948.0 70716.6 70767.6 70941.6 71033.6 71484.0 76787.6 76939.0 77267.6 77378.0 77408.0 19654.4 20303.8 20312.0 20327.5 20339.6 15429.8 15605.3 15657.2 15666.1 15669.8 19098.0 21302.5 21596.0 21848.5 21965.0 7377.4 7454.7 7615.5 7700.8 7870.8 1010.2 1035.0 1051.8 1064.0 1120.2 34597.5 34829.8 34955.0 34980.0 35079.0 1144.0 1156.0 1160.9 1219.1 1238.8 18060.8 18306.8 18344.3 18345.6 18426.4 634367.0 635753.0 638415.0 641428.0 641546.0 65346.0 65794.3 65882.0 65976.3 65998.3 1382.5 1408.1 1410.5 1450.3 1452.4 31479.0 35533.4 35540.8 35824.1 36005.3 55492.0 60684.7 61311.0 61439.7 67668.7 541675.0 542124.0 545370.0 548608.0 549444.0 27283.0 29918.1 30343.7 31613.5 32128.0 51647.5 52091.7 52520.2 52688.7 53652.7 41986.4 43205.6 44203.8 44379.3 44503.0 41895.8 42246.6 42843.1 42920.1 44100.6 43694.0 44864.3 45180.8 45254.3 45407.8 36964.6 37309.0 37535.4 37973.2 38408.4 29966.4 30021.7 30153.2 30205.7 30434.2 07:44:05 INFO - PROCESS | 29552 | 07:44:05 INFO - PROCESS | 29552 | [#2] jquery.html Cycles:180 Average:31041.98 Median:22085.51 stddev:90062.28 (407.8%) stddev-sans-first:90285.57 07:44:05 INFO - PROCESS | 29552 | Values: 414.1 418.3 423.6 426.8 435.7 18601.4 19169.8 20252.8 20421.1 20451.7 17811.9 17886.4 17893.6 17908.4 19430.9 5483.8 5645.3 5856.1 5866.5 5869.4 5504.3 5682.6 5747.1 5758.3 5758.3 5646.0 5650.4 5687.0 5688.3 5688.5 5463.5 5650.2 5658.8 5665.2 5705.1 5113.9 5153.9 5154.9 5155.9 5167.1 21773.3 22397.7 22535.3 22707.0 22771.3 2351.9 2358.6 2421.3 2443.2 2500.4 13914.9 14587.6 14873.9 14901.4 14988.4 2017.2 2029.0 2033.2 2052.7 2063.0 74670.6 79244.6 79290.2 79443.6 79597.0 11250.6 11633.3 11734.6 11839.0 11937.7 16736.2 16835.6 16837.2 16882.7 16885.2 8884.2 8952.0 9003.7 9130.8 9141.8 8686.2 8728.0 8730.5 8785.6 8968.1 5010.4 5028.0 5067.3 5069.5 5107.8 1884.5 1906.2 1911.1 2044.5 2054.4 756.1 923.4 966.0 1101.5 1107.1 18509.2 18921.2 19006.6 19249.1 19333.5 1010.3 1020.9 1026.2 1042.3 1053.6 10542.0 10570.0 10881.0 11011.0 11061.2 544012.0 544676.0 549065.0 549131.0 549217.0 63188.0 98516.0 102540.0 108335.0 109680.5 1104.5 1116.8 1126.6 1126.9 1143.1 17479.2 17595.9 17612.4 17759.5 17978.6 42301.4 43398.8 44043.8 44970.3 46051.1 62762.4 62922.0 63160.0 64781.4 64866.7 6336.5 8255.1 8335.1 8523.6 8529.1 12348.4 12805.3 12850.2 13014.6 13213.8 11446.3 11468.6 11479.5 11530.4 11779.7 10989.9 11399.6 11459.9 11527.0 11760.5 11298.2 11770.5 11790.4 11898.6 12016.9 7225.4 7919.5 8491.2 8652.0 8752.1 11848.4 11886.2 11972.2 12080.8 12146.5 07:44:05 INFO - PROCESS | 29552 | 07:44:05 INFO - PROCESS | 29552 | [#3] mootools.html Cycles:180 Average:5805.63 Median:4818.41 stddev:3262.15 (67.7%) stddev-sans-first:3254.19 07:44:05 INFO - PROCESS | 29552 | Values: 1359.6 1484.5 1522.3 1699.0 1829.0 8325.5 8667.3 8725.4 8937.6 8946.4 8673.6 8876.1 8881.0 8881.6 8881.9 2017.4 2295.7 2368.4 2411.2 2436.5 2387.1 2395.4 2395.8 2401.1 2401.7 2369.7 2378.9 2406.6 2406.7 2415.8 2050.1 2110.7 2116.2 2276.1 2345.9 2361.9 2402.3 2403.1 2405.8 2410.0 8723.3 8769.3 8769.4 8776.8 8785.4 5168.3 5314.1 5315.8 5317.4 5317.9 3447.9 3504.9 3550.5 3616.2 3623.8 1202.3 1216.1 1218.0 1243.9 1249.5 11917.0 11938.2 11954.6 11959.2 11960.3 4694.6 4759.2 4831.6 4836.5 4849.7 10146.5 10185.0 10202.3 10208.3 10212.4 5114.1 5135.7 5141.6 5142.2 5149.9 4427.3 4805.2 4879.6 4944.9 4986.5 4133.7 4142.6 4178.3 4187.0 4219.6 1288.4 1320.9 1337.6 1342.6 1343.6 909.3 994.2 995.4 1011.2 1017.1 5849.9 5958.7 6037.1 6076.1 6131.6 475.8 491.4 494.4 500.0 510.2 4182.7 4231.5 4233.9 4250.3 4269.4 10404.9 10545.2 10738.8 10742.9 10794.0 10503.2 10571.6 10578.5 10593.3 10631.3 7788.8 7851.1 7856.3 7870.4 8147.1 5845.9 5879.6 5904.6 5962.9 5976.7 9722.3 10007.8 10247.8 10259.1 10386.7 10094.0 10470.1 10496.3 10504.9 10508.9 6947.4 7685.8 7801.6 7933.4 8099.6 8809.3 8822.7 8841.2 8891.3 8893.5 7445.5 7670.4 7687.5 7809.2 8085.4 7580.9 7611.8 7634.6 7670.2 7804.7 7246.0 7273.0 7302.4 7317.4 7317.8 4969.3 4985.8 5051.2 5167.4 5224.7 5320.4 5345.7 5347.8 5369.7 5474.8 07:44:05 INFO - PROCESS | 29552 | 07:44:05 INFO - PROCESS | 29552 | [#4] prototype.html Cycles:180 Average:4748.41 Median:5465.21 stddev:1395.76 (25.5%) stddev-sans-first:1359.75 07:44:05 INFO - PROCESS | 29552 | Values: 332.2 345.0 351.2 352.4 353.0 5280.6 5355.7 5397.9 5423.7 5442.3 5332.9 5341.1 5354.6 5368.2 5374.0 4009.4 4231.2 4252.8 4264.1 4283.7 3853.9 4072.6 4175.0 4202.8 4218.2 4153.2 4154.6 4162.0 4169.0 4182.1 4004.0 4160.1 4169.0 4174.2 4188.5 3601.9 3715.9 3731.7 3737.6 3752.4 5090.7 5114.9 5115.2 5167.5 5219.7 4670.8 4815.6 4818.3 4852.6 4864.6 5483.9 5570.0 5576.3 5579.8 5582.7 4120.3 4123.6 4128.4 4129.6 4154.7 5496.5 5840.3 5851.7 5864.1 5870.7 4125.3 4149.4 4156.0 4168.7 4175.6 4210.1 4214.9 4216.5 4221.2 4227.9 4811.7 4822.6 4822.7 4836.1 4844.0 5459.2 5573.6 5586.6 5602.0 5612.8 1424.2 1449.5 1452.5 1455.0 1462.8 899.0 931.5 944.6 954.3 958.1 4979.2 4981.2 5291.6 5369.2 5574.0 5789.3 5792.0 5801.0 5801.9 5803.5 5465.6 5495.1 5534.8 5542.5 5577.0 2913.6 3050.2 3081.6 3097.7 3111.8 5885.4 5890.0 5915.5 5959.6 5981.8 5641.5 5951.2 5953.7 5960.6 5960.8 5923.9 5943.2 5943.2 5952.9 5956.7 5644.7 5853.9 5880.7 5889.7 5917.5 5698.0 5734.5 5750.9 5767.2 5790.1 5905.6 5960.6 5971.1 5972.0 5998.9 4036.8 4131.8 4161.3 4176.9 4195.3 5822.4 5846.8 5857.7 5865.0 5910.7 5648.7 5704.0 5708.4 5771.4 5783.9 5530.3 5574.2 5579.9 5579.9 5584.2 5505.6 5537.8 5540.7 5549.1 5562.6 5464.8 5547.6 5702.0 5714.4 5733.9 5556.7 5568.0 5571.7 5588.8 5596.7 07:44:05 INFO - PROCESS | 29552 | 07:44:05 INFO - PROCESS | 29552 | [#5] yui.html Cycles:180 Average:21229.03 Median:3664.87 stddev:30194.24 (823.9%) stddev-sans-first:30240.12 07:44:05 INFO - PROCESS | 29552 | Values: 835.9 848.5 853.1 856.9 883.4 14260.6 14291.4 14320.2 14340.9 14357.4 14336.6 14381.8 14386.7 14388.3 14392.0 722.4 831.9 852.7 856.7 864.6 863.6 865.8 868.7 869.7 870.9 916.7 918.6 919.2 920.3 920.4 763.2 900.3 919.2 920.3 921.7 674.4 674.8 675.2 675.2 675.4 16147.1 16174.7 16184.8 16189.8 16286.9 15224.5 15420.8 15468.4 15619.4 15884.4 13339.0 13713.9 13797.9 14099.3 14194.1 4508.5 4510.7 4532.9 4561.4 4562.1 77251.6 78514.6 78869.0 79195.0 79417.2 12002.7 12024.9 12027.1 12157.0 12221.1 23244.9 23291.5 23326.8 23413.3 23436.0 8752.3 8914.6 8972.6 9143.4 9305.3 5084.0 5137.5 5194.2 5229.3 5299.7 3563.4 3642.0 3647.5 3659.6 3670.1 611.7 614.0 626.8 628.1 630.6 627.5 635.4 646.2 657.0 666.0 9355.1 10013.8 10127.1 10168.2 10538.7 627.6 707.7 709.3 747.5 781.5 4490.9 4572.9 4647.1 4656.0 4718.5 111757.9 119128.4 119852.4 119898.0 120045.0 85285.0 101671.0 101975.5 102524.9 103827.0 62497.7 73756.6 86467.6 86786.6 87575.6 9646.4 10133.8 10284.1 10339.7 10390.7 54482.5 54603.7 54710.5 56317.7 56591.7 71183.0 78333.6 78647.6 78688.6 79462.2 14060.2 14072.3 14087.6 14241.8 14265.5 13284.8 13538.9 13935.0 14096.0 14509.3 13629.0 13809.0 13976.3 14697.8 14817.9 13070.1 13074.0 13623.5 13786.9 14559.2 13287.8 13502.6 13795.2 13866.5 13949.8 11026.2 11113.3 11166.0 11254.2 11362.9 11436.5 11485.8 12017.7 12041.4 12090.0 07:44:05 INFO - PROCESS | 29552 | -------- Summary: end -------- 07:44:05 INFO - PROCESS | 29552 | 07:44:05 INFO - TEST-INFO | 29552: exit 0 07:44:05 INFO - TEST-OK | dromaeo_css | took 1112018ms 07:44:05 INFO - TEST-START | kraken 07:44:05 INFO - operating with platform_type : linux_ 07:44:05 INFO - Initialising browser for kraken test... 07:44:05 INFO - TEST-INFO | started process 29780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_oEMsk/profile http://localhost:45423/getInfo.html) 07:44:09 INFO - PROCESS | 29780 | __metrics Screen width/height:1600/1200 07:44:09 INFO - PROCESS | 29780 | colorDepth:24 07:44:09 INFO - PROCESS | 29780 | Browser inner width/height: 1024/697 07:44:09 INFO - PROCESS | 29780 | __metrics 07:44:10 INFO - PROCESS | 29780 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:44:10 ERROR - PROCESS | 29780 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:44:11 INFO - TEST-INFO | 29780: exit 0 07:44:11 INFO - Browser initialized. 07:44:11 INFO - Running cycle 1/1 for kraken test... 07:44:11 INFO - TEST-INFO | started process 29875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_oEMsk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:23 INFO - PROCESS | 29875 | RSS: Main: 145215488 07:44:23 INFO - PROCESS | 29875 | 07:44:25 INFO - PROCESS | 29875 | Cycle 1(1): loaded http://localhost:45423/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45423/tests/kraken/driver.html?testName=audio-beat-detection) 07:44:26 INFO - PROCESS | 29875 | RSS: Main: 194433024 07:44:26 INFO - PROCESS | 29875 | 07:44:29 INFO - PROCESS | 29875 | Cycle 1(1): loaded http://localhost:45423/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45423/tests/kraken/driver.html?testName=audio-dft) 07:44:29 INFO - PROCESS | 29875 | RSS: Main: 193232896 07:44:29 INFO - PROCESS | 29875 | 07:44:32 INFO - PROCESS | 29875 | Cycle 1(1): loaded http://localhost:45423/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45423/tests/kraken/driver.html?testName=audio-fft) 07:44:33 INFO - PROCESS | 29875 | RSS: Main: 278695936 07:44:33 INFO - PROCESS | 29875 | 07:44:35 INFO - PROCESS | 29875 | Cycle 1(1): loaded http://localhost:45423/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45423/tests/kraken/driver.html?testName=audio-oscillator) 07:44:35 INFO - PROCESS | 29875 | RSS: Main: 186982400 07:44:35 INFO - PROCESS | 29875 | 07:44:37 INFO - PROCESS | 29875 | Cycle 1(1): loaded http://localhost:45423/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45423/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:44:38 INFO - PROCESS | 29875 | RSS: Main: 187535360 07:44:38 INFO - PROCESS | 29875 | 07:44:41 INFO - PROCESS | 29875 | Cycle 1(1): loaded http://localhost:45423/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45423/tests/kraken/driver.html?testName=imaging-darkroom) 07:44:42 INFO - PROCESS | 29875 | RSS: Main: 223072256 07:44:42 INFO - PROCESS | 29875 | 07:44:45 INFO - PROCESS | 29875 | Cycle 1(1): loaded http://localhost:45423/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45423/tests/kraken/driver.html?testName=imaging-desaturate) 07:44:46 INFO - PROCESS | 29875 | RSS: Main: 223236096 07:44:46 INFO - PROCESS | 29875 | 07:44:48 INFO - PROCESS | 29875 | Cycle 1(1): loaded http://localhost:45423/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45423/tests/kraken/driver.html?testName=json-parse-financial) 07:44:49 INFO - PROCESS | 29875 | RSS: Main: 222904320 07:44:49 INFO - PROCESS | 29875 | 07:44:51 INFO - PROCESS | 29875 | Cycle 1(1): loaded http://localhost:45423/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45423/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:44:51 INFO - PROCESS | 29875 | RSS: Main: 200536064 07:44:51 INFO - PROCESS | 29875 | 07:44:53 INFO - PROCESS | 29875 | Cycle 1(1): loaded http://localhost:45423/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45423/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:44:53 INFO - PROCESS | 29875 | RSS: Main: 201596928 07:44:53 INFO - PROCESS | 29875 | 07:44:55 INFO - PROCESS | 29875 | Cycle 1(1): loaded http://localhost:45423/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45423/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:44:56 INFO - PROCESS | 29875 | RSS: Main: 207060992 07:44:56 INFO - PROCESS | 29875 | 07:44:59 INFO - PROCESS | 29875 | Cycle 1(1): loaded http://localhost:45423/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:44:59 INFO - PROCESS | 29875 | RSS: Main: 212873216 07:44:59 INFO - PROCESS | 29875 | 07:45:02 INFO - PROCESS | 29875 | Cycle 1(1): loaded http://localhost:45423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:45:02 INFO - PROCESS | 29875 | RSS: Main: 213381120 07:45:02 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | Cycle 1(1): loaded http://localhost:45423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45423/tests/kraken/driver.html?testName=ai-astar) 07:45:04 INFO - PROCESS | 29875 | RSS: Main: 256475136 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | __start_tp_report 07:45:04 INFO - PROCESS | 29875 | _x_x_mozilla_page_load 07:45:04 INFO - PROCESS | 29875 | _x_x_mozilla_page_load_details 07:45:04 INFO - PROCESS | 29875 | |i|pagename|runs| 07:45:04 INFO - PROCESS | 29875 | |0;ai-astar;111;106;109;110;110;110;110;110;108;112 07:45:04 INFO - PROCESS | 29875 | |1;audio-beat-detection;146;123;126;180;130;127;151;127;158;130 07:45:04 INFO - PROCESS | 29875 | |2;audio-dft;161;161;161;159;160;160;161;162;161;161 07:45:04 INFO - PROCESS | 29875 | |3;audio-fft;76;74;78;123;75;74;75;76;102;75 07:45:04 INFO - PROCESS | 29875 | |4;audio-oscillator;85;85;110;84;84;83;115;84;84;122 07:45:04 INFO - PROCESS | 29875 | |5;imaging-gaussian-blur;117;117;118;117;116;118;117;117;117;117 07:45:04 INFO - PROCESS | 29875 | |6;imaging-darkroom;146;146;147;147;147;145;146;146;146;146 07:45:04 INFO - PROCESS | 29875 | |7;imaging-desaturate;95;95;94;95;95;95;94;95;95;95 07:45:04 INFO - PROCESS | 29875 | |8;json-parse-financial;51;50;50;51;56;54;50;50;51;50 07:45:04 INFO - PROCESS | 29875 | |9;json-stringify-tinderbox;61;61;61;61;60;61;60;61;60;60 07:45:04 INFO - PROCESS | 29875 | |10;stanford-crypto-aes;76;75;76;76;76;78;77;77;112;76 07:45:04 INFO - PROCESS | 29875 | |11;stanford-crypto-ccm;121;124;116;122;128;115;115;117;134;129 07:45:04 INFO - PROCESS | 29875 | |12;stanford-crypto-pbkdf2;155;154;155;156;156;158;159;153;157;154 07:45:04 INFO - PROCESS | 29875 | |13;stanford-crypto-sha256-iterative;60;61;62;61;62;61;62;60;61;59 07:45:04 INFO - PROCESS | 29875 | __end_tp_report 07:45:04 INFO - PROCESS | 29875 | __start_cc_report 07:45:04 INFO - PROCESS | 29875 | _x_x_mozilla_cycle_collect,1606 07:45:04 INFO - PROCESS | 29875 | __end_cc_report 07:45:04 INFO - PROCESS | 29875 | __startTimestamp1469025904870__endTimestamp 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | ------- Summary: start ------- 07:45:04 INFO - PROCESS | 29875 | Number of tests: 14 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.65 (1.5%) stddev-sans-first:1.67 07:45:04 INFO - PROCESS | 29875 | Values: 111.0 106.0 109.0 110.0 110.0 110.0 110.0 110.0 108.0 112.0 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:138.00 stddev:18.57 (13.5%) stddev-sans-first:19.56 07:45:04 INFO - PROCESS | 29875 | Values: 146.0 123.0 126.0 180.0 130.0 127.0 151.0 127.0 158.0 130.0 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 07:45:04 INFO - PROCESS | 29875 | Values: 161.0 161.0 161.0 159.0 160.0 160.0 161.0 162.0 161.0 161.0 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.00 stddev:16.46 (21.9%) stddev-sans-first:17.27 07:45:04 INFO - PROCESS | 29875 | Values: 76.0 74.0 78.0 123.0 75.0 74.0 75.0 76.0 102.0 75.0 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:84.00 stddev:15.50 (18.5%) stddev-sans-first:16.13 07:45:04 INFO - PROCESS | 29875 | Values: 85.0 85.0 110.0 84.0 84.0 83.0 115.0 84.0 84.0 122.0 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:45:04 INFO - PROCESS | 29875 | Values: 117.0 117.0 118.0 117.0 116.0 118.0 117.0 117.0 117.0 117.0 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:45:04 INFO - PROCESS | 29875 | Values: 146.0 146.0 147.0 147.0 147.0 145.0 146.0 146.0 146.0 146.0 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:45:04 INFO - PROCESS | 29875 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:2.06 (4.0%) stddev-sans-first:2.18 07:45:04 INFO - PROCESS | 29875 | Values: 51.0 50.0 50.0 51.0 56.0 54.0 50.0 50.0 51.0 50.0 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 07:45:04 INFO - PROCESS | 29875 | Values: 61.0 61.0 61.0 61.0 60.0 61.0 60.0 61.0 60.0 60.0 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:76.00 stddev:11.31 (14.9%) stddev-sans-first:11.91 07:45:04 INFO - PROCESS | 29875 | Values: 76.0 75.0 76.0 76.0 76.0 78.0 77.0 77.0 112.0 76.0 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:123.00 stddev:6.61 (5.4%) stddev-sans-first:7.00 07:45:04 INFO - PROCESS | 29875 | Values: 121.0 124.0 116.0 122.0 128.0 115.0 115.0 117.0 134.0 129.0 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:156.00 stddev:1.89 (1.2%) stddev-sans-first:1.99 07:45:04 INFO - PROCESS | 29875 | Values: 155.0 154.0 155.0 156.0 156.0 158.0 159.0 153.0 157.0 154.0 07:45:04 INFO - PROCESS | 29875 | 07:45:04 INFO - PROCESS | 29875 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:61.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 07:45:04 INFO - PROCESS | 29875 | Values: 60.0 61.0 62.0 61.0 62.0 61.0 62.0 60.0 61.0 59.0 07:45:04 INFO - PROCESS | 29875 | -------- Summary: end -------- 07:45:04 INFO - PROCESS | 29875 | 07:45:05 INFO - TEST-INFO | 29875: exit 0 07:45:05 INFO - TEST-OK | kraken | took 59915ms 07:45:05 INFO - SUITE-END | took 1171s 07:45:06 INFO - Completed test suite (00:19:32) 07:45:06 INFO - javascript benchmark 07:45:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3298.1919429739714, 3305.983470082649, 3311.9337613247735, 3336.4995250712404, 3350.396928552861, 5377.247185394048, 5419.187121931712, 5442.482964118407, 5445.292112025431, 5469.781208751645, 5454.400015998237, 5520.889582208353, 5529.0324193266115, 5529.917051244234, 5553.222548843165, 4782.258749893772, 4822.951770482286, 4960.950390496103, 4965.776540055688, 4999.150144475429, 4851.781669824866, 4875.70745755254, 4891.241857512091, 4934.407871055479, 4938.160512712848, 4894.5594896459315, 4972.0, 5004.949950500485, 5022.296878437021, 5037.042961837239, 5093.643444958854, 5095.949040509585, 5102.464241254671, 5107.923381149286, 5131.794728210848, 4796.688215265996, 4842.0, 4887.7311747853855, 5021.07110184617, 5030.471800460972, 5272.973635131838, 5305.257263983045, 5305.628605997582, 5343.839684809462, 5344.465553444663, 5814.47669709724, 5887.175795388649, 5888.087346461305, 5890.204822348971, 5892.204552385416, 5807.709614519299, 5850.5612079094235, 5861.267341582302, 5901.557383196277, 5911.349751527328, 5486.149646804752, 5517.089680202762, 5526.115821468546, 5530.2810634618045, 5532.30846144232, 5816.88366232673, 6015.368386319461, 6020.488258498077, 6029.577929544977, 6035.758569657252, 5633.718314084362, 5677.460641239159, 5685.147227915846, 5697.373288938214, 5711.143328500758, 5797.36229014808, 5807.245058142415, 5817.127430885401, 5822.0684690449325, 5824.184614154022, 5678.063119585222, 5678.233438485834, 5793.826185214366, 5803.303603567514, 5810.302763668386, 5718.428157184248, 5769.711514424346, 5770.769169233267, 5788.942110578924, 5798.971005144947, 4463.285874260103, 4475.641948644101, 4477.552244775561, 4482.8206871725415, 4501.774911254424, 3981.462502562117, 3982.203559288154, 4023.155137421116, 4023.8189281482405, 4064.207479541461, 5559.805406810742, 5589.74846131925, 5590.97204513983, 5593.580481463907, 5604.747786349542, 5856.560757943086, 5858.238429004202, 5864.677442740605, 5868.149118377897, 5899.852503687443, 5390.757415916293, 5496.1755736639825, 5522.282103326622, 5546.112621980464, 5583.804566840141, 4969.329140566049, 4991.051700176955, 4998.800047998112, 5004.524570165829, 5006.148954677641, 5863.560232982543, 5935.851603709942, 5937.940620593825, 5943.970280148658, 5962.791302304398, 5701.572382071278, 5724.856878578069, 5733.0540460823495, 5734.885302294014, 5848.883022339614, 5867.618604790675, 5875.882482350415, 5877.147813567094, 5879.529637628894, 5882.735276912635, 5679.517241034393, 5687.744051517774, 5688.77244910199, 5688.829335119953, 5694.629849059798, 5652.886942261214, 5742.3109226891365, 5778.913316300175, 5789.536837052941, 5821.592488525763, 5703.600747947604, 5708.771649133988, 5709.0, 5709.486146246858, 5713.371529131875, 5519.31008623922, 5674.77300907959, 5679.886402271849, 5679.977604031314, 5683.60214784961, 5555.777768889199, 5586.832395028156, 5614.7192640367, 5654.745536450787, 5655.604107712586, 5728.312602487728, 5768.3078030634915, 5804.912926306024, 5816.389279125631, 5817.738201780845, 5461.399246083007, 5556.083246264321, 5680.40355762639, 5680.829575112753, 5696.629719068247], "value": 5371.8365276922805, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.3845197124919, 648.8604949935764, 652.8792173447913, 655.243194110802, 665.3147258323928, 32444.513332300005, 35107.82446087766, 35135.64864351356, 35149.824250878744, 35158.0, 36291.81854090733, 46825.0, 47897.52102478983, 47924.520754792444, 51861.74069129658, 9057.864132038041, 9176.0, 9176.908230917672, 9186.632534698603, 9186.908130918706, 8210.83578328433, 9029.23251523618, 9123.315751318678, 9136.177744003038, 9136.6802161924, 10709.036186743191, 10962.068224200952, 10969.561217551329, 11350.886491135065, 11368.261063030877, 10717.83923241152, 10719.19606029551, 10784.676459706221, 10853.837192442119, 10866.782664346709, 8295.170482951717, 10617.0, 10725.410102444363, 10804.891951080546, 10979.725506862313, 41327.1734565307, 45130.77434612839, 45257.773711131566, 45289.320660190126, 45361.77319113416, 3831.7892515911612, 3915.745476544044, 3918.8432462701458, 3980.44273801668, 4110.445089912883, 35577.64422355769, 35777.82111089428, 36033.63966360355, 36236.275274494365, 37245.627543724484, 4729.763511824395, 4769.594584460325, 4786.138495070886, 4850.054239423313, 4896.828610998634, 419081.0, 425297.0, 425960.0, 426207.0, 427948.0, 70716.64641676862, 70767.64616176886, 70941.64529177321, 71033.64483177551, 71484.0, 76787.61606191934, 76939.0, 77267.61366193133, 77378.0, 77408.0, 19654.410367688994, 20303.796962030487, 20312.0, 20327.491812704506, 20339.593208135753, 15429.845701542841, 15605.297761600756, 15657.217139142997, 15666.138362390178, 15669.843301567067, 19098.0, 21302.467438313855, 21596.0, 21848.453788655093, 21965.0, 7377.446691498052, 7454.658161530977, 7615.466917315845, 7700.807479812937, 7870.842583148419, 1010.2271762101998, 1034.9534270957674, 1051.8001579699833, 1063.9627613033506, 1120.2326406411635, 34597.481037784455, 34829.82585087109, 34955.0, 34980.0, 35079.0, 1144.0, 1156.034711016294, 1160.9013233875214, 1219.0978675779859, 1238.7646347194004, 18060.819391806177, 18306.816931830777, 18344.266229350942, 18345.633087338178, 18426.355077572487, 634367.0, 635753.0, 638415.0, 641428.0, 641546.0, 65346.0, 65794.34205657979, 65882.0, 65976.34023659799, 65998.34001659922, 1382.4539306973688, 1408.0847449157925, 1410.4569740649924, 1450.3400952566558, 1452.4262916148061, 31479.0, 35533.38066051397, 35540.82229588939, 35824.10439739027, 36005.27989440249, 55492.0, 60684.696576516835, 61311.0, 61439.692801535704, 67668.66165669337, 541675.0, 542124.0, 545370.0, 548608.0, 549444.0, 27283.0, 29918.102456926328, 30343.696563034086, 31613.52579711352, 32128.0, 51647.483525164265, 52091.73954130205, 52520.21219681631, 52688.73655631697, 53652.73173634263, 41986.37020444757, 43205.56794432141, 44203.778981104886, 44379.33430998473, 44503.0, 41895.7905210472, 42246.57753422549, 42843.14313713646, 42920.141597168506, 44100.55899440964, 43694.0, 44864.32703509385, 45180.77409612931, 45254.32118518159, 45407.772961134986, 36964.6303536972, 37309.0, 37535.43696844495, 37973.240535189696, 38408.42387364136, 29966.400671986874, 30021.69978300189, 30153.246168845955, 30205.69794302029, 30434.239144021576], "value": 22242.10447726082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.08900419078014, 418.32649434410604, 423.60181429456287, 426.7972712961343, 435.7363794904083, 18601.441956741302, 19169.808301916975, 20252.797472025275, 20421.08105135269, 20451.693224601644, 17811.910940445312, 17886.37397691081, 17893.552661183476, 17908.37320693776, 19430.902845485787, 5483.8080667176655, 5645.294338207724, 5856.121581762727, 5866.472017518422, 5869.442402971711, 5504.284443022401, 5682.636167319854, 5747.080467125261, 5758.251427314443, 5758.280214973129, 5646.040173170551, 5650.378458369576, 5686.971565142168, 5688.288963879515, 5688.488036076752, 5463.453654634544, 5650.237217975582, 5658.830235092933, 5665.150227465892, 5705.144228365778, 5113.872153196163, 5153.871153221199, 5154.92267615986, 5155.871103222412, 5167.147420675622, 21773.34679959604, 22397.66403503949, 22535.323940281818, 22707.0, 22771.31686049421, 2351.905923763047, 2358.563665721847, 2421.285720712394, 2443.230382429529, 2500.3999040230215, 13914.93042534791, 14587.562373128823, 14873.925630371887, 14901.403943842233, 14988.400463981428, 2017.1729590867674, 2029.0, 2033.1562401603464, 2052.7126202331688, 2062.958206105907, 74670.62664686696, 79244.60377698133, 79290.20709792885, 79443.60278198573, 79597.0, 11250.606228782117, 11633.302001879914, 11734.589289374831, 11839.0, 11937.701557461132, 16736.16319184036, 16835.579110522336, 16837.242324095445, 16882.74675879863, 16885.24016419264, 8884.244839188741, 8951.955240223757, 9003.729888103368, 9130.81738365229, 9141.81716365669, 8686.174813392718, 8727.996280427706, 8730.519821409756, 8785.560721963877, 8968.148025937526, 5010.448850626428, 5028.0, 5067.265246539231, 5069.493050694975, 5107.846764597068, 1884.5288677830542, 1906.1993962535769, 1911.149538455374, 2044.5483706568207, 2054.4042227754085, 756.1417790807474, 923.3951761596165, 966.0100193601064, 1101.542859713226, 1107.0921844087932, 18509.167087481095, 18921.243150273836, 19006.61986760257, 19249.13378897953, 19333.51666208356, 1010.3281317923645, 1020.882598501167, 1026.1790567545934, 1042.3224903812431, 1053.6312290698195, 10542.0, 10570.048695617432, 10881.0, 11011.00900918921, 11061.17291444718, 544012.0, 544676.0, 549065.0, 549131.0173796501, 549217.0, 63188.0, 98516.0, 102539.9999999985, 108335.0, 109680.4515977415, 1104.5250542266742, 1116.821308590638, 1126.5606413498742, 1126.881677423875, 1143.056977993159, 17479.213435395184, 17595.912020439817, 17612.383566575107, 17759.467215983543, 17978.640427191644, 42301.36547951722, 43398.78300608477, 44043.779781100886, 44970.325445119, 46051.07897841957, 62762.372376275656, 62922.0, 63160.0, 64781.35218647942, 64866.67566662136, 6336.461400780985, 8255.133211012997, 8335.083140854622, 8523.573821309034, 8529.061803201766, 12348.444320005441, 12805.295708735735, 12850.228986260854, 13014.609561713163, 13213.801792972921, 11446.313221206754, 11468.598599048993, 11479.540818367506, 11530.423478825858, 11779.705507362385, 10989.890101098887, 11399.601013964471, 11459.885401145882, 11527.0, 11760.470778814803, 11298.209125361474, 11770.470328835394, 11790.351530665552, 11898.583549575724, 12016.879831201577, 7225.421966242583, 7919.524828510308, 8491.235788778793, 8651.95674021626, 8752.124787521198, 11848.407579620813, 11886.16796824214, 11972.221805582609, 12080.818787718015, 12146.514139434325], "value": 9492.607001549379, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.5785306554974, 1484.480431848853, 1522.2617030740091, 1698.9830101698988, 1828.9542761430962, 8325.458845175068, 8667.263282620977, 8725.432846864956, 8937.597808098635, 8946.418482798614, 8673.566321683922, 8876.112388761137, 8881.0, 8881.60032798524, 8881.91118088819, 2017.4452025692906, 2295.735990361113, 2368.3723813189517, 2411.2284069097896, 2436.5248776488593, 2387.128698025217, 2395.4490467192554, 2395.772401621843, 2401.0635852017726, 2401.7238017628024, 2369.6800931874236, 2378.9048438062455, 2406.614941609343, 2406.7232268289195, 2415.7825795678386, 2050.0569737920573, 2110.7150534677776, 2116.185268671557, 2276.066812606823, 2345.8592484450987, 2361.9055237790467, 2402.315340128055, 2403.086827005744, 2405.7971014492755, 2410.0, 8723.345749068782, 8769.254613357873, 8769.429987050886, 8776.780580485474, 8785.428947118417, 5168.2764412982215, 5314.1497360422145, 5315.760790764425, 5317.41508434072, 5317.867053323659, 3447.896563103111, 3504.9474257886154, 3550.5384300041087, 3616.2405894762132, 3623.836927338276, 1202.3327053485311, 1216.1183142221907, 1217.9878201218053, 1243.8507379114565, 1249.450241893564, 11917.0, 11938.164328497009, 11954.581589644407, 11959.162858599902, 11960.34218118003, 4694.6009589185305, 4759.190937540627, 4831.613470922318, 4836.492168322346, 4849.684770489906, 10146.492675366202, 10185.0, 10202.285839991278, 10208.336458130198, 10212.387256764618, 5114.053900028507, 5135.743212839343, 5141.562967147759, 5142.202958541432, 5149.948500515022, 4427.335899615019, 4805.207140821725, 4879.56083952446, 4944.90110197794, 4986.476419975923, 4133.689973252018, 4142.565030671736, 4178.289690752579, 4187.0, 4219.641330486882, 1288.400893584469, 1320.8877245434053, 1337.5786627212397, 1342.6039318401095, 1343.6372179511477, 909.3270979475141, 994.2344394815951, 995.4475266227313, 1011.2466212671607, 1017.1455976979373, 5849.941500585025, 5958.6722730249385, 6037.094435834572, 6076.058210977306, 6131.570790044654, 475.8382150068993, 491.3734987890397, 494.4486897109697, 499.997505002475, 510.1658787881766, 4182.665386769051, 4231.492220933507, 4233.894152646147, 4250.298700714409, 4269.423627810268, 10404.895951040544, 10545.156387489136, 10738.78522429547, 10742.892571074346, 10794.0, 10503.159747220205, 10571.62999295021, 10578.471076446147, 10593.258471906893, 10631.255812093234, 7788.805279868048, 7851.05787305527, 7856.332211762065, 7870.44906856526, 8147.103818579952, 5845.912311315419, 5879.617824841372, 5904.586678932434, 5962.880742385041, 5976.701164941823, 9722.31943763958, 10007.849882251918, 10247.795044099226, 10259.076683098558, 10386.74033149147, 10094.0, 10470.11004064663, 10496.265261431932, 10504.947475262576, 10508.947455262674, 6947.3747362737595, 7685.846283074419, 7801.648925798239, 7933.444658874054, 8099.554524501209, 8809.339299552686, 8822.735317940473, 8841.248493877834, 8891.333150013905, 8893.510856902674, 7445.478816482794, 7670.386369090571, 7687.500312479671, 7809.180036096128, 8085.393595480245, 7580.886286705814, 7611.847763044819, 7634.618269086634, 7670.156282808775, 7804.6878124874365, 7246.0, 7273.0, 7302.3792977597495, 7317.414606831547, 7317.780466586011, 4969.254611808257, 4985.8005679772405, 5051.217061355495, 5167.354080739908, 5224.660397074178, 5320.441353657965, 5345.65253258537, 5347.839564813062, 5369.704666243238, 5474.835754927359], "value": 4604.737437026565, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.1844870842083, 344.9827508624569, 351.1554710920238, 352.3850880214025, 353.0098074899906, 5280.630355875091, 5355.732213389334, 5397.892042159155, 5423.728813559321, 5442.292501974747, 5332.893342133165, 5341.145416733323, 5354.625176237665, 5368.248445217663, 5374.0, 4009.4386785850006, 4231.196072746184, 4252.808623611945, 4264.083222107246, 4283.721558098714, 3853.903652408684, 4072.60509547808, 4175.0, 4202.831886724527, 4218.240716670998, 4153.231652144348, 4154.649738834875, 4161.979190104045, 4168.978600242945, 4182.05903671673, 4004.0, 4160.084781348099, 4168.97915510422, 4174.24863524567, 4188.518320393133, 3601.873934412283, 3715.9442608360896, 3731.6641502264924, 3737.6449237322413, 3752.43713442983, 5090.669106508065, 5114.923276150861, 5115.2327150927285, 5167.48325167484, 5219.660722053054, 4670.789814458358, 4815.5906747926465, 4818.277258411232, 4852.56326930578, 4864.635152363587, 5483.928999760147, 5570.0, 5576.302962129734, 5579.776808927638, 5582.720863956826, 4120.269486815545, 4123.649489793341, 4128.401381799652, 4129.566395528486, 4154.709170358076, 5496.4503549645515, 5840.269966254218, 5851.736671849777, 5864.1203819427, 5870.706464676749, 4125.257453658311, 4149.419081328617, 4155.958440415618, 4168.687348448879, 4175.55729898013, 4210.115875666083, 4214.852480163179, 4216.451861258017, 4221.155768846243, 4227.915441691149, 4811.735354555463, 4822.565969062801, 4822.68652537584, 4836.12949669063, 4844.0, 5459.153831156177, 5573.5819813513335, 5586.608937374344, 5602.0, 5612.775488980476, 1424.2380326525467, 1449.521657852906, 1452.4771082410323, 1454.978175327371, 1462.7732701431296, 898.9730308090768, 931.5156118818177, 944.5702205496483, 954.3176628710505, 958.1376760915232, 4979.203327467588, 4981.203007518852, 5291.550218231493, 5369.221462887859, 5574.0, 5789.2763404574425, 5792.0, 5801.026296986578, 5801.88396232073, 5803.47768700819, 5465.6335916021, 5495.148252020943, 5534.75093620788, 5542.501174894279, 5576.97211513948, 2913.606663100454, 3050.1916991997136, 3081.6147981502313, 3097.659257481675, 3111.766617503651, 5885.382034886361, 5890.0, 5915.497182739429, 5959.612625179349, 5981.79063732776, 5641.52047075995, 5951.166836642873, 5953.732082056318, 5960.552958528127, 5960.821175364746, 5923.933691935406, 5943.157621137461, 5943.227380440601, 5952.9107063394085, 5956.672383018976, 5644.717764111861, 5853.94146058551, 5880.735366908414, 5889.705514724333, 5917.497012753792, 5697.971510142423, 5734.541236701138, 5750.8849823002465, 5767.192593037062, 5790.131480277992, 5905.645661260338, 5960.642361458326, 5971.104334349882, 5972.0, 5998.940010599838, 4036.766233637656, 4131.752094874317, 4161.313383291723, 4176.91646167081, 4195.286801243735, 5822.388649191774, 5846.824595262149, 5857.736401862012, 5864.970675146597, 5910.704464776658, 5648.689322087324, 5703.971480142573, 5708.400617935223, 5771.422857714195, 5783.884322313446, 5530.336359636869, 5574.219609254626, 5579.860503487445, 5579.879645734757, 5584.246126772996, 5505.642133261325, 5537.784886045614, 5540.667559946416, 5549.056660367828, 5562.610617256753, 5464.781408743765, 5547.583931205257, 5702.0, 5714.3999880012, 5733.913991290217, 5556.722163891708, 5567.972160139173, 5571.721413929368, 5588.77644894216, 5596.692181930033], "value": 4304.762555232466, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.8704400817871, 848.5248260973851, 853.117023880284, 856.9442986205897, 883.4257732473893, 14260.57218283452, 14291.428342866298, 14320.21238831865, 14340.856591434083, 14357.353919073641, 14336.56990290293, 14381.78427323591, 14386.712265754679, 14388.280585970711, 14392.0, 722.3967986731086, 831.9459235149695, 852.654674856684, 856.7130011446142, 864.6022829498438, 863.5595846118493, 865.8051938313891, 868.7089824908663, 869.6608322754131, 870.9346798990069, 916.6883259691704, 918.6279556779515, 919.2278486071698, 920.3419555018161, 920.3695468603994, 763.2253262938123, 900.2527901841456, 919.1865199298602, 920.2821798996794, 921.6774129054844, 674.4435840431663, 674.8380388706724, 675.2167485716594, 675.2336098528157, 675.4427597232254, 16147.111908845009, 16174.676506469923, 16184.83815161857, 16189.83810161895, 16286.918565407215, 15224.543263701997, 15420.768688469681, 15468.381264749396, 15619.375224990987, 15884.444044458503, 13339.0, 13713.931430342784, 13797.931010344984, 14099.295035248197, 14194.077384970047, 4508.504064552896, 4510.729356238636, 4532.864014079583, 4561.384213131251, 4562.110388474249, 77251.61374193092, 78514.60742696308, 78869.0, 79195.0, 79417.20582794157, 12002.699932501582, 12024.939875300568, 12027.09796765246, 12157.027437804954, 12221.144519883701, 23244.883775581013, 23291.534169316517, 23326.7667323328, 23413.297601071994, 23436.0, 8752.256058235122, 8914.643414263357, 8972.596233169523, 9143.405678630868, 9305.25557955362, 5083.974580127149, 5137.51193636604, 5194.168932970707, 5229.267902493654, 5299.708516031578, 3563.429851223792, 3642.0348607619003, 3647.452882067711, 3659.6340365963724, 3670.100825297766, 611.6941529235382, 613.9693015349214, 626.7586979013113, 628.0892705576932, 630.5554584018348, 627.541894417069, 635.4154178156108, 646.15676542113, 657.0472814419112, 665.9966700166565, 9355.111264429868, 10013.79972400548, 10127.088562029452, 10168.170897993614, 10538.743923008296, 627.626562195493, 707.7133760826873, 709.2623671381808, 747.4767662636176, 781.5268219406346, 4490.865274041784, 4572.908541829145, 4647.140279048387, 4656.0, 4718.504557021463, 111757.88242117474, 119128.40435797766, 119852.40073799575, 119898.0, 120045.0, 85285.0, 101671.0, 101975.49012254892, 102524.92425227255, 103827.0, 62497.68751156215, 73756.63121684357, 86467.56766216255, 86786.56606716926, 87575.56212218897, 9646.42121472714, 10133.797324053625, 10284.074433301039, 10339.741506462098, 10390.740231494274, 54482.455175447736, 54603.72698136484, 54710.452895472125, 56317.71841140768, 56591.71704141453, 71183.0, 78333.60833195798, 78647.60676196583, 78688.60655696684, 79462.20537794779, 14060.156390616596, 14072.279527460643, 14087.577372678836, 14241.786373204617, 14265.500707475188, 13284.802562741887, 13538.93230533841, 13935.0, 14096.0, 14509.347079381241, 13629.0, 13809.0, 13976.301184940916, 14697.779533306795, 14817.925910370379, 13070.085094043327, 13074.0, 13623.523176689165, 13786.862131378557, 14559.19924404168, 13287.80068298957, 13502.594922152352, 13795.2412617303, 13866.514671986431, 13949.790753138508, 11026.173037022096, 11113.333200008025, 11165.97902911857, 11254.21220514556, 11362.94318528402, 11436.485358158736, 11485.82771258415, 12017.699557511132, 12041.397930103285, 12090.0], "value": 7835.380990570798, "unit": "score"}], "name": "dromaeo_css", "value": 7487.287538592293, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 108.0, 112.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 126.0, 180.0, 130.0, 127.0, 151.0, 127.0, 158.0, 130.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 159.0, 160.0, 160.0, 161.0, 162.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 78.0, 123.0, 75.0, 74.0, 75.0, 76.0, 102.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 110.0, 84.0, 84.0, 83.0, 115.0, 84.0, 84.0, 122.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 51.0, 56.0, 54.0, 50.0, 50.0, 51.0, 50.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0, 60.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 76.0, 76.0, 78.0, 77.0, 77.0, 112.0, 76.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 124.0, 116.0, 122.0, 128.0, 115.0, 115.0, 117.0, 134.0, 129.0], "value": 122.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 155.0, 156.0, 156.0, 158.0, 159.0, 153.0, 157.0, 154.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 61.0, 62.0, 61.0, 62.0, 60.0, 61.0, 59.0], "value": 60.9, "unit": "score"}], "name": "kraken", "value": 1475.1, "alertThreshold": 2.0}]} 07:45:06 INFO - Return code: 0 07:45:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:45:06 ERROR - # TBPL SUCCESS # 07:45:06 INFO - Running post-action listener: _resource_record_post_action 07:45:06 INFO - ##### 07:45:06 INFO - ##### Finished run-tests step (success) 07:45:06 INFO - ##### 07:45:06 INFO - Running post-run listener: _resource_record_post_run 07:45:06 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 2887680; Write bytes: 508637184; Read time: 944; Write time: 384224 07:45:06 INFO - TinderboxPrint: CPU usage
13.0% 07:45:06 INFO - TinderboxPrint: I/O read bytes / time
2,887,680 / 944 07:45:06 INFO - TinderboxPrint: I/O write bytes / time
508,637,184 / 384,224 07:45:06 INFO - TinderboxPrint: CPU idle
8,252.3 (87.0%) 07:45:06 INFO - TinderboxPrint: CPU user
1,194.7 (12.6%) 07:45:06 INFO - TinderboxPrint: Swap in / out
0 / 0 07:45:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 252731392; Read time: 0; Write time: 218288 07:45:06 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 2863104; Write bytes: 255905792; Read time: 924; Write time: 165936 07:45:06 INFO - Running post-run listener: _upload_blobber_files 07:45:06 INFO - Blob upload gear active. 07:45:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:45:06 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 07:45:06 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'] 07:45:06 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 07:45:07 INFO - (blobuploader) - INFO - Open directory for files ... 07:45:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:45:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:45:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:21 INFO - (blobuploader) - INFO - Done attempting. 07:45:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:45:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:45:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:22 INFO - (blobuploader) - INFO - Done attempting. 07:45:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:45:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:45:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:23 INFO - (blobuploader) - INFO - Done attempting. 07:45:23 INFO - (blobuploader) - INFO - Iteration through files over. 07:45:23 INFO - Return code: 0 07:45:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:45:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:45:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/992c47975c697652c222182163cb548f9ee701b0b5c3d33c0f202ff1ecc61c355f6c6a090ad56b3b2d6a339405cedb5d77a856584ef84db85de4b95a505772b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a082892ee7971610e8f36d061457b7b6fb616d5c73f4945511a3dfa4f07557233005a33f7fc11f41692a0228076dbc424ef991e82517f7b674534e5af31c306d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b07f6fa2727a8891cd5583aabc78859478306074c53aea023bfaef334cfd5921bb930cf941a956d4ce767525ecd91680484afdcc56e559f29d6d85b7056b8be5"} 07:45:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:45:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:45:23 INFO - Contents: 07:45:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/992c47975c697652c222182163cb548f9ee701b0b5c3d33c0f202ff1ecc61c355f6c6a090ad56b3b2d6a339405cedb5d77a856584ef84db85de4b95a505772b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a082892ee7971610e8f36d061457b7b6fb616d5c73f4945511a3dfa4f07557233005a33f7fc11f41692a0228076dbc424ef991e82517f7b674534e5af31c306d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b07f6fa2727a8891cd5583aabc78859478306074c53aea023bfaef334cfd5921bb930cf941a956d4ce767525ecd91680484afdcc56e559f29d6d85b7056b8be5"} 07:45:23 INFO - Running post-run listener: copy_logs_to_upload_dir 07:45:23 INFO - Copying logs to upload dir... 07:45:23 INFO - mkdir: /builds/slave/test/build/upload/logs 07:45:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.968247 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-20 07:45:22.282496) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 07:45:22.285829) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/992c47975c697652c222182163cb548f9ee701b0b5c3d33c0f202ff1ecc61c355f6c6a090ad56b3b2d6a339405cedb5d77a856584ef84db85de4b95a505772b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a082892ee7971610e8f36d061457b7b6fb616d5c73f4945511a3dfa4f07557233005a33f7fc11f41692a0228076dbc424ef991e82517f7b674534e5af31c306d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b07f6fa2727a8891cd5583aabc78859478306074c53aea023bfaef334cfd5921bb930cf941a956d4ce767525ecd91680484afdcc56e559f29d6d85b7056b8be5"} build_url:https://queue.taskcluster.net/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/H7HMVwKvQGGvyfFnpsMy_A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/992c47975c697652c222182163cb548f9ee701b0b5c3d33c0f202ff1ecc61c355f6c6a090ad56b3b2d6a339405cedb5d77a856584ef84db85de4b95a505772b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a082892ee7971610e8f36d061457b7b6fb616d5c73f4945511a3dfa4f07557233005a33f7fc11f41692a0228076dbc424ef991e82517f7b674534e5af31c306d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b07f6fa2727a8891cd5583aabc78859478306074c53aea023bfaef334cfd5921bb930cf941a956d4ce767525ecd91680484afdcc56e559f29d6d85b7056b8be5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 07:45:22.311565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:45:22.311902) ========= 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=3a3620fb28aea1604ab609ef000001d2-1469024680.250755-1494320447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004711 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 07:45:22.395748) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 07:45:22.396247) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 07:45:22.396820) ========= ========= Total master_lag: 0.15 =========