builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1466066544.39 results: success (0) buildid: 20160616000726 builduid: 6ec867bba8354a8baeab27087efa5a18 revision: 6b40db1565705c392042da04396d1ca83c0d017d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 01:42:24.392245) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 01:42:24.392731) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 01:42:24.393005) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 01:42:24.407583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:42:24.407913) ========= 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=ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 01:42:25-- 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% 43.3M=0s 2016-06-16 01:42:25 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108779 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:42:24.531013) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:42:24.531339) ========= 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=ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018439 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:42:24.580395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 01:42:24.580760) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6b40db1565705c392042da04396d1ca83c0d017d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6b40db1565705c392042da04396d1ca83c0d017d --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=ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 01:42:25,780 truncating revision to first 12 chars 2016-06-16 01:42:25,780 Setting DEBUG logging. 2016-06-16 01:42:25,780 attempt 1/10 2016-06-16 01:42:25,780 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6b40db156570?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 01:42:27,020 unpacking tar archive at: mozilla-central-6b40db156570/testing/mozharness/ program finished with exit code 0 elapsedTime=1.612177 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 01:42:26.206315) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 01:42:26.206652) ========= script_repo_revision: 6b40db1565705c392042da04396d1ca83c0d017d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 01:42:26.207053) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 01:42:26.207321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 01:42:26.215365) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-06-16 01:42:26.215720) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:42:27 INFO - MultiFileLogger online at 20160616 01:42:27 in /builds/slave/test 01:42:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 01:42:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:42:27 INFO - {'append_to_log': False, 01:42:27 INFO - 'base_work_dir': '/builds/slave/test', 01:42:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 01:42:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:42:27 INFO - 'branch': 'Firefox-Non-PGO', 01:42:27 INFO - 'buildbot_json_path': 'buildprops.json', 01:42:27 INFO - 'config_files': ('talos/linux_config.py',), 01:42:27 INFO - 'default_actions': ('clobber', 01:42:27 INFO - 'read-buildbot-config', 01:42:27 INFO - 'download-and-extract', 01:42:27 INFO - 'populate-webroot', 01:42:27 INFO - 'create-virtualenv', 01:42:27 INFO - 'install', 01:42:27 INFO - 'run-tests'), 01:42:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:42:27 INFO - 'download_minidump_stackwalk': True, 01:42:27 INFO - 'download_symbols': 'ondemand', 01:42:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:42:27 INFO - 'tooltool.py': '/tools/tooltool.py', 01:42:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:42:27 INFO - '/tools/misc-python/virtualenv.py')}, 01:42:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:42:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:42:27 INFO - 'installer_path': 'installer.exe', 01:42:27 INFO - 'log_level': 'info', 01:42:27 INFO - 'log_name': 'talos', 01:42:27 INFO - 'log_to_console': True, 01:42:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:42:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:42:27 INFO - 'opt_config_files': (), 01:42:27 INFO - 'pip_index': False, 01:42:27 INFO - 'sps_profile': False, 01:42:27 INFO - 'sps_profile_interval': 0, 01:42:27 INFO - 'suite': 'dromaeojs', 01:42:27 INFO - 'system_bits': '32', 01:42:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:42:27 INFO - 'title': 'talos-linux64-ix-035', 01:42:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:42:27 INFO - 'use_talos_json': True, 01:42:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:42:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:42:27 INFO - 'work_dir': 'build'} 01:42:27 INFO - ##### 01:42:27 INFO - ##### Running clobber step. 01:42:27 INFO - ##### 01:42:27 INFO - Running pre-action listener: _resource_record_pre_action 01:42:27 INFO - Running main action method: clobber 01:42:27 INFO - rmtree: /builds/slave/test/build 01:42:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:42:27 INFO - Running post-action listener: _resource_record_post_action 01:42:27 INFO - ##### 01:42:27 INFO - ##### Finished clobber step (success) 01:42:27 INFO - ##### 01:42:27 INFO - ##### 01:42:27 INFO - ##### Running read-buildbot-config step. 01:42:27 INFO - ##### 01:42:27 INFO - Running pre-action listener: _resource_record_pre_action 01:42:27 INFO - Running main action method: read_buildbot_config 01:42:27 INFO - Using buildbot properties: 01:42:27 INFO - { 01:42:27 INFO - "project": "", 01:42:27 INFO - "product": "firefox", 01:42:27 INFO - "script_repo_revision": "production", 01:42:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:42:27 INFO - "repository": "", 01:42:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 01:42:27 INFO - "buildid": "20160616000726", 01:42:27 INFO - "pgo_build": "False", 01:42:27 INFO - "basedir": "/builds/slave/test", 01:42:27 INFO - "buildnumber": 117, 01:42:27 INFO - "slavename": "talos-linux64-ix-035", 01:42:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:42:27 INFO - "platform": "ubuntu64_hw", 01:42:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 01:42:27 INFO - "branch": "mozilla-central", 01:42:27 INFO - "repo_path": "mozilla-central", 01:42:27 INFO - "revision": "6b40db1565705c392042da04396d1ca83c0d017d", 01:42:27 INFO - "stage_platform": "linux64", 01:42:27 INFO - "builduid": "6ec867bba8354a8baeab27087efa5a18", 01:42:27 INFO - "slavebuilddir": "test" 01:42:27 INFO - } 01:42:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:42:27 INFO - Running post-action listener: _resource_record_post_action 01:42:27 INFO - ##### 01:42:27 INFO - ##### Finished read-buildbot-config step (success) 01:42:27 INFO - ##### 01:42:27 INFO - ##### 01:42:27 INFO - ##### Running download-and-extract step. 01:42:27 INFO - ##### 01:42:27 INFO - Running pre-action listener: _resource_record_pre_action 01:42:27 INFO - Running main action method: download_and_extract 01:42:27 INFO - mkdir: /builds/slave/test/build/tests 01:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:27 INFO - https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:42:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:42:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:42:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:42:27 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:42:27 INFO - Running command: ['nslookup', 'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 01:42:27 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 01:42:28 INFO - Server: 10.26.75.40 01:42:28 INFO - Address: 10.26.75.40#53 01:42:28 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 01:42:28 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 01:42:28 INFO - Address: 10.26.48.46 01:42:28 INFO - Return code: 0 01:42:28 INFO - retry: attempt #1 caught exception: 01:42:28 INFO - retry: Failed, sleeping 30 seconds before retrying 01:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #2 01:42:58 INFO - Downloaded 1361 bytes. 01:42:58 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:42:58 INFO - Using the following test package requirements: 01:42:58 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:42:58 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:42:58 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:42:58 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:58 INFO - u'jsshell-linux-x86_64.zip'], 01:42:58 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:42:58 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:42:58 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:42:58 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:42:58 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:42:58 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:42:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:42:58 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:42:58 INFO - https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:42:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:42:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:42:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:42:59 INFO - Downloaded 22654279 bytes. 01:42:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:42:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:43:00 INFO - Return code: 0 01:43:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:00 INFO - https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:43:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:43:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:43:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:43:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:43:02 INFO - Downloaded 22654279 bytes. 01:43:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:43:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:43:03 INFO - Return code: 0 01:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:03 INFO - https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:43:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:43:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:43:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:43:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:43:04 INFO - Downloaded 14405384 bytes. 01:43:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:43:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:43:05 INFO - Return code: 0 01:43: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')]} 01:43:05 INFO - https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:43:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:43:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:43:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:43:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:43:06 INFO - Downloaded 55449102 bytes. 01:43:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:43:06 INFO - mkdir: /builds/slave/test/properties 01:43:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:43:06 INFO - Writing to file /builds/slave/test/properties/build_url 01:43:06 INFO - Contents: 01:43:06 INFO - build_url:https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:43:07 INFO - Running post-action listener: _resource_record_post_action 01:43:07 INFO - Running post-action listener: set_extra_try_arguments 01:43:07 INFO - ##### 01:43:07 INFO - ##### Finished download-and-extract step (success) 01:43:07 INFO - ##### 01:43:07 INFO - ##### 01:43:07 INFO - ##### Running populate-webroot step. 01:43:07 INFO - ##### 01:43:07 INFO - Running pre-action listener: _resource_record_pre_action 01:43:07 INFO - Running main action method: populate_webroot 01:43:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:43:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:43:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:43:07 INFO - '--tppagecycles', 01:43:07 INFO - '7'], 01:43:07 INFO - 'tests': ['tsvgm']}}, 01:43:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:43:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:43:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:43:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:43:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:43:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:43:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:43:07 INFO - 'talos_options': ['--disable-e10s'], 01:43:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:43:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:43:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:43:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:43:07 INFO - 'talos_options': ['--disable-e10s'], 01:43:07 INFO - 'tests': ['damp', 'tps']}, 01:43:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:43:07 INFO - 'tests': ['damp', 'tps']}, 01:43:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:43:07 INFO - 'tests': ['dromaeo_dom']}, 01:43:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:43:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:43:07 INFO - 'tests': ['basic_compositor_video']}, 01:43:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:43:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:43:07 INFO - 'tests': ['a11yr', 01:43:07 INFO - 'ts_paint', 01:43:07 INFO - 'tpaint', 01:43:07 INFO - 'sessionrestore', 01:43:07 INFO - 'sessionrestore_no_auto_restore', 01:43:07 INFO - 'tabpaint']}, 01:43:07 INFO - 'other-e10s': {'tests': ['a11yr', 01:43:07 INFO - 'ts_paint', 01:43:07 INFO - 'tpaint', 01:43:07 INFO - 'sessionrestore', 01:43:07 INFO - 'sessionrestore_no_auto_restore', 01:43:07 INFO - 'tabpaint']}, 01:43:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:43:07 INFO - 'ts_paint', 01:43:07 INFO - 'tpaint', 01:43:07 INFO - 'sessionrestore', 01:43:07 INFO - 'sessionrestore_no_auto_restore', 01:43:07 INFO - 'tabpaint']}, 01:43:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:43:07 INFO - 'ts_paint', 01:43:07 INFO - 'tpaint', 01:43:07 INFO - 'sessionrestore', 01:43:07 INFO - 'sessionrestore_no_auto_restore', 01:43:07 INFO - 'tabpaint']}, 01:43:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:43:07 INFO - 'tests': ['a11yr', 01:43:07 INFO - 'ts_paint', 01:43:07 INFO - 'tpaint', 01:43:07 INFO - 'sessionrestore', 01:43:07 INFO - 'sessionrestore_no_auto_restore', 01:43:07 INFO - 'tabpaint']}, 01:43:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:43:07 INFO - 'tests': ['a11yr', 01:43:07 INFO - 'ts_paint', 01:43:07 INFO - 'tpaint', 01:43:07 INFO - 'sessionrestore', 01:43:07 INFO - 'sessionrestore_no_auto_restore', 01:43:07 INFO - 'tabpaint']}, 01:43:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:43:07 INFO - 'tests': ['tsvgx', 01:43:07 INFO - 'tsvgr_opacity', 01:43:07 INFO - 'tart', 01:43:07 INFO - 'tscrollx', 01:43:07 INFO - 'cart']}, 01:43:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:43:07 INFO - 'tsvgr_opacity', 01:43:07 INFO - 'tart', 01:43:07 INFO - 'tscrollx', 01:43:07 INFO - 'cart']}, 01:43:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:43:07 INFO - 'talos_options': ['--disable-e10s'], 01:43:07 INFO - 'tests': ['tp5o']}, 01:43:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:43:07 INFO - 'tests': ['tp5o']}, 01:43:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:43:07 INFO - 'talos_options': ['--disable-e10s', 01:43:07 INFO - '--xperf_path', 01:43:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:43:07 INFO - 'tests': ['tp5n']}, 01:43:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:43:07 INFO - 'talos_options': ['--xperf_path', 01:43:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:43:07 INFO - 'tests': ['tp5n']}}, 01:43:07 INFO - 'talos.zip': {'path': '', 01:43:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:43:07 INFO - Running post-action listener: _resource_record_post_action 01:43:07 INFO - ##### 01:43:07 INFO - ##### Finished populate-webroot step (success) 01:43:07 INFO - ##### 01:43:07 INFO - ##### 01:43:07 INFO - ##### Running create-virtualenv step. 01:43:07 INFO - ##### 01:43:07 INFO - Running pre-action listener: _resource_record_pre_action 01:43:07 INFO - Running main action method: create_virtualenv 01:43:07 INFO - Creating virtualenv /builds/slave/test/build/venv 01:43:07 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 01:43:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:43:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:43:07 INFO - Using real prefix '/usr' 01:43:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:43:07 INFO - Installing distribute.............................................................................................................................................................................................done. 01:43:09 INFO - Installing pip.................done. 01:43:09 INFO - Return code: 0 01:43:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:43: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')]} 01:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43: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')]} 01:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff20528af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c821c0>, '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 0x2c830c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c83550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', '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 01:43:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:43:09 INFO - Using env: {'DISPLAY': ':0', 01:43:09 INFO - 'HOME': '/home/cltbld', 01:43:09 INFO - 'LANG': 'en_US.UTF-8', 01:43:09 INFO - 'LANGUAGE': 'en_US:en', 01:43:09 INFO - 'LOGNAME': 'cltbld', 01:43:09 INFO - 'MAIL': '/var/mail/cltbld', 01:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:09 INFO - 'MOZ_NO_REMOTE': '1', 01:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:09 INFO - 'NO_EM_RESTART': '1', 01:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:09 INFO - 'PWD': '/builds/slave/test', 01:43:09 INFO - 'SHELL': '/bin/bash', 01:43:09 INFO - 'SHLVL': '1', 01:43:09 INFO - 'TERM': 'linux', 01:43:09 INFO - 'TMOUT': '86400', 01:43:09 INFO - 'USER': 'cltbld', 01:43:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', 01:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:09 INFO - '_': '/tools/buildbot/bin/python'} 01:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:09 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 01:43:09 INFO - Cleaning up... 01:43:09 INFO - Return code: 0 01:43:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:43: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')]} 01:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43: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')]} 01:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff20528af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c821c0>, '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 0x2c830c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c83550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', '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 01:43:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:43:09 INFO - Using env: {'DISPLAY': ':0', 01:43:09 INFO - 'HOME': '/home/cltbld', 01:43:09 INFO - 'LANG': 'en_US.UTF-8', 01:43:09 INFO - 'LANGUAGE': 'en_US:en', 01:43:09 INFO - 'LOGNAME': 'cltbld', 01:43:09 INFO - 'MAIL': '/var/mail/cltbld', 01:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:09 INFO - 'MOZ_NO_REMOTE': '1', 01:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:09 INFO - 'NO_EM_RESTART': '1', 01:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:09 INFO - 'PWD': '/builds/slave/test', 01:43:09 INFO - 'SHELL': '/bin/bash', 01:43:09 INFO - 'SHLVL': '1', 01:43:09 INFO - 'TERM': 'linux', 01:43:09 INFO - 'TMOUT': '86400', 01:43:09 INFO - 'USER': 'cltbld', 01:43:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', 01:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:09 INFO - '_': '/tools/buildbot/bin/python'} 01:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:10 INFO - Downloading/unpacking psutil>=3.1.1 01:43: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 01:43: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 01:43: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 01:43: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 01:43: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 01:43: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 01:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:43:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:43:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:43:12 INFO - Installing collected packages: psutil 01:43:12 INFO - Running setup.py install for psutil 01:43:12 INFO - building 'psutil._psutil_linux' extension 01:43:12 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 01:43:12 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 01:43:12 INFO - building 'psutil._psutil_posix' extension 01:43:12 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 01:43:12 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 01:43:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:43:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:43:12 INFO - Successfully installed psutil 01:43:12 INFO - Cleaning up... 01:43:12 INFO - Return code: 0 01:43:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:43: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')]} 01:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43: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')]} 01:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff20528af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c821c0>, '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 0x2c830c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c83550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', '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 01:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:43:12 INFO - Using env: {'DISPLAY': ':0', 01:43:12 INFO - 'HOME': '/home/cltbld', 01:43:12 INFO - 'LANG': 'en_US.UTF-8', 01:43:12 INFO - 'LANGUAGE': 'en_US:en', 01:43:12 INFO - 'LOGNAME': 'cltbld', 01:43:12 INFO - 'MAIL': '/var/mail/cltbld', 01:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:12 INFO - 'MOZ_NO_REMOTE': '1', 01:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:12 INFO - 'NO_EM_RESTART': '1', 01:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:12 INFO - 'PWD': '/builds/slave/test', 01:43:12 INFO - 'SHELL': '/bin/bash', 01:43:12 INFO - 'SHLVL': '1', 01:43:12 INFO - 'TERM': 'linux', 01:43:12 INFO - 'TMOUT': '86400', 01:43:12 INFO - 'USER': 'cltbld', 01:43:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', 01:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:12 INFO - '_': '/tools/buildbot/bin/python'} 01:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:43:14 INFO - Installing collected packages: mozsystemmonitor 01:43:14 INFO - Running setup.py install for mozsystemmonitor 01:43:14 INFO - Successfully installed mozsystemmonitor 01:43:14 INFO - Cleaning up... 01:43:14 INFO - Return code: 0 01:43:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:14 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 0x7ff20528af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c821c0>, '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 0x2c830c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c83550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', '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 01:43:14 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 01:43:14 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 01:43:14 INFO - Using env: {'DISPLAY': ':0', 01:43:14 INFO - 'HOME': '/home/cltbld', 01:43:14 INFO - 'LANG': 'en_US.UTF-8', 01:43:14 INFO - 'LANGUAGE': 'en_US:en', 01:43:14 INFO - 'LOGNAME': 'cltbld', 01:43:14 INFO - 'MAIL': '/var/mail/cltbld', 01:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:14 INFO - 'MOZ_NO_REMOTE': '1', 01:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:14 INFO - 'NO_EM_RESTART': '1', 01:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:14 INFO - 'PWD': '/builds/slave/test', 01:43:14 INFO - 'SHELL': '/bin/bash', 01:43:14 INFO - 'SHLVL': '1', 01:43:14 INFO - 'TERM': 'linux', 01:43:14 INFO - 'TMOUT': '86400', 01:43:14 INFO - 'USER': 'cltbld', 01:43:14 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', 01:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:14 INFO - '_': '/tools/buildbot/bin/python'} 01:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:15 INFO - Downloading/unpacking jsonschema==2.5.1 01:43: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 01:43: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 01:43: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 01:43: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 01:43: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 01:43: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 01:43:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:43:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:17 INFO - Downloading functools32-3.2.3-2.tar.gz 01:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:43:17 INFO - warning: no files found matching '*.txt' 01:43:17 INFO - no previously-included directories found matching 'build' 01:43:17 INFO - no previously-included directories found matching 'dist' 01:43:17 INFO - no previously-included directories found matching '.git*' 01:43:17 INFO - Installing collected packages: jsonschema, functools32 01:43:17 INFO - Running setup.py install for functools32 01:43:17 INFO - warning: no files found matching '*.txt' 01:43:17 INFO - no previously-included directories found matching 'build' 01:43:17 INFO - no previously-included directories found matching 'dist' 01:43:17 INFO - no previously-included directories found matching '.git*' 01:43:17 INFO - Successfully installed jsonschema functools32 01:43:17 INFO - Cleaning up... 01:43:17 INFO - Return code: 0 01:43:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:43:17 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')]} 01:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:17 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')]} 01:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:17 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 0x7ff20528af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c821c0>, '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 0x2c830c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c83550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', '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 01:43:17 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 01:43:17 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 01:43:17 INFO - Using env: {'DISPLAY': ':0', 01:43:17 INFO - 'HOME': '/home/cltbld', 01:43:17 INFO - 'LANG': 'en_US.UTF-8', 01:43:17 INFO - 'LANGUAGE': 'en_US:en', 01:43:17 INFO - 'LOGNAME': 'cltbld', 01:43:17 INFO - 'MAIL': '/var/mail/cltbld', 01:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:17 INFO - 'MOZ_NO_REMOTE': '1', 01:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:17 INFO - 'NO_EM_RESTART': '1', 01:43:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:17 INFO - 'PWD': '/builds/slave/test', 01:43:17 INFO - 'SHELL': '/bin/bash', 01:43:17 INFO - 'SHLVL': '1', 01:43:17 INFO - 'TERM': 'linux', 01:43:17 INFO - 'TMOUT': '86400', 01:43:17 INFO - 'USER': 'cltbld', 01:43:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', 01:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:17 INFO - '_': '/tools/buildbot/bin/python'} 01:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:17 INFO - Downloading/unpacking blobuploader==1.2.4 01:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:19 INFO - Downloading blobuploader-1.2.4.tar.gz 01:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:43:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:43:19 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 01:43:19 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 01:43:19 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 01:43:19 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 01:43:19 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 01:43:19 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 01:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:43:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:20 INFO - Downloading docopt-0.6.1.tar.gz 01:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:43:20 INFO - Installing collected packages: blobuploader, requests, docopt 01:43:20 INFO - Running setup.py install for blobuploader 01:43:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:43:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:43:20 INFO - Running setup.py install for requests 01:43:20 INFO - Running setup.py install for docopt 01:43:20 INFO - Successfully installed blobuploader requests docopt 01:43:20 INFO - Cleaning up... 01:43:20 INFO - Return code: 0 01:43:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:43:20 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')]} 01:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:20 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')]} 01:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:20 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 0x7ff20528af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c821c0>, '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 0x2c830c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c83550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', '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 01:43:20 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 01:43:20 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 01:43:20 INFO - Using env: {'DISPLAY': ':0', 01:43:20 INFO - 'HOME': '/home/cltbld', 01:43:20 INFO - 'LANG': 'en_US.UTF-8', 01:43:20 INFO - 'LANGUAGE': 'en_US:en', 01:43:20 INFO - 'LOGNAME': 'cltbld', 01:43:20 INFO - 'MAIL': '/var/mail/cltbld', 01:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:20 INFO - 'MOZ_NO_REMOTE': '1', 01:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:20 INFO - 'NO_EM_RESTART': '1', 01:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:20 INFO - 'PWD': '/builds/slave/test', 01:43:20 INFO - 'SHELL': '/bin/bash', 01:43:20 INFO - 'SHLVL': '1', 01:43:20 INFO - 'TERM': 'linux', 01:43:20 INFO - 'TMOUT': '86400', 01:43:20 INFO - 'USER': 'cltbld', 01:43:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', 01:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:20 INFO - '_': '/tools/buildbot/bin/python'} 01:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:43:21 INFO - Running setup.py (path:/tmp/pip-Gtfw_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:43:21 INFO - Running setup.py (path:/tmp/pip-19MJcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:43:21 INFO - Running setup.py (path:/tmp/pip-iK8tuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:43:21 INFO - Running setup.py (path:/tmp/pip-F5pKmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:43:21 INFO - Running setup.py (path:/tmp/pip-Ch5pkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:43:21 INFO - Running setup.py (path:/tmp/pip-EvYdZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:43:21 INFO - Running setup.py (path:/tmp/pip-0CEpsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:43:21 INFO - Running setup.py (path:/tmp/pip-dlOH3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:43:21 INFO - Running setup.py (path:/tmp/pip-tcevx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:43:21 INFO - Running setup.py (path:/tmp/pip-FFXgS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:43:21 INFO - Running setup.py (path:/tmp/pip-f6LVhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:43:21 INFO - Running setup.py (path:/tmp/pip-WzAC6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:43:22 INFO - Running setup.py (path:/tmp/pip-ARS19z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:43:22 INFO - Running setup.py (path:/tmp/pip-sqkOwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:43:22 INFO - Running setup.py (path:/tmp/pip-njTXge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:43:22 INFO - Running setup.py (path:/tmp/pip-RX0Gr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:43:22 INFO - Running setup.py (path:/tmp/pip-jPC7z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:43:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:43:22 INFO - Running setup.py install for manifestparser 01:43:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:43:22 INFO - Running setup.py install for mozcrash 01:43:22 INFO - Running setup.py install for mozdebug 01:43:22 INFO - Running setup.py install for mozdevice 01:43:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:43:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:43:22 INFO - Running setup.py install for mozfile 01:43:22 INFO - Running setup.py install for mozhttpd 01:43:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:43:23 INFO - Running setup.py install for mozinfo 01:43:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:43:23 INFO - Running setup.py install for mozInstall 01:43:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:43:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:43:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:43:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:43:23 INFO - Running setup.py install for mozleak 01:43:23 INFO - Running setup.py install for mozlog 01:43:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:43:23 INFO - Running setup.py install for moznetwork 01:43:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:43:23 INFO - Running setup.py install for mozprocess 01:43:23 INFO - Running setup.py install for mozprofile 01:43:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:43:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:43:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:43:23 INFO - Running setup.py install for mozrunner 01:43:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:43:23 INFO - Running setup.py install for mozscreenshot 01:43:23 INFO - Running setup.py install for moztest 01:43:24 INFO - Running setup.py install for mozversion 01:43:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:43:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:43:24 INFO - Cleaning up... 01:43:24 INFO - Return code: 0 01:43:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:24 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 0x7ff20528af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c821c0>, '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 0x2c830c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c83550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', '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 01:43:24 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 01:43:24 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 01:43:24 INFO - Using env: {'DISPLAY': ':0', 01:43:24 INFO - 'HOME': '/home/cltbld', 01:43:24 INFO - 'LANG': 'en_US.UTF-8', 01:43:24 INFO - 'LANGUAGE': 'en_US:en', 01:43:24 INFO - 'LOGNAME': 'cltbld', 01:43:24 INFO - 'MAIL': '/var/mail/cltbld', 01:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:24 INFO - 'MOZ_NO_REMOTE': '1', 01:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:24 INFO - 'NO_EM_RESTART': '1', 01:43:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:24 INFO - 'PWD': '/builds/slave/test', 01:43:24 INFO - 'SHELL': '/bin/bash', 01:43:24 INFO - 'SHLVL': '1', 01:43:24 INFO - 'TERM': 'linux', 01:43:24 INFO - 'TMOUT': '86400', 01:43:24 INFO - 'USER': 'cltbld', 01:43:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', 01:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:24 INFO - '_': '/tools/buildbot/bin/python'} 01:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:43:24 INFO - Running setup.py (path:/tmp/pip-4P_kOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:43:24 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)) 01:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:43:24 INFO - Running setup.py (path:/tmp/pip-bS3kFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:43:24 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)) 01:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:43:24 INFO - Running setup.py (path:/tmp/pip-pjGS9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:43:24 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)) 01:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:43:24 INFO - Running setup.py (path:/tmp/pip-twEEM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:43:24 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)) 01:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:43:24 INFO - Running setup.py (path:/tmp/pip-iIBLfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:43:24 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)) 01:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:43:24 INFO - Running setup.py (path:/tmp/pip-U2V6Sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:43:24 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)) 01:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:43:24 INFO - Running setup.py (path:/tmp/pip-KS_DQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:43:24 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)) 01:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:43:24 INFO - Running setup.py (path:/tmp/pip-VuxYfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:43:24 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)) 01:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:43:24 INFO - Running setup.py (path:/tmp/pip-QwgjpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:43:25 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)) 01:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:43:25 INFO - Running setup.py (path:/tmp/pip-43LgHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:43:25 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)) 01:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:43:25 INFO - Running setup.py (path:/tmp/pip-zdsUkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:43:25 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)) 01:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:43:25 INFO - Running setup.py (path:/tmp/pip-9_yjpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:43:25 INFO - Running setup.py (path:/tmp/pip-3mP7iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:43:25 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)) 01:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:43:25 INFO - Running setup.py (path:/tmp/pip-UH3LXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:43:25 INFO - Running setup.py (path:/tmp/pip-nwUs2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:43:25 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)) 01:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:43:25 INFO - Running setup.py (path:/tmp/pip-l025ZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:43:25 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)) 01:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:43:25 INFO - Running setup.py (path:/tmp/pip-aHOdd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:43:25 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)) 01:43:25 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)) 01:43:25 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)) 01:43:25 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)) 01:43:25 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)) 01:43:25 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)) 01:43:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:27 INFO - Downloading blessings-1.6.tar.gz 01:43:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:43:27 INFO - Installing collected packages: blessings 01:43:27 INFO - Running setup.py install for blessings 01:43:27 INFO - Successfully installed blessings 01:43:27 INFO - Cleaning up... 01:43:27 INFO - Return code: 0 01:43:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:43:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:43:27 INFO - Reading from file tmpfile_stdout 01:43:27 INFO - Current package versions: 01:43:27 INFO - argparse == 1.2.1 01:43:27 INFO - blessings == 1.6 01:43:27 INFO - blobuploader == 1.2.4 01:43:27 INFO - docopt == 0.6.1 01:43:27 INFO - functools32 == 3.2.3-2 01:43:27 INFO - jsonschema == 2.5.1 01:43:27 INFO - manifestparser == 1.1 01:43:27 INFO - mozInstall == 1.12 01:43:27 INFO - mozcrash == 0.17 01:43:27 INFO - mozdebug == 0.1 01:43:27 INFO - mozdevice == 0.48 01:43:27 INFO - mozfile == 1.2 01:43:27 INFO - mozhttpd == 0.7 01:43:27 INFO - mozinfo == 0.9 01:43:27 INFO - mozleak == 0.1 01:43:27 INFO - mozlog == 3.2 01:43:27 INFO - moznetwork == 0.27 01:43:27 INFO - mozprocess == 0.22 01:43:27 INFO - mozprofile == 0.28 01:43:27 INFO - mozrunner == 6.11 01:43:27 INFO - mozscreenshot == 0.1 01:43:27 INFO - mozsystemmonitor == 0.3 01:43:27 INFO - moztest == 0.7 01:43:27 INFO - mozversion == 1.4 01:43:27 INFO - psutil == 3.1.1 01:43:27 INFO - requests == 1.2.3 01:43:27 INFO - wsgiref == 0.1.2 01:43:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:27 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 0x7ff20528af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c821c0>, '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 0x2c830c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c83550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', '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 01:43:27 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 01:43:27 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 01:43:27 INFO - Using env: {'DISPLAY': ':0', 01:43:27 INFO - 'HOME': '/home/cltbld', 01:43:27 INFO - 'LANG': 'en_US.UTF-8', 01:43:27 INFO - 'LANGUAGE': 'en_US:en', 01:43:27 INFO - 'LOGNAME': 'cltbld', 01:43:27 INFO - 'MAIL': '/var/mail/cltbld', 01:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:27 INFO - 'MOZ_NO_REMOTE': '1', 01:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:27 INFO - 'NO_EM_RESTART': '1', 01:43:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:27 INFO - 'PWD': '/builds/slave/test', 01:43:27 INFO - 'SHELL': '/bin/bash', 01:43:27 INFO - 'SHLVL': '1', 01:43:27 INFO - 'TERM': 'linux', 01:43:27 INFO - 'TMOUT': '86400', 01:43:27 INFO - 'USER': 'cltbld', 01:43:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', 01:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:27 INFO - '_': '/tools/buildbot/bin/python'} 01:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:28 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)) 01:43:28 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)) 01:43:28 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)) 01:43:28 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)) 01:43:28 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)) 01:43:28 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)) 01:43:28 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)) 01:43:28 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)) 01:43:28 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)) 01:43:28 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)) 01:43:28 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)) 01:43:28 INFO - Cleaning up... 01:43:28 INFO - Return code: 0 01:43:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:43:28 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')]} 01:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:28 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')]} 01:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:28 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 0x7ff20528af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c821c0>, '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 0x2c830c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c83550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', '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 01:43:28 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 01:43:28 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 01:43:28 INFO - Using env: {'DISPLAY': ':0', 01:43:28 INFO - 'HOME': '/home/cltbld', 01:43:28 INFO - 'LANG': 'en_US.UTF-8', 01:43:28 INFO - 'LANGUAGE': 'en_US:en', 01:43:28 INFO - 'LOGNAME': 'cltbld', 01:43:28 INFO - 'MAIL': '/var/mail/cltbld', 01:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:28 INFO - 'MOZ_NO_REMOTE': '1', 01:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:28 INFO - 'NO_EM_RESTART': '1', 01:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:28 INFO - 'PWD': '/builds/slave/test', 01:43:28 INFO - 'SHELL': '/bin/bash', 01:43:28 INFO - 'SHLVL': '1', 01:43:28 INFO - 'TERM': 'linux', 01:43:28 INFO - 'TMOUT': '86400', 01:43:28 INFO - 'USER': 'cltbld', 01:43:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', 01:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:28 INFO - '_': '/tools/buildbot/bin/python'} 01:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:43:28 INFO - Cleaning up... 01:43:28 INFO - Return code: 0 01:43:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:43:28 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')]} 01:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:28 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')]} 01:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:43:28 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 0x7ff20528af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c821c0>, '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 0x2c830c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c83550>, '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': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', '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 01:43:28 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 01:43:28 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 01:43:28 INFO - Using env: {'DISPLAY': ':0', 01:43:28 INFO - 'HOME': '/home/cltbld', 01:43:28 INFO - 'LANG': 'en_US.UTF-8', 01:43:28 INFO - 'LANGUAGE': 'en_US:en', 01:43:28 INFO - 'LOGNAME': 'cltbld', 01:43:28 INFO - 'MAIL': '/var/mail/cltbld', 01:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:28 INFO - 'MOZ_NO_REMOTE': '1', 01:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:28 INFO - 'NO_EM_RESTART': '1', 01:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:28 INFO - 'PWD': '/builds/slave/test', 01:43:28 INFO - 'SHELL': '/bin/bash', 01:43:28 INFO - 'SHLVL': '1', 01:43:28 INFO - 'TERM': 'linux', 01:43:28 INFO - 'TMOUT': '86400', 01:43:28 INFO - 'USER': 'cltbld', 01:43:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', 01:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:28 INFO - '_': '/tools/buildbot/bin/python'} 01:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:43:28 INFO - Downloading/unpacking flake8 01:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:43:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:43:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:43:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:43:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:43:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:43:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:43:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:43:31 INFO - no previously-included directories found matching 'docs/_build' 01:43:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:43:31 INFO - Running setup.py install for pep8 01:43:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:43:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:43:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:43:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:43:31 INFO - no previously-included directories found matching 'docs/_build' 01:43:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:43:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:43:31 INFO - Cleaning up... 01:43:31 INFO - Return code: 0 01:43:31 INFO - Running post-action listener: _resource_record_post_action 01:43:31 INFO - Running post-action listener: _start_resource_monitoring 01:43:31 INFO - Starting resource monitoring. 01:43:31 INFO - ##### 01:43:31 INFO - ##### Finished create-virtualenv step (success) 01:43:31 INFO - ##### 01:43:31 INFO - ##### 01:43:31 INFO - ##### Running install step. 01:43:31 INFO - ##### 01:43:31 INFO - Running pre-action listener: _resource_record_pre_action 01:43:31 INFO - Running main action method: install 01:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:43:31 INFO - Reading from file tmpfile_stdout 01:43:31 INFO - Detecting whether we're running mozinstall >=1.0... 01:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:43:31 INFO - Reading from file tmpfile_stdout 01:43:31 INFO - Output received: 01:43:31 INFO - Usage: mozinstall [options] installer 01:43:31 INFO - Options: 01:43:31 INFO - -h, --help show this help message and exit 01:43:31 INFO - -d DEST, --destination=DEST 01:43:31 INFO - Directory to install application into. [default: 01:43:31 INFO - "/builds/slave/test"] 01:43:31 INFO - --app=APP Application being installed. [default: firefox] 01:43:31 INFO - mkdir: /builds/slave/test/build/application 01:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:43:47 INFO - Reading from file tmpfile_stdout 01:43:47 INFO - Output received: 01:43:47 INFO - /builds/slave/test/build/application/firefox/firefox 01:43:47 INFO - Running post-action listener: _resource_record_post_action 01:43:47 INFO - ##### 01:43:47 INFO - ##### Finished install step (success) 01:43:47 INFO - ##### 01:43:47 INFO - ##### 01:43:47 INFO - ##### Running run-tests step. 01:43:47 INFO - ##### 01:43:47 INFO - Running pre-action listener: _resource_record_pre_action 01:43:47 INFO - Running main action method: run_tests 01:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:43:47 INFO - Python 2.7.3 01:43:47 INFO - Return code: 0 01:43:47 INFO - grabbing minidump binary from tooltool 01:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:43:47 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 0x2c821c0>, '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 0x2c830c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c83550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:43:47 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 01:43:47 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 01:43:47 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 01:43:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:43:47 INFO - Return code: 0 01:43:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:43:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:43:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:43:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:43:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:43:48 INFO - Return code: 0 01:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 01:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 01:43:48 INFO - Using env: {'DISPLAY': ':0', 01:43:48 INFO - 'HOME': '/home/cltbld', 01:43:48 INFO - 'LANG': 'en_US.UTF-8', 01:43:48 INFO - 'LANGUAGE': 'en_US:en', 01:43:48 INFO - 'LOGNAME': 'cltbld', 01:43:48 INFO - 'MAIL': '/var/mail/cltbld', 01:43:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:43:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:43:48 INFO - 'MOZ_NO_REMOTE': '1', 01:43:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:43:48 INFO - 'NO_EM_RESTART': '1', 01:43:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:43:48 INFO - 'PWD': '/builds/slave/test', 01:43:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:43:48 INFO - 'SHELL': '/bin/bash', 01:43:48 INFO - 'SHLVL': '1', 01:43:48 INFO - 'TERM': 'linux', 01:43:48 INFO - 'TMOUT': '86400', 01:43:48 INFO - 'USER': 'cltbld', 01:43:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140', 01:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:43:48 INFO - '_': '/tools/buildbot/bin/python'} 01:43:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 01:43:49 INFO - mozversion application_buildid: 20160616000726 01:43:49 INFO - mozversion application_changeset: 6b40db1565705c392042da04396d1ca83c0d017d 01:43:49 INFO - mozversion application_display_name: Nightly 01:43:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:43:49 INFO - mozversion application_name: Firefox 01:43:49 INFO - mozversion application_remotingname: firefox 01:43:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:43:49 INFO - mozversion application_vendor: Mozilla 01:43:49 INFO - mozversion application_version: 50.0a1 01:43:49 INFO - mozversion platform_buildid: 20160616000726 01:43:49 INFO - mozversion platform_changeset: 6b40db1565705c392042da04396d1ca83c0d017d 01:43:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:43:49 INFO - mozversion platform_version: 50.0a1 01:43:49 INFO - using testdate: 1466066629 01:43:49 INFO - actual date: 1466066629 01:43:49 INFO - starting webserver on 'localhost:58587' 01:43:49 INFO - SUITE-START | Running 2 tests 01:43:49 INFO - TEST-START | dromaeo_css 01:43:49 INFO - operating with platform_type : linux_ 01:43:49 INFO - Initialising browser for dromaeo_css test... 01:43:49 INFO - TEST-INFO | started process 21836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9ZJiD4/profile http://localhost:58587/getInfo.html) 01:43:53 INFO - PROCESS | 21836 | __metrics Screen width/height:1600/1200 01:43:53 INFO - PROCESS | 21836 | colorDepth:24 01:43:53 INFO - PROCESS | 21836 | Browser inner width/height: 1024/697 01:43:53 INFO - PROCESS | 21836 | __metrics 01:43:54 INFO - PROCESS | 21836 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:43:55 INFO - TEST-INFO | 21836: exit 0 01:43:55 INFO - Browser initialized. 01:43:55 INFO - Running cycle 1/1 for dromaeo_css test... 01:43:55 INFO - TEST-INFO | started process 21919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9ZJiD4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:44:07 INFO - PROCESS | 21919 | RSS: Main: 175742976 01:44:07 INFO - PROCESS | 21919 | 01:44:58 INFO - PROCESS | 21919 | 1466066698726 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] 01:47:11 INFO - PROCESS | 21919 | Cycle 1(1): loaded http://localhost:58587/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58587/tests/dromaeo/cssquery-ext.html) 01:47:12 INFO - PROCESS | 21919 | RSS: Main: 297488384 01:47:12 INFO - PROCESS | 21919 | 01:50:15 INFO - PROCESS | 21919 | Cycle 1(1): loaded http://localhost:58587/tests/dromaeo/cssquery-ext.html (next: http://localhost:58587/tests/dromaeo/cssquery-jquery.html) 01:50:16 INFO - PROCESS | 21919 | RSS: Main: 255385600 01:50:16 INFO - PROCESS | 21919 | 01:53:18 INFO - PROCESS | 21919 | Cycle 1(1): loaded http://localhost:58587/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58587/tests/dromaeo/cssquery-mootools.html) 01:53:19 INFO - PROCESS | 21919 | RSS: Main: 257445888 01:53:19 INFO - PROCESS | 21919 | 01:56:21 INFO - PROCESS | 21919 | Cycle 1(1): loaded http://localhost:58587/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58587/tests/dromaeo/cssquery-prototype.html) 01:56:21 INFO - PROCESS | 21919 | RSS: Main: 257064960 01:56:21 INFO - PROCESS | 21919 | 01:59:25 INFO - PROCESS | 21919 | Cycle 1(1): loaded http://localhost:58587/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58587/tests/dromaeo/cssquery-yui.html) 01:59:25 INFO - PROCESS | 21919 | RSS: Main: 244928512 01:59:25 INFO - PROCESS | 21919 | 02:02:28 INFO - PROCESS | 21919 | Cycle 1(1): loaded http://localhost:58587/tests/dromaeo/cssquery-yui.html (next: http://localhost:58587/tests/dromaeo/cssquery-dojo.html) 02:02:28 INFO - PROCESS | 21919 | RSS: Main: 293654528 02:02:28 INFO - PROCESS | 21919 | 02:02:28 INFO - PROCESS | 21919 | __start_tp_report 02:02:28 INFO - PROCESS | 21919 | _x_x_mozilla_page_load 02:02:28 INFO - PROCESS | 21919 | _x_x_mozilla_page_load_details 02:02:28 INFO - PROCESS | 21919 | |i|pagename|runs| 02:02:28 INFO - PROCESS | 21919 | |0;dojo.html;2632.9868350658244;2637.1165659504063;2685.5971604259366;2693.461307738453;2697.9747695875562;4702.764861756916;4764.999350136472;4776.949071204338;4851.902961940759;4920.901581968363;4804.20730579454;4811.10994466024;4813.278008298748;4860.100881336955;4873.5613794758465;4301.204277208726;4419.491758447787;4428.291473364262;4457.799399027035;4593.655475839309;4519.887002824939;4538.228501154812;4562.315652652095;4573.49691533931;4600.953990460102;4339.47926248849;4399.076193999264;4407.008423104808;4425.690201685883;4458.621017213541;4353.84761533348;4355.194289056535;4357.085012147453;4401.405810215612;4407.449068866392;4385.188740083063;4451.198784218839;4454.443194600675;4464.553544645542;4465.419495465569;4645.163870503308;4687.929681054787;4746.667733258673;4750.216214324632;4818.445878723956;5187.170052791535;5192.0394726975255;5209.791608335662;5215.426303106655;5217.713025783581;5199.324087868591;5234.110201265794;5234.659747116425;5237.790488380499;5241.842744717665;4705.294205869147;4728.976355118271;4748.169070412664;4754.5245475452175;4787.976060119747;5241.606879484054;5270.183121616155;5318.97340513295;5322.707251101227;5323.1216849219445;5054.039732450822;5090.032893750175;5095.133827249377;5107.6169287302855;5110.744462776846;5021.171506701354;5108.131617625013;5140.460251673595;5150.227465880073;5150.793968241228;5120.615953803405;5130.358705161855;5131.307273518102;5131.589472842164;5188.610854185876;4973.651844370932;5086.440491545927;5102.209157580581;5116.155834287301;5124.154514505065;4312.482502099768;4365.934510982338;4402.471703395549;4404.647628189737;4419.226635338803;3804.8668296609485;3826.081740382288;3833.9041523962123;3863.8840834775;3867.497225360685;4313.2883074292395;4398.516163222043;4407.37113683927;4409.14021765759;4438.312061630452;5118.053160165381;5144.408393034774;5173;5188.8962220755375;5203.791848326025;4376.387305777193;4388.385626012361;4420.624246939046;4421.977890110529;4441.133978874089;4614.261718125151;4670.556297151765;4698.8355407560575;4718.88202794926;4747.667663263607;4849.781759820887;4886.462489126122;4905.215165573634;4909.533594308535;4956.454789973028;5228.294180285765;5228.63399562027;5248.396434409939;5255.395629502656;5302.416734159317;4735.33705281254;4776.331313616166;4784.6889952153;4907.3620429343955;4927.310176575354;5061.898762024813;5081.136206844772;5088.1604535252745;5089.160288552347;5129.410117836496;5136.871578210575;5166.354205724285;5168.715720635401;5170.741462926914;5208.557272631869;4914.557689807934;4994.750262486788;5024.57291130258;5024.924626130684;5054.620903432184;5046.899062018666;5063;5073.137566613611;5075.264086707481;5123.5388815005335;4966.627502937222;4970.030843985388;5021.397432308147;5023.196288593807;5028.798848046037;4944;4985.5762260208285;5015.724135172601;5037.471065538066;5069.847904562869;4909.1899836528;4941.481144479778;4945.8021679132435;4969.552740253394;5014.799408023784 02:02:28 INFO - PROCESS | 21919 | |1;ext.html;543.9224552028716;578.1645522220391;584.5411352088609;591.1841658511254;597.4294548705985;27216.863915680442;38600.22799544007;39696.60303396965;39712;39741.40387894177;41105.58894411055;41500.58499415005;41528.792356038255;41576.58423415765;41587.168256634846;7572.432067594925;7958.6418611162635;8090.190980901922;8091.069527004411;10146.086852183302;10030.39817610942;10417.479126043705;10426.113780328682;10428.582856685762;10429.791404171912;10376.273660843744;10430.061294483496;10438.843417348746;10440.216983726252;10440.895591044105;7653.234676532358;10252.487375631188;10329.84505232422;10543.103836173934;10554.947225263824;10021.298509104365;10389.376637401705;10405.947970260177;10410.219233557438;10414.791704165875;38407;38876.222475550334;38913.80543097295;38949.61050389488;38951.805240973896;2988.13344130202;3130.624325080982;3456.792592444436;3520.700740437066;3758.661720445146;29785.106446806414;29999.400011999856;30062.84968575165;30103.096907092822;30527.694723052708;3331.1838599543266;3363.596368435779;3419.589649242082;3445.1214940190343;3450.1547120955274;253286;255705;255874;256019;258239;32157.51763723546;55448.72275638596;56326;56350;56370;33132.171695707315;34946.82526587402;34999.12502187415;35000.29999399998;35002.12494687653;11551.711207219718;11629.65111046653;11652.76694466106;11683.707907302216;11685.766284674259;8317.209865062809;9140.954295228481;9366.531673416303;9374.203192728695;9651.613935442643;8041.557714325768;8043.477173983672;8061.4760040597175;8095.959520202479;8157.551334676531;3181.9522707159413;3200.4239236937574;3200.9839950800097;3236.3527294541186;3268.166617512519;898.447454815297;902.2105657549644;924.3806649544821;953.0850383631653;976.5410257179115;26913.596296055573;28380.574291385645;28816.279593010342;28821.423571528452;28951.276218094717;920.3281604428804;933.5959903249025;966.8308046091905;967.6129548180784;984.3208186351395;14066.718665626835;14595.635109122357;14608.634784130481;14842.92578537122;14868.479603213835;196885;198900;199307;199377;199478;48644;49362;49410.505894940594;49492.75253623781;49519.75240123848;1085.5277954089838;1120.2102517724823;1124.5726623882872;1197.3115458611333;1233.3956361382857;23362;28122.71877281201;30176;30893;31082;45579.54420455886;46575.369862056024;46627.30059049049;46699.76650116728;46711.53288467072;372794;384520;384783;385176;385729;22307;24319;24954.37614059663;25344.366390840376;25688.8715556421;40579;40698;40729.592704073766;41923.371149432176;42014.78992605017;35051.47422788711;35179.29641407209;35561.288774224886;35777.64222357743;36018.27963440769;32310.83844580762;34830;35426.11434714153;35665.82167089148;35685;34241.828790855885;34285.057218419206;34725.30549389048;34743.4788478168;34959;30627.387452251274;31540.842295788374;31686.68313316837;31723.524147138272;31820.204494887814;24462.63306050375;24489;24638;24789.87605061963;24948.251552453454 02:02:28 INFO - PROCESS | 21919 | |2;jquery.html;369.20804873546246;369.58421775502575;370.21699106389985;376.5293383270911;389.0410139007348;15967.361305547778;16589.83410165898;17093.461588457052;17281.395151169712;17342.82657173428;14274.857251427482;14651.267436628179;15244.618884527892;15250.84749152508;15252.618684532865;4861.270809378595;5197.844064678046;5230.555402790767;5266.894662106774;5267.446918073604;3662.10278481771;5122.897542049157;5782.392848750884;6132.4480796728285;6149.754009839623;6189.102580125879;6199.9690001549925;6213.409726076015;6218.160548325986;6221.844453888666;5167.276581278624;5455.781768729246;5459.344878614572;5497.752601132958;5527.198556209368;3350.748693847947;4958.801647934079;5250.343707036621;5251.317328747238;5334.813281535166;12078.456469458895;12168.81746773799;12572.811407828889;12673.619791406272;12792.360381980863;1775.3608700867678;1952.8828270303827;2124.8618839775518;2393.042782886842;2395.796357309631;9057.637694492212;9078.364514483988;9393.389429687048;9535.809283814286;9602.807943841153;1560.6488540078506;1719.0545200139873;1736;1737.2616637928957;1767.5227688524155;63774.681126594536;64177;64789.676051619914;67759.98360024604;68225.9999999995;9938.701838944844;10130.189584833342;10160;10167.644132455476;10972.506237219344;13842.86157138436;14017.229052402012;14065.71868562623;14085.788713169311;14099.85900141006;6810.965945170243;6890.276520965226;6956.65216739161;6995.265497122728;7040.3663670269925;6266.561340706106;6278.4035516625845;6278.466330361879;6393.073004414334;6417.9679101605125;4348.869533913988;4370.409994650681;4383.60547550722;4419.337099435111;4505.571970662847;1593.529908676943;1686.1232159277108;1766.0352508617977;1825.6805059114602;1827.2873579304082;780.9414293927978;808.8705807070841;816.2123550773532;903.46695449685;904.9140331668481;16133.515994520183;16163.67672646564;16480.752788708178;16507;16611.169441527876;797.5453991224946;805.2149154574361;821.9712310069119;827.0365024746224;844.0588743551019;9249.306302027375;9331.953340233254;9356.95321523388;9450.621975120917;9723.708288751348;351542;352317;367287;376438;381675;47124;68892.31107688959;70429.29570704227;76938.23061769422;82012;880.1330689271191;896.0859922878627;917.8347897378536;921.6129225725211;950.2587981374677;15300.693986120437;15555.066695998275;15579.922100389425;15821;16033;30016.849915751154;30768.384632307676;32368.35263294768;36950.81524592467;37144;48768.512314876396;50303.74848125736;50373;50587.24119138142;50737.70204936667;7686.3850891927395;7705.1524332324525;7715.459917805924;7832.412569057229;7871.803204919694;8607.225349718556;11563.826542601699;11928.343941083323;12024.879751202376;12073.396330183632;9957.402555846673;10514.842277365693;10541.420221887869;10703.304285221435;10905.672829815117;10463.843042354523;10633.096186824207;10860.728481787703;10888.237823352607;10922.344659320466;10282.794344112926;10835.458227088457;10942.452877355941;10958;11195.664130076111;7836.177201393772;7860.4104692147175;8018.118007019107;8072.878906816285;8205.261526462647;9867.45728984884;10067.949660251652;10126.44304563256;10260.179185665278;10522.263441559018 02:02:28 INFO - PROCESS | 21919 | |3;mootools.html;1187.6733898178006;1352.3981828086498;1379.9931000344998;1395.3790563199375;1670.5740036290736;7466.738664146756;7876.803079922997;7878.094019187795;7998.440109192359;8014.7194848180325;7799.532028078319;7955.681772729098;7974.122846486896;7980.481268717529;7984.760457186294;1883.5761953560407;1946.2896042944294;1955;2153.4508700281444;2181.0839447432036;2004.3886614582545;2105.884176370299;2177.8148857347146;2182.694422780812;2199.076387917071;1979.2775636892575;2001.2095222387147;2011.306099395706;2017.1931227508967;2017.9899100504476;2115.090511080235;2180.1061564758534;2186.606410846055;2189.37602783206;2191.2659259148204;2119.1205649655376;2140.785921407862;2159.7948194921455;2162.10272736814;2162.664786958024;8048.798780030487;8061.032676078849;8109.553974531398;8116.8782468263025;8137.918620813834;4302.634276086536;4444.888877778049;4446;4446.888827779331;4451.599356057938;2839.176638774753;2871.3826527296733;2957.2311199088176;2970.658374286963;2976.7023297670275;817.2318021060184;848.6732607945924;942.8868535775682;971.8299297622888;983.306768728045;10482.528286227138;10691.251612387136;10750.086242669382;10768.515416806262;10792.838107428395;4209;4254.553271906405;4309.913801723948;4342.782860856944;4363.52001279859;9206;9211.30915181364;9223.538823058954;9223.538823058954;9223.723288301362;4530.07133537624;4531.116432295671;4532.9093418132115;4533.274676051816;4535.4103966484145;3365.3437579671727;3382.4418970870024;3981.8009099544906;4020.3567429211184;4022.4770779798437;3644.6902013328636;3728.12389088564;3797.240551889633;3809.6190380962234;3821.9044523887123;1214.2653694514868;1225.5281716539018;1235.9134860559855;1237.449335045914;1244.67638414013;674.8751480976035;798.5248776977689;815.6900377856376;822.4695071678734;833.0794472108354;4995.600351971833;5101.464346243591;5249.790008399697;5343.919841202385;5364.6512976656395;819.1399031017407;864.6757465950269;880.3705350674298;882.2368651116866;885.6103314541581;3457.8098204598487;3463.809490478048;3495.720342372604;3520.0319912024397;3641.8361173747244;9892.60429582823;10074.798504029879;10214.846777298346;10217.74455638615;10229.079382855578;10044.648437304659;10087.646932357478;10139.695809125738;10154.187664986783;10156.39061656303;7430.7399241026305;7487.288707572772;7500.324970752658;7552.697892084255;7633.625947329534;5160.122779127632;5234.659747116425;5270.7101109439345;5328.8401347959625;5405.432429594994;8806.251468625238;9138.588763505526;9267.860982085409;9284.767880802763;9285.675001374919;8748;9119.544022798966;9162.679306224516;9395.24838012971;9426.387284826464;6940.13248343957;6960.965195173992;7007.404370628554;7268.563886166847;7549.924500755142;7534;7767.92232077672;7788.805279868048;7798.766037018899;7827.217278272127;6764.594124352555;7007.229204787572;7075.787726368218;7077.823054423475;7091.1490621125795;6899.344562266577;6925.965370173117;6948.270431604608;6953.33943275388;6981.650917454209;6415.166028416276;6420.1974753155855;6503.577267477599;6511.804645860631;6513.478921686348;4478.440194975628;4518.480374756814;4524.88687782808;4555.9544404556855;4590.816367345269;4540.137373898949;4576.473705523774;4636.250311642982;4736.194846876108;4746.833860814855 02:02:28 INFO - PROCESS | 21919 | |4;prototype.html;283.8197744432285;284.47514336050006;286.25573508876914;288.12266648056664;291.7010064683699;4835.274708793679;4838.467768545457;4843.927341089878;4854.660173787832;4879.634027447938;4747.93171536405;4761.4763275751775;4770.425759499366;4774.952250477494;4809.533092406815;3576.660217279354;3679.2641471705633;3705.2033812730256;3796.7721936683747;3834.6357096075826;3770.660640542351;3789.5263092113487;3800.353939830222;3808.5810560838286;3811.9047023824487;3560.8397622106936;3736.7010639148803;3763.811809409532;3778.6599206071446;3787.223619158066;3634.473001414793;3778.7921664308587;3788.4696142540065;3789.1853251551047;3796.620337966209;3323.3187196624635;3362.041818081835;3362.4788157835574;3363.5122907178566;3370.7303415726683;4631.374764406795;4655.976720116378;4665.906681866344;4667.579917807414;4705.200115980258;4219.261629214875;4292.18448494785;4297.742135471882;4302.139572085595;4319.654427645781;4968.354113965198;4989.226669866177;4995.825980894487;4997.825076122354;5012.699238045729;3606.206634540397;3609.2781443711365;3612.548431446069;3619.2942376236642;3635.800030998294;4968.54057241664;5195.2986346843445;5198.844034678966;5218.5825133989565;5223.973880130613;3681.650243226889;3684.1158122050515;3686.078480379905;3693.372126738461;3722.739408241451;3765.2281282337053;3767.7362584619364;3768.9246215075545;3775.112848480605;3778.6221377861993;4288.2281189385585;4288.807003684841;4289.506706728766;4289.978550107292;4290.635295999875;4754.857354279377;5021.974890125599;5033.364156649103;5052.242163675404;5059.494050594911;1320.8877245434246;1330.1221194011905;1330.5143622577882;1335.9045582622157;1341.9798703019462;851.2976794144855;857.7083791510917;895.6104094718818;921.4701546610726;927.2072378116613;4393.923488745214;4401.525488961234;4426.380306757057;4435.028530884315;4443.422355093817;5120.948790512121;5146.768395422215;5148.253503242009;5180.197069454241;5180.378354597472;4198.6011328923705;4400.779961001937;4415.183191109655;4418.9337159942625;4427.446569178853;2719.972800271972;2750.436160587075;2759.558470644687;2762.8342299462097;2768.5985532098134;4866.562009419169;4871.14754917888;4877.3903262092235;4883.755812209375;4886.951130488721;5135.768890399866;5278.8944221116135;5298.311219541435;5301.867453313698;5321.787128514893;4848.587870031087;4876.390451193601;4877.585405240523;4880.072786170616;4885.413750349981;5176.275321455075;5177.301064356264;5179.974100129475;5185.974070129625;5187.844364669066;4887.90224195507;5002.52476014778;5083.72039537829;5086.872828179326;5092.694438333712;4849.175640141255;4854.543636908843;4865.002674451658;4867.610591152628;4884.5603895649565;3753.2868754936476;3755.267722794029;3763.6101075816505;3767.171222331083;3777.1690228149764;5008.649394542493;5047.2429135629945;5077.187649976134;5078.162103252922;5221.686698798084;4929.309896614405;4930.6055515557955;4972.414344540891;5019.322391477104;5029.29589857413;4993.750312484434;5027.698338099725;5030.572401345927;5038;5041.521055499722;4665.2069148245555;4736.194846876108;4871.147549178951;4890.779914903766;4946.554810067111;5014;5025.597952163891;5026.271190677405;5026.899462010812;5030.170021946338;4821.734804585782;4959.156943319572;4993.4257560379565;4998.350214472095;4999.775010124626 02:02:28 INFO - PROCESS | 21919 | |5;yui.html;640.9423151916327;660.4485254812231;671.399097807462;704.8519810839722;736.2159300345132;12557.497700091997;13531.864681353183;13558.728825423486;13563.254021028852;13564.932175339109;12757.872421275784;13159.802602960963;13472.730545389086;13474;13475.191488510673;615.2186722861962;751.7519218657857;776.8329809091044;792.9167437419075;794.297047113306;791.8495485857698;802.9076656184526;803.6945960535018;803.8753993131074;804.3243675312737;839.3914412051275;843.7553109598209;844.0968164064453;844.543946269014;845.023997283139;646.4053071174484;778.0663204155037;834.8455535725849;840.9075001749802;841.970531031414;608.084832327349;608.6013661052018;609.2049874913237;609.3053918532831;609.5276160975279;12986.935065324707;12994.28531430771;13025.674358141028;13034.348282585834;13048.28234447105;12782.808257876139;13207.933960330136;13293.867061329456;13524.594242270503;13658.795118073236;9791.559379827924;10371;10510.369377837354;10596.41719705416;10734.463276836126;3272.803631782077;3280.6719328067243;3318.900432987014;3319.7842140261046;3404.5914490261325;50761.49238507642;52943.94112117736;53022.73488632571;59599.70200149015;61494.38505614932;10351.06840384369;10446.791064178673;10493.317934334244;10566.207534434794;10601.038807820578;18733.34433294828;18767.24931002772;18817;18828.15273312704;18848;6395.872082558323;6548.541602087808;6731.49513786468;6908.412784913338;7105;3663.670269675742;3700.7594506357;3712.201876596491;3722.8510859565313;3724.9068773280883;2990.970090299069;3100.2869340051916;3103.953440698391;3107.02128829418;3112.7198552130417;536.506414099022;538.0825692194799;540.1115165552723;548.4844246408443;548.7503186050337;388.0821856309807;421.6647765026811;459.5037359651568;459.53586877254213;460.7903403951194;6844.657767111625;7153.678084486107;7277.963610181915;7464.813379665552;7557.848843023109;414.5916272471613;478.9257665061921;486.9975650121727;487.68056922715675;498.3496537019225;3559.6618321259957;3634.3821550336506;3676.4669122977552;3676.6139555346303;3682.4660424238873;89208;89262.10737892539;89401;91639.54180229057;92719;77653.6117319421;78053.21946780459;78093.60953195198;79237.60381198057;84142;73135.63432182805;73156.26843731494;73781.6310918442;73873.63063184649;74855.62572187213;7016.6491675415;7058.435325174077;7230.42156627479;7241.312075352833;7242.963785181251;43630;45266.094678106914;45552.772236139936;46435.767821160676;47006.76496617495;57443;57730.422695774185;59054.40945590661;63076.684616576626;64485.35514644981;8426.73598960161;8650.30797536183;8751.124887511452;8782.165694259034;8820.25027872638;10224.13094886943;10297.9485102577;10333.121684656888;10349.793004140025;10360.860305366254;8493.745187644381;10146.695599132037;10329.74175645615;11257.437128143723;11438.313701177956;10970.396628185206;11001.724956876142;11477.311361318347;11980.341081240615;12077.154599177973;10508.369497830156;10550.892156323782;10622.8406573903;10834.241603087708;10995.505202265756;9140.63437462494;9239.122283383067;9411.200047995997;9707.126358627474;9786.51067446639;9783.752249983761;9907;9943.552540135855;9989.459012544461;10028.348157369748 02:02:28 INFO - PROCESS | 21919 | __end_tp_report 02:02:28 INFO - PROCESS | 21919 | __start_cc_report 02:02:28 INFO - PROCESS | 21919 | _x_x_mozilla_cycle_collect,1197 02:02:28 INFO - PROCESS | 21919 | __end_cc_report 02:02:28 INFO - PROCESS | 21919 | __startTimestamp1466067748699__endTimestamp 02:02:28 INFO - PROCESS | 21919 | 02:02:28 INFO - PROCESS | 21919 | ------- Summary: start ------- 02:02:28 INFO - PROCESS | 21919 | Number of tests: 6 02:02:28 INFO - PROCESS | 21919 | 02:02:28 INFO - PROCESS | 21919 | [#0] dojo.html Cycles:165 Average:4767.50 Median:4909.53 stddev:506.56 (10.3%) stddev-sans-first:479.64 02:02:28 INFO - PROCESS | 21919 | Values: 2633.0 2637.1 2685.6 2693.5 2698.0 4702.8 4765.0 4776.9 4851.9 4920.9 4804.2 4811.1 4813.3 4860.1 4873.6 4301.2 4419.5 4428.3 4457.8 4593.7 4519.9 4538.2 4562.3 4573.5 4601.0 4339.5 4399.1 4407.0 4425.7 4458.6 4353.8 4355.2 4357.1 4401.4 4407.4 4385.2 4451.2 4454.4 4464.6 4465.4 4645.2 4687.9 4746.7 4750.2 4818.4 5187.2 5192.0 5209.8 5215.4 5217.7 5199.3 5234.1 5234.7 5237.8 5241.8 4705.3 4729.0 4748.2 4754.5 4788.0 5241.6 5270.2 5319.0 5322.7 5323.1 5054.0 5090.0 5095.1 5107.6 5110.7 5021.2 5108.1 5140.5 5150.2 5150.8 5120.6 5130.4 5131.3 5131.6 5188.6 4973.7 5086.4 5102.2 5116.2 5124.2 4312.5 4365.9 4402.5 4404.6 4419.2 3804.9 3826.1 3833.9 3863.9 3867.5 4313.3 4398.5 4407.4 4409.1 4438.3 5118.1 5144.4 5173.0 5188.9 5203.8 4376.4 4388.4 4420.6 4422.0 4441.1 4614.3 4670.6 4698.8 4718.9 4747.7 4849.8 4886.5 4905.2 4909.5 4956.5 5228.3 5228.6 5248.4 5255.4 5302.4 4735.3 4776.3 4784.7 4907.4 4927.3 5061.9 5081.1 5088.2 5089.2 5129.4 5136.9 5166.4 5168.7 5170.7 5208.6 4914.6 4994.8 5024.6 5024.9 5054.6 5046.9 5063.0 5073.1 5075.3 5123.5 4966.6 4970.0 5021.4 5023.2 5028.8 4944.0 4985.6 5015.7 5037.5 5069.8 4909.2 4941.5 4945.8 4969.6 5014.8 02:02:28 INFO - PROCESS | 21919 | 02:02:28 INFO - PROCESS | 21919 | [#1] ext.html Cycles:180 Average:43237.21 Median:18865.09 stddev:76286.93 (404.4%) stddev-sans-first:76433.59 02:02:28 INFO - PROCESS | 21919 | Values: 543.9 578.2 584.5 591.2 597.4 27216.9 38600.2 39696.6 39712.0 39741.4 41105.6 41500.6 41528.8 41576.6 41587.2 7572.4 7958.6 8090.2 8091.1 10146.1 10030.4 10417.5 10426.1 10428.6 10429.8 10376.3 10430.1 10438.8 10440.2 10440.9 7653.2 10252.5 10329.8 10543.1 10554.9 10021.3 10389.4 10405.9 10410.2 10414.8 38407.0 38876.2 38913.8 38949.6 38951.8 2988.1 3130.6 3456.8 3520.7 3758.7 29785.1 29999.4 30062.8 30103.1 30527.7 3331.2 3363.6 3419.6 3445.1 3450.2 253286.0 255705.0 255874.0 256019.0 258239.0 32157.5 55448.7 56326.0 56350.0 56370.0 33132.2 34946.8 34999.1 35000.3 35002.1 11551.7 11629.7 11652.8 11683.7 11685.8 8317.2 9141.0 9366.5 9374.2 9651.6 8041.6 8043.5 8061.5 8096.0 8157.6 3182.0 3200.4 3201.0 3236.4 3268.2 898.4 902.2 924.4 953.1 976.5 26913.6 28380.6 28816.3 28821.4 28951.3 920.3 933.6 966.8 967.6 984.3 14066.7 14595.6 14608.6 14842.9 14868.5 196885.0 198900.0 199307.0 199377.0 199478.0 48644.0 49362.0 49410.5 49492.8 49519.8 1085.5 1120.2 1124.6 1197.3 1233.4 23362.0 28122.7 30176.0 30893.0 31082.0 45579.5 46575.4 46627.3 46699.8 46711.5 372794.0 384520.0 384783.0 385176.0 385729.0 22307.0 24319.0 24954.4 25344.4 25688.9 40579.0 40698.0 40729.6 41923.4 42014.8 35051.5 35179.3 35561.3 35777.6 36018.3 32310.8 34830.0 35426.1 35665.8 35685.0 34241.8 34285.1 34725.3 34743.5 34959.0 30627.4 31540.8 31686.7 31723.5 31820.2 24462.6 24489.0 24638.0 24789.9 24948.3 02:02:28 INFO - PROCESS | 21919 | 02:02:28 INFO - PROCESS | 21919 | [#2] jquery.html Cycles:180 Average:22947.06 Median:4401.47 stddev:60387.37 (1372.0%) stddev-sans-first:60532.97 02:02:28 INFO - PROCESS | 21919 | Values: 369.2 369.6 370.2 376.5 389.0 15967.4 16589.8 17093.5 17281.4 17342.8 14274.9 14651.3 15244.6 15250.8 15252.6 4861.3 5197.8 5230.6 5266.9 5267.4 3662.1 5122.9 5782.4 6132.4 6149.8 6189.1 6200.0 6213.4 6218.2 6221.8 5167.3 5455.8 5459.3 5497.8 5527.2 3350.7 4958.8 5250.3 5251.3 5334.8 12078.5 12168.8 12572.8 12673.6 12792.4 1775.4 1952.9 2124.9 2393.0 2395.8 9057.6 9078.4 9393.4 9535.8 9602.8 1560.6 1719.1 1736.0 1737.3 1767.5 63774.7 64177.0 64789.7 67760.0 68226.0 9938.7 10130.2 10160.0 10167.6 10972.5 13842.9 14017.2 14065.7 14085.8 14099.9 6811.0 6890.3 6956.7 6995.3 7040.4 6266.6 6278.4 6278.5 6393.1 6418.0 4348.9 4370.4 4383.6 4419.3 4505.6 1593.5 1686.1 1766.0 1825.7 1827.3 780.9 808.9 816.2 903.5 904.9 16133.5 16163.7 16480.8 16507.0 16611.2 797.5 805.2 822.0 827.0 844.1 9249.3 9332.0 9357.0 9450.6 9723.7 351542.0 352317.0 367287.0 376438.0 381675.0 47124.0 68892.3 70429.3 76938.2 82012.0 880.1 896.1 917.8 921.6 950.3 15300.7 15555.1 15579.9 15821.0 16033.0 30016.8 30768.4 32368.4 36950.8 37144.0 48768.5 50303.7 50373.0 50587.2 50737.7 7686.4 7705.2 7715.5 7832.4 7871.8 8607.2 11563.8 11928.3 12024.9 12073.4 9957.4 10514.8 10541.4 10703.3 10905.7 10463.8 10633.1 10860.7 10888.2 10922.3 10282.8 10835.5 10942.5 10958.0 11195.7 7836.2 7860.4 8018.1 8072.9 8205.3 9867.5 10067.9 10126.4 10260.2 10522.3 02:02:28 INFO - PROCESS | 21919 | 02:02:28 INFO - PROCESS | 21919 | [#3] mootools.html Cycles:180 Average:5215.17 Median:4613.53 stddev:3003.31 (65.1%) stddev-sans-first:2996.48 02:02:28 INFO - PROCESS | 21919 | Values: 1187.7 1352.4 1380.0 1395.4 1670.6 7466.7 7876.8 7878.1 7998.4 8014.7 7799.5 7955.7 7974.1 7980.5 7984.8 1883.6 1946.3 1955.0 2153.5 2181.1 2004.4 2105.9 2177.8 2182.7 2199.1 1979.3 2001.2 2011.3 2017.2 2018.0 2115.1 2180.1 2186.6 2189.4 2191.3 2119.1 2140.8 2159.8 2162.1 2162.7 8048.8 8061.0 8109.6 8116.9 8137.9 4302.6 4444.9 4446.0 4446.9 4451.6 2839.2 2871.4 2957.2 2970.7 2976.7 817.2 848.7 942.9 971.8 983.3 10482.5 10691.3 10750.1 10768.5 10792.8 4209.0 4254.6 4309.9 4342.8 4363.5 9206.0 9211.3 9223.5 9223.5 9223.7 4530.1 4531.1 4532.9 4533.3 4535.4 3365.3 3382.4 3981.8 4020.4 4022.5 3644.7 3728.1 3797.2 3809.6 3821.9 1214.3 1225.5 1235.9 1237.4 1244.7 674.9 798.5 815.7 822.5 833.1 4995.6 5101.5 5249.8 5343.9 5364.7 819.1 864.7 880.4 882.2 885.6 3457.8 3463.8 3495.7 3520.0 3641.8 9892.6 10074.8 10214.8 10217.7 10229.1 10044.6 10087.6 10139.7 10154.2 10156.4 7430.7 7487.3 7500.3 7552.7 7633.6 5160.1 5234.7 5270.7 5328.8 5405.4 8806.3 9138.6 9267.9 9284.8 9285.7 8748.0 9119.5 9162.7 9395.2 9426.4 6940.1 6961.0 7007.4 7268.6 7549.9 7534.0 7767.9 7788.8 7798.8 7827.2 6764.6 7007.2 7075.8 7077.8 7091.1 6899.3 6926.0 6948.3 6953.3 6981.7 6415.2 6420.2 6503.6 6511.8 6513.5 4478.4 4518.5 4524.9 4556.0 4590.8 4540.1 4576.5 4636.3 4736.2 4746.8 02:02:28 INFO - PROCESS | 21919 | 02:02:28 INFO - PROCESS | 21919 | [#4] prototype.html Cycles:180 Average:4177.64 Median:4772.69 stddev:1195.32 (25.0%) stddev-sans-first:1162.40 02:02:28 INFO - PROCESS | 21919 | Values: 283.8 284.5 286.3 288.1 291.7 4835.3 4838.5 4843.9 4854.7 4879.6 4747.9 4761.5 4770.4 4775.0 4809.5 3576.7 3679.3 3705.2 3796.8 3834.6 3770.7 3789.5 3800.4 3808.6 3811.9 3560.8 3736.7 3763.8 3778.7 3787.2 3634.5 3778.8 3788.5 3789.2 3796.6 3323.3 3362.0 3362.5 3363.5 3370.7 4631.4 4656.0 4665.9 4667.6 4705.2 4219.3 4292.2 4297.7 4302.1 4319.7 4968.4 4989.2 4995.8 4997.8 5012.7 3606.2 3609.3 3612.5 3619.3 3635.8 4968.5 5195.3 5198.8 5218.6 5224.0 3681.7 3684.1 3686.1 3693.4 3722.7 3765.2 3767.7 3768.9 3775.1 3778.6 4288.2 4288.8 4289.5 4290.0 4290.6 4754.9 5022.0 5033.4 5052.2 5059.5 1320.9 1330.1 1330.5 1335.9 1342.0 851.3 857.7 895.6 921.5 927.2 4393.9 4401.5 4426.4 4435.0 4443.4 5120.9 5146.8 5148.3 5180.2 5180.4 4198.6 4400.8 4415.2 4418.9 4427.4 2720.0 2750.4 2759.6 2762.8 2768.6 4866.6 4871.1 4877.4 4883.8 4887.0 5135.8 5278.9 5298.3 5301.9 5321.8 4848.6 4876.4 4877.6 4880.1 4885.4 5176.3 5177.3 5180.0 5186.0 5187.8 4887.9 5002.5 5083.7 5086.9 5092.7 4849.2 4854.5 4865.0 4867.6 4884.6 3753.3 3755.3 3763.6 3767.2 3777.2 5008.6 5047.2 5077.2 5078.2 5221.7 4929.3 4930.6 4972.4 5019.3 5029.3 4993.8 5027.7 5030.6 5038.0 5041.5 4665.2 4736.2 4871.1 4890.8 4946.6 5014.0 5025.6 5026.3 5026.9 5030.2 4821.7 4959.2 4993.4 4998.4 4999.8 02:02:28 INFO - PROCESS | 21919 | 02:02:28 INFO - PROCESS | 21919 | [#5] yui.html Cycles:180 Average:16931.28 Median:52983.34 stddev:24018.86 (45.3%) stddev-sans-first:24055.09 02:02:28 INFO - PROCESS | 21919 | Values: 640.9 660.4 671.4 704.9 736.2 12557.5 13531.9 13558.7 13563.3 13564.9 12757.9 13159.8 13472.7 13474.0 13475.2 615.2 751.8 776.8 792.9 794.3 791.8 802.9 803.7 803.9 804.3 839.4 843.8 844.1 844.5 845.0 646.4 778.1 834.8 840.9 842.0 608.1 608.6 609.2 609.3 609.5 12986.9 12994.3 13025.7 13034.3 13048.3 12782.8 13207.9 13293.9 13524.6 13658.8 9791.6 10371.0 10510.4 10596.4 10734.5 3272.8 3280.7 3318.9 3319.8 3404.6 50761.5 52943.9 53022.7 59599.7 61494.4 10351.1 10446.8 10493.3 10566.2 10601.0 18733.3 18767.2 18817.0 18828.2 18848.0 6395.9 6548.5 6731.5 6908.4 7105.0 3663.7 3700.8 3712.2 3722.9 3724.9 2991.0 3100.3 3104.0 3107.0 3112.7 536.5 538.1 540.1 548.5 548.8 388.1 421.7 459.5 459.5 460.8 6844.7 7153.7 7278.0 7464.8 7557.8 414.6 478.9 487.0 487.7 498.3 3559.7 3634.4 3676.5 3676.6 3682.5 89208.0 89262.1 89401.0 91639.5 92719.0 77653.6 78053.2 78093.6 79237.6 84142.0 73135.6 73156.3 73781.6 73873.6 74855.6 7016.6 7058.4 7230.4 7241.3 7243.0 43630.0 45266.1 45552.8 46435.8 47006.8 57443.0 57730.4 59054.4 63076.7 64485.4 8426.7 8650.3 8751.1 8782.2 8820.3 10224.1 10297.9 10333.1 10349.8 10360.9 8493.7 10146.7 10329.7 11257.4 11438.3 10970.4 11001.7 11477.3 11980.3 12077.2 10508.4 10550.9 10622.8 10834.2 10995.5 9140.6 9239.1 9411.2 9707.1 9786.5 9783.8 9907.0 9943.6 9989.5 10028.3 02:02:28 INFO - PROCESS | 21919 | -------- Summary: end -------- 02:02:28 INFO - PROCESS | 21919 | 02:02:29 INFO - TEST-INFO | 21919: exit 0 02:02:29 INFO - TEST-OK | dromaeo_css | took 1120441ms 02:02:29 INFO - TEST-START | kraken 02:02:29 INFO - operating with platform_type : linux_ 02:02:29 INFO - Initialising browser for kraken test... 02:02:29 INFO - TEST-INFO | started process 22105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPMPfKJ/profile http://localhost:58587/getInfo.html) 02:02:33 INFO - PROCESS | 22105 | __metrics Screen width/height:1600/1200 02:02:33 INFO - PROCESS | 22105 | colorDepth:24 02:02:33 INFO - PROCESS | 22105 | Browser inner width/height: 1024/697 02:02:33 INFO - PROCESS | 22105 | __metrics 02:02:34 INFO - PROCESS | 22105 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:02:35 INFO - TEST-INFO | 22105: exit 0 02:02:35 INFO - Browser initialized. 02:02:35 INFO - Running cycle 1/1 for kraken test... 02:02:35 INFO - TEST-INFO | started process 22184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPMPfKJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:02:47 INFO - PROCESS | 22184 | RSS: Main: 175063040 02:02:47 INFO - PROCESS | 22184 | 02:02:50 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:58587/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58587/tests/kraken/driver.html?testName=audio-beat-detection) 02:02:51 INFO - PROCESS | 22184 | RSS: Main: 234205184 02:02:51 INFO - PROCESS | 22184 | 02:02:54 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:58587/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58587/tests/kraken/driver.html?testName=audio-dft) 02:02:54 INFO - PROCESS | 22184 | RSS: Main: 220450816 02:02:54 INFO - PROCESS | 22184 | 02:02:58 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:58587/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58587/tests/kraken/driver.html?testName=audio-fft) 02:02:58 INFO - PROCESS | 22184 | RSS: Main: 289071104 02:02:58 INFO - PROCESS | 22184 | 02:03:00 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:58587/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58587/tests/kraken/driver.html?testName=audio-oscillator) 02:03:01 INFO - PROCESS | 22184 | RSS: Main: 199159808 02:03:01 INFO - PROCESS | 22184 | 02:03:03 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:58587/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58587/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:03:04 INFO - PROCESS | 22184 | RSS: Main: 203374592 02:03:04 INFO - PROCESS | 22184 | 02:03:07 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:58587/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58587/tests/kraken/driver.html?testName=imaging-darkroom) 02:03:08 INFO - PROCESS | 22184 | RSS: Main: 239116288 02:03:08 INFO - PROCESS | 22184 | 02:03:11 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:58587/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58587/tests/kraken/driver.html?testName=imaging-desaturate) 02:03:12 INFO - PROCESS | 22184 | RSS: Main: 235069440 02:03:12 INFO - PROCESS | 22184 | 02:03:15 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:58587/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58587/tests/kraken/driver.html?testName=json-parse-financial) 02:03:15 INFO - PROCESS | 22184 | RSS: Main: 237477888 02:03:15 INFO - PROCESS | 22184 | 02:03:17 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:58587/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58587/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:03:18 INFO - PROCESS | 22184 | RSS: Main: 225456128 02:03:18 INFO - PROCESS | 22184 | 02:03:20 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:58587/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58587/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:03:20 INFO - PROCESS | 22184 | RSS: Main: 230326272 02:03:20 INFO - PROCESS | 22184 | 02:03:22 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:58587/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58587/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:03:23 INFO - PROCESS | 22184 | RSS: Main: 238088192 02:03:23 INFO - PROCESS | 22184 | 02:03:26 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:58587/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58587/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:03:26 INFO - PROCESS | 22184 | RSS: Main: 242716672 02:03:26 INFO - PROCESS | 22184 | 02:03:29 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:58587/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58587/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:03:30 INFO - PROCESS | 22184 | RSS: Main: 244162560 02:03:30 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:58587/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58587/tests/kraken/driver.html?testName=ai-astar) 02:03:32 INFO - PROCESS | 22184 | RSS: Main: 286658560 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | __start_tp_report 02:03:32 INFO - PROCESS | 22184 | _x_x_mozilla_page_load 02:03:32 INFO - PROCESS | 22184 | _x_x_mozilla_page_load_details 02:03:32 INFO - PROCESS | 22184 | |i|pagename|runs| 02:03:32 INFO - PROCESS | 22184 | |0;ai-astar;112;106;111;113;113;113;112;113;113;112 02:03:32 INFO - PROCESS | 22184 | |1;audio-beat-detection;168;134;133;199;140;134;156;141;173;132 02:03:32 INFO - PROCESS | 22184 | |2;audio-dft;161;162;162;163;163;162;161;164;167;161 02:03:32 INFO - PROCESS | 22184 | |3;audio-fft;75;77;76;105;76;77;75;75;99;75 02:03:32 INFO - PROCESS | 22184 | |4;audio-oscillator;87;87;121;86;86;86;121;87;86;136 02:03:32 INFO - PROCESS | 22184 | |5;imaging-gaussian-blur;118;117;116;116;116;118;118;117;117;117 02:03:32 INFO - PROCESS | 22184 | |6;imaging-darkroom;146;146;146;147;148;147;146;147;147;218 02:03:32 INFO - PROCESS | 22184 | |7;imaging-desaturate;95;95;95;95;95;95;94;94;94;95 02:03:32 INFO - PROCESS | 22184 | |8;json-parse-financial;63;64;63;63;63;64;63;63;62;63 02:03:32 INFO - PROCESS | 22184 | |9;json-stringify-tinderbox;66;66;65;66;66;65;66;66;66;67 02:03:32 INFO - PROCESS | 22184 | |10;stanford-crypto-aes;83;83;83;82;84;85;84;85;120;83 02:03:32 INFO - PROCESS | 22184 | |11;stanford-crypto-ccm;144;133;132;136;129;139;128;131;150;134 02:03:32 INFO - PROCESS | 22184 | |12;stanford-crypto-pbkdf2;170;172;176;173;168;173;171;171;167;169 02:03:32 INFO - PROCESS | 22184 | |13;stanford-crypto-sha256-iterative;68;68;66;66;67;67;69;68;67;69 02:03:32 INFO - PROCESS | 22184 | __end_tp_report 02:03:32 INFO - PROCESS | 22184 | __start_cc_report 02:03:32 INFO - PROCESS | 22184 | _x_x_mozilla_cycle_collect,1927 02:03:32 INFO - PROCESS | 22184 | __end_cc_report 02:03:32 INFO - PROCESS | 22184 | __startTimestamp1466067812465__endTimestamp 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | ------- Summary: start ------- 02:03:32 INFO - PROCESS | 22184 | Number of tests: 14 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:2.15 (1.9%) stddev-sans-first:2.28 02:03:32 INFO - PROCESS | 22184 | Values: 112.0 106.0 111.0 113.0 113.0 113.0 112.0 113.0 113.0 112.0 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:148.50 stddev:22.57 (15.2%) stddev-sans-first:23.09 02:03:32 INFO - PROCESS | 22184 | Values: 168.0 134.0 133.0 199.0 140.0 134.0 156.0 141.0 173.0 132.0 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:1.84 (1.1%) stddev-sans-first:1.86 02:03:32 INFO - PROCESS | 22184 | Values: 161.0 162.0 162.0 163.0 163.0 162.0 161.0 164.0 167.0 161.0 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:11.19 (14.7%) stddev-sans-first:11.65 02:03:32 INFO - PROCESS | 22184 | Values: 75.0 77.0 76.0 105.0 76.0 77.0 75.0 75.0 99.0 75.0 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | [#4] audio-oscillator Cycles:10 Average:98.30 Median:86.00 stddev:19.55 (22.7%) stddev-sans-first:20.30 02:03:32 INFO - PROCESS | 22184 | Values: 87.0 87.0 121.0 86.0 86.0 86.0 121.0 87.0 86.0 136.0 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 02:03:32 INFO - PROCESS | 22184 | Values: 118.0 117.0 116.0 116.0 116.0 118.0 118.0 117.0 117.0 117.0 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | [#6] imaging-darkroom Cycles:10 Average:153.80 Median:147.00 stddev:22.57 (15.4%) stddev-sans-first:23.76 02:03:32 INFO - PROCESS | 22184 | Values: 146.0 146.0 146.0 147.0 148.0 147.0 146.0 147.0 147.0 218.0 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:03:32 INFO - PROCESS | 22184 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 02:03:32 INFO - PROCESS | 22184 | Values: 63.0 64.0 63.0 63.0 63.0 64.0 63.0 63.0 62.0 63.0 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 02:03:32 INFO - PROCESS | 22184 | Values: 66.0 66.0 65.0 66.0 66.0 65.0 66.0 66.0 66.0 67.0 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:83.50 stddev:11.56 (13.8%) stddev-sans-first:12.17 02:03:32 INFO - PROCESS | 22184 | Values: 83.0 83.0 83.0 82.0 84.0 85.0 84.0 85.0 120.0 83.0 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:135.00 stddev:6.95 (5.1%) stddev-sans-first:6.67 02:03:32 INFO - PROCESS | 22184 | Values: 144.0 133.0 132.0 136.0 129.0 139.0 128.0 131.0 150.0 134.0 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:171.50 stddev:2.67 (1.6%) stddev-sans-first:2.80 02:03:32 INFO - PROCESS | 22184 | Values: 170.0 172.0 176.0 173.0 168.0 173.0 171.0 171.0 167.0 169.0 02:03:32 INFO - PROCESS | 22184 | 02:03:32 INFO - PROCESS | 22184 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.08 (1.6%) stddev-sans-first:1.13 02:03:32 INFO - PROCESS | 22184 | Values: 68.0 68.0 66.0 66.0 67.0 67.0 69.0 68.0 67.0 69.0 02:03:32 INFO - PROCESS | 22184 | -------- Summary: end -------- 02:03:32 INFO - PROCESS | 22184 | 02:03:33 INFO - TEST-INFO | 22184: exit 0 02:03:33 INFO - TEST-OK | kraken | took 64044ms 02:03:33 INFO - SUITE-END | took 1184s 02:03:33 INFO - Completed test suite (00:19:44) 02:03:33 INFO - javascript benchmark 02:03:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.9868350658244, 2637.1165659504063, 2685.5971604259366, 2693.461307738453, 2697.9747695875562, 4702.764861756916, 4764.999350136472, 4776.949071204338, 4851.902961940759, 4920.901581968363, 4804.20730579454, 4811.10994466024, 4813.278008298748, 4860.100881336955, 4873.5613794758465, 4301.204277208726, 4419.491758447787, 4428.291473364262, 4457.799399027035, 4593.655475839309, 4519.887002824939, 4538.228501154812, 4562.315652652095, 4573.49691533931, 4600.953990460102, 4339.47926248849, 4399.076193999264, 4407.008423104808, 4425.690201685883, 4458.621017213541, 4353.84761533348, 4355.194289056535, 4357.085012147453, 4401.405810215612, 4407.449068866392, 4385.188740083063, 4451.198784218839, 4454.443194600675, 4464.553544645542, 4465.419495465569, 4645.163870503308, 4687.929681054787, 4746.667733258673, 4750.216214324632, 4818.445878723956, 5187.170052791535, 5192.0394726975255, 5209.791608335662, 5215.426303106655, 5217.713025783581, 5199.324087868591, 5234.110201265794, 5234.659747116425, 5237.790488380499, 5241.842744717665, 4705.294205869147, 4728.976355118271, 4748.169070412664, 4754.5245475452175, 4787.976060119747, 5241.606879484054, 5270.183121616155, 5318.97340513295, 5322.707251101227, 5323.1216849219445, 5054.039732450822, 5090.032893750175, 5095.133827249377, 5107.6169287302855, 5110.744462776846, 5021.171506701354, 5108.131617625013, 5140.460251673595, 5150.227465880073, 5150.793968241228, 5120.615953803405, 5130.358705161855, 5131.307273518102, 5131.589472842164, 5188.610854185876, 4973.651844370932, 5086.440491545927, 5102.209157580581, 5116.155834287301, 5124.154514505065, 4312.482502099768, 4365.934510982338, 4402.471703395549, 4404.647628189737, 4419.226635338803, 3804.8668296609485, 3826.081740382288, 3833.9041523962123, 3863.8840834775, 3867.497225360685, 4313.2883074292395, 4398.516163222043, 4407.37113683927, 4409.14021765759, 4438.312061630452, 5118.053160165381, 5144.408393034774, 5173.0, 5188.8962220755375, 5203.791848326025, 4376.387305777193, 4388.385626012361, 4420.624246939046, 4421.977890110529, 4441.133978874089, 4614.261718125151, 4670.556297151765, 4698.8355407560575, 4718.88202794926, 4747.667663263607, 4849.781759820887, 4886.462489126122, 4905.215165573634, 4909.533594308535, 4956.454789973028, 5228.294180285765, 5228.63399562027, 5248.396434409939, 5255.395629502656, 5302.416734159317, 4735.33705281254, 4776.331313616166, 4784.6889952153, 4907.3620429343955, 4927.310176575354, 5061.898762024813, 5081.136206844772, 5088.1604535252745, 5089.160288552347, 5129.410117836496, 5136.871578210575, 5166.354205724285, 5168.715720635401, 5170.741462926914, 5208.557272631869, 4914.557689807934, 4994.750262486788, 5024.57291130258, 5024.924626130684, 5054.620903432184, 5046.899062018666, 5063.0, 5073.137566613611, 5075.264086707481, 5123.5388815005335, 4966.627502937222, 4970.030843985388, 5021.397432308147, 5023.196288593807, 5028.798848046037, 4944.0, 4985.5762260208285, 5015.724135172601, 5037.471065538066, 5069.847904562869, 4909.1899836528, 4941.481144479778, 4945.8021679132435, 4969.552740253394, 5014.799408023784], "value": 4734.601230271114, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.9224552028716, 578.1645522220391, 584.5411352088609, 591.1841658511254, 597.4294548705985, 27216.863915680442, 38600.22799544007, 39696.60303396965, 39712.0, 39741.40387894177, 41105.58894411055, 41500.58499415005, 41528.792356038255, 41576.58423415765, 41587.168256634846, 7572.432067594925, 7958.6418611162635, 8090.190980901922, 8091.069527004411, 10146.086852183302, 10030.39817610942, 10417.479126043705, 10426.113780328682, 10428.582856685762, 10429.791404171912, 10376.273660843744, 10430.061294483496, 10438.843417348746, 10440.216983726252, 10440.895591044105, 7653.234676532358, 10252.487375631188, 10329.84505232422, 10543.103836173934, 10554.947225263824, 10021.298509104365, 10389.376637401705, 10405.947970260177, 10410.219233557438, 10414.791704165875, 38407.0, 38876.222475550334, 38913.80543097295, 38949.61050389488, 38951.805240973896, 2988.13344130202, 3130.624325080982, 3456.792592444436, 3520.700740437066, 3758.661720445146, 29785.106446806414, 29999.400011999856, 30062.84968575165, 30103.096907092822, 30527.694723052708, 3331.1838599543266, 3363.596368435779, 3419.589649242082, 3445.1214940190343, 3450.1547120955274, 253286.0, 255705.0, 255874.0, 256019.0, 258239.0, 32157.51763723546, 55448.72275638596, 56326.0, 56350.0, 56370.0, 33132.171695707315, 34946.82526587402, 34999.12502187415, 35000.29999399998, 35002.12494687653, 11551.711207219718, 11629.65111046653, 11652.76694466106, 11683.707907302216, 11685.766284674259, 8317.209865062809, 9140.954295228481, 9366.531673416303, 9374.203192728695, 9651.613935442643, 8041.557714325768, 8043.477173983672, 8061.4760040597175, 8095.959520202479, 8157.551334676531, 3181.9522707159413, 3200.4239236937574, 3200.9839950800097, 3236.3527294541186, 3268.166617512519, 898.447454815297, 902.2105657549644, 924.3806649544821, 953.0850383631653, 976.5410257179115, 26913.596296055573, 28380.574291385645, 28816.279593010342, 28821.423571528452, 28951.276218094717, 920.3281604428804, 933.5959903249025, 966.8308046091905, 967.6129548180784, 984.3208186351395, 14066.718665626835, 14595.635109122357, 14608.634784130481, 14842.92578537122, 14868.479603213835, 196885.0, 198900.0, 199307.0, 199377.0, 199478.0, 48644.0, 49362.0, 49410.505894940594, 49492.75253623781, 49519.75240123848, 1085.5277954089838, 1120.2102517724823, 1124.5726623882872, 1197.3115458611333, 1233.3956361382857, 23362.0, 28122.71877281201, 30176.0, 30893.0, 31082.0, 45579.54420455886, 46575.369862056024, 46627.30059049049, 46699.76650116728, 46711.53288467072, 372794.0, 384520.0, 384783.0, 385176.0, 385729.0, 22307.0, 24319.0, 24954.37614059663, 25344.366390840376, 25688.8715556421, 40579.0, 40698.0, 40729.592704073766, 41923.371149432176, 42014.78992605017, 35051.47422788711, 35179.29641407209, 35561.288774224886, 35777.64222357743, 36018.27963440769, 32310.83844580762, 34830.0, 35426.11434714153, 35665.82167089148, 35685.0, 34241.828790855885, 34285.057218419206, 34725.30549389048, 34743.4788478168, 34959.0, 30627.387452251274, 31540.842295788374, 31686.68313316837, 31723.524147138272, 31820.204494887814, 24462.63306050375, 24489.0, 24638.0, 24789.87605061963, 24948.251552453454], "value": 16674.7457340485, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.20804873546246, 369.58421775502575, 370.21699106389985, 376.5293383270911, 389.0410139007348, 15967.361305547778, 16589.83410165898, 17093.461588457052, 17281.395151169712, 17342.82657173428, 14274.857251427482, 14651.267436628179, 15244.618884527892, 15250.84749152508, 15252.618684532865, 4861.270809378595, 5197.844064678046, 5230.555402790767, 5266.894662106774, 5267.446918073604, 3662.10278481771, 5122.897542049157, 5782.392848750884, 6132.4480796728285, 6149.754009839623, 6189.102580125879, 6199.9690001549925, 6213.409726076015, 6218.160548325986, 6221.844453888666, 5167.276581278624, 5455.781768729246, 5459.344878614572, 5497.752601132958, 5527.198556209368, 3350.748693847947, 4958.801647934079, 5250.343707036621, 5251.317328747238, 5334.813281535166, 12078.456469458895, 12168.81746773799, 12572.811407828889, 12673.619791406272, 12792.360381980863, 1775.3608700867678, 1952.8828270303827, 2124.8618839775518, 2393.042782886842, 2395.796357309631, 9057.637694492212, 9078.364514483988, 9393.389429687048, 9535.809283814286, 9602.807943841153, 1560.6488540078506, 1719.0545200139873, 1736.0, 1737.2616637928957, 1767.5227688524155, 63774.681126594536, 64177.0, 64789.676051619914, 67759.98360024604, 68225.9999999995, 9938.701838944844, 10130.189584833342, 10160.0, 10167.644132455476, 10972.506237219344, 13842.86157138436, 14017.229052402012, 14065.71868562623, 14085.788713169311, 14099.85900141006, 6810.965945170243, 6890.276520965226, 6956.65216739161, 6995.265497122728, 7040.3663670269925, 6266.561340706106, 6278.4035516625845, 6278.466330361879, 6393.073004414334, 6417.9679101605125, 4348.869533913988, 4370.409994650681, 4383.60547550722, 4419.337099435111, 4505.571970662847, 1593.529908676943, 1686.1232159277108, 1766.0352508617977, 1825.6805059114602, 1827.2873579304082, 780.9414293927978, 808.8705807070841, 816.2123550773532, 903.46695449685, 904.9140331668481, 16133.515994520183, 16163.67672646564, 16480.752788708178, 16507.0, 16611.169441527876, 797.5453991224946, 805.2149154574361, 821.9712310069119, 827.0365024746224, 844.0588743551019, 9249.306302027375, 9331.953340233254, 9356.95321523388, 9450.621975120917, 9723.708288751348, 351542.0, 352317.0, 367287.0, 376438.0, 381675.0, 47124.0, 68892.31107688959, 70429.29570704227, 76938.23061769422, 82012.0, 880.1330689271191, 896.0859922878627, 917.8347897378536, 921.6129225725211, 950.2587981374677, 15300.693986120437, 15555.066695998275, 15579.922100389425, 15821.0, 16033.0, 30016.849915751154, 30768.384632307676, 32368.35263294768, 36950.81524592467, 37144.0, 48768.512314876396, 50303.74848125736, 50373.0, 50587.24119138142, 50737.70204936667, 7686.3850891927395, 7705.1524332324525, 7715.459917805924, 7832.412569057229, 7871.803204919694, 8607.225349718556, 11563.826542601699, 11928.343941083323, 12024.879751202376, 12073.396330183632, 9957.402555846673, 10514.842277365693, 10541.420221887869, 10703.304285221435, 10905.672829815117, 10463.843042354523, 10633.096186824207, 10860.728481787703, 10888.237823352607, 10922.344659320466, 10282.794344112926, 10835.458227088457, 10942.452877355941, 10958.0, 11195.664130076111, 7836.177201393772, 7860.4104692147175, 8018.118007019107, 8072.878906816285, 8205.261526462647, 9867.45728984884, 10067.949660251652, 10126.44304563256, 10260.179185665278, 10522.263441559018], "value": 7999.435448826427, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1187.6733898178006, 1352.3981828086498, 1379.9931000344998, 1395.3790563199375, 1670.5740036290736, 7466.738664146756, 7876.803079922997, 7878.094019187795, 7998.440109192359, 8014.7194848180325, 7799.532028078319, 7955.681772729098, 7974.122846486896, 7980.481268717529, 7984.760457186294, 1883.5761953560407, 1946.2896042944294, 1955.0, 2153.4508700281444, 2181.0839447432036, 2004.3886614582545, 2105.884176370299, 2177.8148857347146, 2182.694422780812, 2199.076387917071, 1979.2775636892575, 2001.2095222387147, 2011.306099395706, 2017.1931227508967, 2017.9899100504476, 2115.090511080235, 2180.1061564758534, 2186.606410846055, 2189.37602783206, 2191.2659259148204, 2119.1205649655376, 2140.785921407862, 2159.7948194921455, 2162.10272736814, 2162.664786958024, 8048.798780030487, 8061.032676078849, 8109.553974531398, 8116.8782468263025, 8137.918620813834, 4302.634276086536, 4444.888877778049, 4446.0, 4446.888827779331, 4451.599356057938, 2839.176638774753, 2871.3826527296733, 2957.2311199088176, 2970.658374286963, 2976.7023297670275, 817.2318021060184, 848.6732607945924, 942.8868535775682, 971.8299297622888, 983.306768728045, 10482.528286227138, 10691.251612387136, 10750.086242669382, 10768.515416806262, 10792.838107428395, 4209.0, 4254.553271906405, 4309.913801723948, 4342.782860856944, 4363.52001279859, 9206.0, 9211.30915181364, 9223.538823058954, 9223.538823058954, 9223.723288301362, 4530.07133537624, 4531.116432295671, 4532.9093418132115, 4533.274676051816, 4535.4103966484145, 3365.3437579671727, 3382.4418970870024, 3981.8009099544906, 4020.3567429211184, 4022.4770779798437, 3644.6902013328636, 3728.12389088564, 3797.240551889633, 3809.6190380962234, 3821.9044523887123, 1214.2653694514868, 1225.5281716539018, 1235.9134860559855, 1237.449335045914, 1244.67638414013, 674.8751480976035, 798.5248776977689, 815.6900377856376, 822.4695071678734, 833.0794472108354, 4995.600351971833, 5101.464346243591, 5249.790008399697, 5343.919841202385, 5364.6512976656395, 819.1399031017407, 864.6757465950269, 880.3705350674298, 882.2368651116866, 885.6103314541581, 3457.8098204598487, 3463.809490478048, 3495.720342372604, 3520.0319912024397, 3641.8361173747244, 9892.60429582823, 10074.798504029879, 10214.846777298346, 10217.74455638615, 10229.079382855578, 10044.648437304659, 10087.646932357478, 10139.695809125738, 10154.187664986783, 10156.39061656303, 7430.7399241026305, 7487.288707572772, 7500.324970752658, 7552.697892084255, 7633.625947329534, 5160.122779127632, 5234.659747116425, 5270.7101109439345, 5328.8401347959625, 5405.432429594994, 8806.251468625238, 9138.588763505526, 9267.860982085409, 9284.767880802763, 9285.675001374919, 8748.0, 9119.544022798966, 9162.679306224516, 9395.24838012971, 9426.387284826464, 6940.13248343957, 6960.965195173992, 7007.404370628554, 7268.563886166847, 7549.924500755142, 7534.0, 7767.92232077672, 7788.805279868048, 7798.766037018899, 7827.217278272127, 6764.594124352555, 7007.229204787572, 7075.787726368218, 7077.823054423475, 7091.1490621125795, 6899.344562266577, 6925.965370173117, 6948.270431604608, 6953.33943275388, 6981.650917454209, 6415.166028416276, 6420.1974753155855, 6503.577267477599, 6511.804645860631, 6513.478921686348, 4478.440194975628, 4518.480374756814, 4524.88687782808, 4555.9544404556855, 4590.816367345269, 4540.137373898949, 4576.473705523774, 4636.250311642982, 4736.194846876108, 4746.833860814855], "value": 4149.205420792846, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.8197744432285, 284.47514336050006, 286.25573508876914, 288.12266648056664, 291.7010064683699, 4835.274708793679, 4838.467768545457, 4843.927341089878, 4854.660173787832, 4879.634027447938, 4747.93171536405, 4761.4763275751775, 4770.425759499366, 4774.952250477494, 4809.533092406815, 3576.660217279354, 3679.2641471705633, 3705.2033812730256, 3796.7721936683747, 3834.6357096075826, 3770.660640542351, 3789.5263092113487, 3800.353939830222, 3808.5810560838286, 3811.9047023824487, 3560.8397622106936, 3736.7010639148803, 3763.811809409532, 3778.6599206071446, 3787.223619158066, 3634.473001414793, 3778.7921664308587, 3788.4696142540065, 3789.1853251551047, 3796.620337966209, 3323.3187196624635, 3362.041818081835, 3362.4788157835574, 3363.5122907178566, 3370.7303415726683, 4631.374764406795, 4655.976720116378, 4665.906681866344, 4667.579917807414, 4705.200115980258, 4219.261629214875, 4292.18448494785, 4297.742135471882, 4302.139572085595, 4319.654427645781, 4968.354113965198, 4989.226669866177, 4995.825980894487, 4997.825076122354, 5012.699238045729, 3606.206634540397, 3609.2781443711365, 3612.548431446069, 3619.2942376236642, 3635.800030998294, 4968.54057241664, 5195.2986346843445, 5198.844034678966, 5218.5825133989565, 5223.973880130613, 3681.650243226889, 3684.1158122050515, 3686.078480379905, 3693.372126738461, 3722.739408241451, 3765.2281282337053, 3767.7362584619364, 3768.9246215075545, 3775.112848480605, 3778.6221377861993, 4288.2281189385585, 4288.807003684841, 4289.506706728766, 4289.978550107292, 4290.635295999875, 4754.857354279377, 5021.974890125599, 5033.364156649103, 5052.242163675404, 5059.494050594911, 1320.8877245434246, 1330.1221194011905, 1330.5143622577882, 1335.9045582622157, 1341.9798703019462, 851.2976794144855, 857.7083791510917, 895.6104094718818, 921.4701546610726, 927.2072378116613, 4393.923488745214, 4401.525488961234, 4426.380306757057, 4435.028530884315, 4443.422355093817, 5120.948790512121, 5146.768395422215, 5148.253503242009, 5180.197069454241, 5180.378354597472, 4198.6011328923705, 4400.779961001937, 4415.183191109655, 4418.9337159942625, 4427.446569178853, 2719.972800271972, 2750.436160587075, 2759.558470644687, 2762.8342299462097, 2768.5985532098134, 4866.562009419169, 4871.14754917888, 4877.3903262092235, 4883.755812209375, 4886.951130488721, 5135.768890399866, 5278.8944221116135, 5298.311219541435, 5301.867453313698, 5321.787128514893, 4848.587870031087, 4876.390451193601, 4877.585405240523, 4880.072786170616, 4885.413750349981, 5176.275321455075, 5177.301064356264, 5179.974100129475, 5185.974070129625, 5187.844364669066, 4887.90224195507, 5002.52476014778, 5083.72039537829, 5086.872828179326, 5092.694438333712, 4849.175640141255, 4854.543636908843, 4865.002674451658, 4867.610591152628, 4884.5603895649565, 3753.2868754936476, 3755.267722794029, 3763.6101075816505, 3767.171222331083, 3777.1690228149764, 5008.649394542493, 5047.2429135629945, 5077.187649976134, 5078.162103252922, 5221.686698798084, 4929.309896614405, 4930.6055515557955, 4972.414344540891, 5019.322391477104, 5029.29589857413, 4993.750312484434, 5027.698338099725, 5030.572401345927, 5038.0, 5041.521055499722, 4665.2069148245555, 4736.194846876108, 4871.147549178951, 4890.779914903766, 4946.554810067111, 5014.0, 5025.597952163891, 5026.271190677405, 5026.899462010812, 5030.170021946338, 4821.734804585782, 4959.156943319572, 4993.4257560379565, 4998.350214472095, 4999.775010124626], "value": 3797.540118274693, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.9423151916327, 660.4485254812231, 671.399097807462, 704.8519810839722, 736.2159300345132, 12557.497700091997, 13531.864681353183, 13558.728825423486, 13563.254021028852, 13564.932175339109, 12757.872421275784, 13159.802602960963, 13472.730545389086, 13474.0, 13475.191488510673, 615.2186722861962, 751.7519218657857, 776.8329809091044, 792.9167437419075, 794.297047113306, 791.8495485857698, 802.9076656184526, 803.6945960535018, 803.8753993131074, 804.3243675312737, 839.3914412051275, 843.7553109598209, 844.0968164064453, 844.543946269014, 845.023997283139, 646.4053071174484, 778.0663204155037, 834.8455535725849, 840.9075001749802, 841.970531031414, 608.084832327349, 608.6013661052018, 609.2049874913237, 609.3053918532831, 609.5276160975279, 12986.935065324707, 12994.28531430771, 13025.674358141028, 13034.348282585834, 13048.28234447105, 12782.808257876139, 13207.933960330136, 13293.867061329456, 13524.594242270503, 13658.795118073236, 9791.559379827924, 10371.0, 10510.369377837354, 10596.41719705416, 10734.463276836126, 3272.803631782077, 3280.6719328067243, 3318.900432987014, 3319.7842140261046, 3404.5914490261325, 50761.49238507642, 52943.94112117736, 53022.73488632571, 59599.70200149015, 61494.38505614932, 10351.06840384369, 10446.791064178673, 10493.317934334244, 10566.207534434794, 10601.038807820578, 18733.34433294828, 18767.24931002772, 18817.0, 18828.15273312704, 18848.0, 6395.872082558323, 6548.541602087808, 6731.49513786468, 6908.412784913338, 7105.0, 3663.670269675742, 3700.7594506357, 3712.201876596491, 3722.8510859565313, 3724.9068773280883, 2990.970090299069, 3100.2869340051916, 3103.953440698391, 3107.02128829418, 3112.7198552130417, 536.506414099022, 538.0825692194799, 540.1115165552723, 548.4844246408443, 548.7503186050337, 388.0821856309807, 421.6647765026811, 459.5037359651568, 459.53586877254213, 460.7903403951194, 6844.657767111625, 7153.678084486107, 7277.963610181915, 7464.813379665552, 7557.848843023109, 414.5916272471613, 478.9257665061921, 486.9975650121727, 487.68056922715675, 498.3496537019225, 3559.6618321259957, 3634.3821550336506, 3676.4669122977552, 3676.6139555346303, 3682.4660424238873, 89208.0, 89262.10737892539, 89401.0, 91639.54180229057, 92719.0, 77653.6117319421, 78053.21946780459, 78093.60953195198, 79237.60381198057, 84142.0, 73135.63432182805, 73156.26843731494, 73781.6310918442, 73873.63063184649, 74855.62572187213, 7016.6491675415, 7058.435325174077, 7230.42156627479, 7241.312075352833, 7242.963785181251, 43630.0, 45266.094678106914, 45552.772236139936, 46435.767821160676, 47006.76496617495, 57443.0, 57730.422695774185, 59054.40945590661, 63076.684616576626, 64485.35514644981, 8426.73598960161, 8650.30797536183, 8751.124887511452, 8782.165694259034, 8820.25027872638, 10224.13094886943, 10297.9485102577, 10333.121684656888, 10349.793004140025, 10360.860305366254, 8493.745187644381, 10146.695599132037, 10329.74175645615, 11257.437128143723, 11438.313701177956, 10970.396628185206, 11001.724956876142, 11477.311361318347, 11980.341081240615, 12077.154599177973, 10508.369497830156, 10550.892156323782, 10622.8406573903, 10834.241603087708, 10995.505202265756, 9140.63437462494, 9239.122283383067, 9411.200047995997, 9707.126358627474, 9786.51067446639, 9783.752249983761, 9907.0, 9943.552540135855, 9989.459012544461, 10028.348157369748], "value": 6267.586092812742, "unit": "score"}], "name": "dromaeo_css", "value": 6297.51720591621, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 134.0, 133.0, 199.0, 140.0, 134.0, 156.0, 141.0, 173.0, 132.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 163.0, 162.0, 161.0, 164.0, 167.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 105.0, 76.0, 77.0, 75.0, 75.0, 99.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 121.0, 86.0, 86.0, 86.0, 121.0, 87.0, 86.0, 136.0], "value": 98.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 116.0, 116.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 218.0], "value": 153.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 62.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 67.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 84.0, 85.0, 84.0, 85.0, 120.0, 83.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 133.0, 132.0, 136.0, 129.0, 139.0, 128.0, 131.0, 150.0, 134.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 176.0, 173.0, 168.0, 173.0, 171.0, 171.0, 167.0, 169.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 66.0, 67.0, 67.0, 69.0, 68.0, 67.0, 69.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1560.5, "alertThreshold": 2.0}]} 02:03:33 INFO - Return code: 0 02:03:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:03:33 INFO - # TBPL SUCCESS # 02:03:33 INFO - Running post-action listener: _resource_record_post_action 02:03:33 INFO - ##### 02:03:33 INFO - ##### Finished run-tests step (success) 02:03:33 INFO - ##### 02:03:33 INFO - Running post-run listener: _resource_record_post_run 02:03:33 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 550072320; Read time: 0; Write time: 428624 02:03:33 INFO - TinderboxPrint: CPU usage
13.1% 02:03:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:03:33 INFO - TinderboxPrint: I/O write bytes / time
550,072,320 / 428,624 02:03:33 INFO - TinderboxPrint: CPU idle
8,330.8 (86.8%) 02:03:33 INFO - TinderboxPrint: CPU user
1,215.2 (12.7%) 02:03:33 INFO - TinderboxPrint: Swap in / out
0 / 0 02:03:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252145664; Read time: 0; Write time: 230240 02:03:33 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 297926656; Read time: 0; Write time: 198384 02:03:34 INFO - Running post-run listener: _upload_blobber_files 02:03:34 INFO - Blob upload gear active. 02:03:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:03:34 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 02:03:34 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:03:34 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:03:34 INFO - (blobuploader) - INFO - Open directory for files ... 02:03:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:03:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:03:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:03:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:03:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:03:35 INFO - (blobuploader) - INFO - Done attempting. 02:03:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:03:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:03:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:03:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:03:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:03:39 INFO - (blobuploader) - INFO - Done attempting. 02:03:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:03:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:03:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:03:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:03:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:03:40 INFO - (blobuploader) - INFO - Done attempting. 02:03:40 INFO - (blobuploader) - INFO - Iteration through files over. 02:03:40 INFO - Return code: 0 02:03:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:03:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:03:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2f03b1540d25462ba1f15ba79fd702d665c618829f26c0abf0a2c323b0ca93c9759b7650530ee442f480bbbe5cfd1a6d7d948fbd8c0d62fee949928f905a881", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eedb6629edfc89de92deca564e9d80cc33ebafaea4da3e45ee8e98631654cc4e26c5d9476e7da52212003f42bc0ea8eae6f8fc5b69c04681c796b36f462c9d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68eff3eba8ece443a93c01de0bbed1985080078de70bf0ff86cf2fb1c7cd792bef0a1b8117a68a2e3821c65550f7e59114e4c631a295d7d8cb4d54d68fe3e94d"} 02:03:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:03:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:03:40 INFO - Contents: 02:03:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2f03b1540d25462ba1f15ba79fd702d665c618829f26c0abf0a2c323b0ca93c9759b7650530ee442f480bbbe5cfd1a6d7d948fbd8c0d62fee949928f905a881", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eedb6629edfc89de92deca564e9d80cc33ebafaea4da3e45ee8e98631654cc4e26c5d9476e7da52212003f42bc0ea8eae6f8fc5b69c04681c796b36f462c9d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68eff3eba8ece443a93c01de0bbed1985080078de70bf0ff86cf2fb1c7cd792bef0a1b8117a68a2e3821c65550f7e59114e4c631a295d7d8cb4d54d68fe3e94d"} 02:03:40 INFO - Running post-run listener: copy_logs_to_upload_dir 02:03:40 INFO - Copying logs to upload dir... 02:03:40 INFO - mkdir: /builds/slave/test/build/upload/logs 02:03:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.780403 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-06-16 02:03:39.014737) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 02:03:39.017976) ========= 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=ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2f03b1540d25462ba1f15ba79fd702d665c618829f26c0abf0a2c323b0ca93c9759b7650530ee442f480bbbe5cfd1a6d7d948fbd8c0d62fee949928f905a881", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eedb6629edfc89de92deca564e9d80cc33ebafaea4da3e45ee8e98631654cc4e26c5d9476e7da52212003f42bc0ea8eae6f8fc5b69c04681c796b36f462c9d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68eff3eba8ece443a93c01de0bbed1985080078de70bf0ff86cf2fb1c7cd792bef0a1b8117a68a2e3821c65550f7e59114e4c631a295d7d8cb4d54d68fe3e94d"} build_url:https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d2f03b1540d25462ba1f15ba79fd702d665c618829f26c0abf0a2c323b0ca93c9759b7650530ee442f480bbbe5cfd1a6d7d948fbd8c0d62fee949928f905a881", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eedb6629edfc89de92deca564e9d80cc33ebafaea4da3e45ee8e98631654cc4e26c5d9476e7da52212003f42bc0ea8eae6f8fc5b69c04681c796b36f462c9d89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/68eff3eba8ece443a93c01de0bbed1985080078de70bf0ff86cf2fb1c7cd792bef0a1b8117a68a2e3821c65550f7e59114e4c631a295d7d8cb4d54d68fe3e94d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 02:03:39.047007) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:03:39.047635) ========= 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=ed14279e38b05397cf4aa391000001a4-1466066544.855616-867684140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:03:39.131840) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 02:03:39.132903) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 02:03:39.133578) ========= ========= Total master_lag: 0.17 =========