builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1465505731.92 results: success (0) buildid: 20160609121630 builduid: 913f38ce02014930aee888cd600f74ac revision: 3ccccf8e5036179a3178437cabc154b5e04b333d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:31.923682) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:31.924227) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:31.924563) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:31.939510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:31.939810) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 13:55:32-- 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% 39.6M=0s 2016-06-09 13:55:32 (39.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087532 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:32.042928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:32.043548) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016459 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:32.094514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 13:55:32.094938) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3ccccf8e5036179a3178437cabc154b5e04b333d --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 3ccccf8e5036179a3178437cabc154b5e04b333d --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=d6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 13:55:32,402 truncating revision to first 12 chars 2016-06-09 13:55:32,402 Setting DEBUG logging. 2016-06-09 13:55:32,402 attempt 1/10 2016-06-09 13:55:32,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3ccccf8e5036?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 13:55:33,127 unpacking tar archive at: mozilla-central-3ccccf8e5036/testing/mozharness/ program finished with exit code 0 elapsedTime=1.101496 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 13:55:33.210525) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:33.210925) ========= script_repo_revision: 3ccccf8e5036179a3178437cabc154b5e04b333d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:33.211401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:33.211720) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:33.221309) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-09 13:55:33.221624) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:55:33 INFO - MultiFileLogger online at 20160609 13:55:33 in /builds/slave/test 13:55:33 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 13:55:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:55:33 INFO - {'append_to_log': False, 13:55:33 INFO - 'base_work_dir': '/builds/slave/test', 13:55:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:55:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:55:33 INFO - 'branch': 'Firefox-Non-PGO', 13:55:33 INFO - 'buildbot_json_path': 'buildprops.json', 13:55:33 INFO - 'config_files': ('talos/linux_config.py',), 13:55:33 INFO - 'default_actions': ('clobber', 13:55:33 INFO - 'read-buildbot-config', 13:55:33 INFO - 'download-and-extract', 13:55:33 INFO - 'populate-webroot', 13:55:33 INFO - 'create-virtualenv', 13:55:33 INFO - 'install', 13:55:33 INFO - 'run-tests'), 13:55:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:55:33 INFO - 'download_minidump_stackwalk': True, 13:55:33 INFO - 'download_symbols': 'ondemand', 13:55:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:55:33 INFO - 'tooltool.py': '/tools/tooltool.py', 13:55:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:55:33 INFO - '/tools/misc-python/virtualenv.py')}, 13:55:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:55:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:55:33 INFO - 'installer_path': 'installer.exe', 13:55:33 INFO - 'log_level': 'info', 13:55:33 INFO - 'log_name': 'talos', 13:55:33 INFO - 'log_to_console': True, 13:55:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:55:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:55:33 INFO - 'opt_config_files': (), 13:55:33 INFO - 'pip_index': False, 13:55:33 INFO - 'sps_profile': False, 13:55:33 INFO - 'sps_profile_interval': 0, 13:55:33 INFO - 'suite': 'dromaeojs', 13:55:33 INFO - 'system_bits': '32', 13:55:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:55:33 INFO - 'title': 'talos-linux64-ix-034', 13:55:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:55:33 INFO - 'use_talos_json': True, 13:55:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:55:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:55:33 INFO - 'work_dir': 'build'} 13:55:33 INFO - ##### 13:55:33 INFO - ##### Running clobber step. 13:55:33 INFO - ##### 13:55:33 INFO - Running pre-action listener: _resource_record_pre_action 13:55:33 INFO - Running main action method: clobber 13:55:33 INFO - rmtree: /builds/slave/test/build 13:55:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:55:34 INFO - Running post-action listener: _resource_record_post_action 13:55:34 INFO - ##### 13:55:34 INFO - ##### Finished clobber step (success) 13:55:34 INFO - ##### 13:55:34 INFO - ##### 13:55:34 INFO - ##### Running read-buildbot-config step. 13:55:34 INFO - ##### 13:55:34 INFO - Running pre-action listener: _resource_record_pre_action 13:55:34 INFO - Running main action method: read_buildbot_config 13:55:34 INFO - Using buildbot properties: 13:55:34 INFO - { 13:55:34 INFO - "project": "", 13:55:34 INFO - "product": "firefox", 13:55:34 INFO - "script_repo_revision": "production", 13:55:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:55:34 INFO - "repository": "", 13:55:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 13:55:34 INFO - "buildid": "20160609121630", 13:55:34 INFO - "pgo_build": "False", 13:55:34 INFO - "basedir": "/builds/slave/test", 13:55:34 INFO - "buildnumber": 527, 13:55:34 INFO - "slavename": "talos-linux64-ix-034", 13:55:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:55:34 INFO - "platform": "ubuntu64_hw", 13:55:34 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 13:55:34 INFO - "branch": "mozilla-central", 13:55:34 INFO - "repo_path": "mozilla-central", 13:55:34 INFO - "revision": "3ccccf8e5036179a3178437cabc154b5e04b333d", 13:55:34 INFO - "stage_platform": "linux64", 13:55:34 INFO - "builduid": "913f38ce02014930aee888cd600f74ac", 13:55:34 INFO - "slavebuilddir": "test" 13:55:34 INFO - } 13:55:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:55:34 INFO - Running post-action listener: _resource_record_post_action 13:55:34 INFO - ##### 13:55:34 INFO - ##### Finished read-buildbot-config step (success) 13:55:34 INFO - ##### 13:55:34 INFO - ##### 13:55:34 INFO - ##### Running download-and-extract step. 13:55:34 INFO - ##### 13:55:34 INFO - Running pre-action listener: _resource_record_pre_action 13:55:34 INFO - Running main action method: download_and_extract 13:55:34 INFO - mkdir: /builds/slave/test/build/tests 13:55:34 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')]} 13:55:34 INFO - https://queue.taskcluster.net/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:55:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:55:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:55:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/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 13:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/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 13:55:34 INFO - Downloaded 1361 bytes. 13:55:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:55:34 INFO - Using the following test package requirements: 13:55:34 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:55:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:55:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:55:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:34 INFO - u'jsshell-linux-x86_64.zip'], 13:55:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:55:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:55:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:55:34 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:55:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:55:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:55:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:55:34 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')]} 13:55:34 INFO - https://queue.taskcluster.net/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:55:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:55:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:55:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/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 13:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/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 13:55:36 INFO - Downloaded 22879571 bytes. 13:55:36 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'] 13:55:36 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 13:55:37 INFO - Return code: 0 13:55:37 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 13:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:37 INFO - https://queue.taskcluster.net/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:55:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:55:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:55:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/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 13:55:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/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 13:55:38 INFO - Downloaded 22879571 bytes. 13:55:38 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'] 13:55:38 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 13:55:40 INFO - Return code: 0 13:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:40 INFO - https://queue.taskcluster.net/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:55:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:55:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:55:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/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 13:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/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 13:55:41 INFO - Downloaded 10833377 bytes. 13:55:41 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'] 13:55:41 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 13:55:41 INFO - Return code: 0 13:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:41 INFO - https://queue.taskcluster.net/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:55:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:55:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:55:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/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 13:55:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/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 13:55:43 INFO - Downloaded 55432767 bytes. 13:55:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:55:43 INFO - mkdir: /builds/slave/test/properties 13:55:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:55:43 INFO - Writing to file /builds/slave/test/properties/build_url 13:55:43 INFO - Contents: 13:55:43 INFO - build_url:https://queue.taskcluster.net/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:55:43 INFO - Running post-action listener: _resource_record_post_action 13:55:43 INFO - Running post-action listener: set_extra_try_arguments 13:55:43 INFO - ##### 13:55:43 INFO - ##### Finished download-and-extract step (success) 13:55:43 INFO - ##### 13:55:43 INFO - ##### 13:55:43 INFO - ##### Running populate-webroot step. 13:55:43 INFO - ##### 13:55:43 INFO - Running pre-action listener: _resource_record_pre_action 13:55:43 INFO - Running main action method: populate_webroot 13:55:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:55:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:55:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:55:43 INFO - '--tppagecycles', 13:55:43 INFO - '7'], 13:55:43 INFO - 'tests': ['tsvgm']}}, 13:55:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:55:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:55:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:55:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:55:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:55:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:55:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:43 INFO - 'talos_options': ['--disable-e10s'], 13:55:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:43 INFO - 'talos_options': ['--disable-e10s'], 13:55:43 INFO - 'tests': ['damp', 'tps']}, 13:55:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:43 INFO - 'tests': ['damp', 'tps']}, 13:55:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:55:43 INFO - 'tests': ['dromaeo_dom']}, 13:55:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:55:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:55:43 INFO - 'tests': ['a11yr', 13:55:43 INFO - 'ts_paint', 13:55:43 INFO - 'tpaint', 13:55:43 INFO - 'sessionrestore', 13:55:43 INFO - 'sessionrestore_no_auto_restore', 13:55:43 INFO - 'tabpaint']}, 13:55:43 INFO - 'other-e10s': {'tests': ['a11yr', 13:55:43 INFO - 'ts_paint', 13:55:43 INFO - 'tpaint', 13:55:43 INFO - 'sessionrestore', 13:55:43 INFO - 'sessionrestore_no_auto_restore', 13:55:43 INFO - 'tabpaint']}, 13:55:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:55:43 INFO - 'ts_paint', 13:55:43 INFO - 'tpaint', 13:55:43 INFO - 'sessionrestore', 13:55:43 INFO - 'sessionrestore_no_auto_restore', 13:55:43 INFO - 'tabpaint']}, 13:55:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:55:43 INFO - 'ts_paint', 13:55:43 INFO - 'tpaint', 13:55:43 INFO - 'sessionrestore', 13:55:43 INFO - 'sessionrestore_no_auto_restore', 13:55:43 INFO - 'tabpaint']}, 13:55:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:55:43 INFO - 'tests': ['a11yr', 13:55:43 INFO - 'ts_paint', 13:55:43 INFO - 'tpaint', 13:55:43 INFO - 'sessionrestore', 13:55:43 INFO - 'sessionrestore_no_auto_restore', 13:55:43 INFO - 'tabpaint']}, 13:55:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:55:43 INFO - 'tests': ['a11yr', 13:55:43 INFO - 'ts_paint', 13:55:43 INFO - 'tpaint', 13:55:43 INFO - 'sessionrestore', 13:55:43 INFO - 'sessionrestore_no_auto_restore', 13:55:43 INFO - 'tabpaint']}, 13:55:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:55:43 INFO - 'tests': ['tsvgx', 13:55:43 INFO - 'tsvgr_opacity', 13:55:43 INFO - 'tart', 13:55:43 INFO - 'tscrollx', 13:55:43 INFO - 'cart']}, 13:55:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:55:43 INFO - 'tsvgr_opacity', 13:55:43 INFO - 'tart', 13:55:43 INFO - 'tscrollx', 13:55:43 INFO - 'cart']}, 13:55:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:43 INFO - 'talos_options': ['--disable-e10s'], 13:55:43 INFO - 'tests': ['tp5o']}, 13:55:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:43 INFO - 'tests': ['tp5o']}, 13:55:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:43 INFO - 'talos_options': ['--disable-e10s', 13:55:43 INFO - '--xperf_path', 13:55:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:43 INFO - 'tests': ['tp5n']}, 13:55:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:43 INFO - 'talos_options': ['--xperf_path', 13:55:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:43 INFO - 'tests': ['tp5n']}}, 13:55:43 INFO - 'talos.zip': {'path': '', 13:55:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:55:43 INFO - Running post-action listener: _resource_record_post_action 13:55:43 INFO - ##### 13:55:43 INFO - ##### Finished populate-webroot step (success) 13:55:43 INFO - ##### 13:55:43 INFO - ##### 13:55:43 INFO - ##### Running create-virtualenv step. 13:55:43 INFO - ##### 13:55:43 INFO - Running pre-action listener: _resource_record_pre_action 13:55:43 INFO - Running main action method: create_virtualenv 13:55:43 INFO - Creating virtualenv /builds/slave/test/build/venv 13:55:43 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 13:55:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:55:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:55:43 INFO - Using real prefix '/usr' 13:55:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:55:44 INFO - Installing distribute.............................................................................................................................................................................................done. 13:55:46 INFO - Installing pip.................done. 13:55:46 INFO - Return code: 0 13:55:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:55:46 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')]} 13:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:46 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')]} 13:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:46 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 0x7f08c2d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', '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 13:55:46 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 13:55:46 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 13:55:46 INFO - Using env: {'DISPLAY': ':0', 13:55:46 INFO - 'HOME': '/home/cltbld', 13:55:46 INFO - 'LANG': 'en_US.UTF-8', 13:55:46 INFO - 'LANGUAGE': 'en_US:en', 13:55:46 INFO - 'LOGNAME': 'cltbld', 13:55:46 INFO - 'MAIL': '/var/mail/cltbld', 13:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:46 INFO - 'MOZ_NO_REMOTE': '1', 13:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:46 INFO - 'NO_EM_RESTART': '1', 13:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:46 INFO - 'PWD': '/builds/slave/test', 13:55:46 INFO - 'SHELL': '/bin/bash', 13:55:46 INFO - 'SHLVL': '1', 13:55:46 INFO - 'TERM': 'linux', 13:55:46 INFO - 'TMOUT': '86400', 13:55:46 INFO - 'USER': 'cltbld', 13:55:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', 13:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:46 INFO - '_': '/tools/buildbot/bin/python'} 13:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:46 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 13:55:46 INFO - Cleaning up... 13:55:46 INFO - Return code: 0 13:55:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:55:46 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')]} 13:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:46 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')]} 13:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:46 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 0x7f08c2d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', '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 13:55:46 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 13:55:46 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 13:55:46 INFO - Using env: {'DISPLAY': ':0', 13:55:46 INFO - 'HOME': '/home/cltbld', 13:55:46 INFO - 'LANG': 'en_US.UTF-8', 13:55:46 INFO - 'LANGUAGE': 'en_US:en', 13:55:46 INFO - 'LOGNAME': 'cltbld', 13:55:46 INFO - 'MAIL': '/var/mail/cltbld', 13:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:46 INFO - 'MOZ_NO_REMOTE': '1', 13:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:46 INFO - 'NO_EM_RESTART': '1', 13:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:46 INFO - 'PWD': '/builds/slave/test', 13:55:46 INFO - 'SHELL': '/bin/bash', 13:55:46 INFO - 'SHLVL': '1', 13:55:46 INFO - 'TERM': 'linux', 13:55:46 INFO - 'TMOUT': '86400', 13:55:46 INFO - 'USER': 'cltbld', 13:55:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', 13:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:46 INFO - '_': '/tools/buildbot/bin/python'} 13:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:46 INFO - Downloading/unpacking psutil>=3.1.1 13:55:46 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 13:55:46 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 13:55:46 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 13:55:46 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 13:55:46 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 13:55:46 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 13:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:55:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:48 INFO - Installing collected packages: psutil 13:55:48 INFO - Running setup.py install for psutil 13:55:48 INFO - building 'psutil._psutil_linux' extension 13:55:48 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 13:55:49 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 13:55:49 INFO - building 'psutil._psutil_posix' extension 13:55:49 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 13:55:49 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 13:55:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:49 INFO - Successfully installed psutil 13:55:49 INFO - Cleaning up... 13:55:49 INFO - Return code: 0 13:55:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:49 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 0x7f08c2d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', '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 13:55:49 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 13:55:49 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 13:55:49 INFO - Using env: {'DISPLAY': ':0', 13:55:49 INFO - 'HOME': '/home/cltbld', 13:55:49 INFO - 'LANG': 'en_US.UTF-8', 13:55:49 INFO - 'LANGUAGE': 'en_US:en', 13:55:49 INFO - 'LOGNAME': 'cltbld', 13:55:49 INFO - 'MAIL': '/var/mail/cltbld', 13:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:49 INFO - 'MOZ_NO_REMOTE': '1', 13:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:49 INFO - 'NO_EM_RESTART': '1', 13:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:49 INFO - 'PWD': '/builds/slave/test', 13:55:49 INFO - 'SHELL': '/bin/bash', 13:55:49 INFO - 'SHLVL': '1', 13:55:49 INFO - 'TERM': 'linux', 13:55:49 INFO - 'TMOUT': '86400', 13:55:49 INFO - 'USER': 'cltbld', 13:55:49 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', 13:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:49 INFO - '_': '/tools/buildbot/bin/python'} 13:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:55:49 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 13:55:49 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 13:55:49 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 13:55:49 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 13:55:49 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 13:55:49 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 13:55:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:55:51 INFO - Installing collected packages: mozsystemmonitor 13:55:51 INFO - Running setup.py install for mozsystemmonitor 13:55:51 INFO - Successfully installed mozsystemmonitor 13:55:51 INFO - Cleaning up... 13:55:51 INFO - Return code: 0 13:55:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:55:51 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')]} 13:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:51 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')]} 13:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:51 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 0x7f08c2d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', '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 13:55:51 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 13:55:51 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 13:55:51 INFO - Using env: {'DISPLAY': ':0', 13:55:51 INFO - 'HOME': '/home/cltbld', 13:55:51 INFO - 'LANG': 'en_US.UTF-8', 13:55:51 INFO - 'LANGUAGE': 'en_US:en', 13:55:51 INFO - 'LOGNAME': 'cltbld', 13:55:51 INFO - 'MAIL': '/var/mail/cltbld', 13:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:51 INFO - 'MOZ_NO_REMOTE': '1', 13:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:51 INFO - 'NO_EM_RESTART': '1', 13:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:51 INFO - 'PWD': '/builds/slave/test', 13:55:51 INFO - 'SHELL': '/bin/bash', 13:55:51 INFO - 'SHLVL': '1', 13:55:51 INFO - 'TERM': 'linux', 13:55:51 INFO - 'TMOUT': '86400', 13:55:51 INFO - 'USER': 'cltbld', 13:55:51 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', 13:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:51 INFO - '_': '/tools/buildbot/bin/python'} 13:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:51 INFO - Downloading/unpacking jsonschema==2.5.1 13:55:51 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 13:55:51 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 13:55:51 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 13:55:51 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 13:55:51 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 13:55:51 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 13:55:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:55:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:55:53 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 13:55:53 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 13:55:53 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 13:55:53 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 13:55:53 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 13:55:53 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 13:55:53 INFO - Downloading functools32-3.2.3-2.tar.gz 13:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:55:53 INFO - warning: no files found matching '*.txt' 13:55:53 INFO - no previously-included directories found matching 'build' 13:55:53 INFO - no previously-included directories found matching 'dist' 13:55:53 INFO - no previously-included directories found matching '.git*' 13:55:54 INFO - Installing collected packages: jsonschema, functools32 13:55:54 INFO - Running setup.py install for functools32 13:55:54 INFO - warning: no files found matching '*.txt' 13:55:54 INFO - no previously-included directories found matching 'build' 13:55:54 INFO - no previously-included directories found matching 'dist' 13:55:54 INFO - no previously-included directories found matching '.git*' 13:55:54 INFO - Successfully installed jsonschema functools32 13:55:54 INFO - Cleaning up... 13:55:54 INFO - Return code: 0 13:55:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f08c2d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', '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 13:55:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:55:54 INFO - Using env: {'DISPLAY': ':0', 13:55:54 INFO - 'HOME': '/home/cltbld', 13:55:54 INFO - 'LANG': 'en_US.UTF-8', 13:55:54 INFO - 'LANGUAGE': 'en_US:en', 13:55:54 INFO - 'LOGNAME': 'cltbld', 13:55:54 INFO - 'MAIL': '/var/mail/cltbld', 13:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:54 INFO - 'MOZ_NO_REMOTE': '1', 13:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:54 INFO - 'NO_EM_RESTART': '1', 13:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:54 INFO - 'PWD': '/builds/slave/test', 13:55:54 INFO - 'SHELL': '/bin/bash', 13:55:54 INFO - 'SHLVL': '1', 13:55:54 INFO - 'TERM': 'linux', 13:55:54 INFO - 'TMOUT': '86400', 13:55:54 INFO - 'USER': 'cltbld', 13:55:54 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', 13:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:54 INFO - '_': '/tools/buildbot/bin/python'} 13:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:54 INFO - Downloading/unpacking blobuploader==1.2.4 13:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:55:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:55:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:57 INFO - Downloading docopt-0.6.1.tar.gz 13:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:55:57 INFO - Installing collected packages: blobuploader, requests, docopt 13:55:57 INFO - Running setup.py install for blobuploader 13:55:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:55:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:55:57 INFO - Running setup.py install for requests 13:55:57 INFO - Running setup.py install for docopt 13:55:57 INFO - Successfully installed blobuploader requests docopt 13:55:57 INFO - Cleaning up... 13:55:57 INFO - Return code: 0 13:55:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:57 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 0x7f08c2d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', '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 13:55:57 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 13:55:57 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 13:55:57 INFO - Using env: {'DISPLAY': ':0', 13:55:57 INFO - 'HOME': '/home/cltbld', 13:55:57 INFO - 'LANG': 'en_US.UTF-8', 13:55:57 INFO - 'LANGUAGE': 'en_US:en', 13:55:57 INFO - 'LOGNAME': 'cltbld', 13:55:57 INFO - 'MAIL': '/var/mail/cltbld', 13:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:57 INFO - 'MOZ_NO_REMOTE': '1', 13:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:57 INFO - 'NO_EM_RESTART': '1', 13:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:57 INFO - 'PWD': '/builds/slave/test', 13:55:57 INFO - 'SHELL': '/bin/bash', 13:55:57 INFO - 'SHLVL': '1', 13:55:57 INFO - 'TERM': 'linux', 13:55:57 INFO - 'TMOUT': '86400', 13:55:57 INFO - 'USER': 'cltbld', 13:55:57 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', 13:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:57 INFO - '_': '/tools/buildbot/bin/python'} 13:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:57 INFO - Running setup.py (path:/tmp/pip-6j_kKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:57 INFO - Running setup.py (path:/tmp/pip-TEruXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:58 INFO - Running setup.py (path:/tmp/pip-HVY6L2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:55:58 INFO - Running setup.py (path:/tmp/pip-5xT2ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:55:58 INFO - Running setup.py (path:/tmp/pip-FQ30Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:55:58 INFO - Running setup.py (path:/tmp/pip-dlYmSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:55:58 INFO - Running setup.py (path:/tmp/pip-X1eAMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:55:58 INFO - Running setup.py (path:/tmp/pip-m1V3wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:55:58 INFO - Running setup.py (path:/tmp/pip-zZDpEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:55:58 INFO - Running setup.py (path:/tmp/pip-DpAkJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:58 INFO - Running setup.py (path:/tmp/pip-YDmkb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:58 INFO - Running setup.py (path:/tmp/pip-o6CSlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:55:58 INFO - Running setup.py (path:/tmp/pip-rpQvl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:55:58 INFO - Running setup.py (path:/tmp/pip-Nw1W5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:58 INFO - Running setup.py (path:/tmp/pip-cLjjyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:55:59 INFO - Running setup.py (path:/tmp/pip-qJtggy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:55:59 INFO - Running setup.py (path:/tmp/pip-zXyrXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:55:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:55:59 INFO - Running setup.py install for manifestparser 13:55:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:55:59 INFO - Running setup.py install for mozcrash 13:55:59 INFO - Running setup.py install for mozdebug 13:55:59 INFO - Running setup.py install for mozdevice 13:55:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:55:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:55:59 INFO - Running setup.py install for mozfile 13:55:59 INFO - Running setup.py install for mozhttpd 13:55:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:55:59 INFO - Running setup.py install for mozinfo 13:55:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:55:59 INFO - Running setup.py install for mozInstall 13:55:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:55:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:55:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:55:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:55:59 INFO - Running setup.py install for mozleak 13:56:00 INFO - Running setup.py install for mozlog 13:56:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:56:00 INFO - Running setup.py install for moznetwork 13:56:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:56:00 INFO - Running setup.py install for mozprocess 13:56:00 INFO - Running setup.py install for mozprofile 13:56:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:56:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:56:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:56:00 INFO - Running setup.py install for mozrunner 13:56:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:56:00 INFO - Running setup.py install for mozscreenshot 13:56:00 INFO - Running setup.py install for moztest 13:56:00 INFO - Running setup.py install for mozversion 13:56:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:56:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:56:00 INFO - Cleaning up... 13:56:00 INFO - Return code: 0 13:56:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:56: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')]} 13:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56: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')]} 13:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:00 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 0x7f08c2d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', '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 13:56:00 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 13:56:00 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 13:56:00 INFO - Using env: {'DISPLAY': ':0', 13:56:00 INFO - 'HOME': '/home/cltbld', 13:56:00 INFO - 'LANG': 'en_US.UTF-8', 13:56:00 INFO - 'LANGUAGE': 'en_US:en', 13:56:00 INFO - 'LOGNAME': 'cltbld', 13:56:00 INFO - 'MAIL': '/var/mail/cltbld', 13:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:00 INFO - 'MOZ_NO_REMOTE': '1', 13:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:00 INFO - 'NO_EM_RESTART': '1', 13:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:00 INFO - 'PWD': '/builds/slave/test', 13:56:00 INFO - 'SHELL': '/bin/bash', 13:56:00 INFO - 'SHLVL': '1', 13:56:00 INFO - 'TERM': 'linux', 13:56:00 INFO - 'TMOUT': '86400', 13:56:00 INFO - 'USER': 'cltbld', 13:56:00 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', 13:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:00 INFO - '_': '/tools/buildbot/bin/python'} 13:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:56:01 INFO - Running setup.py (path:/tmp/pip-nWjpuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:56:01 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)) 13:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:56:01 INFO - Running setup.py (path:/tmp/pip-tTrvqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:56:01 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)) 13:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:56:01 INFO - Running setup.py (path:/tmp/pip-Rut6uJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:56:01 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)) 13:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:56:01 INFO - Running setup.py (path:/tmp/pip-tJA_EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:56:01 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)) 13:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:56:01 INFO - Running setup.py (path:/tmp/pip-I9LhqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:56:01 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)) 13:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:56:01 INFO - Running setup.py (path:/tmp/pip-KlR2uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:56:01 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)) 13:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:56:01 INFO - Running setup.py (path:/tmp/pip-ZVepH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:56:01 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)) 13:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:56:01 INFO - Running setup.py (path:/tmp/pip-dUQDdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:56:01 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)) 13:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:56:01 INFO - Running setup.py (path:/tmp/pip-p56COa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:56:01 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)) 13:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:56:01 INFO - Running setup.py (path:/tmp/pip-5mzcEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:56:01 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)) 13:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:56:01 INFO - Running setup.py (path:/tmp/pip-fktwbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:56:01 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)) 13:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:56:01 INFO - Running setup.py (path:/tmp/pip-9HEkSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:56:02 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)) 13:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:56:02 INFO - Running setup.py (path:/tmp/pip-gwwP0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:56:02 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)) 13:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:56:02 INFO - Running setup.py (path:/tmp/pip-fXUyex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:56:02 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)) 13:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:02 INFO - Running setup.py (path:/tmp/pip-Bs_8Lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:02 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)) 13:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:56:02 INFO - Running setup.py (path:/tmp/pip-IRWERu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:56:02 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)) 13:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:56:02 INFO - Running setup.py (path:/tmp/pip-iqLJx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:56:02 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)) 13:56:02 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)) 13:56:02 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)) 13:56:02 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)) 13:56:02 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)) 13:56:02 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)) 13:56:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:04 INFO - Downloading blessings-1.6.tar.gz 13:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:56:04 INFO - Installing collected packages: blessings 13:56:04 INFO - Running setup.py install for blessings 13:56:04 INFO - Successfully installed blessings 13:56:04 INFO - Cleaning up... 13:56:04 INFO - Return code: 0 13:56:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:56:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:56:04 INFO - Reading from file tmpfile_stdout 13:56:04 INFO - Current package versions: 13:56:04 INFO - argparse == 1.2.1 13:56:04 INFO - blessings == 1.6 13:56:04 INFO - blobuploader == 1.2.4 13:56:04 INFO - docopt == 0.6.1 13:56:04 INFO - functools32 == 3.2.3-2 13:56:04 INFO - jsonschema == 2.5.1 13:56:04 INFO - manifestparser == 1.1 13:56:04 INFO - mozInstall == 1.12 13:56:04 INFO - mozcrash == 0.17 13:56:04 INFO - mozdebug == 0.1 13:56:04 INFO - mozdevice == 0.48 13:56:04 INFO - mozfile == 1.2 13:56:04 INFO - mozhttpd == 0.7 13:56:04 INFO - mozinfo == 0.9 13:56:04 INFO - mozleak == 0.1 13:56:04 INFO - mozlog == 3.2 13:56:04 INFO - moznetwork == 0.27 13:56:04 INFO - mozprocess == 0.22 13:56:04 INFO - mozprofile == 0.28 13:56:04 INFO - mozrunner == 6.11 13:56:04 INFO - mozscreenshot == 0.1 13:56:04 INFO - mozsystemmonitor == 0.3 13:56:04 INFO - moztest == 0.7 13:56:04 INFO - mozversion == 1.4 13:56:04 INFO - psutil == 3.1.1 13:56:04 INFO - requests == 1.2.3 13:56:04 INFO - wsgiref == 0.1.2 13:56:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:04 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 0x7f08c2d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', '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 13:56:04 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 13:56:04 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 13:56:04 INFO - Using env: {'DISPLAY': ':0', 13:56:04 INFO - 'HOME': '/home/cltbld', 13:56:04 INFO - 'LANG': 'en_US.UTF-8', 13:56:04 INFO - 'LANGUAGE': 'en_US:en', 13:56:04 INFO - 'LOGNAME': 'cltbld', 13:56:04 INFO - 'MAIL': '/var/mail/cltbld', 13:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:04 INFO - 'MOZ_NO_REMOTE': '1', 13:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:04 INFO - 'NO_EM_RESTART': '1', 13:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:04 INFO - 'PWD': '/builds/slave/test', 13:56:04 INFO - 'SHELL': '/bin/bash', 13:56:04 INFO - 'SHLVL': '1', 13:56:04 INFO - 'TERM': 'linux', 13:56:04 INFO - 'TMOUT': '86400', 13:56:04 INFO - 'USER': 'cltbld', 13:56:04 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', 13:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:04 INFO - '_': '/tools/buildbot/bin/python'} 13:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:05 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)) 13:56:05 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)) 13:56:05 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)) 13:56:05 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)) 13:56:05 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)) 13:56:05 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)) 13:56:05 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)) 13:56:05 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)) 13:56:05 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)) 13:56:05 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)) 13:56:05 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)) 13:56:05 INFO - Cleaning up... 13:56:05 INFO - Return code: 0 13:56:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:56: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')]} 13:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56: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')]} 13:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:05 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 0x7f08c2d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', '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 13:56:05 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 13:56:05 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 13:56:05 INFO - Using env: {'DISPLAY': ':0', 13:56:05 INFO - 'HOME': '/home/cltbld', 13:56:05 INFO - 'LANG': 'en_US.UTF-8', 13:56:05 INFO - 'LANGUAGE': 'en_US:en', 13:56:05 INFO - 'LOGNAME': 'cltbld', 13:56:05 INFO - 'MAIL': '/var/mail/cltbld', 13:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:05 INFO - 'MOZ_NO_REMOTE': '1', 13:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:05 INFO - 'NO_EM_RESTART': '1', 13:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:05 INFO - 'PWD': '/builds/slave/test', 13:56:05 INFO - 'SHELL': '/bin/bash', 13:56:05 INFO - 'SHLVL': '1', 13:56:05 INFO - 'TERM': 'linux', 13:56:05 INFO - 'TMOUT': '86400', 13:56:05 INFO - 'USER': 'cltbld', 13:56:05 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', 13:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:05 INFO - '_': '/tools/buildbot/bin/python'} 13:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:56:05 INFO - Cleaning up... 13:56:05 INFO - Return code: 0 13:56:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:56: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')]} 13:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56: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')]} 13:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:05 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 0x7f08c2d44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2199350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', '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 13:56:05 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 13:56:05 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 13:56:05 INFO - Using env: {'DISPLAY': ':0', 13:56:05 INFO - 'HOME': '/home/cltbld', 13:56:05 INFO - 'LANG': 'en_US.UTF-8', 13:56:05 INFO - 'LANGUAGE': 'en_US:en', 13:56:05 INFO - 'LOGNAME': 'cltbld', 13:56:05 INFO - 'MAIL': '/var/mail/cltbld', 13:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:05 INFO - 'MOZ_NO_REMOTE': '1', 13:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:05 INFO - 'NO_EM_RESTART': '1', 13:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:05 INFO - 'PWD': '/builds/slave/test', 13:56:05 INFO - 'SHELL': '/bin/bash', 13:56:05 INFO - 'SHLVL': '1', 13:56:05 INFO - 'TERM': 'linux', 13:56:05 INFO - 'TMOUT': '86400', 13:56:05 INFO - 'USER': 'cltbld', 13:56:05 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', 13:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:05 INFO - '_': '/tools/buildbot/bin/python'} 13:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:05 INFO - Downloading/unpacking flake8 13:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:56:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:56:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:56:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:56:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:56:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:56:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:56:08 INFO - no previously-included directories found matching 'docs/_build' 13:56:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:56:08 INFO - Running setup.py install for pep8 13:56:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:56:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:56:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:56:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:56:08 INFO - no previously-included directories found matching 'docs/_build' 13:56:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:56:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:56:08 INFO - Cleaning up... 13:56:08 INFO - Return code: 0 13:56:08 INFO - Running post-action listener: _resource_record_post_action 13:56:08 INFO - Running post-action listener: _start_resource_monitoring 13:56:08 INFO - Starting resource monitoring. 13:56:08 INFO - ##### 13:56:08 INFO - ##### Finished create-virtualenv step (success) 13:56:08 INFO - ##### 13:56:08 INFO - ##### 13:56:08 INFO - ##### Running install step. 13:56:08 INFO - ##### 13:56:08 INFO - Running pre-action listener: _resource_record_pre_action 13:56:08 INFO - Running main action method: install 13:56:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:56:08 INFO - Reading from file tmpfile_stdout 13:56:08 INFO - Detecting whether we're running mozinstall >=1.0... 13:56:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:56:08 INFO - Reading from file tmpfile_stdout 13:56:08 INFO - Output received: 13:56:08 INFO - Usage: mozinstall [options] installer 13:56:08 INFO - Options: 13:56:08 INFO - -h, --help show this help message and exit 13:56:08 INFO - -d DEST, --destination=DEST 13:56:08 INFO - Directory to install application into. [default: 13:56:08 INFO - "/builds/slave/test"] 13:56:08 INFO - --app=APP Application being installed. [default: firefox] 13:56:08 INFO - mkdir: /builds/slave/test/build/application 13:56:08 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'] 13:56:08 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 13:56:24 INFO - Reading from file tmpfile_stdout 13:56:24 INFO - Output received: 13:56:24 INFO - /builds/slave/test/build/application/firefox/firefox 13:56:24 INFO - Running post-action listener: _resource_record_post_action 13:56:24 INFO - ##### 13:56:24 INFO - ##### Finished install step (success) 13:56:24 INFO - ##### 13:56:24 INFO - ##### 13:56:24 INFO - ##### Running run-tests step. 13:56:24 INFO - ##### 13:56:24 INFO - Running pre-action listener: _resource_record_pre_action 13:56:24 INFO - Running main action method: run_tests 13:56:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:56:24 INFO - Python 2.7.3 13:56:24 INFO - Return code: 0 13:56:24 INFO - grabbing minidump binary from tooltool 13:56: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')]} 13:56:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22281c0>, '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 0x22290c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2229550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:56:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:56:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:56:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:56:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:56:24 INFO - Return code: 0 13:56:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:56:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:56:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:56:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:56:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:56:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:56:25 INFO - Return code: 0 13:56:25 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/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 13:56:25 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/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 13:56:25 INFO - Using env: {'DISPLAY': ':0', 13:56:25 INFO - 'HOME': '/home/cltbld', 13:56:25 INFO - 'LANG': 'en_US.UTF-8', 13:56:25 INFO - 'LANGUAGE': 'en_US:en', 13:56:25 INFO - 'LOGNAME': 'cltbld', 13:56:25 INFO - 'MAIL': '/var/mail/cltbld', 13:56:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:56:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:25 INFO - 'MOZ_NO_REMOTE': '1', 13:56:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:25 INFO - 'NO_EM_RESTART': '1', 13:56:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:25 INFO - 'PWD': '/builds/slave/test', 13:56:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:56:25 INFO - 'SHELL': '/bin/bash', 13:56:25 INFO - 'SHLVL': '1', 13:56:25 INFO - 'TERM': 'linux', 13:56:25 INFO - 'TMOUT': '86400', 13:56:25 INFO - 'USER': 'cltbld', 13:56:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571', 13:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:25 INFO - '_': '/tools/buildbot/bin/python'} 13:56:25 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/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 13:56:25 INFO - mozversion application_buildid: 20160609121630 13:56:25 INFO - mozversion application_changeset: 3ccccf8e5036179a3178437cabc154b5e04b333d 13:56:25 INFO - mozversion application_display_name: Nightly 13:56:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:56:25 INFO - mozversion application_name: Firefox 13:56:25 INFO - mozversion application_remotingname: firefox 13:56:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:56:25 INFO - mozversion application_vendor: Mozilla 13:56:25 INFO - mozversion application_version: 50.0a1 13:56:25 INFO - mozversion platform_buildid: 20160609121630 13:56:25 INFO - mozversion platform_changeset: 3ccccf8e5036179a3178437cabc154b5e04b333d 13:56:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:56:25 INFO - mozversion platform_version: 50.0a1 13:56:25 INFO - using testdate: 1465505785 13:56:25 INFO - actual date: 1465505785 13:56:25 INFO - starting webserver on 'localhost:58745' 13:56:25 INFO - SUITE-START | Running 2 tests 13:56:25 INFO - TEST-START | dromaeo_css 13:56:25 INFO - operating with platform_type : linux_ 13:56:25 INFO - Initialising browser for dromaeo_css test... 13:56:25 INFO - TEST-INFO | started process 30205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3_z1qT/profile http://localhost:58745/getInfo.html) 13:56:30 INFO - PROCESS | 30205 | __metrics Screen width/height:1600/1200 13:56:30 INFO - PROCESS | 30205 | colorDepth:24 13:56:30 INFO - PROCESS | 30205 | Browser inner width/height: 1024/697 13:56:30 INFO - PROCESS | 30205 | __metrics 13:56:31 ERROR - PROCESS | 30205 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:56:31 INFO - PROCESS | 30205 | console.error: PushService: 13:56:31 INFO - PROCESS | 30205 | stateChangeProcessEnqueue: Error transitioning state 13:56:31 INFO - PROCESS | 30205 | UnknownError 13:56:32 INFO - TEST-INFO | 30205: exit 0 13:56:32 INFO - Browser initialized. 13:56:32 INFO - Running cycle 1/1 for dromaeo_css test... 13:56:32 INFO - TEST-INFO | started process 30286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3_z1qT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:56:44 INFO - PROCESS | 30286 | RSS: Main: 175497216 13:56:44 INFO - PROCESS | 30286 | 13:57:35 INFO - PROCESS | 30286 | 1465505855265 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] 13:59:47 INFO - PROCESS | 30286 | Cycle 1(1): loaded http://localhost:58745/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58745/tests/dromaeo/cssquery-ext.html) 13:59:49 INFO - PROCESS | 30286 | RSS: Main: 294060032 13:59:49 INFO - PROCESS | 30286 | 14:02:52 INFO - PROCESS | 30286 | Cycle 1(1): loaded http://localhost:58745/tests/dromaeo/cssquery-ext.html (next: http://localhost:58745/tests/dromaeo/cssquery-jquery.html) 14:02:52 INFO - PROCESS | 30286 | RSS: Main: 252612608 14:02:52 INFO - PROCESS | 30286 | 14:05:54 INFO - PROCESS | 30286 | Cycle 1(1): loaded http://localhost:58745/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58745/tests/dromaeo/cssquery-mootools.html) 14:05:55 INFO - PROCESS | 30286 | RSS: Main: 255717376 14:05:55 INFO - PROCESS | 30286 | 14:08:57 INFO - PROCESS | 30286 | Cycle 1(1): loaded http://localhost:58745/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58745/tests/dromaeo/cssquery-prototype.html) 14:08:58 INFO - PROCESS | 30286 | RSS: Main: 249597952 14:08:58 INFO - PROCESS | 30286 | 14:12:01 INFO - PROCESS | 30286 | Cycle 1(1): loaded http://localhost:58745/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58745/tests/dromaeo/cssquery-yui.html) 14:12:01 INFO - PROCESS | 30286 | RSS: Main: 236957696 14:12:01 INFO - PROCESS | 30286 | 14:15:04 INFO - PROCESS | 30286 | Cycle 1(1): loaded http://localhost:58745/tests/dromaeo/cssquery-yui.html (next: http://localhost:58745/tests/dromaeo/cssquery-dojo.html) 14:15:04 INFO - PROCESS | 30286 | RSS: Main: 284319744 14:15:04 INFO - PROCESS | 30286 | 14:15:04 INFO - PROCESS | 30286 | __start_tp_report 14:15:04 INFO - PROCESS | 30286 | _x_x_mozilla_page_load 14:15:04 INFO - PROCESS | 30286 | _x_x_mozilla_page_load_details 14:15:04 INFO - PROCESS | 30286 | |i|pagename|runs| 14:15:04 INFO - PROCESS | 30286 | |0;dojo.html;2625.2255584602544;2646.020972240269;2671.8931242750286;2688.798340124491;2689.69068557116;4554.70394424363;4612.815487380509;4803.5916947059495;4871.707697538151;4912.582430493408;4748.857534273969;4765.285207218919;4784.234522476405;4819.710817350961;4848.539388758071;4292.163028209508;4369.410129632491;4377.080813029268;4391.5827996340295;4552.726836389811;4448.199324121657;4490.3040028795585;4504.662150338721;4507.188706032913;4535.954640453586;4272.615464608185;4317.978410107929;4329.112531930978;4364.716293440948;4393.934090988638;4388.253996820548;4410.25025745624;4462.553744625544;4463.933041004388;4470.597646211824;4417.712848664859;4442.666799989981;4449.17690227309;4474.082813023322;4480.48474425442;4637.3275874997935;4755.334253204554;4838.491958344358;4842.806287748486;4882.609391248691;5146.433892271847;5166.173412254021;5191.0656081905245;5196.350456192976;5218.973905130488;4958.479359667219;5172.19830926207;5242.7640756166065;5245.31810864589;5247.370315562119;4707.364505791708;4776.593989510861;4777.808887644455;4797.832075877328;4815.807367705323;5288.735563221823;5310.468953104659;5312.07038768214;5312.787488500417;5314.176302673091;5089.134847076006;5129.102407078746;5134.306868572695;5138.177891537336;5140.254663073833;4990.950090499121;5048.495150484922;5093.516115968977;5100.770465329069;5103.744812759347;5042.218456139304;5045.495450454999;5048.848534543969;5053.31780209667;5093.9490605094215;4855.417349918032;5027.79888804451;5036.798528058836;5038.420581633086;5043.646944713908;4230.978845105817;4295.076558539867;4332.9133417332105;4348.217320882271;4354.346847972766;3757.5866654667966;3786.6213378662464;3789.4315852622326;3827.942580861289;3828.1769419574925;4220.957790422057;4385.605295523418;4400.73595584266;4437.290033594674;4447.177272204588;5081.4918508148885;5130.974345128325;5145.845624631267;5217.869553261199;5218.165093585008;4361.542038086019;4377.277749171351;4382.211201983673;4391.099824536026;4431.0694754102;4610.608098311614;4611.1469378164475;4622.491525932145;4630.467496237909;4670.789814458358;4611.377464042378;4779.498152693917;4836.322914792002;4841.588464980516;4853.6602437829015;5135.666181698178;5165.199394093921;5170.0952333340765;5175.094358487175;5234.11020126587;4583.702059366131;4851.175300198904;4858.562729354375;4865.7323847188745;4909.68087074339;4973.378327709036;5006.774695138801;5028.094942910311;5036.269740887624;5046.369203849519;5097.133487307241;5098.592112631055;5122.154844450624;5131.820386286462;5143.948560514347;4865.659403841697;4926.064047830901;4933.383327084114;4935.259711043373;4938.037082768969;4991.425986011655;5004.349434573628;5015.498450154955;5024.723640199824;5067.315912351933;4905;4919.631027672867;4977.228529577921;4995.925061124159;4998.325226094431;4832.540908613676;4927.926081108714;4928.630352723489;5100.132977393926;5109.540141387293;4746;4793.328933949319;4851.490593487633;4881.438634556929;4913.6069114471475 14:15:04 INFO - PROCESS | 30286 | |1;ext.html;532.8564881792123;570.4210226619981;581.790555400056;583.0670926517575;583.3437382944188;39358.2128357433;39689.20621587567;40715.185696286055;40792.796036019856;41079.79460102699;37331.62668373322;41014.38478422818;41085.58914410855;41158;41177.79411102948;7549.773506794805;7861.292483676468;8015.799605009892;8021.799455013642;9978.151857092156;9820.11618954294;9926.057024582653;10238.027387398186;10240.078392944633;10257;10248.487575621226;10328.638497652584;10332.94833525835;10333.070023697866;10333.276670633059;10184.898151018506;10268.74328141795;10279.640212592598;10280.691579252634;10285.691429257135;10178.491075446273;10247.282690211689;10249.692509224735;10255.538500767483;10265.127464165555;39236.60763392358;39431.80284098561;39446.60553394458;39478.802605986784;39630.405543916866;2843.559248316514;2867.4981878171443;2909.985450072736;2960.7039296070434;3097.4579448596405;29925;30124.54813177804;30562.54156187637;30586.388272234653;30759.538606920913;3636.945445818315;3640;3653.1780349421433;3672.338978983782;3696.2607478504406;288864;294056;294084.99999999785;406476;406520;58313.70843145757;58565;58749.41250587525;58779;58839;62906.68546657237;63202.0519692205;63226.36773632205;63384;63385.36614633887;15551.377944882304;15792;15801.920990394974;15992.600184995468;16001.599960001093;10046.748831279276;11873.287602743863;12145.453454594564;12211.084168687385;12452.564160254347;19187.32844350441;19241.90379048124;19291.807081929;19300.1314940828;19312.80687193138;7213.49505534618;7243.637818109179;7280.199178090405;7300.744473943492;7593.430492713069;758.4425447296233;803.4416080823771;857.237059017475;863.4042510667745;932.16105505046;27182.728172718416;28322.461833299345;28516.71483285182;28671.56992645112;28727.85636071848;919.4850883505125;922.4373132389237;937.6249500199974;994.5682805540529;995.2237254941158;14760.114393136231;15071.849281507264;15198.924005380124;15452.5364239073;15472.071675699493;394296;396532;400834;401952;403636;49720;50306;50308.49691503038;50326.74836625793;50341.496585034416;1069.3316677076828;1194.9006913639298;1228.9692757680773;1231.359692959656;1246.4515613130193;27641.44717105687;29119.689613967;29379.706202937698;29549.26126846846;29909.401811964075;42235.36646950237;42658;42670.78664606657;42694.146117078104;42753.572464274956;243918;247961;248381;248495;248779;31966.041018769472;37071;37829.24341513209;38802.22395552017;40128.1974360517;41600;42695.5730442704;42798.786006071015;42952.140957180054;42956.78521607497;35693.1076723084;35709.285814284085;35865.82067089648;36038.4594231092;36728;35712;35850.4622430669;36230.598010103124;36297;36448.81775591105;35380.823095884356;35567.28865422625;35628.64371356357;35891.461628076126;36190;30846.53730194004;32301.676983230805;32420.675793241764;32508;32530.83734581312;23380.064797407915;23586.88206558956;23692;23851;23924.521509569364 14:15:04 INFO - PROCESS | 30286 | |2;jquery.html;355.6265920783178;357.85506869717767;360.14106356340136;370.35927844828444;372.88813355993193;15734.921325393372;16332.918335408322;16960;16994.065326407042;17009.659806803873;15713.528594142193;16003.119828409463;16243.187840607952;16525.752113718274;16525.91737041313;4820.421549414075;5042.344495215617;5079.288899554047;5113;5118.027574760802;3034.438628853658;3236.3689080629288;4979.278004689318;5475.561955043587;5791.652500849941;5792.7972520961775;5838.065909454488;5874.853128671774;5875.441833025856;5878.1770552122525;5657;5784.421557844203;5857.736401861926;5858.443447872467;5866;2818.3517790908;4761.928571071437;5016.122178618763;5051.797928082872;5058.696478211319;20298.89850550738;20311.492212694655;20384;20739.58520829575;20794.48013799652;1792.3099606651404;1840.2638944422204;1882.2000649723814;1928.3347245200384;2040.897955102239;12671.936640316831;12737.93631031839;12921.353932303347;13031.86968130316;13281.667958301023;1577.550398136537;1592.7292360298777;1611.5165450364962;1619.1823129319737;1630.3940618490776;59065.609714960345;67121.32878671249;67647.6149719849;67760.6611966937;68717.3128268716;8940.776480588038;9208.907910920805;9287.535623218811;9625.470599116976;9806.362586432002;12387.256764594153;12403.689907752378;12465.813012804816;12486;12520.499180032697;7342.559446433231;7498.250174982458;7568.697252109854;7602.885956710654;7732.729354472566;7585.848283034308;7684.346830519356;7685.462017658822;7793;7871.212878712083;5815.94184058154;5921.3190483094995;5966.343702192756;6023.020440563587;6087.66517841523;1492.8656420922168;1596.6647004129263;1605.1412494315484;1660.3358656537482;1675.7151284281701;798.6605692580746;846.7036537211926;877.0615441477557;891.1133422244908;910.6676063237003;16850.32598696063;17115.572110697332;17164.31342746301;17182.02072072984;17748.29006839738;897.1925267259519;907.5190149220923;923.7090316550265;957.8563215517728;994.3536701144315;9977.301588888708;10058.647947321955;10135.847962280572;10242.231832612584;10248.874093401584;413112;413903;419819;420269;427312;73279;73422.63288683523;73484.26515734775;73524.63237683778;74209;904.8823652925078;943.306669597845;955.5556666150135;957.9664711735056;961.3270710502676;14478.186166498957;15553.922230388776;15567.455139070531;15720.21398930026;16031.35874565051;26548.070817521293;33020.33959320752;34160.145996349296;34318.48522272118;35297.64702352943;43258.35112473252;44038.339424909296;46032.769836150605;46065;46248.537514624426;7415.703371865281;7507.774766757006;7612.467127301035;7637;7711.575863327346;11371.943140284246;11783.646490605295;11797.469113890067;11890.34603096838;11952.64142075739;8482.68518379652;9820.91969883298;9821.705348839261;10220.386776793417;10555.52500137511;9365.672201472917;9885.703428897144;9908.455034973145;9967.900320996698;9971.252156088178;9993.850092248767;10150;10192.184625229815;10282.691519254435;10603.676114250276;6735.6295403753265;7006.614636195059;7263.564186148848;7273.272672732896;7620;7711.768646940601;9781.168600669023;10272.280940334105;10339.327943683636;10506.579736810747 14:15:04 INFO - PROCESS | 30286 | |3;mootools.html;1208.0396085112334;1384.9307534623272;1398.9090709103907;1452.2375752729822;1689.5438231677447;6426.068220108082;7212.206657267703;7490.4756667033325;7501.249875012496;7689.307962283393;7403.074615673041;7588.317051465367;7605.163432022473;7615.5811430371305;7627.199144089874;2185.115028413495;2217.301550011749;2219.1234462387347;2219.7891200335944;2220;2134.391698365966;2161.146347192858;2191.923282685106;2193.517426166241;2199.4281486813384;2155.385715071205;2158.5035441848386;2166.9241576544823;2169.045619927227;2193.451637090727;2127.553213825091;2162.416147640144;2167.815735662463;2168.11107445948;2168.27362833451;2069.2757534862826;2144.6246906791407;2146.9570608587896;2148.9684951223344;2149.720536330283;7565.508241964255;7567.432442566829;7621.428392870502;7632.923670763333;7844.4901081429525;4434.778261086965;4552.8861778455475;4560.201964656172;4560.315952607136;4565.429321334833;2750.587411888213;2851.987544421742;2906.578546110823;2908.5346344584764;2920.78094142938;885.6236099657684;891.8706787515774;892.638481415028;901.833160865242;907.1155623267327;10215.591376344937;10287.228457865614;10291;10331.638392656296;10334.17326613869;3835.2521258354354;3920.6079392061138;4006.5192176938954;4058.837646494166;4088.8160032798596;8219.917800822035;8272.420930534805;8274.462159959583;8277.089520152778;8303.294219991247;4323.027318853296;4333.328334108218;4353.281708518059;4368.694191406571;4377.430933978562;3585.928281434357;4016;4134.545200027995;4154.439150714676;4168.437260969791;3374.8401023345077;3394.2702319001532;3430.2281986552825;3472.756907016535;3502.8598856045983;997.9501024948723;1038.8909164537765;1039.4127318065268;1042.4266653340633;1052.8526006358964;653.8855700252436;776.088096486626;790.1229635105029;793.6904607203195;806.4435539477859;4882.2432522959;4925.458199598042;5033.370828646419;5080.212567052113;5117;400.5873949831678;404.66210714054097;404.9976308636102;405.85389259866423;423.4220289305138;3334.483155110962;3414.6756058174433;3481.398556663912;3491.389006923778;3491.773034752733;9123.863142052875;9484.573194206278;9513.66702165421;9813.16588090006;9862.901370986341;9402.670906518239;9648.75878103039;9654.662086826927;9683.951580242054;9693.903060969442;7168.390686791577;7380.594067326241;7380.889286660705;7406.814829629195;7443.069616297963;5200.323957885451;5274.997750427407;5330.413654498079;5418.024755543882;5537.944620553743;8402.201790829862;8737.03892571804;8745.212930836255;8769.210771030637;9048.457092574467;8695.479107165838;8917.152870477294;8937.150970657776;8945.507997060224;9041.77395565116;5586.357568879631;6268.091126786499;6507.251666058464;6522.249941256816;6709.7316107355155;7488.063992001;7501.662425190771;7547.886781698388;7566.31903128721;7581.052368453943;6419;6793.490488213502;6811.386975172259;6845.110135682329;6892.069570608104;6670;6689;6701.262861085374;6803.89794153098;6811.250762416229;6055;6117.908231376444;6171.043488259327;6178.042403427476;6183.752649893954;4252.851150209728;4264.360345948133;4276.31578947367;4308.2460569400855;4336.284513055437;4109.404136400145;4164.20880032805;4184.225918205142;4192.266353388206;4265.616094551505 14:15:04 INFO - PROCESS | 30286 | |4;prototype.html;285.9042220856013;294.58169399452777;300.58969506623464;300.9548567714844;301.0786991805076;4681.4616319123315;4794.3767310249705;4819.325294458774;4927.98976209877;4945.579625731808;4658.580727734503;4802.759862006903;4804.879878003052;4810.206315957871;4824.155772739774;3786.280606684728;3790.5451345838537;3800.619938006205;3814.7329686921926;3824.9426258606004;3570.553680789901;3663.46879702443;3789.128500444899;3796.54441467023;3803.8668646597375;3785.186184970231;3802.2015376770773;3812.866549670762;3817.7900215488276;3822.2546603412347;3773.245350929811;3786.2995345861104;3792.184680293736;3801.2777572261184;3808.4096964970195;3366.6296707362417;3380.256343604403;3380.6281309055985;3385.5260263563123;3385.5768028996376;4613.9618585817925;4676.251799712064;4680.765961701902;4688.249880019214;4701.365315682373;4317.15815415994;4317.417148684919;4323.178596066738;4331.523532411432;4334.5882141196535;5007.749612519396;5017.899642007176;5024.723640199788;5031.6729412588065;5046.208595948458;3522.3307571561577;3624.0033990652782;3630.310241054218;3633.3278343506536;3644.4351125575577;5175.482451754832;5239.633225674166;5257.08001099806;5262.447443018505;5279.815206467755;3705.7776533408082;3709.2581483703366;3725.3666876631037;3743.7753734776;3755.9812200938823;3651;3813.103920578662;3830.004198908304;3834.328992426314;3843.8462461501786;4226.5773422657485;4226.873193804191;4228.281192197333;4260.87086921966;4276.935845962313;4973.278874563241;4975.303457515951;4975.4278258000795;4983.206045823501;5009.547231302954;1215.2404747033104;1269.1369868489517;1298.6818229533635;1299.1620404838825;1300.8048792681172;831.5655494272332;834.8585877224899;855.6962278391206;861.9353548483889;868.2880038368603;3984.9913315447234;4022.0694066848077;4029.5567487576345;4046.612498625825;4049.542164820662;4510.571495707968;4633.467151277646;4676.381226513164;4683.695559788603;4689.859304220879;3965.4646622705563;3997.400389941474;4001.4598029265676;4030.5163380393956;4054.878353649395;2303.7465878753324;2446.853188808642;2448.4980578981267;2459.913903013386;2477.541654793833;4368.8907777305185;4388.341748737715;4402.185595664748;4407.779611019436;4423;4703.424352841768;4711.3639658646325;4727.289078073695;4760.9765849513815;4764.356811830427;3965.2599388379203;4385.605295523418;4394.780260986938;4395.846145384896;4430.648652161121;4587.449506059294;4602.516735742699;4621.907561848811;4636.211843986463;4656.764752918686;4465.566266384893;4503.301988191835;4505.459344878635;4535.637149028136;4549.181147393501;4128.896777580585;4334.154839806208;4364;4367.759773212377;4394.934075988799;3343.3981883261245;3371.129023392041;3374.1901943533867;3388.5764279465066;3430.691237788611;4531;4563.877796824492;4585.380973568525;4675.737550861317;4982.925256121089;4860.489648586848;5025.874353141201;5088.516590923857;5095.872603184802;5107.540321371094;5031.496850315086;5035.16919708244;5065.645404821775;5073.543381095719;5073.92389114171;4781.402324709411;4965.602751779921;5003.599712022957;5009.924851127309;5010.69935803853;5095.286659867547;5096.210087436453;5097.337346145126;5106.872328191825;5121.103806833864;4977.776000079933;4978.626603004716;4984.601231901512;4993.201087825931;5013.498650134958 14:15:04 INFO - PROCESS | 30286 | |5;yui.html;528.3369371438844;538.4158188365623;542.9701366424845;550.6833570696849;551.269567822635;10451.790964180711;11145.052670522995;11146.777064458716;11157.163212759035;11163.720906977329;12011.159218854684;12215.328156951364;12325.445354959025;12578.99368050556;12922.5477108301;599.9280086389639;740.7222291640635;764.3961270596236;775.9107702614187;777.5567926282022;782.3897360059163;796.0845028217567;796.7291121018852;796.77690246731;796.9960150199241;827.0819390476566;831.1314676163394;831.4055450352996;832;832.6211573733937;629.968501574924;768.4697558684545;817.9427440079197;822.5722624235394;823.6170180865896;601.4646964201863;601.9488343490808;601.9608725432832;602.1840406249556;602.5631417222522;11215.271007384494;11225.550977960871;11250.606228782035;11255.774884502263;11257.437128143642;11774.411279436079;12268.693282667915;12339.50641974329;12428.937855310665;12726.518328925864;9212.447253164764;9428.198603118743;9431.952840235756;10687.038166565046;10747.83878241827;4136.751794892316;4190.811413486401;4222.59885310895;4243.193793179286;4252.468441444819;55737.163942540894;56331;56864.71567642135;57583.424165758224;58456.83086338292;9533.666321678707;9549.427034377959;9746.415215086976;9769.413835169913;9892.851607225897;15674;17225.56936076608;17333.959962402296;17483;17510.91244543769;6185.567010309235;6249.625082481847;6384.170057892445;6550.115734375799;6742.056112144303;3546.2021045265124;3631.1829838286176;3642.3990041642833;3680.4479328100465;3726.7018638508853;2697.2447714639934;2778.2220978126156;2783.0120307291027;2785.832850029005;2786.373066060161;496.37704680625586;510.4997102839164;513.512163444729;515.0574448758763;517.9870503237449;412.3402555910519;478.2754127496845;513.1020713750936;527.082875796112;529.9814506492254;6962.1297337832775;7284.271572842674;7300.744473943387;7414.295641914009;7436.290486608305;465.353159108839;518.3675915383302;520.4171328112539;546.5108727688696;553.8255449533384;3180.189051791778;3373.1735724747596;3401.4897765334904;3556.2531868307947;3642.053066202753;52577.211341829905;78435;88416.6737498938;88597;91250.54374728084;78661.60669196617;78697;79321.60339198267;79473;79654;43679;65693.34306656872;70416;70649.29350706427;70971.64514177396;6721.126253587003;6736.360045795642;6880.724771009303;6880.759173428906;6888.276730943179;42120.36819447772;42179;42497.36253956131;42933.785331074396;43830.34254486249;58672.4132758667;62816.37183628288;63000.68499657656;63106.36893631005;63328.100156995366;9058.682946096855;9128.680496182602;9214.861777073484;9260.49067301305;9336.346455748304;9610.903890961281;9677.467739274407;9872.555734991798;10067.798644026932;10256.846147307946;7323.890141647986;10511.526981286013;10610.023961661589;10616.681499555025;10874.184436167478;9787.559559819967;10076.395416275047;10195.811952573566;10323.896761032294;10534.68395948092;10524.162158925523;10570.207234457293;10595.258331917;10944.23390362667;10946.671599852018;9202.539873006457;9563.856542152012;9569.282303827102;9646.565904534173;9767.9023209767;9086.636534538544;9095.454272743656;9104.362694611315;9156.359054866096;9321.44071355721 14:15:04 INFO - PROCESS | 30286 | __end_tp_report 14:15:04 INFO - PROCESS | 30286 | __start_cc_report 14:15:04 INFO - PROCESS | 30286 | _x_x_mozilla_cycle_collect,1097 14:15:04 INFO - PROCESS | 30286 | __end_cc_report 14:15:04 INFO - PROCESS | 30286 | __startTimestamp1465506904753__endTimestamp 14:15:04 INFO - PROCESS | 30286 | 14:15:04 INFO - PROCESS | 30286 | ------- Summary: start ------- 14:15:04 INFO - PROCESS | 30286 | Number of tests: 6 14:15:04 INFO - PROCESS | 30286 | 14:15:04 INFO - PROCESS | 30286 | [#0] dojo.html Cycles:165 Average:4730.46 Median:4853.66 stddev:501.00 (10.3%) stddev-sans-first:474.53 14:15:04 INFO - PROCESS | 30286 | Values: 2625.2 2646.0 2671.9 2688.8 2689.7 4554.7 4612.8 4803.6 4871.7 4912.6 4748.9 4765.3 4784.2 4819.7 4848.5 4292.2 4369.4 4377.1 4391.6 4552.7 4448.2 4490.3 4504.7 4507.2 4536.0 4272.6 4318.0 4329.1 4364.7 4393.9 4388.3 4410.3 4462.6 4463.9 4470.6 4417.7 4442.7 4449.2 4474.1 4480.5 4637.3 4755.3 4838.5 4842.8 4882.6 5146.4 5166.2 5191.1 5196.4 5219.0 4958.5 5172.2 5242.8 5245.3 5247.4 4707.4 4776.6 4777.8 4797.8 4815.8 5288.7 5310.5 5312.1 5312.8 5314.2 5089.1 5129.1 5134.3 5138.2 5140.3 4991.0 5048.5 5093.5 5100.8 5103.7 5042.2 5045.5 5048.8 5053.3 5093.9 4855.4 5027.8 5036.8 5038.4 5043.6 4231.0 4295.1 4332.9 4348.2 4354.3 3757.6 3786.6 3789.4 3827.9 3828.2 4221.0 4385.6 4400.7 4437.3 4447.2 5081.5 5131.0 5145.8 5217.9 5218.2 4361.5 4377.3 4382.2 4391.1 4431.1 4610.6 4611.1 4622.5 4630.5 4670.8 4611.4 4779.5 4836.3 4841.6 4853.7 5135.7 5165.2 5170.1 5175.1 5234.1 4583.7 4851.2 4858.6 4865.7 4909.7 4973.4 5006.8 5028.1 5036.3 5046.4 5097.1 5098.6 5122.2 5131.8 5143.9 4865.7 4926.1 4933.4 4935.3 4938.0 4991.4 5004.3 5015.5 5024.7 5067.3 4905.0 4919.6 4977.2 4995.9 4998.3 4832.5 4927.9 4928.6 5100.1 5109.5 4746.0 4793.3 4851.5 4881.4 4913.6 14:15:04 INFO - PROCESS | 30286 | 14:15:04 INFO - PROCESS | 30286 | [#1] ext.html Cycles:180 Average:49435.47 Median:35964.96 stddev:88378.05 (245.7%) stddev-sans-first:88549.70 14:15:04 INFO - PROCESS | 30286 | Values: 532.9 570.4 581.8 583.1 583.3 39358.2 39689.2 40715.2 40792.8 41079.8 37331.6 41014.4 41085.6 41158.0 41177.8 7549.8 7861.3 8015.8 8021.8 9978.2 9820.1 9926.1 10238.0 10240.1 10257.0 10248.5 10328.6 10332.9 10333.1 10333.3 10184.9 10268.7 10279.6 10280.7 10285.7 10178.5 10247.3 10249.7 10255.5 10265.1 39236.6 39431.8 39446.6 39478.8 39630.4 2843.6 2867.5 2910.0 2960.7 3097.5 29925.0 30124.5 30562.5 30586.4 30759.5 3636.9 3640.0 3653.2 3672.3 3696.3 288864.0 294056.0 294085.0 406476.0 406520.0 58313.7 58565.0 58749.4 58779.0 58839.0 62906.7 63202.1 63226.4 63384.0 63385.4 15551.4 15792.0 15801.9 15992.6 16001.6 10046.7 11873.3 12145.5 12211.1 12452.6 19187.3 19241.9 19291.8 19300.1 19312.8 7213.5 7243.6 7280.2 7300.7 7593.4 758.4 803.4 857.2 863.4 932.2 27182.7 28322.5 28516.7 28671.6 28727.9 919.5 922.4 937.6 994.6 995.2 14760.1 15071.8 15198.9 15452.5 15472.1 394296.0 396532.0 400834.0 401952.0 403636.0 49720.0 50306.0 50308.5 50326.7 50341.5 1069.3 1194.9 1229.0 1231.4 1246.5 27641.4 29119.7 29379.7 29549.3 29909.4 42235.4 42658.0 42670.8 42694.1 42753.6 243918.0 247961.0 248381.0 248495.0 248779.0 31966.0 37071.0 37829.2 38802.2 40128.2 41600.0 42695.6 42798.8 42952.1 42956.8 35693.1 35709.3 35865.8 36038.5 36728.0 35712.0 35850.5 36230.6 36297.0 36448.8 35380.8 35567.3 35628.6 35891.5 36190.0 30846.5 32301.7 32420.7 32508.0 32530.8 23380.1 23586.9 23692.0 23851.0 23924.5 14:15:04 INFO - PROCESS | 30286 | 14:15:04 INFO - PROCESS | 30286 | [#2] jquery.html Cycles:180 Average:24680.12 Median:25505.23 stddev:68791.80 (269.7%) stddev-sans-first:68960.53 14:15:04 INFO - PROCESS | 30286 | Values: 355.6 357.9 360.1 370.4 372.9 15734.9 16332.9 16960.0 16994.1 17009.7 15713.5 16003.1 16243.2 16525.8 16525.9 4820.4 5042.3 5079.3 5113.0 5118.0 3034.4 3236.4 4979.3 5475.6 5791.7 5792.8 5838.1 5874.9 5875.4 5878.2 5657.0 5784.4 5857.7 5858.4 5866.0 2818.4 4761.9 5016.1 5051.8 5058.7 20298.9 20311.5 20384.0 20739.6 20794.5 1792.3 1840.3 1882.2 1928.3 2040.9 12671.9 12737.9 12921.4 13031.9 13281.7 1577.6 1592.7 1611.5 1619.2 1630.4 59065.6 67121.3 67647.6 67760.7 68717.3 8940.8 9208.9 9287.5 9625.5 9806.4 12387.3 12403.7 12465.8 12486.0 12520.5 7342.6 7498.3 7568.7 7602.9 7732.7 7585.8 7684.3 7685.5 7793.0 7871.2 5815.9 5921.3 5966.3 6023.0 6087.7 1492.9 1596.7 1605.1 1660.3 1675.7 798.7 846.7 877.1 891.1 910.7 16850.3 17115.6 17164.3 17182.0 17748.3 897.2 907.5 923.7 957.9 994.4 9977.3 10058.6 10135.8 10242.2 10248.9 413112.0 413903.0 419819.0 420269.0 427312.0 73279.0 73422.6 73484.3 73524.6 74209.0 904.9 943.3 955.6 958.0 961.3 14478.2 15553.9 15567.5 15720.2 16031.4 26548.1 33020.3 34160.1 34318.5 35297.6 43258.4 44038.3 46032.8 46065.0 46248.5 7415.7 7507.8 7612.5 7637.0 7711.6 11371.9 11783.6 11797.5 11890.3 11952.6 8482.7 9820.9 9821.7 10220.4 10555.5 9365.7 9885.7 9908.5 9967.9 9971.3 9993.9 10150.0 10192.2 10282.7 10603.7 6735.6 7006.6 7263.6 7273.3 7620.0 7711.8 9781.2 10272.3 10339.3 10506.6 14:15:04 INFO - PROCESS | 30286 | 14:15:04 INFO - PROCESS | 30286 | [#3] mootools.html Cycles:180 Average:4987.12 Median:4979.41 stddev:2838.11 (57.0%) stddev-sans-first:2831.86 14:15:04 INFO - PROCESS | 30286 | Values: 1208.0 1384.9 1398.9 1452.2 1689.5 6426.1 7212.2 7490.5 7501.2 7689.3 7403.1 7588.3 7605.2 7615.6 7627.2 2185.1 2217.3 2219.1 2219.8 2220.0 2134.4 2161.1 2191.9 2193.5 2199.4 2155.4 2158.5 2166.9 2169.0 2193.5 2127.6 2162.4 2167.8 2168.1 2168.3 2069.3 2144.6 2147.0 2149.0 2149.7 7565.5 7567.4 7621.4 7632.9 7844.5 4434.8 4552.9 4560.2 4560.3 4565.4 2750.6 2852.0 2906.6 2908.5 2920.8 885.6 891.9 892.6 901.8 907.1 10215.6 10287.2 10291.0 10331.6 10334.2 3835.3 3920.6 4006.5 4058.8 4088.8 8219.9 8272.4 8274.5 8277.1 8303.3 4323.0 4333.3 4353.3 4368.7 4377.4 3585.9 4016.0 4134.5 4154.4 4168.4 3374.8 3394.3 3430.2 3472.8 3502.9 998.0 1038.9 1039.4 1042.4 1052.9 653.9 776.1 790.1 793.7 806.4 4882.2 4925.5 5033.4 5080.2 5117.0 400.6 404.7 405.0 405.9 423.4 3334.5 3414.7 3481.4 3491.4 3491.8 9123.9 9484.6 9513.7 9813.2 9862.9 9402.7 9648.8 9654.7 9684.0 9693.9 7168.4 7380.6 7380.9 7406.8 7443.1 5200.3 5275.0 5330.4 5418.0 5537.9 8402.2 8737.0 8745.2 8769.2 9048.5 8695.5 8917.2 8937.2 8945.5 9041.8 5586.4 6268.1 6507.3 6522.2 6709.7 7488.1 7501.7 7547.9 7566.3 7581.1 6419.0 6793.5 6811.4 6845.1 6892.1 6670.0 6689.0 6701.3 6803.9 6811.3 6055.0 6117.9 6171.0 6178.0 6183.8 4252.9 4264.4 4276.3 4308.2 4336.3 4109.4 4164.2 4184.2 4192.3 4265.6 14:15:04 INFO - PROCESS | 30286 | 14:15:04 INFO - PROCESS | 30286 | [#4] prototype.html Cycles:180 Average:4037.76 Median:4399.02 stddev:1158.06 (26.3%) stddev-sans-first:1126.55 14:15:04 INFO - PROCESS | 30286 | Values: 285.9 294.6 300.6 301.0 301.1 4681.5 4794.4 4819.3 4928.0 4945.6 4658.6 4802.8 4804.9 4810.2 4824.2 3786.3 3790.5 3800.6 3814.7 3824.9 3570.6 3663.5 3789.1 3796.5 3803.9 3785.2 3802.2 3812.9 3817.8 3822.3 3773.2 3786.3 3792.2 3801.3 3808.4 3366.6 3380.3 3380.6 3385.5 3385.6 4614.0 4676.3 4680.8 4688.2 4701.4 4317.2 4317.4 4323.2 4331.5 4334.6 5007.7 5017.9 5024.7 5031.7 5046.2 3522.3 3624.0 3630.3 3633.3 3644.4 5175.5 5239.6 5257.1 5262.4 5279.8 3705.8 3709.3 3725.4 3743.8 3756.0 3651.0 3813.1 3830.0 3834.3 3843.8 4226.6 4226.9 4228.3 4260.9 4276.9 4973.3 4975.3 4975.4 4983.2 5009.5 1215.2 1269.1 1298.7 1299.2 1300.8 831.6 834.9 855.7 861.9 868.3 3985.0 4022.1 4029.6 4046.6 4049.5 4510.6 4633.5 4676.4 4683.7 4689.9 3965.5 3997.4 4001.5 4030.5 4054.9 2303.7 2446.9 2448.5 2459.9 2477.5 4368.9 4388.3 4402.2 4407.8 4423.0 4703.4 4711.4 4727.3 4761.0 4764.4 3965.3 4385.6 4394.8 4395.8 4430.6 4587.4 4602.5 4621.9 4636.2 4656.8 4465.6 4503.3 4505.5 4535.6 4549.2 4128.9 4334.2 4364.0 4367.8 4394.9 3343.4 3371.1 3374.2 3388.6 3430.7 4531.0 4563.9 4585.4 4675.7 4982.9 4860.5 5025.9 5088.5 5095.9 5107.5 5031.5 5035.2 5065.6 5073.5 5073.9 4781.4 4965.6 5003.6 5009.9 5010.7 5095.3 5096.2 5097.3 5106.9 5121.1 4977.8 4978.6 4984.6 4993.2 5013.5 14:15:04 INFO - PROCESS | 30286 | 14:15:04 INFO - PROCESS | 30286 | [#5] yui.html Cycles:180 Average:16051.84 Median:56597.86 stddev:22835.99 (40.3%) stddev-sans-first:22870.30 14:15:04 INFO - PROCESS | 30286 | Values: 528.3 538.4 543.0 550.7 551.3 10451.8 11145.1 11146.8 11157.2 11163.7 12011.2 12215.3 12325.4 12579.0 12922.5 599.9 740.7 764.4 775.9 777.6 782.4 796.1 796.7 796.8 797.0 827.1 831.1 831.4 832.0 832.6 630.0 768.5 817.9 822.6 823.6 601.5 601.9 602.0 602.2 602.6 11215.3 11225.6 11250.6 11255.8 11257.4 11774.4 12268.7 12339.5 12428.9 12726.5 9212.4 9428.2 9432.0 10687.0 10747.8 4136.8 4190.8 4222.6 4243.2 4252.5 55737.2 56331.0 56864.7 57583.4 58456.8 9533.7 9549.4 9746.4 9769.4 9892.9 15674.0 17225.6 17334.0 17483.0 17510.9 6185.6 6249.6 6384.2 6550.1 6742.1 3546.2 3631.2 3642.4 3680.4 3726.7 2697.2 2778.2 2783.0 2785.8 2786.4 496.4 510.5 513.5 515.1 518.0 412.3 478.3 513.1 527.1 530.0 6962.1 7284.3 7300.7 7414.3 7436.3 465.4 518.4 520.4 546.5 553.8 3180.2 3373.2 3401.5 3556.3 3642.1 52577.2 78435.0 88416.7 88597.0 91250.5 78661.6 78697.0 79321.6 79473.0 79654.0 43679.0 65693.3 70416.0 70649.3 70971.6 6721.1 6736.4 6880.7 6880.8 6888.3 42120.4 42179.0 42497.4 42933.8 43830.3 58672.4 62816.4 63000.7 63106.4 63328.1 9058.7 9128.7 9214.9 9260.5 9336.3 9610.9 9677.5 9872.6 10067.8 10256.8 7323.9 10511.5 10610.0 10616.7 10874.2 9787.6 10076.4 10195.8 10323.9 10534.7 10524.2 10570.2 10595.3 10944.2 10946.7 9202.5 9563.9 9569.3 9646.6 9767.9 9086.6 9095.5 9104.4 9156.4 9321.4 14:15:04 INFO - PROCESS | 30286 | -------- Summary: end -------- 14:15:04 INFO - PROCESS | 30286 | 14:15:05 INFO - TEST-INFO | 30286: exit 0 14:15:05 INFO - TEST-OK | dromaeo_css | took 1119672ms 14:15:05 INFO - TEST-START | kraken 14:15:05 INFO - operating with platform_type : linux_ 14:15:05 INFO - Initialising browser for kraken test... 14:15:05 INFO - TEST-INFO | started process 30465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTgK2qd/profile http://localhost:58745/getInfo.html) 14:15:09 INFO - PROCESS | 30465 | __metrics Screen width/height:1600/1200 14:15:09 INFO - PROCESS | 30465 | colorDepth:24 14:15:09 INFO - PROCESS | 30465 | Browser inner width/height: 1024/697 14:15:09 INFO - PROCESS | 30465 | __metrics 14:15:10 ERROR - PROCESS | 30465 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:15:10 INFO - PROCESS | 30465 | console.error: PushService: 14:15:10 INFO - PROCESS | 30465 | stateChangeProcessEnqueue: Error transitioning state 14:15:10 INFO - PROCESS | 30465 | UnknownError 14:15:11 INFO - TEST-INFO | 30465: exit 0 14:15:11 INFO - Browser initialized. 14:15:11 INFO - Running cycle 1/1 for kraken test... 14:15:11 INFO - TEST-INFO | started process 30545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTgK2qd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:23 INFO - PROCESS | 30545 | RSS: Main: 175173632 14:15:23 INFO - PROCESS | 30545 | 14:15:26 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:58745/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58745/tests/kraken/driver.html?testName=audio-beat-detection) 14:15:27 INFO - PROCESS | 30545 | RSS: Main: 231686144 14:15:27 INFO - PROCESS | 30545 | 14:15:30 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:58745/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58745/tests/kraken/driver.html?testName=audio-dft) 14:15:30 INFO - PROCESS | 30545 | RSS: Main: 219336704 14:15:30 INFO - PROCESS | 30545 | 14:15:34 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:58745/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58745/tests/kraken/driver.html?testName=audio-fft) 14:15:34 INFO - PROCESS | 30545 | RSS: Main: 287596544 14:15:34 INFO - PROCESS | 30545 | 14:15:36 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:58745/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58745/tests/kraken/driver.html?testName=audio-oscillator) 14:15:37 INFO - PROCESS | 30545 | RSS: Main: 196964352 14:15:37 INFO - PROCESS | 30545 | 14:15:39 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:58745/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58745/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:15:40 INFO - PROCESS | 30545 | RSS: Main: 201662464 14:15:40 INFO - PROCESS | 30545 | 14:15:43 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:58745/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58745/tests/kraken/driver.html?testName=imaging-darkroom) 14:15:44 INFO - PROCESS | 30545 | RSS: Main: 237928448 14:15:44 INFO - PROCESS | 30545 | 14:15:47 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:58745/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58745/tests/kraken/driver.html?testName=imaging-desaturate) 14:15:48 INFO - PROCESS | 30545 | RSS: Main: 233734144 14:15:48 INFO - PROCESS | 30545 | 14:15:51 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:58745/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58745/tests/kraken/driver.html?testName=json-parse-financial) 14:15:51 INFO - PROCESS | 30545 | RSS: Main: 237043712 14:15:51 INFO - PROCESS | 30545 | 14:15:53 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:58745/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58745/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:15:53 INFO - PROCESS | 30545 | RSS: Main: 224497664 14:15:53 INFO - PROCESS | 30545 | 14:15:55 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:58745/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58745/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:15:56 INFO - PROCESS | 30545 | RSS: Main: 226852864 14:15:56 INFO - PROCESS | 30545 | 14:15:58 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:58745/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58745/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:15:59 INFO - PROCESS | 30545 | RSS: Main: 234635264 14:15:59 INFO - PROCESS | 30545 | 14:16:02 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:58745/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:16:02 INFO - PROCESS | 30545 | RSS: Main: 239685632 14:16:02 INFO - PROCESS | 30545 | 14:16:05 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:58745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:16:06 INFO - PROCESS | 30545 | RSS: Main: 237416448 14:16:06 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | Cycle 1(1): loaded http://localhost:58745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58745/tests/kraken/driver.html?testName=ai-astar) 14:16:08 INFO - PROCESS | 30545 | RSS: Main: 281292800 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | __start_tp_report 14:16:08 INFO - PROCESS | 30545 | _x_x_mozilla_page_load 14:16:08 INFO - PROCESS | 30545 | _x_x_mozilla_page_load_details 14:16:08 INFO - PROCESS | 30545 | |i|pagename|runs| 14:16:08 INFO - PROCESS | 30545 | |0;ai-astar;113;108;112;113;112;113;112;113;113;114 14:16:08 INFO - PROCESS | 30545 | |1;audio-beat-detection;150;130;134;184;131;140;156;137;187;131 14:16:08 INFO - PROCESS | 30545 | |2;audio-dft;162;161;162;163;161;160;164;162;164;162 14:16:08 INFO - PROCESS | 30545 | |3;audio-fft;76;77;76;130;75;76;75;75;96;75 14:16:08 INFO - PROCESS | 30545 | |4;audio-oscillator;87;86;129;87;87;86;121;85;86;133 14:16:08 INFO - PROCESS | 30545 | |5;imaging-gaussian-blur;116;117;117;117;116;116;117;117;117;116 14:16:08 INFO - PROCESS | 30545 | |6;imaging-darkroom;146;146;146;145;146;146;146;146;146;145 14:16:08 INFO - PROCESS | 30545 | |7;imaging-desaturate;95;95;95;95;95;96;96;95;95;96 14:16:08 INFO - PROCESS | 30545 | |8;json-parse-financial;63;63;65;64;65;63;64;71;64;64 14:16:08 INFO - PROCESS | 30545 | |9;json-stringify-tinderbox;65;66;65;66;65;65;66;65;65;65 14:16:08 INFO - PROCESS | 30545 | |10;stanford-crypto-aes;91;83;84;83;85;86;84;85;146;85 14:16:08 INFO - PROCESS | 30545 | |11;stanford-crypto-ccm;139;137;137;141;130;131;132;131;136;132 14:16:08 INFO - PROCESS | 30545 | |12;stanford-crypto-pbkdf2;169;165;166;167;168;164;163;164;172;164 14:16:08 INFO - PROCESS | 30545 | |13;stanford-crypto-sha256-iterative;66;67;66;68;67;65;68;67;66;66 14:16:08 INFO - PROCESS | 30545 | __end_tp_report 14:16:08 INFO - PROCESS | 30545 | __start_cc_report 14:16:08 INFO - PROCESS | 30545 | _x_x_mozilla_cycle_collect,1883 14:16:08 INFO - PROCESS | 30545 | __end_cc_report 14:16:08 INFO - PROCESS | 30545 | __startTimestamp1465506968267__endTimestamp 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | ------- Summary: start ------- 14:16:08 INFO - PROCESS | 30545 | Number of tests: 14 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.64 (1.4%) stddev-sans-first:1.72 14:16:08 INFO - PROCESS | 30545 | Values: 113.0 108.0 112.0 113.0 112.0 113.0 112.0 113.0 113.0 114.0 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:145.00 stddev:21.52 (14.8%) stddev-sans-first:22.81 14:16:08 INFO - PROCESS | 30545 | Values: 150.0 130.0 134.0 184.0 131.0 140.0 156.0 137.0 187.0 131.0 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 14:16:08 INFO - PROCESS | 30545 | Values: 162.0 161.0 162.0 163.0 161.0 160.0 164.0 162.0 164.0 162.0 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | [#3] audio-fft Cycles:10 Average:83.10 Median:76.00 stddev:17.69 (23.3%) stddev-sans-first:18.58 14:16:08 INFO - PROCESS | 30545 | Values: 76.0 77.0 76.0 130.0 75.0 76.0 75.0 75.0 96.0 75.0 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | [#4] audio-oscillator Cycles:10 Average:98.70 Median:86.00 stddev:20.20 (23.5%) stddev-sans-first:20.98 14:16:08 INFO - PROCESS | 30545 | Values: 87.0 86.0 129.0 87.0 87.0 86.0 121.0 85.0 86.0 133.0 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:16:08 INFO - PROCESS | 30545 | Values: 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 14:16:08 INFO - PROCESS | 30545 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:16:08 INFO - PROCESS | 30545 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.00 stddev:2.37 (3.7%) stddev-sans-first:2.44 14:16:08 INFO - PROCESS | 30545 | Values: 63.0 63.0 65.0 64.0 65.0 63.0 64.0 71.0 64.0 64.0 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 14:16:08 INFO - PROCESS | 30545 | Values: 65.0 66.0 65.0 66.0 65.0 65.0 66.0 65.0 65.0 65.0 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:85.00 stddev:19.39 (22.8%) stddev-sans-first:20.57 14:16:08 INFO - PROCESS | 30545 | Values: 91.0 83.0 84.0 83.0 85.0 86.0 84.0 85.0 146.0 85.0 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:136.50 stddev:3.86 (2.8%) stddev-sans-first:3.76 14:16:08 INFO - PROCESS | 30545 | Values: 139.0 137.0 137.0 141.0 130.0 131.0 132.0 131.0 136.0 132.0 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.50 stddev:2.82 (1.7%) stddev-sans-first:2.80 14:16:08 INFO - PROCESS | 30545 | Values: 169.0 165.0 166.0 167.0 168.0 164.0 163.0 164.0 172.0 164.0 14:16:08 INFO - PROCESS | 30545 | 14:16:08 INFO - PROCESS | 30545 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 14:16:08 INFO - PROCESS | 30545 | Values: 66.0 67.0 66.0 68.0 67.0 65.0 68.0 67.0 66.0 66.0 14:16:08 INFO - PROCESS | 30545 | -------- Summary: end -------- 14:16:08 INFO - PROCESS | 30545 | 14:16:09 INFO - TEST-INFO | 30545: exit 0 14:16:09 INFO - TEST-OK | kraken | took 63802ms 14:16:09 INFO - SUITE-END | took 1183s 14:16:09 INFO - Completed test suite (00:19:43) 14:16:09 INFO - javascript benchmark 14:16:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2625.2255584602544, 2646.020972240269, 2671.8931242750286, 2688.798340124491, 2689.69068557116, 4554.70394424363, 4612.815487380509, 4803.5916947059495, 4871.707697538151, 4912.582430493408, 4748.857534273969, 4765.285207218919, 4784.234522476405, 4819.710817350961, 4848.539388758071, 4292.163028209508, 4369.410129632491, 4377.080813029268, 4391.5827996340295, 4552.726836389811, 4448.199324121657, 4490.3040028795585, 4504.662150338721, 4507.188706032913, 4535.954640453586, 4272.615464608185, 4317.978410107929, 4329.112531930978, 4364.716293440948, 4393.934090988638, 4388.253996820548, 4410.25025745624, 4462.553744625544, 4463.933041004388, 4470.597646211824, 4417.712848664859, 4442.666799989981, 4449.17690227309, 4474.082813023322, 4480.48474425442, 4637.3275874997935, 4755.334253204554, 4838.491958344358, 4842.806287748486, 4882.609391248691, 5146.433892271847, 5166.173412254021, 5191.0656081905245, 5196.350456192976, 5218.973905130488, 4958.479359667219, 5172.19830926207, 5242.7640756166065, 5245.31810864589, 5247.370315562119, 4707.364505791708, 4776.593989510861, 4777.808887644455, 4797.832075877328, 4815.807367705323, 5288.735563221823, 5310.468953104659, 5312.07038768214, 5312.787488500417, 5314.176302673091, 5089.134847076006, 5129.102407078746, 5134.306868572695, 5138.177891537336, 5140.254663073833, 4990.950090499121, 5048.495150484922, 5093.516115968977, 5100.770465329069, 5103.744812759347, 5042.218456139304, 5045.495450454999, 5048.848534543969, 5053.31780209667, 5093.9490605094215, 4855.417349918032, 5027.79888804451, 5036.798528058836, 5038.420581633086, 5043.646944713908, 4230.978845105817, 4295.076558539867, 4332.9133417332105, 4348.217320882271, 4354.346847972766, 3757.5866654667966, 3786.6213378662464, 3789.4315852622326, 3827.942580861289, 3828.1769419574925, 4220.957790422057, 4385.605295523418, 4400.73595584266, 4437.290033594674, 4447.177272204588, 5081.4918508148885, 5130.974345128325, 5145.845624631267, 5217.869553261199, 5218.165093585008, 4361.542038086019, 4377.277749171351, 4382.211201983673, 4391.099824536026, 4431.0694754102, 4610.608098311614, 4611.1469378164475, 4622.491525932145, 4630.467496237909, 4670.789814458358, 4611.377464042378, 4779.498152693917, 4836.322914792002, 4841.588464980516, 4853.6602437829015, 5135.666181698178, 5165.199394093921, 5170.0952333340765, 5175.094358487175, 5234.11020126587, 4583.702059366131, 4851.175300198904, 4858.562729354375, 4865.7323847188745, 4909.68087074339, 4973.378327709036, 5006.774695138801, 5028.094942910311, 5036.269740887624, 5046.369203849519, 5097.133487307241, 5098.592112631055, 5122.154844450624, 5131.820386286462, 5143.948560514347, 4865.659403841697, 4926.064047830901, 4933.383327084114, 4935.259711043373, 4938.037082768969, 4991.425986011655, 5004.349434573628, 5015.498450154955, 5024.723640199824, 5067.315912351933, 4905.0, 4919.631027672867, 4977.228529577921, 4995.925061124159, 4998.325226094431, 4832.540908613676, 4927.926081108714, 4928.630352723489, 5100.132977393926, 5109.540141387293, 4746.0, 4793.328933949319, 4851.490593487633, 4881.438634556929, 4913.6069114471475], "value": 4698.350714303581, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.8564881792123, 570.4210226619981, 581.790555400056, 583.0670926517575, 583.3437382944188, 39358.2128357433, 39689.20621587567, 40715.185696286055, 40792.796036019856, 41079.79460102699, 37331.62668373322, 41014.38478422818, 41085.58914410855, 41158.0, 41177.79411102948, 7549.773506794805, 7861.292483676468, 8015.799605009892, 8021.799455013642, 9978.151857092156, 9820.11618954294, 9926.057024582653, 10238.027387398186, 10240.078392944633, 10257.0, 10248.487575621226, 10328.638497652584, 10332.94833525835, 10333.070023697866, 10333.276670633059, 10184.898151018506, 10268.74328141795, 10279.640212592598, 10280.691579252634, 10285.691429257135, 10178.491075446273, 10247.282690211689, 10249.692509224735, 10255.538500767483, 10265.127464165555, 39236.60763392358, 39431.80284098561, 39446.60553394458, 39478.802605986784, 39630.405543916866, 2843.559248316514, 2867.4981878171443, 2909.985450072736, 2960.7039296070434, 3097.4579448596405, 29925.0, 30124.54813177804, 30562.54156187637, 30586.388272234653, 30759.538606920913, 3636.945445818315, 3640.0, 3653.1780349421433, 3672.338978983782, 3696.2607478504406, 288864.0, 294056.0, 294084.99999999785, 406476.0, 406520.0, 58313.70843145757, 58565.0, 58749.41250587525, 58779.0, 58839.0, 62906.68546657237, 63202.0519692205, 63226.36773632205, 63384.0, 63385.36614633887, 15551.377944882304, 15792.0, 15801.920990394974, 15992.600184995468, 16001.599960001093, 10046.748831279276, 11873.287602743863, 12145.453454594564, 12211.084168687385, 12452.564160254347, 19187.32844350441, 19241.90379048124, 19291.807081929, 19300.1314940828, 19312.80687193138, 7213.49505534618, 7243.637818109179, 7280.199178090405, 7300.744473943492, 7593.430492713069, 758.4425447296233, 803.4416080823771, 857.237059017475, 863.4042510667745, 932.16105505046, 27182.728172718416, 28322.461833299345, 28516.71483285182, 28671.56992645112, 28727.85636071848, 919.4850883505125, 922.4373132389237, 937.6249500199974, 994.5682805540529, 995.2237254941158, 14760.114393136231, 15071.849281507264, 15198.924005380124, 15452.5364239073, 15472.071675699493, 394296.0, 396532.0, 400834.0, 401952.0, 403636.0, 49720.0, 50306.0, 50308.49691503038, 50326.74836625793, 50341.496585034416, 1069.3316677076828, 1194.9006913639298, 1228.9692757680773, 1231.359692959656, 1246.4515613130193, 27641.44717105687, 29119.689613967, 29379.706202937698, 29549.26126846846, 29909.401811964075, 42235.36646950237, 42658.0, 42670.78664606657, 42694.146117078104, 42753.572464274956, 243918.0, 247961.0, 248381.0, 248495.0, 248779.0, 31966.041018769472, 37071.0, 37829.24341513209, 38802.22395552017, 40128.1974360517, 41600.0, 42695.5730442704, 42798.786006071015, 42952.140957180054, 42956.78521607497, 35693.1076723084, 35709.285814284085, 35865.82067089648, 36038.4594231092, 36728.0, 35712.0, 35850.4622430669, 36230.598010103124, 36297.0, 36448.81775591105, 35380.823095884356, 35567.28865422625, 35628.64371356357, 35891.461628076126, 36190.0, 30846.53730194004, 32301.676983230805, 32420.675793241764, 32508.0, 32530.83734581312, 23380.064797407915, 23586.88206558956, 23692.0, 23851.0, 23924.521509569364], "value": 18605.08358860131, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.6265920783178, 357.85506869717767, 360.14106356340136, 370.35927844828444, 372.88813355993193, 15734.921325393372, 16332.918335408322, 16960.0, 16994.065326407042, 17009.659806803873, 15713.528594142193, 16003.119828409463, 16243.187840607952, 16525.752113718274, 16525.91737041313, 4820.421549414075, 5042.344495215617, 5079.288899554047, 5113.0, 5118.027574760802, 3034.438628853658, 3236.3689080629288, 4979.278004689318, 5475.561955043587, 5791.652500849941, 5792.7972520961775, 5838.065909454488, 5874.853128671774, 5875.441833025856, 5878.1770552122525, 5657.0, 5784.421557844203, 5857.736401861926, 5858.443447872467, 5866.0, 2818.3517790908, 4761.928571071437, 5016.122178618763, 5051.797928082872, 5058.696478211319, 20298.89850550738, 20311.492212694655, 20384.0, 20739.58520829575, 20794.48013799652, 1792.3099606651404, 1840.2638944422204, 1882.2000649723814, 1928.3347245200384, 2040.897955102239, 12671.936640316831, 12737.93631031839, 12921.353932303347, 13031.86968130316, 13281.667958301023, 1577.550398136537, 1592.7292360298777, 1611.5165450364962, 1619.1823129319737, 1630.3940618490776, 59065.609714960345, 67121.32878671249, 67647.6149719849, 67760.6611966937, 68717.3128268716, 8940.776480588038, 9208.907910920805, 9287.535623218811, 9625.470599116976, 9806.362586432002, 12387.256764594153, 12403.689907752378, 12465.813012804816, 12486.0, 12520.499180032697, 7342.559446433231, 7498.250174982458, 7568.697252109854, 7602.885956710654, 7732.729354472566, 7585.848283034308, 7684.346830519356, 7685.462017658822, 7793.0, 7871.212878712083, 5815.94184058154, 5921.3190483094995, 5966.343702192756, 6023.020440563587, 6087.66517841523, 1492.8656420922168, 1596.6647004129263, 1605.1412494315484, 1660.3358656537482, 1675.7151284281701, 798.6605692580746, 846.7036537211926, 877.0615441477557, 891.1133422244908, 910.6676063237003, 16850.32598696063, 17115.572110697332, 17164.31342746301, 17182.02072072984, 17748.29006839738, 897.1925267259519, 907.5190149220923, 923.7090316550265, 957.8563215517728, 994.3536701144315, 9977.301588888708, 10058.647947321955, 10135.847962280572, 10242.231832612584, 10248.874093401584, 413112.0, 413903.0, 419819.0, 420269.0, 427312.0, 73279.0, 73422.63288683523, 73484.26515734775, 73524.63237683778, 74209.0, 904.8823652925078, 943.306669597845, 955.5556666150135, 957.9664711735056, 961.3270710502676, 14478.186166498957, 15553.922230388776, 15567.455139070531, 15720.21398930026, 16031.35874565051, 26548.070817521293, 33020.33959320752, 34160.145996349296, 34318.48522272118, 35297.64702352943, 43258.35112473252, 44038.339424909296, 46032.769836150605, 46065.0, 46248.537514624426, 7415.703371865281, 7507.774766757006, 7612.467127301035, 7637.0, 7711.575863327346, 11371.943140284246, 11783.646490605295, 11797.469113890067, 11890.34603096838, 11952.64142075739, 8482.68518379652, 9820.91969883298, 9821.705348839261, 10220.386776793417, 10555.52500137511, 9365.672201472917, 9885.703428897144, 9908.455034973145, 9967.900320996698, 9971.252156088178, 9993.850092248767, 10150.0, 10192.184625229815, 10282.691519254435, 10603.676114250276, 6735.6295403753265, 7006.614636195059, 7263.564186148848, 7273.272672732896, 7620.0, 7711.768646940601, 9781.168600669023, 10272.280940334105, 10339.327943683636, 10506.579736810747], "value": 8168.346617088961, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1208.0396085112334, 1384.9307534623272, 1398.9090709103907, 1452.2375752729822, 1689.5438231677447, 6426.068220108082, 7212.206657267703, 7490.4756667033325, 7501.249875012496, 7689.307962283393, 7403.074615673041, 7588.317051465367, 7605.163432022473, 7615.5811430371305, 7627.199144089874, 2185.115028413495, 2217.301550011749, 2219.1234462387347, 2219.7891200335944, 2220.0, 2134.391698365966, 2161.146347192858, 2191.923282685106, 2193.517426166241, 2199.4281486813384, 2155.385715071205, 2158.5035441848386, 2166.9241576544823, 2169.045619927227, 2193.451637090727, 2127.553213825091, 2162.416147640144, 2167.815735662463, 2168.11107445948, 2168.27362833451, 2069.2757534862826, 2144.6246906791407, 2146.9570608587896, 2148.9684951223344, 2149.720536330283, 7565.508241964255, 7567.432442566829, 7621.428392870502, 7632.923670763333, 7844.4901081429525, 4434.778261086965, 4552.8861778455475, 4560.201964656172, 4560.315952607136, 4565.429321334833, 2750.587411888213, 2851.987544421742, 2906.578546110823, 2908.5346344584764, 2920.78094142938, 885.6236099657684, 891.8706787515774, 892.638481415028, 901.833160865242, 907.1155623267327, 10215.591376344937, 10287.228457865614, 10291.0, 10331.638392656296, 10334.17326613869, 3835.2521258354354, 3920.6079392061138, 4006.5192176938954, 4058.837646494166, 4088.8160032798596, 8219.917800822035, 8272.420930534805, 8274.462159959583, 8277.089520152778, 8303.294219991247, 4323.027318853296, 4333.328334108218, 4353.281708518059, 4368.694191406571, 4377.430933978562, 3585.928281434357, 4016.0, 4134.545200027995, 4154.439150714676, 4168.437260969791, 3374.8401023345077, 3394.2702319001532, 3430.2281986552825, 3472.756907016535, 3502.8598856045983, 997.9501024948723, 1038.8909164537765, 1039.4127318065268, 1042.4266653340633, 1052.8526006358964, 653.8855700252436, 776.088096486626, 790.1229635105029, 793.6904607203195, 806.4435539477859, 4882.2432522959, 4925.458199598042, 5033.370828646419, 5080.212567052113, 5117.0, 400.5873949831678, 404.66210714054097, 404.9976308636102, 405.85389259866423, 423.4220289305138, 3334.483155110962, 3414.6756058174433, 3481.398556663912, 3491.389006923778, 3491.773034752733, 9123.863142052875, 9484.573194206278, 9513.66702165421, 9813.16588090006, 9862.901370986341, 9402.670906518239, 9648.75878103039, 9654.662086826927, 9683.951580242054, 9693.903060969442, 7168.390686791577, 7380.594067326241, 7380.889286660705, 7406.814829629195, 7443.069616297963, 5200.323957885451, 5274.997750427407, 5330.413654498079, 5418.024755543882, 5537.944620553743, 8402.201790829862, 8737.03892571804, 8745.212930836255, 8769.210771030637, 9048.457092574467, 8695.479107165838, 8917.152870477294, 8937.150970657776, 8945.507997060224, 9041.77395565116, 5586.357568879631, 6268.091126786499, 6507.251666058464, 6522.249941256816, 6709.7316107355155, 7488.063992001, 7501.662425190771, 7547.886781698388, 7566.31903128721, 7581.052368453943, 6419.0, 6793.490488213502, 6811.386975172259, 6845.110135682329, 6892.069570608104, 6670.0, 6689.0, 6701.262861085374, 6803.89794153098, 6811.250762416229, 6055.0, 6117.908231376444, 6171.043488259327, 6178.042403427476, 6183.752649893954, 4252.851150209728, 4264.360345948133, 4276.31578947367, 4308.2460569400855, 4336.284513055437, 4109.404136400145, 4164.20880032805, 4184.225918205142, 4192.266353388206, 4265.616094551505], "value": 3932.524657861623, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.9042220856013, 294.58169399452777, 300.58969506623464, 300.9548567714844, 301.0786991805076, 4681.4616319123315, 4794.3767310249705, 4819.325294458774, 4927.98976209877, 4945.579625731808, 4658.580727734503, 4802.759862006903, 4804.879878003052, 4810.206315957871, 4824.155772739774, 3786.280606684728, 3790.5451345838537, 3800.619938006205, 3814.7329686921926, 3824.9426258606004, 3570.553680789901, 3663.46879702443, 3789.128500444899, 3796.54441467023, 3803.8668646597375, 3785.186184970231, 3802.2015376770773, 3812.866549670762, 3817.7900215488276, 3822.2546603412347, 3773.245350929811, 3786.2995345861104, 3792.184680293736, 3801.2777572261184, 3808.4096964970195, 3366.6296707362417, 3380.256343604403, 3380.6281309055985, 3385.5260263563123, 3385.5768028996376, 4613.9618585817925, 4676.251799712064, 4680.765961701902, 4688.249880019214, 4701.365315682373, 4317.15815415994, 4317.417148684919, 4323.178596066738, 4331.523532411432, 4334.5882141196535, 5007.749612519396, 5017.899642007176, 5024.723640199788, 5031.6729412588065, 5046.208595948458, 3522.3307571561577, 3624.0033990652782, 3630.310241054218, 3633.3278343506536, 3644.4351125575577, 5175.482451754832, 5239.633225674166, 5257.08001099806, 5262.447443018505, 5279.815206467755, 3705.7776533408082, 3709.2581483703366, 3725.3666876631037, 3743.7753734776, 3755.9812200938823, 3651.0, 3813.103920578662, 3830.004198908304, 3834.328992426314, 3843.8462461501786, 4226.5773422657485, 4226.873193804191, 4228.281192197333, 4260.87086921966, 4276.935845962313, 4973.278874563241, 4975.303457515951, 4975.4278258000795, 4983.206045823501, 5009.547231302954, 1215.2404747033104, 1269.1369868489517, 1298.6818229533635, 1299.1620404838825, 1300.8048792681172, 831.5655494272332, 834.8585877224899, 855.6962278391206, 861.9353548483889, 868.2880038368603, 3984.9913315447234, 4022.0694066848077, 4029.5567487576345, 4046.612498625825, 4049.542164820662, 4510.571495707968, 4633.467151277646, 4676.381226513164, 4683.695559788603, 4689.859304220879, 3965.4646622705563, 3997.400389941474, 4001.4598029265676, 4030.5163380393956, 4054.878353649395, 2303.7465878753324, 2446.853188808642, 2448.4980578981267, 2459.913903013386, 2477.541654793833, 4368.8907777305185, 4388.341748737715, 4402.185595664748, 4407.779611019436, 4423.0, 4703.424352841768, 4711.3639658646325, 4727.289078073695, 4760.9765849513815, 4764.356811830427, 3965.2599388379203, 4385.605295523418, 4394.780260986938, 4395.846145384896, 4430.648652161121, 4587.449506059294, 4602.516735742699, 4621.907561848811, 4636.211843986463, 4656.764752918686, 4465.566266384893, 4503.301988191835, 4505.459344878635, 4535.637149028136, 4549.181147393501, 4128.896777580585, 4334.154839806208, 4364.0, 4367.759773212377, 4394.934075988799, 3343.3981883261245, 3371.129023392041, 3374.1901943533867, 3388.5764279465066, 3430.691237788611, 4531.0, 4563.877796824492, 4585.380973568525, 4675.737550861317, 4982.925256121089, 4860.489648586848, 5025.874353141201, 5088.516590923857, 5095.872603184802, 5107.540321371094, 5031.496850315086, 5035.16919708244, 5065.645404821775, 5073.543381095719, 5073.92389114171, 4781.402324709411, 4965.602751779921, 5003.599712022957, 5009.924851127309, 5010.69935803853, 5095.286659867547, 5096.210087436453, 5097.337346145126, 5106.872328191825, 5121.103806833864, 4977.776000079933, 4978.626603004716, 4984.601231901512, 4993.201087825931, 5013.498650134958], "value": 3673.981879849701, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.3369371438844, 538.4158188365623, 542.9701366424845, 550.6833570696849, 551.269567822635, 10451.790964180711, 11145.052670522995, 11146.777064458716, 11157.163212759035, 11163.720906977329, 12011.159218854684, 12215.328156951364, 12325.445354959025, 12578.99368050556, 12922.5477108301, 599.9280086389639, 740.7222291640635, 764.3961270596236, 775.9107702614187, 777.5567926282022, 782.3897360059163, 796.0845028217567, 796.7291121018852, 796.77690246731, 796.9960150199241, 827.0819390476566, 831.1314676163394, 831.4055450352996, 832.0, 832.6211573733937, 629.968501574924, 768.4697558684545, 817.9427440079197, 822.5722624235394, 823.6170180865896, 601.4646964201863, 601.9488343490808, 601.9608725432832, 602.1840406249556, 602.5631417222522, 11215.271007384494, 11225.550977960871, 11250.606228782035, 11255.774884502263, 11257.437128143642, 11774.411279436079, 12268.693282667915, 12339.50641974329, 12428.937855310665, 12726.518328925864, 9212.447253164764, 9428.198603118743, 9431.952840235756, 10687.038166565046, 10747.83878241827, 4136.751794892316, 4190.811413486401, 4222.59885310895, 4243.193793179286, 4252.468441444819, 55737.163942540894, 56331.0, 56864.71567642135, 57583.424165758224, 58456.83086338292, 9533.666321678707, 9549.427034377959, 9746.415215086976, 9769.413835169913, 9892.851607225897, 15674.0, 17225.56936076608, 17333.959962402296, 17483.0, 17510.91244543769, 6185.567010309235, 6249.625082481847, 6384.170057892445, 6550.115734375799, 6742.056112144303, 3546.2021045265124, 3631.1829838286176, 3642.3990041642833, 3680.4479328100465, 3726.7018638508853, 2697.2447714639934, 2778.2220978126156, 2783.0120307291027, 2785.832850029005, 2786.373066060161, 496.37704680625586, 510.4997102839164, 513.512163444729, 515.0574448758763, 517.9870503237449, 412.3402555910519, 478.2754127496845, 513.1020713750936, 527.082875796112, 529.9814506492254, 6962.1297337832775, 7284.271572842674, 7300.744473943387, 7414.295641914009, 7436.290486608305, 465.353159108839, 518.3675915383302, 520.4171328112539, 546.5108727688696, 553.8255449533384, 3180.189051791778, 3373.1735724747596, 3401.4897765334904, 3556.2531868307947, 3642.053066202753, 52577.211341829905, 78435.0, 88416.6737498938, 88597.0, 91250.54374728084, 78661.60669196617, 78697.0, 79321.60339198267, 79473.0, 79654.0, 43679.0, 65693.34306656872, 70416.0, 70649.29350706427, 70971.64514177396, 6721.126253587003, 6736.360045795642, 6880.724771009303, 6880.759173428906, 6888.276730943179, 42120.36819447772, 42179.0, 42497.36253956131, 42933.785331074396, 43830.34254486249, 58672.4132758667, 62816.37183628288, 63000.68499657656, 63106.36893631005, 63328.100156995366, 9058.682946096855, 9128.680496182602, 9214.861777073484, 9260.49067301305, 9336.346455748304, 9610.903890961281, 9677.467739274407, 9872.555734991798, 10067.798644026932, 10256.846147307946, 7323.890141647986, 10511.526981286013, 10610.023961661589, 10616.681499555025, 10874.184436167478, 9787.559559819967, 10076.395416275047, 10195.811952573566, 10323.896761032294, 10534.68395948092, 10524.162158925523, 10570.207234457293, 10595.258331917, 10944.23390362667, 10946.671599852018, 9202.539873006457, 9563.856542152012, 9569.282303827102, 9646.565904534173, 9767.9023209767, 9086.636534538544, 9095.454272743656, 9104.362694611315, 9156.359054866096, 9321.44071355721], "value": 6030.277615187243, "unit": "score"}], "name": "dromaeo_css", "value": 6294.850756096895, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 112.0, 113.0, 112.0, 113.0, 112.0, 113.0, 113.0, 114.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 130.0, 134.0, 184.0, 131.0, 140.0, 156.0, 137.0, 187.0, 131.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 163.0, 161.0, 160.0, 164.0, 162.0, 164.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 130.0, 75.0, 76.0, 75.0, 75.0, 96.0, 75.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 129.0, 87.0, 87.0, 86.0, 121.0, 85.0, 86.0, 133.0], "value": 98.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 64.0, 65.0, 63.0, 64.0, 71.0, 64.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 83.0, 84.0, 83.0, 85.0, 86.0, 84.0, 85.0, 146.0, 85.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 137.0, 141.0, 130.0, 131.0, 132.0, 131.0, 136.0, 132.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 166.0, 167.0, 168.0, 164.0, 163.0, 164.0, 172.0, 164.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 68.0, 67.0, 65.0, 68.0, 67.0, 66.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1550.3999999999999, "alertThreshold": 2.0}]} 14:16:09 INFO - Return code: 0 14:16:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:16:09 ERROR - # TBPL SUCCESS # 14:16:09 INFO - Running post-action listener: _resource_record_post_action 14:16:09 INFO - ##### 14:16:09 INFO - ##### Finished run-tests step (success) 14:16:09 INFO - ##### 14:16:09 INFO - Running post-run listener: _resource_record_post_run 14:16:09 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 531668992; Read time: 16; Write time: 603504 14:16:09 INFO - TinderboxPrint: CPU usage
13.3% 14:16:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 14:16:09 INFO - TinderboxPrint: I/O write bytes / time
531,668,992 / 603,504 14:16:09 INFO - TinderboxPrint: CPU idle
8,310.8 (86.7%) 14:16:09 INFO - TinderboxPrint: CPU user
1,222.9 (12.8%) 14:16:09 INFO - TinderboxPrint: Swap in / out
0 / 0 14:16:09 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 245350400; Read time: 0; Write time: 369008 14:16:09 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285732864; Read time: 16; Write time: 234480 14:16:10 INFO - Running post-run listener: _upload_blobber_files 14:16:10 INFO - Blob upload gear active. 14:16:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:16:10 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 14:16:10 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'] 14:16:10 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 14:16:10 INFO - (blobuploader) - INFO - Open directory for files ... 14:16:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:16:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:16:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:11 INFO - (blobuploader) - INFO - Done attempting. 14:16:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:16:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:16:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:12 INFO - (blobuploader) - INFO - Done attempting. 14:16:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:16:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:16:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:16 INFO - (blobuploader) - INFO - Done attempting. 14:16:16 INFO - (blobuploader) - INFO - Iteration through files over. 14:16:16 INFO - Return code: 0 14:16:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:16:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:16:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85cf55c8692ab442d265643584f89be0e0b4b9c828ea170d3144f3b104c63b9a215292453b1402fe7cb69b25137c773180ab2fe305e4b9d61fc91de5646e42e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/112e06958c7e3b8ad0df6ecbf03e88dc5038c150c07612fd6f7b7dead787f20a4dafa998fa32852d582528fd773e0225ee3b59317373d871b9d657d776bed91d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a3cc78fc878c45f0d36865cbcea42a1dea510f8651c9527b64eda87a5fa402f391b1159c5b1087523d0d567d84290053f227b95ccbda2cc6d89a49b6ccd7d12a"} 14:16:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:16:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:16:16 INFO - Contents: 14:16:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85cf55c8692ab442d265643584f89be0e0b4b9c828ea170d3144f3b104c63b9a215292453b1402fe7cb69b25137c773180ab2fe305e4b9d61fc91de5646e42e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/112e06958c7e3b8ad0df6ecbf03e88dc5038c150c07612fd6f7b7dead787f20a4dafa998fa32852d582528fd773e0225ee3b59317373d871b9d657d776bed91d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a3cc78fc878c45f0d36865cbcea42a1dea510f8651c9527b64eda87a5fa402f391b1159c5b1087523d0d567d84290053f227b95ccbda2cc6d89a49b6ccd7d12a"} 14:16:16 INFO - Running post-run listener: copy_logs_to_upload_dir 14:16:16 INFO - Copying logs to upload dir... 14:16:16 INFO - mkdir: /builds/slave/test/build/upload/logs 14:16:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.792340 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-09 14:16:16.034830) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:16:16.039857) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571 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/85cf55c8692ab442d265643584f89be0e0b4b9c828ea170d3144f3b104c63b9a215292453b1402fe7cb69b25137c773180ab2fe305e4b9d61fc91de5646e42e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/112e06958c7e3b8ad0df6ecbf03e88dc5038c150c07612fd6f7b7dead787f20a4dafa998fa32852d582528fd773e0225ee3b59317373d871b9d657d776bed91d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a3cc78fc878c45f0d36865cbcea42a1dea510f8651c9527b64eda87a5fa402f391b1159c5b1087523d0d567d84290053f227b95ccbda2cc6d89a49b6ccd7d12a"} build_url:https://queue.taskcluster.net/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/GKnD9qvFTpaMoyh_hmzGtQ/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/85cf55c8692ab442d265643584f89be0e0b4b9c828ea170d3144f3b104c63b9a215292453b1402fe7cb69b25137c773180ab2fe305e4b9d61fc91de5646e42e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/112e06958c7e3b8ad0df6ecbf03e88dc5038c150c07612fd6f7b7dead787f20a4dafa998fa32852d582528fd773e0225ee3b59317373d871b9d657d776bed91d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a3cc78fc878c45f0d36865cbcea42a1dea510f8651c9527b64eda87a5fa402f391b1159c5b1087523d0d567d84290053f227b95ccbda2cc6d89a49b6ccd7d12a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:16:16.065887) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:16:16.066238) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465505731.460067-2000643571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:16:16.149892) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:16:16.150257) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:16:16.150607) ========= ========= Total master_lag: 0.18 =========