builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1467065480.11 results: success (0) buildid: 20160627135316 builduid: e8d9f8ea28b54e3db3b1b6da8c4ed1cb revision: 9f59be70ecfb99c0c40a3f2e771f6dd5fa92651b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 15:11:20.112345) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 15:11:20.113058) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 15:11:20.113459) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 15:11:20.159269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:11:20.159563) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 15:11:20-- 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% 226M=0s 2016-06-27 15:11:20 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123777 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:11:20.325430) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:11:20.325733) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.052069 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:11:20.392032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:11:20.392398) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9f59be70ecfb99c0c40a3f2e771f6dd5fa92651b --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 9f59be70ecfb99c0c40a3f2e771f6dd5fa92651b --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=4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 15:11:20,518 truncating revision to first 12 chars 2016-06-27 15:11:20,518 Setting DEBUG logging. 2016-06-27 15:11:20,518 attempt 1/10 2016-06-27 15:11:20,518 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9f59be70ecfb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 15:11:20,822 unpacking tar archive at: mozilla-central-9f59be70ecfb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635750 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:11:21.043333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 15:11:21.043617) ========= script_repo_revision: 9f59be70ecfb99c0c40a3f2e771f6dd5fa92651b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 15:11:21.044000) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 15:11:21.044270) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 15:11:21.055763) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-06-27 15:11:21.056041) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:11:21 INFO - MultiFileLogger online at 20160627 15:11:21 in /builds/slave/test 15:11:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 15:11:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:11:21 INFO - {'append_to_log': False, 15:11:21 INFO - 'base_work_dir': '/builds/slave/test', 15:11:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:11:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:11:21 INFO - 'branch': 'Firefox-Non-PGO', 15:11:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:11:21 INFO - 'config_files': ('talos/linux_config.py',), 15:11:21 INFO - 'default_actions': ('clobber', 15:11:21 INFO - 'read-buildbot-config', 15:11:21 INFO - 'download-and-extract', 15:11:21 INFO - 'populate-webroot', 15:11:21 INFO - 'create-virtualenv', 15:11:21 INFO - 'install', 15:11:21 INFO - 'run-tests'), 15:11:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:11:21 INFO - 'download_minidump_stackwalk': True, 15:11:21 INFO - 'download_symbols': 'ondemand', 15:11:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:11:21 INFO - 'tooltool.py': '/tools/tooltool.py', 15:11:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:11:21 INFO - '/tools/misc-python/virtualenv.py')}, 15:11:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:11:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:11:21 INFO - 'installer_path': 'installer.exe', 15:11:21 INFO - 'log_level': 'info', 15:11:21 INFO - 'log_name': 'talos', 15:11:21 INFO - 'log_to_console': True, 15:11:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:11:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:11:21 INFO - 'opt_config_files': (), 15:11:21 INFO - 'pip_index': False, 15:11:21 INFO - 'sps_profile': False, 15:11:21 INFO - 'sps_profile_interval': 0, 15:11:21 INFO - 'suite': 'dromaeojs-e10s', 15:11:21 INFO - 'system_bits': '32', 15:11:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:11:21 INFO - 'title': 'talos-linux64-ix-030', 15:11:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:11:21 INFO - 'use_talos_json': True, 15:11:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:11:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:11:21 INFO - 'work_dir': 'build'} 15:11:21 INFO - ##### 15:11:21 INFO - ##### Running clobber step. 15:11:21 INFO - ##### 15:11:21 INFO - Running pre-action listener: _resource_record_pre_action 15:11:21 INFO - Running main action method: clobber 15:11:21 INFO - rmtree: /builds/slave/test/build 15:11:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:11:23 INFO - Running post-action listener: _resource_record_post_action 15:11:23 INFO - ##### 15:11:23 INFO - ##### Finished clobber step (success) 15:11:23 INFO - ##### 15:11:23 INFO - ##### 15:11:23 INFO - ##### Running read-buildbot-config step. 15:11:23 INFO - ##### 15:11:23 INFO - Running pre-action listener: _resource_record_pre_action 15:11:23 INFO - Running main action method: read_buildbot_config 15:11:23 INFO - Using buildbot properties: 15:11:23 INFO - { 15:11:23 INFO - "project": "", 15:11:23 INFO - "product": "firefox", 15:11:23 INFO - "script_repo_revision": "production", 15:11:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:11:23 INFO - "repository": "", 15:11:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:11:23 INFO - "buildid": "20160627135316", 15:11:23 INFO - "pgo_build": "False", 15:11:23 INFO - "basedir": "/builds/slave/test", 15:11:23 INFO - "buildnumber": 88, 15:11:23 INFO - "slavename": "talos-linux64-ix-030", 15:11:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:11:23 INFO - "platform": "ubuntu64_hw", 15:11:23 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:11:23 INFO - "branch": "mozilla-central", 15:11:23 INFO - "repo_path": "mozilla-central", 15:11:23 INFO - "revision": "9f59be70ecfb99c0c40a3f2e771f6dd5fa92651b", 15:11:23 INFO - "stage_platform": "linux64", 15:11:23 INFO - "builduid": "e8d9f8ea28b54e3db3b1b6da8c4ed1cb", 15:11:23 INFO - "slavebuilddir": "test" 15:11:23 INFO - } 15:11:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:11:23 INFO - Running post-action listener: _resource_record_post_action 15:11:23 INFO - ##### 15:11:23 INFO - ##### Finished read-buildbot-config step (success) 15:11:23 INFO - ##### 15:11:23 INFO - ##### 15:11:23 INFO - ##### Running download-and-extract step. 15:11:23 INFO - ##### 15:11:23 INFO - Running pre-action listener: _resource_record_pre_action 15:11:23 INFO - Running main action method: download_and_extract 15:11:23 INFO - mkdir: /builds/slave/test/build/tests 15:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:23 INFO - https://queue.taskcluster.net/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:11:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:11:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:11:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/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 15:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/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 15:11:24 INFO - Downloaded 1361 bytes. 15:11:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:11:24 INFO - Using the following test package requirements: 15:11:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:11:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:11:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:11:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:24 INFO - u'jsshell-linux-x86_64.zip'], 15:11:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:11:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:11:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:11:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:11:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:11:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:11:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:11:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:11: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')]} 15:11:24 INFO - https://queue.taskcluster.net/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:11:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:11:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:11:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/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 15:11:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/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 15:11:27 INFO - Downloaded 22713160 bytes. 15:11:27 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'] 15:11:27 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 15:11:28 INFO - Return code: 0 15:11:28 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 15:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:28 INFO - https://queue.taskcluster.net/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:11:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:11:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:11:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/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 15:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/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 15:11:42 INFO - Downloaded 22713160 bytes. 15:11:42 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'] 15:11:42 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 15:11:44 INFO - Return code: 0 15:11:44 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')]} 15:11:44 INFO - https://queue.taskcluster.net/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:11:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:11:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:11:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/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 15:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/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 15:11:45 INFO - Downloaded 14405240 bytes. 15:11:45 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'] 15:11:45 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 15:11:45 INFO - Return code: 0 15:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:45 INFO - https://queue.taskcluster.net/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:11:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:11:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:11:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/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 15:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hckc1-H3Q3e9_7r7KqonMg/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 15:11:47 INFO - Downloaded 56283114 bytes. 15:11:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:11:47 INFO - mkdir: /builds/slave/test/properties 15:11:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:11:47 INFO - Writing to file /builds/slave/test/properties/build_url 15:11:47 INFO - Contents: 15:11:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:11:48 INFO - Running post-action listener: _resource_record_post_action 15:11:48 INFO - Running post-action listener: set_extra_try_arguments 15:11:48 INFO - ##### 15:11:48 INFO - ##### Finished download-and-extract step (success) 15:11:48 INFO - ##### 15:11:48 INFO - ##### 15:11:48 INFO - ##### Running populate-webroot step. 15:11:48 INFO - ##### 15:11:48 INFO - Running pre-action listener: _resource_record_pre_action 15:11:48 INFO - Running main action method: populate_webroot 15:11:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:11:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:11:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:11:48 INFO - '--tppagecycles', 15:11:48 INFO - '7'], 15:11:48 INFO - 'tests': ['tsvgm']}}, 15:11:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:11:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:11:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:11:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:11:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:11:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:11:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:11:48 INFO - 'talos_options': ['--disable-e10s'], 15:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:11:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:11:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:11:48 INFO - 'talos_options': ['--disable-e10s'], 15:11:48 INFO - 'tests': ['damp', 'tps']}, 15:11:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:11:48 INFO - 'tests': ['damp', 'tps']}, 15:11:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:11:48 INFO - 'tests': ['dromaeo_dom']}, 15:11:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:11:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:11:48 INFO - 'tests': ['basic_compositor_video']}, 15:11:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:11:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:11:48 INFO - 'tests': ['a11yr', 15:11:48 INFO - 'ts_paint', 15:11:48 INFO - 'tpaint', 15:11:48 INFO - 'sessionrestore', 15:11:48 INFO - 'sessionrestore_no_auto_restore', 15:11:48 INFO - 'tabpaint']}, 15:11:48 INFO - 'other-e10s': {'tests': ['a11yr', 15:11:48 INFO - 'ts_paint', 15:11:48 INFO - 'tpaint', 15:11:48 INFO - 'sessionrestore', 15:11:48 INFO - 'sessionrestore_no_auto_restore', 15:11:48 INFO - 'tabpaint']}, 15:11:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:11:48 INFO - 'ts_paint', 15:11:48 INFO - 'tpaint', 15:11:48 INFO - 'sessionrestore', 15:11:48 INFO - 'sessionrestore_no_auto_restore', 15:11:48 INFO - 'tabpaint']}, 15:11:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:11:48 INFO - 'ts_paint', 15:11:48 INFO - 'tpaint', 15:11:48 INFO - 'sessionrestore', 15:11:48 INFO - 'sessionrestore_no_auto_restore', 15:11:48 INFO - 'tabpaint']}, 15:11:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:11:48 INFO - 'tests': ['a11yr', 15:11:48 INFO - 'ts_paint', 15:11:48 INFO - 'tpaint', 15:11:48 INFO - 'sessionrestore', 15:11:48 INFO - 'sessionrestore_no_auto_restore', 15:11:48 INFO - 'tabpaint']}, 15:11:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:11:48 INFO - 'tests': ['a11yr', 15:11:48 INFO - 'ts_paint', 15:11:48 INFO - 'tpaint', 15:11:48 INFO - 'sessionrestore', 15:11:48 INFO - 'sessionrestore_no_auto_restore', 15:11:48 INFO - 'tabpaint']}, 15:11:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:11:48 INFO - 'tests': ['tsvgx', 15:11:48 INFO - 'tsvgr_opacity', 15:11:48 INFO - 'tart', 15:11:48 INFO - 'tscrollx', 15:11:48 INFO - 'cart']}, 15:11:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:11:48 INFO - 'tsvgr_opacity', 15:11:48 INFO - 'tart', 15:11:48 INFO - 'tscrollx', 15:11:48 INFO - 'cart']}, 15:11:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:11:48 INFO - 'talos_options': ['--disable-e10s'], 15:11:48 INFO - 'tests': ['tp5o']}, 15:11:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:11:48 INFO - 'tests': ['tp5o']}, 15:11:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:11:48 INFO - 'talos_options': ['--disable-e10s', 15:11:48 INFO - '--xperf_path', 15:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:11:48 INFO - 'tests': ['tp5n']}, 15:11:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:11:48 INFO - 'talos_options': ['--xperf_path', 15:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:11:48 INFO - 'tests': ['tp5n']}}, 15:11:48 INFO - 'talos.zip': {'path': '', 15:11:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:11:48 INFO - Running post-action listener: _resource_record_post_action 15:11:48 INFO - ##### 15:11:48 INFO - ##### Finished populate-webroot step (success) 15:11:48 INFO - ##### 15:11:48 INFO - ##### 15:11:48 INFO - ##### Running create-virtualenv step. 15:11:48 INFO - ##### 15:11:48 INFO - Running pre-action listener: _resource_record_pre_action 15:11:48 INFO - Running main action method: create_virtualenv 15:11:48 INFO - Creating virtualenv /builds/slave/test/build/venv 15:11:48 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 15:11:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:11:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:11:48 INFO - Using real prefix '/usr' 15:11:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:11:49 INFO - Installing distribute.............................................................................................................................................................................................done. 15:11:51 INFO - Installing pip.................done. 15:11:51 INFO - Return code: 0 15:11:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:11: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')]} 15:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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')]} 15:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb86e032f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10467d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5520>, '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 0x10d6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d68b0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', '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 15:11: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', 'pip>=1.5'] in /builds/slave/test/build 15:11: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 pip>=1.5 15:11:51 INFO - Using env: {'DISPLAY': ':0', 15:11:51 INFO - 'HOME': '/home/cltbld', 15:11:51 INFO - 'LANG': 'en_US.UTF-8', 15:11:51 INFO - 'LANGUAGE': 'en_US:en', 15:11:51 INFO - 'LOGNAME': 'cltbld', 15:11:51 INFO - 'MAIL': '/var/mail/cltbld', 15:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:51 INFO - 'MOZ_NO_REMOTE': '1', 15:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:51 INFO - 'NO_EM_RESTART': '1', 15:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:51 INFO - 'PWD': '/builds/slave/test', 15:11:51 INFO - 'SHELL': '/bin/bash', 15:11:51 INFO - 'SHLVL': '1', 15:11:51 INFO - 'TERM': 'linux', 15:11:51 INFO - 'TMOUT': '86400', 15:11:51 INFO - 'USER': 'cltbld', 15:11:51 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', 15:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:51 INFO - '_': '/tools/buildbot/bin/python'} 15:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:51 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 15:11:51 INFO - Cleaning up... 15:11:51 INFO - Return code: 0 15:11:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:11: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')]} 15:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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')]} 15:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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', '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 0x7fb86e032f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10467d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5520>, '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 0x10d6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d68b0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', '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 15:11: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:11: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 psutil>=3.1.1 15:11:51 INFO - Using env: {'DISPLAY': ':0', 15:11:51 INFO - 'HOME': '/home/cltbld', 15:11:51 INFO - 'LANG': 'en_US.UTF-8', 15:11:51 INFO - 'LANGUAGE': 'en_US:en', 15:11:51 INFO - 'LOGNAME': 'cltbld', 15:11:51 INFO - 'MAIL': '/var/mail/cltbld', 15:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:51 INFO - 'MOZ_NO_REMOTE': '1', 15:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:51 INFO - 'NO_EM_RESTART': '1', 15:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:51 INFO - 'PWD': '/builds/slave/test', 15:11:51 INFO - 'SHELL': '/bin/bash', 15:11:51 INFO - 'SHLVL': '1', 15:11:51 INFO - 'TERM': 'linux', 15:11:51 INFO - 'TMOUT': '86400', 15:11:51 INFO - 'USER': 'cltbld', 15:11:51 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', 15:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:51 INFO - '_': '/tools/buildbot/bin/python'} 15:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:51 INFO - Downloading/unpacking psutil>=3.1.1 15:11: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 15:11: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 15:11: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 15:11: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 15:11: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 15:11: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 15:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:11:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:11:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:11:53 INFO - Installing collected packages: psutil 15:11:53 INFO - Running setup.py install for psutil 15:11:54 INFO - building 'psutil._psutil_linux' extension 15:11:54 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 15:11:55 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 15:11:55 INFO - building 'psutil._psutil_posix' extension 15:11:55 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 15:11:55 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 15:11:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:11:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:11:55 INFO - Successfully installed psutil 15:11:55 INFO - Cleaning up... 15:11:55 INFO - Return code: 0 15:11:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:11:55 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')]} 15:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:55 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')]} 15:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:55 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 0x7fb86e032f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10467d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5520>, '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 0x10d6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d68b0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', '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 15:11:55 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 15:11:55 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 15:11:55 INFO - Using env: {'DISPLAY': ':0', 15:11:55 INFO - 'HOME': '/home/cltbld', 15:11:55 INFO - 'LANG': 'en_US.UTF-8', 15:11:55 INFO - 'LANGUAGE': 'en_US:en', 15:11:55 INFO - 'LOGNAME': 'cltbld', 15:11:55 INFO - 'MAIL': '/var/mail/cltbld', 15:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:55 INFO - 'MOZ_NO_REMOTE': '1', 15:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:55 INFO - 'NO_EM_RESTART': '1', 15:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:55 INFO - 'PWD': '/builds/slave/test', 15:11:55 INFO - 'SHELL': '/bin/bash', 15:11:55 INFO - 'SHLVL': '1', 15:11:55 INFO - 'TERM': 'linux', 15:11:55 INFO - 'TMOUT': '86400', 15:11:55 INFO - 'USER': 'cltbld', 15:11:55 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', 15:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:55 INFO - '_': '/tools/buildbot/bin/python'} 15:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:11:55 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 15:11:55 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 15:11:55 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 15:11:55 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 15:11:55 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 15:11:55 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 15:11:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:11:57 INFO - Installing collected packages: mozsystemmonitor 15:11:57 INFO - Running setup.py install for mozsystemmonitor 15:11:57 INFO - Successfully installed mozsystemmonitor 15:11:57 INFO - Cleaning up... 15:11:57 INFO - Return code: 0 15:11:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:11: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')]} 15:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11: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')]} 15:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:11:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb86e032f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10467d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5520>, '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 0x10d6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d68b0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', '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 15:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:11:57 INFO - Using env: {'DISPLAY': ':0', 15:11:57 INFO - 'HOME': '/home/cltbld', 15:11:57 INFO - 'LANG': 'en_US.UTF-8', 15:11:57 INFO - 'LANGUAGE': 'en_US:en', 15:11:57 INFO - 'LOGNAME': 'cltbld', 15:11:57 INFO - 'MAIL': '/var/mail/cltbld', 15:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:57 INFO - 'MOZ_NO_REMOTE': '1', 15:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:57 INFO - 'NO_EM_RESTART': '1', 15:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:57 INFO - 'PWD': '/builds/slave/test', 15:11:57 INFO - 'SHELL': '/bin/bash', 15:11:57 INFO - 'SHLVL': '1', 15:11:57 INFO - 'TERM': 'linux', 15:11:57 INFO - 'TMOUT': '86400', 15:11:57 INFO - 'USER': 'cltbld', 15:11:57 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', 15:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:57 INFO - '_': '/tools/buildbot/bin/python'} 15:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:11:57 INFO - Downloading/unpacking jsonschema==2.5.1 15:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:11:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:00 INFO - Downloading functools32-3.2.3-2.tar.gz 15:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:12:00 INFO - warning: no files found matching '*.txt' 15:12:00 INFO - no previously-included directories found matching 'build' 15:12:00 INFO - no previously-included directories found matching 'dist' 15:12:00 INFO - no previously-included directories found matching '.git*' 15:12:00 INFO - Installing collected packages: jsonschema, functools32 15:12:00 INFO - Running setup.py install for functools32 15:12:00 INFO - warning: no files found matching '*.txt' 15:12:00 INFO - no previously-included directories found matching 'build' 15:12:00 INFO - no previously-included directories found matching 'dist' 15:12:00 INFO - no previously-included directories found matching '.git*' 15:12:00 INFO - Successfully installed jsonschema functools32 15:12:00 INFO - Cleaning up... 15:12:00 INFO - Return code: 0 15:12:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:00 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 0x7fb86e032f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10467d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5520>, '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 0x10d6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d68b0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', '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 15:12:00 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 15:12:00 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 15:12:00 INFO - Using env: {'DISPLAY': ':0', 15:12:00 INFO - 'HOME': '/home/cltbld', 15:12:00 INFO - 'LANG': 'en_US.UTF-8', 15:12:00 INFO - 'LANGUAGE': 'en_US:en', 15:12:00 INFO - 'LOGNAME': 'cltbld', 15:12:00 INFO - 'MAIL': '/var/mail/cltbld', 15:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:00 INFO - 'MOZ_NO_REMOTE': '1', 15:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:00 INFO - 'NO_EM_RESTART': '1', 15:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:00 INFO - 'PWD': '/builds/slave/test', 15:12:00 INFO - 'SHELL': '/bin/bash', 15:12:00 INFO - 'SHLVL': '1', 15:12:00 INFO - 'TERM': 'linux', 15:12:00 INFO - 'TMOUT': '86400', 15:12:00 INFO - 'USER': 'cltbld', 15:12:00 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', 15:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:00 INFO - '_': '/tools/buildbot/bin/python'} 15:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:00 INFO - Downloading/unpacking blobuploader==1.2.4 15:12:00 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 15:12:00 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 15:12:00 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 15:12:00 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 15:12:00 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 15:12:00 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 15:12:02 INFO - Downloading blobuploader-1.2.4.tar.gz 15:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:12:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:12:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:03 INFO - Downloading docopt-0.6.1.tar.gz 15:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:12:03 INFO - Installing collected packages: blobuploader, requests, docopt 15:12:03 INFO - Running setup.py install for blobuploader 15:12:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:12:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:12:03 INFO - Running setup.py install for requests 15:12:03 INFO - Running setup.py install for docopt 15:12:03 INFO - Successfully installed blobuploader requests docopt 15:12:03 INFO - Cleaning up... 15:12:03 INFO - Return code: 0 15:12:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:03 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 0x7fb86e032f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10467d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5520>, '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 0x10d6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d68b0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', '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 15:12:03 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 15:12:03 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 15:12:03 INFO - Using env: {'DISPLAY': ':0', 15:12:03 INFO - 'HOME': '/home/cltbld', 15:12:03 INFO - 'LANG': 'en_US.UTF-8', 15:12:03 INFO - 'LANGUAGE': 'en_US:en', 15:12:03 INFO - 'LOGNAME': 'cltbld', 15:12:03 INFO - 'MAIL': '/var/mail/cltbld', 15:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:03 INFO - 'MOZ_NO_REMOTE': '1', 15:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:03 INFO - 'NO_EM_RESTART': '1', 15:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:03 INFO - 'PWD': '/builds/slave/test', 15:12:03 INFO - 'SHELL': '/bin/bash', 15:12:03 INFO - 'SHLVL': '1', 15:12:03 INFO - 'TERM': 'linux', 15:12:03 INFO - 'TMOUT': '86400', 15:12:03 INFO - 'USER': 'cltbld', 15:12:03 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', 15:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:03 INFO - '_': '/tools/buildbot/bin/python'} 15:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:12:04 INFO - Running setup.py (path:/tmp/pip-oIn2As-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:12:04 INFO - Running setup.py (path:/tmp/pip-v3uRK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:12:04 INFO - Running setup.py (path:/tmp/pip-9tcyCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:12:04 INFO - Running setup.py (path:/tmp/pip-46Ze4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:12:04 INFO - Running setup.py (path:/tmp/pip-HUhzKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:12:04 INFO - Running setup.py (path:/tmp/pip-rsy_P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:12:04 INFO - Running setup.py (path:/tmp/pip-dLqC0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:12:04 INFO - Running setup.py (path:/tmp/pip-ymZf9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:12:04 INFO - Running setup.py (path:/tmp/pip-9I1YMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:12:04 INFO - Running setup.py (path:/tmp/pip-CCg8DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:12:04 INFO - Running setup.py (path:/tmp/pip-0CbPfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:12:04 INFO - Running setup.py (path:/tmp/pip-sHUk3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:12:04 INFO - Running setup.py (path:/tmp/pip-F3EXy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:12:04 INFO - Running setup.py (path:/tmp/pip-WT0M93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:05 INFO - Running setup.py (path:/tmp/pip-EpNia2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:12:05 INFO - Running setup.py (path:/tmp/pip-97dxRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:12:05 INFO - Running setup.py (path:/tmp/pip-dqZpY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:12:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:12:05 INFO - Running setup.py install for manifestparser 15:12:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:12:05 INFO - Running setup.py install for mozcrash 15:12:05 INFO - Running setup.py install for mozdebug 15:12:05 INFO - Running setup.py install for mozdevice 15:12:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:12:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:12:05 INFO - Running setup.py install for mozfile 15:12:05 INFO - Running setup.py install for mozhttpd 15:12:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:12:05 INFO - Running setup.py install for mozinfo 15:12:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:12:05 INFO - Running setup.py install for mozInstall 15:12:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:12:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:12:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:12:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:12:06 INFO - Running setup.py install for mozleak 15:12:06 INFO - Running setup.py install for mozlog 15:12:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:12:06 INFO - Running setup.py install for moznetwork 15:12:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:12:06 INFO - Running setup.py install for mozprocess 15:12:06 INFO - Running setup.py install for mozprofile 15:12:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:12:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:12:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:12:06 INFO - Running setup.py install for mozrunner 15:12:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:12:06 INFO - Running setup.py install for mozscreenshot 15:12:06 INFO - Running setup.py install for moztest 15:12:06 INFO - Running setup.py install for mozversion 15:12:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:12:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:12:07 INFO - Cleaning up... 15:12:07 INFO - Return code: 0 15:12:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:07 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 0x7fb86e032f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10467d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5520>, '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 0x10d6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d68b0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', '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 15:12:07 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 15:12:07 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 15:12:07 INFO - Using env: {'DISPLAY': ':0', 15:12:07 INFO - 'HOME': '/home/cltbld', 15:12:07 INFO - 'LANG': 'en_US.UTF-8', 15:12:07 INFO - 'LANGUAGE': 'en_US:en', 15:12:07 INFO - 'LOGNAME': 'cltbld', 15:12:07 INFO - 'MAIL': '/var/mail/cltbld', 15:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:07 INFO - 'MOZ_NO_REMOTE': '1', 15:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:07 INFO - 'NO_EM_RESTART': '1', 15:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:07 INFO - 'PWD': '/builds/slave/test', 15:12:07 INFO - 'SHELL': '/bin/bash', 15:12:07 INFO - 'SHLVL': '1', 15:12:07 INFO - 'TERM': 'linux', 15:12:07 INFO - 'TMOUT': '86400', 15:12:07 INFO - 'USER': 'cltbld', 15:12:07 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', 15:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:07 INFO - '_': '/tools/buildbot/bin/python'} 15:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:12:07 INFO - Running setup.py (path:/tmp/pip-QElHv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:12:07 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)) 15:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:12:07 INFO - Running setup.py (path:/tmp/pip-lEcHT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:12:07 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)) 15:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:12:07 INFO - Running setup.py (path:/tmp/pip-Bonh78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:12:07 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)) 15:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:12:07 INFO - Running setup.py (path:/tmp/pip-4Vhsuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:12:07 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)) 15:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:12:07 INFO - Running setup.py (path:/tmp/pip-xmYWO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:12:07 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)) 15:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:12:07 INFO - Running setup.py (path:/tmp/pip-2EAZXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:12:07 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)) 15:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:12:07 INFO - Running setup.py (path:/tmp/pip-17ylZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:12:07 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)) 15:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:12:07 INFO - Running setup.py (path:/tmp/pip-YEsVr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:12:07 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)) 15:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:12:07 INFO - Running setup.py (path:/tmp/pip-xQkaYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:12:07 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)) 15:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:12:07 INFO - Running setup.py (path:/tmp/pip-XrdHnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:12:07 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)) 15:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:12:07 INFO - Running setup.py (path:/tmp/pip-Dca3Kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:12:08 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)) 15:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:12:08 INFO - Running setup.py (path:/tmp/pip-gU7K8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:12:08 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)) 15:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:12:08 INFO - Running setup.py (path:/tmp/pip-koqKLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:12:08 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)) 15:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:12:08 INFO - Running setup.py (path:/tmp/pip-debvnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:12:08 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)) 15:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:08 INFO - Running setup.py (path:/tmp/pip-naGUIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:08 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)) 15:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:12:08 INFO - Running setup.py (path:/tmp/pip-BN6lu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:12:08 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)) 15:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:12:08 INFO - Running setup.py (path:/tmp/pip-TEbZJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:12:08 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)) 15:12:08 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)) 15:12:08 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)) 15:12:08 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)) 15:12:08 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)) 15:12:08 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)) 15:12:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:12:08 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 15:12:08 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 15:12:08 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 15:12:08 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 15:12:08 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 15:12:08 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 15:12:10 INFO - Downloading blessings-1.6.tar.gz 15:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:12:10 INFO - Installing collected packages: blessings 15:12:10 INFO - Running setup.py install for blessings 15:12:10 INFO - Successfully installed blessings 15:12:10 INFO - Cleaning up... 15:12:10 INFO - Return code: 0 15:12:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:12:10 INFO - Reading from file tmpfile_stdout 15:12:10 INFO - Current package versions: 15:12:10 INFO - argparse == 1.2.1 15:12:10 INFO - blessings == 1.6 15:12:10 INFO - blobuploader == 1.2.4 15:12:10 INFO - docopt == 0.6.1 15:12:10 INFO - functools32 == 3.2.3-2 15:12:10 INFO - jsonschema == 2.5.1 15:12:10 INFO - manifestparser == 1.1 15:12:10 INFO - mozInstall == 1.12 15:12:10 INFO - mozcrash == 0.17 15:12:10 INFO - mozdebug == 0.1 15:12:10 INFO - mozdevice == 0.48 15:12:10 INFO - mozfile == 1.2 15:12:10 INFO - mozhttpd == 0.7 15:12:10 INFO - mozinfo == 0.9 15:12:10 INFO - mozleak == 0.1 15:12:10 INFO - mozlog == 3.2 15:12:10 INFO - moznetwork == 0.27 15:12:10 INFO - mozprocess == 0.22 15:12:10 INFO - mozprofile == 0.28 15:12:10 INFO - mozrunner == 6.11 15:12:10 INFO - mozscreenshot == 0.1 15:12:10 INFO - mozsystemmonitor == 0.3 15:12:10 INFO - moztest == 0.7 15:12:10 INFO - mozversion == 1.4 15:12:10 INFO - psutil == 3.1.1 15:12:10 INFO - requests == 1.2.3 15:12:10 INFO - wsgiref == 0.1.2 15:12:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:10 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')]} 15:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:10 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')]} 15:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:10 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 0x7fb86e032f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10467d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5520>, '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 0x10d6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d68b0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', '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 15:12:10 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 15:12:10 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 15:12:10 INFO - Using env: {'DISPLAY': ':0', 15:12:10 INFO - 'HOME': '/home/cltbld', 15:12:10 INFO - 'LANG': 'en_US.UTF-8', 15:12:10 INFO - 'LANGUAGE': 'en_US:en', 15:12:10 INFO - 'LOGNAME': 'cltbld', 15:12:10 INFO - 'MAIL': '/var/mail/cltbld', 15:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:10 INFO - 'MOZ_NO_REMOTE': '1', 15:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:10 INFO - 'NO_EM_RESTART': '1', 15:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:10 INFO - 'PWD': '/builds/slave/test', 15:12:10 INFO - 'SHELL': '/bin/bash', 15:12:10 INFO - 'SHLVL': '1', 15:12:10 INFO - 'TERM': 'linux', 15:12:10 INFO - 'TMOUT': '86400', 15:12:10 INFO - 'USER': 'cltbld', 15:12:10 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', 15:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:10 INFO - '_': '/tools/buildbot/bin/python'} 15:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:11 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)) 15:12:11 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)) 15:12:11 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)) 15:12:11 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)) 15:12:11 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)) 15:12:11 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)) 15:12:11 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)) 15:12:11 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)) 15:12:11 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)) 15:12:11 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)) 15:12:11 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)) 15:12:11 INFO - Cleaning up... 15:12:11 INFO - Return code: 0 15:12:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:12:11 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')]} 15:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:11 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')]} 15:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:11 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 0x7fb86e032f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10467d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5520>, '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 0x10d6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d68b0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', '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 15:12:11 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 15:12:11 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 15:12:11 INFO - Using env: {'DISPLAY': ':0', 15:12:11 INFO - 'HOME': '/home/cltbld', 15:12:11 INFO - 'LANG': 'en_US.UTF-8', 15:12:11 INFO - 'LANGUAGE': 'en_US:en', 15:12:11 INFO - 'LOGNAME': 'cltbld', 15:12:11 INFO - 'MAIL': '/var/mail/cltbld', 15:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:11 INFO - 'MOZ_NO_REMOTE': '1', 15:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:11 INFO - 'NO_EM_RESTART': '1', 15:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:11 INFO - 'PWD': '/builds/slave/test', 15:12:11 INFO - 'SHELL': '/bin/bash', 15:12:11 INFO - 'SHLVL': '1', 15:12:11 INFO - 'TERM': 'linux', 15:12:11 INFO - 'TMOUT': '86400', 15:12:11 INFO - 'USER': 'cltbld', 15:12:11 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', 15:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:11 INFO - '_': '/tools/buildbot/bin/python'} 15:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:12:11 INFO - Cleaning up... 15:12:11 INFO - Return code: 0 15:12:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:12:11 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')]} 15:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:11 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')]} 15:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:11 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 0x7fb86e032f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10467d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5520>, '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 0x10d6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d68b0>, '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': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', '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 15:12:11 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 15:12:11 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 15:12:11 INFO - Using env: {'DISPLAY': ':0', 15:12:11 INFO - 'HOME': '/home/cltbld', 15:12:11 INFO - 'LANG': 'en_US.UTF-8', 15:12:11 INFO - 'LANGUAGE': 'en_US:en', 15:12:11 INFO - 'LOGNAME': 'cltbld', 15:12:11 INFO - 'MAIL': '/var/mail/cltbld', 15:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:11 INFO - 'MOZ_NO_REMOTE': '1', 15:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:11 INFO - 'NO_EM_RESTART': '1', 15:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:11 INFO - 'PWD': '/builds/slave/test', 15:12:11 INFO - 'SHELL': '/bin/bash', 15:12:11 INFO - 'SHLVL': '1', 15:12:11 INFO - 'TERM': 'linux', 15:12:11 INFO - 'TMOUT': '86400', 15:12:11 INFO - 'USER': 'cltbld', 15:12:11 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', 15:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:11 INFO - '_': '/tools/buildbot/bin/python'} 15:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:11 INFO - Downloading/unpacking flake8 15:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:12:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:12:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:12:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:12:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:12:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:12:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:12:14 INFO - no previously-included directories found matching 'docs/_build' 15:12:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:12:14 INFO - Running setup.py install for pep8 15:12:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:12:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:12:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:12:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:12:14 INFO - no previously-included directories found matching 'docs/_build' 15:12:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:12:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:12:14 INFO - Cleaning up... 15:12:14 INFO - Return code: 0 15:12:14 INFO - Running post-action listener: _resource_record_post_action 15:12:14 INFO - Running post-action listener: _start_resource_monitoring 15:12:14 INFO - Starting resource monitoring. 15:12:14 INFO - ##### 15:12:14 INFO - ##### Finished create-virtualenv step (success) 15:12:14 INFO - ##### 15:12:14 INFO - ##### 15:12:14 INFO - ##### Running install step. 15:12:14 INFO - ##### 15:12:14 INFO - Running pre-action listener: _resource_record_pre_action 15:12:14 INFO - Running main action method: install 15:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:12:14 INFO - Reading from file tmpfile_stdout 15:12:14 INFO - Detecting whether we're running mozinstall >=1.0... 15:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:12:14 INFO - Reading from file tmpfile_stdout 15:12:14 INFO - Output received: 15:12:14 INFO - Usage: mozinstall [options] installer 15:12:14 INFO - Options: 15:12:14 INFO - -h, --help show this help message and exit 15:12:14 INFO - -d DEST, --destination=DEST 15:12:14 INFO - Directory to install application into. [default: 15:12:14 INFO - "/builds/slave/test"] 15:12:14 INFO - --app=APP Application being installed. [default: firefox] 15:12:14 INFO - mkdir: /builds/slave/test/build/application 15:12:14 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'] 15:12:14 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 15:12:30 INFO - Reading from file tmpfile_stdout 15:12:30 INFO - Output received: 15:12:30 INFO - /builds/slave/test/build/application/firefox/firefox 15:12:30 INFO - Running post-action listener: _resource_record_post_action 15:12:30 INFO - ##### 15:12:30 INFO - ##### Finished install step (success) 15:12:30 INFO - ##### 15:12:30 INFO - ##### 15:12:30 INFO - ##### Running run-tests step. 15:12:30 INFO - ##### 15:12:30 INFO - Running pre-action listener: _resource_record_pre_action 15:12:30 INFO - Running main action method: run_tests 15:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:12:30 INFO - Python 2.7.3 15:12:30 INFO - Return code: 0 15:12:30 INFO - grabbing minidump binary from tooltool 15:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:30 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 0x10d5520>, '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 0x10d6420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d68b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:12:30 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 15:12:30 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 15:12:30 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 15:12:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:12:30 INFO - Return code: 0 15:12:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:12:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:12:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:12:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:12:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:12:31 INFO - Return code: 0 15:12:31 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:12:31 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:12:31 INFO - Using env: {'DISPLAY': ':0', 15:12:31 INFO - 'HOME': '/home/cltbld', 15:12:31 INFO - 'LANG': 'en_US.UTF-8', 15:12:31 INFO - 'LANGUAGE': 'en_US:en', 15:12:31 INFO - 'LOGNAME': 'cltbld', 15:12:31 INFO - 'MAIL': '/var/mail/cltbld', 15:12:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:12:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:31 INFO - 'MOZ_NO_REMOTE': '1', 15:12:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:31 INFO - 'NO_EM_RESTART': '1', 15:12:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:31 INFO - 'PWD': '/builds/slave/test', 15:12:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:12:31 INFO - 'SHELL': '/bin/bash', 15:12:31 INFO - 'SHLVL': '1', 15:12:31 INFO - 'TERM': 'linux', 15:12:31 INFO - 'TMOUT': '86400', 15:12:31 INFO - 'USER': 'cltbld', 15:12:31 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675', 15:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:31 INFO - '_': '/tools/buildbot/bin/python'} 15:12:31 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:12:32 INFO - mozversion application_buildid: 20160627135316 15:12:32 INFO - mozversion application_changeset: 9f59be70ecfb99c0c40a3f2e771f6dd5fa92651b 15:12:32 INFO - mozversion application_display_name: Nightly 15:12:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:12:32 INFO - mozversion application_name: Firefox 15:12:32 INFO - mozversion application_remotingname: firefox 15:12:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:12:32 INFO - mozversion application_vendor: Mozilla 15:12:32 INFO - mozversion application_version: 50.0a1 15:12:32 INFO - mozversion platform_buildid: 20160627135316 15:12:32 INFO - mozversion platform_changeset: 9f59be70ecfb99c0c40a3f2e771f6dd5fa92651b 15:12:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:12:32 INFO - mozversion platform_version: 50.0a1 15:12:32 INFO - using testdate: 1467065552 15:12:32 INFO - actual date: 1467065552 15:12:32 INFO - starting webserver on 'localhost:45343' 15:12:32 INFO - SUITE-START | Running 2 tests 15:12:32 INFO - TEST-START | dromaeo_css 15:12:32 INFO - operating with platform_type : linux_ 15:12:32 INFO - Initialising browser for dromaeo_css test... 15:12:32 INFO - TEST-INFO | started process 3329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXoOGQg/profile http://localhost:45343/getInfo.html) 15:12:40 INFO - PROCESS | 3329 | __metrics Screen width/height:1600/1200 15:12:40 INFO - PROCESS | 3329 | colorDepth:24 15:12:40 INFO - PROCESS | 3329 | Browser inner width/height: 1024/697 15:12:40 INFO - PROCESS | 3329 | __metrics 15:12:41 ERROR - PROCESS | 3329 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:12:42 INFO - TEST-INFO | 3329: exit 0 15:12:42 INFO - Browser initialized. 15:12:42 INFO - Running cycle 1/1 for dromaeo_css test... 15:12:42 INFO - TEST-INFO | started process 3448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXoOGQg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:12:54 INFO - PROCESS | 3448 | RSS: Main: 185978880 15:12:54 INFO - PROCESS | 3448 | 15:13:43 INFO - PROCESS | 3448 | 1467065623860 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] 15:15:56 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:45343/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45343/tests/dromaeo/cssquery-ext.html) 15:15:57 INFO - PROCESS | 3448 | RSS: Main: 188862464 15:15:57 INFO - PROCESS | 3448 | 15:18:59 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:45343/tests/dromaeo/cssquery-ext.html (next: http://localhost:45343/tests/dromaeo/cssquery-jquery.html) 15:19:00 INFO - PROCESS | 3448 | RSS: Main: 187703296 15:19:00 INFO - PROCESS | 3448 | 15:22:02 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:45343/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45343/tests/dromaeo/cssquery-mootools.html) 15:22:02 INFO - PROCESS | 3448 | RSS: Main: 188964864 15:22:02 INFO - PROCESS | 3448 | 15:25:04 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:45343/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45343/tests/dromaeo/cssquery-prototype.html) 15:25:05 INFO - PROCESS | 3448 | RSS: Main: 186232832 15:25:05 INFO - PROCESS | 3448 | 15:28:08 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:45343/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45343/tests/dromaeo/cssquery-yui.html) 15:28:08 INFO - PROCESS | 3448 | RSS: Main: 188534784 15:28:08 INFO - PROCESS | 3448 | 15:31:11 INFO - PROCESS | 3448 | Cycle 1(1): loaded http://localhost:45343/tests/dromaeo/cssquery-yui.html (next: http://localhost:45343/tests/dromaeo/cssquery-dojo.html) 15:31:11 INFO - PROCESS | 3448 | RSS: Main: 189177856 15:31:11 INFO - PROCESS | 3448 | 15:31:11 INFO - PROCESS | 3448 | __start_tp_report 15:31:11 INFO - PROCESS | 3448 | _x_x_mozilla_page_load 15:31:11 INFO - PROCESS | 3448 | _x_x_mozilla_page_load_details 15:31:11 INFO - PROCESS | 3448 | |i|pagename|runs| 15:31:11 INFO - PROCESS | 3448 | |0;dojo.html;2622.2002289301763;2656.7210442903506;2671.959920601191;2710.94273233439;2718.660167479065;4787.976060119703;4828.348172996644;4883.169861123609;4904.117258893398;4921.040397122562;4823.927641085378;4881.096997055538;4905.509449055093;4933.506649335065;5018.899622007558;4453.220686379878;4474.888127796815;4514.706544074641;4604.516525764797;4638.791254393544;4543.182227199103;4592.058627981256;4629.259318509039;4666.416697912761;4678.485366609671;4418.3372494125815;4456.041950980555;4534.9319760203625;4557.430321209848;4568.794404251784;4450.221211288044;4490.618297444721;4507.819687212507;4533.863984080483;4551.294549344857;4457.286834106528;4483.910321793546;4493.988852508192;4499.775011249424;4511.593956543927;4773.737444440554;4849.75751212438;4862.319275301461;4877.170880950247;4879.097366987119;5240.9213861792105;5260.368755749335;5268.4994925482015;5278.5513231375;5316.840494785162;5298.311219541473;5300.814471493479;5305.098133317345;5305.4164041955355;5360.892782144374;4841.733704646278;4876.804927802848;4891;4891.3396691446915;4917.877053073666;5329.706866122323;5337.653052551572;5352.464753524617;5417.918731219035;5422.3764267109;5201.271821944931;5202.453742357074;5204.1673332266655;5217.113090774577;5265.368155821249;5214.7914083437;5256.500632439912;5273.551748101378;5278.551323137576;5290.6296559241255;5034.320366750515;5034.748262586856;5074.517920797518;5150.845474635767;5155.252488389163;5144.536991670768;5151.25306830515;5162.406323272797;5196.506331898464;5198.896022079537;4390.056137930296;4472.798724057425;4477.306017567283;4486.641068714495;4529.32060190974;3844.519435070616;3866.2654095721723;3895.0457138000806;3899;3943.4676318697184;4512.097580483916;4513.842015529441;4523.909521809545;4529.071540334224;4578.267477203632;5131.974340128276;5237.6071794615555;5291.126964050965;5297.390800058042;5311.176767601028;4502.842400515966;4508.120916421332;4510.909781804411;4575.702579332333;4577.1074640444795;4728.527147285244;4762.476127625959;4769.35613692154;4777.474477807438;4803.471618122004;4797.664163508521;4800.543948324904;4808.08646357191;4937.284093806378;4944.802207911715;5184.662996905189;5196.610254231024;5225.216217567243;5232.241325007776;5238.869028274324;4852.539008794159;4863.440704318907;4871.658983871095;4873.585745211697;4923.630727695366;5146.511081447256;5175.792968281226;5206.817761378334;5220.791168353375;5255.159174532057;5320.17537281722;5321.946780532146;5332.813351532678;5333.919991200212;5334.1732031535175;5025.824096156617;5173.689578625294;5178.171492561172;5183.144781111075;5211.635185537128;4932.580730637793;5031.597472202288;5061.898762024665;5067.214581739836;5094.7962081516325;4933.038057578881;4963.726995015309;5032;5036.420811606712;5075.187969924795;5135.974320128375;5170.948290517047;5181.896362072813;5188.0661480933795;5237.921431178612;4924.803007879645;5008.198688210015;5040.924386134284;5062.772175252197;5074.188129899198 15:31:11 INFO - PROCESS | 3448 | |1;ext.html;548.4314859501824;588.723300048977;595.717034408656;605.8212827215972;606.7269728622122;34619.30761384774;38531.80734096333;38636.420453693216;38646.227075458475;38748.80625596872;38778;39275.41086883699;39304.80347598258;39334.803325983405;39419;7750.573718445483;7856.803579910519;7885.526868387915;7891.723789667363;7920.207979202091;7798.649060792278;7859.29266366027;7884.211578842099;7895.8420831583335;7932.246436588515;7860.921390786105;7908.565028923435;7911.446198766089;7919.445638805286;7944.801379965489;7802.726904558342;7836.177201393829;7891.1714270001685;7906.169852165526;7919.7228097016905;7689.192634773324;7760.689572417096;7764.961175194145;7773.611319434062;7800.570968596725;31574.36851262962;31593.684063159533;31758;31761;31812.522812157837;2478.9752102478924;2939.9853000735075;3125.203073216338;3534;3754.2303827715255;28115.57826632602;28591.714082859115;29104;29337.853310733524;29742.512874356195;3093.7370323522528;3100.8139511629374;3101.65881753007;3155.1796532901612;3157.273827019775;220909;221694;222076;222126;222905;31278;31452.21369465736;32198.678013219567;33054.3389132216;33129.66870331314;34670.47994280088;34710.47934280988;34715.65284347175;34773.82613086969;34841.30317393638;11597.246178998337;11672.124590655734;11816.409179540988;11833.763324733458;11872.40637968098;9335.673251436303;9478.052194780466;9484.762880928032;9485.573149208301;9533.570989305497;7917.802054948673;7921.287084162453;7959.801004974806;7964.721234756872;7970.521768693781;3097.829619370911;3109.1449851291077;3147.1345380020675;3172.732085951474;3180.9204769880475;852.8379607874484;925.9952951048053;967.1295833749682;982.1455333859587;987.629638885418;28426;28780.856095719388;29214.853925730236;29275.414491710046;29742.40515189684;943.0616536546044;1001.0690058245756;1014.2291858187831;1017.6183931025865;1038.2732087538752;14962.775558366633;15012.47456339023;15251.771223431657;15423;15645.608859778597;404274;410994;411032;412705;413292;51062.48937510652;51613.74193129085;51790;51937.7403112982;51948;1123.224974767408;1147.552454542729;1171.822318569849;1174.0842143128373;1179.0508640544444;27182.592261115704;27634.447311053264;28289;28652.85673571619;28869.42261154807;44414.555854441045;44701;44767.776161118985;44773.776131119135;44854.77572612116;327908;331483;332895;333206;333406;25829.354266142745;25933.08933654716;26433.207003789918;26619.20142395731;26751.464970700865;43474.565254348316;43858.34212486879;44200;44227;44518.10963780642;37700;38048.048798780255;38101;38421.807890960365;38585.614143859326;37463.43804842875;38188.809055954545;38344.233115338095;38730.4190437138;38900.027499312746;34085.65914340825;36678;37322;37401.43897841589;38361.42457863079;32838;33932.49101263434;34009.31981360309;34278;34689.82655086708;26035.73964260333;26437;26476.73523264743;26621.866890665424;26661.866690666422 15:31:11 INFO - PROCESS | 3448 | |2;jquery.html;368.7639910457306;374.08349543618135;374.9006513273982;379.1034204107287;391.9059425737822;16581.917090414547;17174.39889603864;17769.79452496615;17895.910520447378;18176.818231817662;15838.366465341373;16601.584960375967;17430;17432.3027078917;17468.126593670328;4691.061787642477;4897.191963326047;4934.605231581465;4934.901301973959;4935.136351138554;3534.2754735279336;4867.3915760529935;5402.270693456392;5673.290838645169;5674.716264186774;5737.454941780524;5752.28096487939;5763.884722305552;5764.913526297109;5776.653400795944;5678.517326027272;5748.7987920423;5752.539796816265;5757.654540727549;5757.68332741699;4560.156371071329;5389.380221274564;5487.42382049887;5499;5514.228008078872;19957.401277961686;20175.697364539545;20441.182352705873;20611.69082463764;20641.690374644393;1846.2984066054948;1855.554666879939;1938.6995015772436;2010.9497262568407;2233.9106435742715;9079.546022698905;9147.496887671176;9202.493862837542;9329.813403731956;9410.95294523523;1654.7600597913236;1662.393226472341;1678.2951160512614;1679.6730582839664;1746.8777185597014;63785.68107159481;66344.99999999952;66875;67660;68252.6587367065;9969.501524923724;10090.899091009143;10281.794364112677;10358;10454.790904182026;14121.646958825906;14196.29018549089;14256.215908125152;14264.144151350953;14278.071925325028;7143.178534468499;7166.892496612555;7186.856262874713;7278.963605182046;7352.96323518379;6739.696713647898;6786.966065169642;6788.422984046312;6877.552959057645;6893.379595836399;4439.1121775645;4445.310976798602;4451.198784218872;4486.955130448654;4528.728276303433;1639.1722180298873;1675.656490419461;1759.9296028158985;1826.2329821475012;1847.7875044370069;812.5409143833715;845.6997765793178;871.1984973824098;883.8232353529191;934.621478301289;16598.75101873473;16615.916920415322;16939.830601694073;16969;16985.23566439513;803.5299349880269;838.3293365307729;841.6591280531395;869.517417833096;940.6378544260372;9264;9388.389754665925;9451;9538.332316737762;9617.903820961701;400808;402862;405058;412535;413599;77460;77735.22264777393;79054.604726976;79232.60383698044;79306.20693793104;907.0566610724904;919.3426699909596;920.185635712386;931.4644079654225;934.7522906429801;14707.41170353174;15099.622509437351;15165.24173791328;15237.161956092077;15348.693026139637;35681.28637427289;35721.285574287846;36109.27781444304;36537.63462365342;36894.8155259222;46525.53474465347;48640;51530.742346288025;51914.74042629763;52152;7561.924380756122;7651.617419129133;7685.730999414994;7864.764057078297;7880.093789214085;8542.530160841214;11042.392668402994;11320.62360713324;11367.715807104558;11801.704957376134;9860.753481163028;9993.950635183492;10302.33034852732;10646.095081918123;10767.192460565646;9865.704028879145;9943.154831839374;10187.898121018696;10464.267501274837;10618.1505479563;10038.698839034842;10191.337563058378;10202.081812636898;10385.584576616851;10614.681559553226;7623.199564045695;7679.616019199129;7744.341730952932;7748.883766743616;7848.529088254723;9507.524623768923;10039.247056470647;10516;10534.473276336306;10571.36571805694 15:31:11 INFO - PROCESS | 3448 | |3;mootools.html;1387.0706626560207;1411.2590889782864;1522.573679369776;1700.9489715308546;1702.1149002518698;6803.4897382696245;7405.814854628624;7438.144613369464;7911.999999999993;7912.9604351978305;7411.110666719987;7483.925160748391;7665.923340766591;7687.461877668566;7703.845923081535;2154.762976072631;2219.1678120704737;2219.622664147099;2220.04538048639;2225.499262665903;2179.8474106812528;2214.8449608527408;2238;2245.9775402246014;2250.1561914282142;2197.450637340665;2219.1123550579737;2224.2993457061057;2226.565819665166;2236.575050740354;2159.3845753960204;2183.9454013649706;2184.464806122502;2185.6830759539857;2191;2140.646793279107;2148.119271098842;2149.795769401904;2161.221960094365;2162.7188465499544;7766.262205090507;7776.961115194445;7779.183185765526;7793.415493837985;7821.178776228528;4617.676762626617;4725.1022305762135;4736.881577960544;4743.928841067353;4763.404574428197;2792.190264823199;2816.5915942188267;2900.9274768130754;2902.274431392152;2953.025501584472;938.2212763406357;999.5502024089117;1039.6517166749147;1042.306865934153;1073.6564299424188;10364.792704145875;10577.100946419563;10626.787464250749;10724.302920310232;10771.084457821094;4136.73111247768;4289.270823959934;4299.183155200564;4308.870733877989;4368.934465983013;9244.8613270801;9259.768505787275;9268.490233037113;9300.162985331217;9300.906990930003;4686.625069994392;4698;4699.365585645963;4704.012157446974;4715.434147902273;3785.886423407302;4167.9583204168175;4260.382244574519;4311.50417701962;4367.672424568106;3665.9450108248398;3681.5582130144553;3759.721694623841;3765.811709414518;3783;1161.9186656933935;1175.717827721358;1178.6876477733408;1181.787278289916;1182.030734797475;724.6087112959049;737.3363972424861;740.76665850257;756.1908757629394;756.5007095317064;4929.630277729185;5152.793888244503;5225.503577160163;5236.1098613235845;5263.684178949199;418.332943221263;423.07980143188445;429.78295960539725;431.40035350862325;433.1142812947467;3415.4023045966856;3606.080449485417;3661.1579336752698;3674.356987527172;3678.3746763050344;9440.10319019692;9716.465594392377;9723.319367644339;9787.412755234709;9812.215022798158;9086.86369704455;9733.902660973441;9751.268654850914;9770.169535589555;9781.364211326241;7155.534890232118;7341.045664063744;7354.411647068222;7401.851962960711;7403.074615673041;5169.793208271627;5440.211169380338;5505.6696598204235;5511.338639363142;5582.525485333792;8964.193222609736;8973.05782892787;9061.501617411106;9160.129787670161;9269.212116970133;9065.501397423204;9184.49485278316;9221.400608960395;9320.906790932275;9400.76498087526;6033.155358249936;6613.074169616161;6735;6854.451643868579;6855.622940738307;7468.813279668052;7509.51188172767;7514.323710866049;7535.73624923125;7578.81052973658;6671.099401580725;6879.174499060145;6911.550749201286;6922.134733158356;6939.548929319578;6665.900011499928;6855.143107111611;6859.725610975505;6870.896936546056;6878.174619045746;6034.336223015553;6054.273487181566;6101.359357267423;6115.969420152871;6118.663473509;4421.46942366918;4486.304622783474;4509.2559727644575;4511.436070491189;4535.863924082283;4538.636909047203;4544.341070544819;4626.421697287839;4678.228092364721;4691.812327506998 15:31:11 INFO - PROCESS | 3448 | |4;prototype.html;306.47898572426874;309.2901790391052;313.34041841922755;313.9623245210575;317.6410655958766;5034.723090230041;5054.216596427555;5055.393352797665;5093.046033300686;5103.438621751614;5009.248612708096;5011.774470148843;5030.82392116276;5040.319556859823;5081.161608334621;3786.2806066847347;3867.7679339239594;3967.36522156455;3972.6226008529143;3994.424989634276;3966.841326346943;3971.9205615887663;3991.540972788123;4021.537523184842;4027.62370201581;3991.1219531702977;3994.940075898864;4013.799310034501;4018.2164477926817;4038.9798051009852;3803.6576708096404;3976.284268831609;3991;4060.878173654795;4065.87802365928;3520.556571805573;3521.330947120039;3528.4530897710897;3543.840527176283;3547.9113022174392;4979.526944940261;4986.825461108844;4989.226669866141;5004.224345226496;5039.47085556015;4492.517469235145;4515.143650048924;4579.793909274057;4613.400257966477;4626.745528995903;5319;5319.627626066177;5319.867003324909;5334.226537152092;5367.194920761878;3838.942415863736;3854.4411060396087;3861.498005259298;3865.323568375523;3890.9027274318087;5368.355797304349;5591.384947655754;5599.384067752585;5599.832005039855;5609.270794796691;3809.1810260794064;3815.3323168445413;3823.885283441501;3836.271108489378;3836.3094642964534;3870.43878637596;3871.593482684334;3875.2636998970106;3877.689784817208;3894.7078969077434;4460.553944605514;4485.887852803706;4488.12481566098;4490.775461226991;4491;5163.974180129076;5314.707691077027;5338.3060202173465;5370.1407774756635;5422.213779002102;1396.9941642017732;1401.7336706025822;1408.0917808013774;1418.2554159066367;1418.4326269492285;907.587047893207;909.8771665825029;927.1609193679731;928.5774972387547;948.4735971535864;4571.794269257892;4608.354830323758;4609.9308510372375;4625.676202665848;4630.560096790799;5377.848860455849;5380.650257733235;5392.811251606254;5397.541208997279;5448.809291674852;4482.305242687324;4496.910061798746;4606.539346065367;4616.3537104805355;4624.838130665411;2875.180573536532;2879.467298549775;2884.7115288471405;2916.7520760735574;2919.6204493416144;5071.594272458195;5129.281900533928;5143.665661731976;5148.330717006766;5153.1497302945345;5371.731413429313;5603.215549822947;5608.9439105609235;5631.915521267184;5653.123765816305;5037.168867136955;5062.924056139161;5080.872978175576;5092.745362731923;5133.076046311699;5437.8852335270385;5442.673439593637;5466.480684334982;5475.945240547703;5493.176023596492;5149.639525233198;5384.60385128614;5453.727313634223;5456.181572764117;5485.835424937259;5188.650950752756;5196.792128314976;5199.894042912626;5233.424323324355;5244.7639856207325;3917.236138952877;3920.843166273431;3936.0750223697983;3944.5463771665477;3953.7430067046703;5460.5085542301385;5496.477834605706;5574.163875418558;5585.497305242548;5588.133839254922;5329.600279978939;5385.973070134624;5390;5404.43253458397;5404.918926216032;5193.221016847503;5319.973400132974;5374.48942350476;5381.515663590296;5428.402875683751;5263.421023687315;5291.841244762663;5332.173513105475;5344.198370244339;5344.893102137858;5101.342063829196;5231.738413079254;5417.674939503485;5432.511074003359;5455.5908306876345;5289.338832645919;5295.126304159925;5297.708626025606;5299.708516031656;5333 15:31:11 INFO - PROCESS | 3448 | |5;yui.html;601.6406582423781;602.2682440834385;668.4084585142148;691.4399336537407;699.6222040098347;12803.807942880852;13026.348682565882;13478.932605336984;13511.391987360568;13551.864481355184;13187.538436154737;13371.130876493022;13395.397207125678;13405.396757145927;13503.25732084735;627.7959663109485;776.3556248313914;777.8288776469168;792.065362871811;792.239450127878;796.0487217774762;796.0685997383076;796.9163237860029;799.6681377228443;800.33572135128;828.8342331533718;829.8755186721979;831.0276975938167;831.6881169561415;832.6835802395082;812.4312980913326;817.7097130518699;823.3577809308719;825.1171246765963;826.9090400056019;601.5007543738686;603.4297588778606;603.7132362127954;603.7675494934438;604.5737754882797;13142.540011099662;13219.206847589176;13225.338733063309;13228.669283267898;13231.470741170342;13838.861611383858;14065.085769424955;14286.357113929898;14333.21167335796;14529;10163.796724065478;10311.329763565343;10393.116585090202;10399.896001039968;10409.115225205867;3306.272620023591;3311.1391038329966;3316.585426821647;3357.7985320880825;3391.2030672791875;62357.52849430087;62863;63130.684346577975;66083.3391666082;67030.32969670338;11026.393548354918;11032.669019929415;11077.556897724162;11112.555497779998;11198.104151667847;19211.51971200731;19392.8060719391;19405.611887762167;19484.902575487315;19558.511037224183;7054.188768291609;7064.32888875556;7116.430685545144;7153;7176.282371762782;3767.56672982605;3818.8090595470117;3841.615838416136;3849.7690138591774;3856.9421458678144;2766.502029634685;2859.3280579063903;2876.8993085241914;2878.409925965172;2881.7406433421093;483.3450674336294;487.96584239102924;494.15006189354256;504.45518839653084;505.4212926199481;399.4924562342636;418.8596820065312;481.71097341595464;488.3334248750501;504.2008416659562;7458.105027396638;7631.900007469583;7634.732784352632;8029.7189598363775;8497.405181637227;412.87820093072617;423.62509179376474;425.05114052070985;428.4259092815642;457.5538849621659;3666.2667466506805;3722.8510859565854;3769.7172712046704;3866.478025466582;4283.678724095706;59684.70157649184;76902;100235;100818.49590751999;102562;87362.56318718493;90260;91550.54224728968;91767.54116229377;92552;47941.28088078681;47976.52023479791;62783.80256690994;65396.67301663461;66117;7961.40289478303;8080.434369594307;8137.75586732399;8187.3040791533385;8435.861158743737;41602.58397415987;41610.58389416067;42133.78933105315;44021;45387.77306113448;61105.38894611175;63464;63650;65614;65809.34190658224;10383.117435018108;10417.791644167226;10444.947775261075;10482.21383396233;10681.839772403575;11087.279326843729;11136.443177841238;11321.03771179459;12091.334976576372;12127.401989846489;10526.947365263431;10531.526081326205;11113.83329250078;11140;11452.942735286604;11113.274327447709;11221.495032723384;11299.717507062389;11326.37704926237;12037.277763334228;10523.052925236765;10528.578856845947;10581.947090264499;10981.780364392507;11397.943010284895;9224.40041397307;9355;9374.625014999323;9531;9709.223262139154;9450.952745236229;9647.903520964981;9847;9847.359921605073;9861.802763944537 15:31:11 INFO - PROCESS | 3448 | __end_tp_report 15:31:11 INFO - PROCESS | 3448 | __start_cc_report 15:31:11 INFO - PROCESS | 3448 | _x_x_mozilla_cycle_collect,389 15:31:11 INFO - PROCESS | 3448 | __end_cc_report 15:31:11 INFO - PROCESS | 3448 | __startTimestamp1467066671497__endTimestamp 15:31:11 INFO - PROCESS | 3448 | 15:31:11 INFO - PROCESS | 3448 | ------- Summary: start ------- 15:31:11 INFO - PROCESS | 3448 | Number of tests: 6 15:31:11 INFO - PROCESS | 3448 | 15:31:11 INFO - PROCESS | 3448 | [#0] dojo.html Cycles:165 Average:4844.95 Median:4932.58 stddev:513.73 (10.4%) stddev-sans-first:484.81 15:31:11 INFO - PROCESS | 3448 | Values: 2622.2 2656.7 2672.0 2710.9 2718.7 4788.0 4828.3 4883.2 4904.1 4921.0 4823.9 4881.1 4905.5 4933.5 5018.9 4453.2 4474.9 4514.7 4604.5 4638.8 4543.2 4592.1 4629.3 4666.4 4678.5 4418.3 4456.0 4534.9 4557.4 4568.8 4450.2 4490.6 4507.8 4533.9 4551.3 4457.3 4483.9 4494.0 4499.8 4511.6 4773.7 4849.8 4862.3 4877.2 4879.1 5240.9 5260.4 5268.5 5278.6 5316.8 5298.3 5300.8 5305.1 5305.4 5360.9 4841.7 4876.8 4891.0 4891.3 4917.9 5329.7 5337.7 5352.5 5417.9 5422.4 5201.3 5202.5 5204.2 5217.1 5265.4 5214.8 5256.5 5273.6 5278.6 5290.6 5034.3 5034.7 5074.5 5150.8 5155.3 5144.5 5151.3 5162.4 5196.5 5198.9 4390.1 4472.8 4477.3 4486.6 4529.3 3844.5 3866.3 3895.0 3899.0 3943.5 4512.1 4513.8 4523.9 4529.1 4578.3 5132.0 5237.6 5291.1 5297.4 5311.2 4502.8 4508.1 4510.9 4575.7 4577.1 4728.5 4762.5 4769.4 4777.5 4803.5 4797.7 4800.5 4808.1 4937.3 4944.8 5184.7 5196.6 5225.2 5232.2 5238.9 4852.5 4863.4 4871.7 4873.6 4923.6 5146.5 5175.8 5206.8 5220.8 5255.2 5320.2 5321.9 5332.8 5333.9 5334.2 5025.8 5173.7 5178.2 5183.1 5211.6 4932.6 5031.6 5061.9 5067.2 5094.8 4933.0 4963.7 5032.0 5036.4 5075.2 5136.0 5170.9 5181.9 5188.1 5237.9 4924.8 5008.2 5040.9 5062.8 5074.2 15:31:11 INFO - PROCESS | 3448 | 15:31:11 INFO - PROCESS | 3448 | [#1] ext.html Cycles:180 Average:46203.49 Median:37000.00 stddev:87481.54 (236.4%) stddev-sans-first:87659.79 15:31:11 INFO - PROCESS | 3448 | Values: 548.4 588.7 595.7 605.8 606.7 34619.3 38531.8 38636.4 38646.2 38748.8 38778.0 39275.4 39304.8 39334.8 39419.0 7750.6 7856.8 7885.5 7891.7 7920.2 7798.6 7859.3 7884.2 7895.8 7932.2 7860.9 7908.6 7911.4 7919.4 7944.8 7802.7 7836.2 7891.2 7906.2 7919.7 7689.2 7760.7 7765.0 7773.6 7800.6 31574.4 31593.7 31758.0 31761.0 31812.5 2479.0 2940.0 3125.2 3534.0 3754.2 28115.6 28591.7 29104.0 29337.9 29742.5 3093.7 3100.8 3101.7 3155.2 3157.3 220909.0 221694.0 222076.0 222126.0 222905.0 31278.0 31452.2 32198.7 33054.3 33129.7 34670.5 34710.5 34715.7 34773.8 34841.3 11597.2 11672.1 11816.4 11833.8 11872.4 9335.7 9478.1 9484.8 9485.6 9533.6 7917.8 7921.3 7959.8 7964.7 7970.5 3097.8 3109.1 3147.1 3172.7 3180.9 852.8 926.0 967.1 982.1 987.6 28426.0 28780.9 29214.9 29275.4 29742.4 943.1 1001.1 1014.2 1017.6 1038.3 14962.8 15012.5 15251.8 15423.0 15645.6 404274.0 410994.0 411032.0 412705.0 413292.0 51062.5 51613.7 51790.0 51937.7 51948.0 1123.2 1147.6 1171.8 1174.1 1179.1 27182.6 27634.4 28289.0 28652.9 28869.4 44414.6 44701.0 44767.8 44773.8 44854.8 327908.0 331483.0 332895.0 333206.0 333406.0 25829.4 25933.1 26433.2 26619.2 26751.5 43474.6 43858.3 44200.0 44227.0 44518.1 37700.0 38048.0 38101.0 38421.8 38585.6 37463.4 38188.8 38344.2 38730.4 38900.0 34085.7 36678.0 37322.0 37401.4 38361.4 32838.0 33932.5 34009.3 34278.0 34689.8 26035.7 26437.0 26476.7 26621.9 26661.9 15:31:11 INFO - PROCESS | 3448 | 15:31:11 INFO - PROCESS | 3448 | [#2] jquery.html Cycles:180 Average:24703.92 Median:25608.30 stddev:67073.35 (261.9%) stddev-sans-first:67236.62 15:31:11 INFO - PROCESS | 3448 | Values: 368.8 374.1 374.9 379.1 391.9 16581.9 17174.4 17769.8 17895.9 18176.8 15838.4 16601.6 17430.0 17432.3 17468.1 4691.1 4897.2 4934.6 4934.9 4935.1 3534.3 4867.4 5402.3 5673.3 5674.7 5737.5 5752.3 5763.9 5764.9 5776.7 5678.5 5748.8 5752.5 5757.7 5757.7 4560.2 5389.4 5487.4 5499.0 5514.2 19957.4 20175.7 20441.2 20611.7 20641.7 1846.3 1855.6 1938.7 2010.9 2233.9 9079.5 9147.5 9202.5 9329.8 9411.0 1654.8 1662.4 1678.3 1679.7 1746.9 63785.7 66345.0 66875.0 67660.0 68252.7 9969.5 10090.9 10281.8 10358.0 10454.8 14121.6 14196.3 14256.2 14264.1 14278.1 7143.2 7166.9 7186.9 7279.0 7353.0 6739.7 6787.0 6788.4 6877.6 6893.4 4439.1 4445.3 4451.2 4487.0 4528.7 1639.2 1675.7 1759.9 1826.2 1847.8 812.5 845.7 871.2 883.8 934.6 16598.8 16615.9 16939.8 16969.0 16985.2 803.5 838.3 841.7 869.5 940.6 9264.0 9388.4 9451.0 9538.3 9617.9 400808.0 402862.0 405058.0 412535.0 413599.0 77460.0 77735.2 79054.6 79232.6 79306.2 907.1 919.3 920.2 931.5 934.8 14707.4 15099.6 15165.2 15237.2 15348.7 35681.3 35721.3 36109.3 36537.6 36894.8 46525.5 48640.0 51530.7 51914.7 52152.0 7561.9 7651.6 7685.7 7864.8 7880.1 8542.5 11042.4 11320.6 11367.7 11801.7 9860.8 9994.0 10302.3 10646.1 10767.2 9865.7 9943.2 10187.9 10464.3 10618.2 10038.7 10191.3 10202.1 10385.6 10614.7 7623.2 7679.6 7744.3 7748.9 7848.5 9507.5 10039.2 10516.0 10534.5 10571.4 15:31:11 INFO - PROCESS | 3448 | 15:31:11 INFO - PROCESS | 3448 | [#3] mootools.html Cycles:180 Average:5148.60 Median:4740.41 stddev:2902.19 (61.2%) stddev-sans-first:2896.56 15:31:11 INFO - PROCESS | 3448 | Values: 1387.1 1411.3 1522.6 1700.9 1702.1 6803.5 7405.8 7438.1 7912.0 7913.0 7411.1 7483.9 7665.9 7687.5 7703.8 2154.8 2219.2 2219.6 2220.0 2225.5 2179.8 2214.8 2238.0 2246.0 2250.2 2197.5 2219.1 2224.3 2226.6 2236.6 2159.4 2183.9 2184.5 2185.7 2191.0 2140.6 2148.1 2149.8 2161.2 2162.7 7766.3 7777.0 7779.2 7793.4 7821.2 4617.7 4725.1 4736.9 4743.9 4763.4 2792.2 2816.6 2900.9 2902.3 2953.0 938.2 999.6 1039.7 1042.3 1073.7 10364.8 10577.1 10626.8 10724.3 10771.1 4136.7 4289.3 4299.2 4308.9 4368.9 9244.9 9259.8 9268.5 9300.2 9300.9 4686.6 4698.0 4699.4 4704.0 4715.4 3785.9 4168.0 4260.4 4311.5 4367.7 3665.9 3681.6 3759.7 3765.8 3783.0 1161.9 1175.7 1178.7 1181.8 1182.0 724.6 737.3 740.8 756.2 756.5 4929.6 5152.8 5225.5 5236.1 5263.7 418.3 423.1 429.8 431.4 433.1 3415.4 3606.1 3661.2 3674.4 3678.4 9440.1 9716.5 9723.3 9787.4 9812.2 9086.9 9733.9 9751.3 9770.2 9781.4 7155.5 7341.0 7354.4 7401.9 7403.1 5169.8 5440.2 5505.7 5511.3 5582.5 8964.2 8973.1 9061.5 9160.1 9269.2 9065.5 9184.5 9221.4 9320.9 9400.8 6033.2 6613.1 6735.0 6854.5 6855.6 7468.8 7509.5 7514.3 7535.7 7578.8 6671.1 6879.2 6911.6 6922.1 6939.5 6665.9 6855.1 6859.7 6870.9 6878.2 6034.3 6054.3 6101.4 6116.0 6118.7 4421.5 4486.3 4509.3 4511.4 4535.9 4538.6 4544.3 4626.4 4678.2 4691.8 15:31:11 INFO - PROCESS | 3448 | 15:31:11 INFO - PROCESS | 3448 | [#4] prototype.html Cycles:180 Average:4429.59 Median:5047.27 stddev:1281.86 (25.4%) stddev-sans-first:1247.54 15:31:11 INFO - PROCESS | 3448 | Values: 306.5 309.3 313.3 314.0 317.6 5034.7 5054.2 5055.4 5093.0 5103.4 5009.2 5011.8 5030.8 5040.3 5081.2 3786.3 3867.8 3967.4 3972.6 3994.4 3966.8 3971.9 3991.5 4021.5 4027.6 3991.1 3994.9 4013.8 4018.2 4039.0 3803.7 3976.3 3991.0 4060.9 4065.9 3520.6 3521.3 3528.5 3543.8 3547.9 4979.5 4986.8 4989.2 5004.2 5039.5 4492.5 4515.1 4579.8 4613.4 4626.7 5319.0 5319.6 5319.9 5334.2 5367.2 3838.9 3854.4 3861.5 3865.3 3890.9 5368.4 5591.4 5599.4 5599.8 5609.3 3809.2 3815.3 3823.9 3836.3 3836.3 3870.4 3871.6 3875.3 3877.7 3894.7 4460.6 4485.9 4488.1 4490.8 4491.0 5164.0 5314.7 5338.3 5370.1 5422.2 1397.0 1401.7 1408.1 1418.3 1418.4 907.6 909.9 927.2 928.6 948.5 4571.8 4608.4 4609.9 4625.7 4630.6 5377.8 5380.7 5392.8 5397.5 5448.8 4482.3 4496.9 4606.5 4616.4 4624.8 2875.2 2879.5 2884.7 2916.8 2919.6 5071.6 5129.3 5143.7 5148.3 5153.1 5371.7 5603.2 5608.9 5631.9 5653.1 5037.2 5062.9 5080.9 5092.7 5133.1 5437.9 5442.7 5466.5 5475.9 5493.2 5149.6 5384.6 5453.7 5456.2 5485.8 5188.7 5196.8 5199.9 5233.4 5244.8 3917.2 3920.8 3936.1 3944.5 3953.7 5460.5 5496.5 5574.2 5585.5 5588.1 5329.6 5386.0 5390.0 5404.4 5404.9 5193.2 5320.0 5374.5 5381.5 5428.4 5263.4 5291.8 5332.2 5344.2 5344.9 5101.3 5231.7 5417.7 5432.5 5455.6 5289.3 5295.1 5297.7 5299.7 5333.0 15:31:11 INFO - PROCESS | 3448 | 15:31:11 INFO - PROCESS | 3448 | [#5] yui.html Cycles:180 Average:17223.92 Median:2356.05 stddev:24487.76 (1039.4%) stddev-sans-first:24524.65 15:31:11 INFO - PROCESS | 3448 | Values: 601.6 602.3 668.4 691.4 699.6 12803.8 13026.3 13478.9 13511.4 13551.9 13187.5 13371.1 13395.4 13405.4 13503.3 627.8 776.4 777.8 792.1 792.2 796.0 796.1 796.9 799.7 800.3 828.8 829.9 831.0 831.7 832.7 812.4 817.7 823.4 825.1 826.9 601.5 603.4 603.7 603.8 604.6 13142.5 13219.2 13225.3 13228.7 13231.5 13838.9 14065.1 14286.4 14333.2 14529.0 10163.8 10311.3 10393.1 10399.9 10409.1 3306.3 3311.1 3316.6 3357.8 3391.2 62357.5 62863.0 63130.7 66083.3 67030.3 11026.4 11032.7 11077.6 11112.6 11198.1 19211.5 19392.8 19405.6 19484.9 19558.5 7054.2 7064.3 7116.4 7153.0 7176.3 3767.6 3818.8 3841.6 3849.8 3856.9 2766.5 2859.3 2876.9 2878.4 2881.7 483.3 488.0 494.2 504.5 505.4 399.5 418.9 481.7 488.3 504.2 7458.1 7631.9 7634.7 8029.7 8497.4 412.9 423.6 425.1 428.4 457.6 3666.3 3722.9 3769.7 3866.5 4283.7 59684.7 76902.0 100235.0 100818.5 102562.0 87362.6 90260.0 91550.5 91767.5 92552.0 47941.3 47976.5 62783.8 65396.7 66117.0 7961.4 8080.4 8137.8 8187.3 8435.9 41602.6 41610.6 42133.8 44021.0 45387.8 61105.4 63464.0 63650.0 65614.0 65809.3 10383.1 10417.8 10444.9 10482.2 10681.8 11087.3 11136.4 11321.0 12091.3 12127.4 10526.9 10531.5 11113.8 11140.0 11452.9 11113.3 11221.5 11299.7 11326.4 12037.3 10523.1 10528.6 10581.9 10981.8 11397.9 9224.4 9355.0 9374.6 9531.0 9709.2 9451.0 9647.9 9847.0 9847.4 9861.8 15:31:11 INFO - PROCESS | 3448 | -------- Summary: end -------- 15:31:11 INFO - PROCESS | 3448 | 15:31:12 INFO - TEST-INFO | 3448: exit 0 15:31:12 INFO - TEST-OK | dromaeo_css | took 1120133ms 15:31:12 INFO - TEST-START | kraken 15:31:12 INFO - operating with platform_type : linux_ 15:31:12 INFO - Initialising browser for kraken test... 15:31:12 INFO - TEST-INFO | started process 3680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdP1CVX/profile http://localhost:45343/getInfo.html) 15:31:17 INFO - PROCESS | 3680 | __metrics Screen width/height:1600/1200 15:31:17 INFO - PROCESS | 3680 | colorDepth:24 15:31:17 INFO - PROCESS | 3680 | Browser inner width/height: 1024/697 15:31:17 INFO - PROCESS | 3680 | __metrics 15:31:18 ERROR - PROCESS | 3680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:31:19 INFO - TEST-INFO | 3680: exit 0 15:31:19 INFO - Browser initialized. 15:31:19 INFO - Running cycle 1/1 for kraken test... 15:31:19 INFO - TEST-INFO | started process 3796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdP1CVX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:31:31 INFO - PROCESS | 3796 | RSS: Main: 186204160 15:31:31 INFO - PROCESS | 3796 | 15:31:34 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:45343/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45343/tests/kraken/driver.html?testName=audio-beat-detection) 15:31:34 INFO - PROCESS | 3796 | RSS: Main: 190312448 15:31:34 INFO - PROCESS | 3796 | 15:31:37 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:45343/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45343/tests/kraken/driver.html?testName=audio-dft) 15:31:38 INFO - PROCESS | 3796 | RSS: Main: 190464000 15:31:38 INFO - PROCESS | 3796 | 15:31:41 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:45343/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45343/tests/kraken/driver.html?testName=audio-fft) 15:31:42 INFO - PROCESS | 3796 | RSS: Main: 186146816 15:31:42 INFO - PROCESS | 3796 | 15:31:44 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:45343/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45343/tests/kraken/driver.html?testName=audio-oscillator) 15:31:44 INFO - PROCESS | 3796 | RSS: Main: 186867712 15:31:44 INFO - PROCESS | 3796 | 15:31:47 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:45343/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45343/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:31:47 INFO - PROCESS | 3796 | RSS: Main: 187150336 15:31:47 INFO - PROCESS | 3796 | 15:31:50 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:45343/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45343/tests/kraken/driver.html?testName=imaging-darkroom) 15:31:51 INFO - PROCESS | 3796 | RSS: Main: 187494400 15:31:51 INFO - PROCESS | 3796 | 15:31:54 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:45343/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45343/tests/kraken/driver.html?testName=imaging-desaturate) 15:31:55 INFO - PROCESS | 3796 | RSS: Main: 184508416 15:31:55 INFO - PROCESS | 3796 | 15:31:58 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:45343/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45343/tests/kraken/driver.html?testName=json-parse-financial) 15:31:59 INFO - PROCESS | 3796 | RSS: Main: 186007552 15:31:59 INFO - PROCESS | 3796 | 15:32:00 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:45343/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45343/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:32:01 INFO - PROCESS | 3796 | RSS: Main: 186904576 15:32:01 INFO - PROCESS | 3796 | 15:32:03 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:45343/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45343/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:32:04 INFO - PROCESS | 3796 | RSS: Main: 186679296 15:32:04 INFO - PROCESS | 3796 | 15:32:06 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:45343/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45343/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:32:07 INFO - PROCESS | 3796 | RSS: Main: 187621376 15:32:07 INFO - PROCESS | 3796 | 15:32:10 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:45343/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:32:10 INFO - PROCESS | 3796 | RSS: Main: 187895808 15:32:10 INFO - PROCESS | 3796 | 15:32:13 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:45343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:32:14 INFO - PROCESS | 3796 | RSS: Main: 187633664 15:32:14 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | Cycle 1(1): loaded http://localhost:45343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45343/tests/kraken/driver.html?testName=ai-astar) 15:32:16 INFO - PROCESS | 3796 | RSS: Main: 188456960 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | __start_tp_report 15:32:16 INFO - PROCESS | 3796 | _x_x_mozilla_page_load 15:32:16 INFO - PROCESS | 3796 | _x_x_mozilla_page_load_details 15:32:16 INFO - PROCESS | 3796 | |i|pagename|runs| 15:32:16 INFO - PROCESS | 3796 | |0;ai-astar;106;115;107;115;113;116;115;114;114;113 15:32:16 INFO - PROCESS | 3796 | |1;audio-beat-detection;161;133;154;192;131;171;160;133;184;134 15:32:16 INFO - PROCESS | 3796 | |2;audio-dft;164;164;175;163;161;162;164;165;162;163 15:32:16 INFO - PROCESS | 3796 | |3;audio-fft;75;77;76;149;77;76;77;75;170;75 15:32:16 INFO - PROCESS | 3796 | |4;audio-oscillator;87;86;137;87;87;86;141;87;86;133 15:32:16 INFO - PROCESS | 3796 | |5;imaging-gaussian-blur;117;119;118;118;120;117;118;120;119;118 15:32:16 INFO - PROCESS | 3796 | |6;imaging-darkroom;147;148;147;149;150;147;147;148;147;148 15:32:16 INFO - PROCESS | 3796 | |7;imaging-desaturate;100;95;95;95;96;96;96;95;96;95 15:32:16 INFO - PROCESS | 3796 | |8;json-parse-financial;65;64;64;63;65;63;63;67;65;63 15:32:16 INFO - PROCESS | 3796 | |9;json-stringify-tinderbox;66;65;65;66;65;66;65;66;68;64 15:32:16 INFO - PROCESS | 3796 | |10;stanford-crypto-aes;83;83;83;83;84;83;84;84;91;86 15:32:16 INFO - PROCESS | 3796 | |11;stanford-crypto-ccm;136;135;145;136;129;152;133;133;148;134 15:32:16 INFO - PROCESS | 3796 | |12;stanford-crypto-pbkdf2;169;180;171;164;168;167;170;169;167;167 15:32:16 INFO - PROCESS | 3796 | |13;stanford-crypto-sha256-iterative;70;71;68;71;69;70;66;69;67;66 15:32:16 INFO - PROCESS | 3796 | __end_tp_report 15:32:16 INFO - PROCESS | 3796 | __start_cc_report 15:32:16 INFO - PROCESS | 3796 | _x_x_mozilla_cycle_collect,976 15:32:16 INFO - PROCESS | 3796 | __end_cc_report 15:32:16 INFO - PROCESS | 3796 | __startTimestamp1467066736370__endTimestamp 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | ------- Summary: start ------- 15:32:16 INFO - PROCESS | 3796 | Number of tests: 14 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.50 stddev:3.46 (3.0%) stddev-sans-first:2.65 15:32:16 INFO - PROCESS | 3796 | Values: 106.0 115.0 107.0 115.0 113.0 116.0 115.0 114.0 114.0 113.0 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | [#1] audio-beat-detection Cycles:10 Average:155.30 Median:160.50 stddev:22.39 (14.0%) stddev-sans-first:23.65 15:32:16 INFO - PROCESS | 3796 | Values: 161.0 133.0 154.0 192.0 131.0 171.0 160.0 133.0 184.0 134.0 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:3.95 (2.4%) stddev-sans-first:4.18 15:32:16 INFO - PROCESS | 3796 | Values: 164.0 164.0 175.0 163.0 161.0 162.0 164.0 165.0 162.0 163.0 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | [#3] audio-fft Cycles:10 Average:92.70 Median:76.00 stddev:35.56 (46.8%) stddev-sans-first:37.14 15:32:16 INFO - PROCESS | 3796 | Values: 75.0 77.0 76.0 149.0 77.0 76.0 77.0 75.0 170.0 75.0 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:86.50 stddev:24.44 (28.2%) stddev-sans-first:25.33 15:32:16 INFO - PROCESS | 3796 | Values: 87.0 86.0 137.0 87.0 87.0 86.0 141.0 87.0 86.0 133.0 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.50 stddev:1.07 (0.9%) stddev-sans-first:1.01 15:32:16 INFO - PROCESS | 3796 | Values: 117.0 119.0 118.0 118.0 120.0 117.0 118.0 120.0 119.0 118.0 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 15:32:16 INFO - PROCESS | 3796 | Values: 147.0 148.0 147.0 149.0 150.0 147.0 147.0 148.0 147.0 148.0 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.50 stddev:1.52 (1.6%) stddev-sans-first:0.53 15:32:16 INFO - PROCESS | 3796 | Values: 100.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.50 stddev:1.32 (2.0%) stddev-sans-first:1.36 15:32:16 INFO - PROCESS | 3796 | Values: 65.0 64.0 64.0 63.0 65.0 63.0 63.0 67.0 65.0 63.0 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 15:32:16 INFO - PROCESS | 3796 | Values: 66.0 65.0 65.0 66.0 65.0 66.0 65.0 66.0 68.0 64.0 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.50 (3.0%) stddev-sans-first:2.60 15:32:16 INFO - PROCESS | 3796 | Values: 83.0 83.0 83.0 83.0 84.0 83.0 84.0 84.0 91.0 86.0 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:136.00 stddev:7.52 (5.5%) stddev-sans-first:7.94 15:32:16 INFO - PROCESS | 3796 | Values: 136.0 135.0 145.0 136.0 129.0 152.0 133.0 133.0 148.0 134.0 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:169.00 stddev:4.26 (2.5%) stddev-sans-first:4.52 15:32:16 INFO - PROCESS | 3796 | Values: 169.0 180.0 171.0 164.0 168.0 167.0 170.0 169.0 167.0 167.0 15:32:16 INFO - PROCESS | 3796 | 15:32:16 INFO - PROCESS | 3796 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:1.89 (2.7%) stddev-sans-first:1.94 15:32:16 INFO - PROCESS | 3796 | Values: 70.0 71.0 68.0 71.0 69.0 70.0 66.0 69.0 67.0 66.0 15:32:16 INFO - PROCESS | 3796 | -------- Summary: end -------- 15:32:16 INFO - PROCESS | 3796 | 15:32:17 INFO - TEST-INFO | 3796: exit 0 15:32:17 INFO - TEST-OK | kraken | took 65177ms 15:32:17 INFO - SUITE-END | took 1185s 15:32:17 INFO - Completed test suite (00:19:45) 15:32:17 INFO - javascript benchmark 15:32:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6375.201753327139, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2622.2002289301763, 2656.7210442903506, 2671.959920601191, 2710.94273233439, 2718.660167479065, 4787.976060119703, 4828.348172996644, 4883.169861123609, 4904.117258893398, 4921.040397122562, 4823.927641085378, 4881.096997055538, 4905.509449055093, 4933.506649335065, 5018.899622007558, 4453.220686379878, 4474.888127796815, 4514.706544074641, 4604.516525764797, 4638.791254393544, 4543.182227199103, 4592.058627981256, 4629.259318509039, 4666.416697912761, 4678.485366609671, 4418.3372494125815, 4456.041950980555, 4534.9319760203625, 4557.430321209848, 4568.794404251784, 4450.221211288044, 4490.618297444721, 4507.819687212507, 4533.863984080483, 4551.294549344857, 4457.286834106528, 4483.910321793546, 4493.988852508192, 4499.775011249424, 4511.593956543927, 4773.737444440554, 4849.75751212438, 4862.319275301461, 4877.170880950247, 4879.097366987119, 5240.9213861792105, 5260.368755749335, 5268.4994925482015, 5278.5513231375, 5316.840494785162, 5298.311219541473, 5300.814471493479, 5305.098133317345, 5305.4164041955355, 5360.892782144374, 4841.733704646278, 4876.804927802848, 4891.0, 4891.3396691446915, 4917.877053073666, 5329.706866122323, 5337.653052551572, 5352.464753524617, 5417.918731219035, 5422.3764267109, 5201.271821944931, 5202.453742357074, 5204.1673332266655, 5217.113090774577, 5265.368155821249, 5214.7914083437, 5256.500632439912, 5273.551748101378, 5278.551323137576, 5290.6296559241255, 5034.320366750515, 5034.748262586856, 5074.517920797518, 5150.845474635767, 5155.252488389163, 5144.536991670768, 5151.25306830515, 5162.406323272797, 5196.506331898464, 5198.896022079537, 4390.056137930296, 4472.798724057425, 4477.306017567283, 4486.641068714495, 4529.32060190974, 3844.519435070616, 3866.2654095721723, 3895.0457138000806, 3899.0, 3943.4676318697184, 4512.097580483916, 4513.842015529441, 4523.909521809545, 4529.071540334224, 4578.267477203632, 5131.974340128276, 5237.6071794615555, 5291.126964050965, 5297.390800058042, 5311.176767601028, 4502.842400515966, 4508.120916421332, 4510.909781804411, 4575.702579332333, 4577.1074640444795, 4728.527147285244, 4762.476127625959, 4769.35613692154, 4777.474477807438, 4803.471618122004, 4797.664163508521, 4800.543948324904, 4808.08646357191, 4937.284093806378, 4944.802207911715, 5184.662996905189, 5196.610254231024, 5225.216217567243, 5232.241325007776, 5238.869028274324, 4852.539008794159, 4863.440704318907, 4871.658983871095, 4873.585745211697, 4923.630727695366, 5146.511081447256, 5175.792968281226, 5206.817761378334, 5220.791168353375, 5255.159174532057, 5320.17537281722, 5321.946780532146, 5332.813351532678, 5333.919991200212, 5334.1732031535175, 5025.824096156617, 5173.689578625294, 5178.171492561172, 5183.144781111075, 5211.635185537128, 4932.580730637793, 5031.597472202288, 5061.898762024665, 5067.214581739836, 5094.7962081516325, 4933.038057578881, 4963.726995015309, 5032.0, 5036.420811606712, 5075.187969924795, 5135.974320128375, 5170.948290517047, 5181.896362072813, 5188.0661480933795, 5237.921431178612, 4924.803007879645, 5008.198688210015, 5040.924386134284, 5062.772175252197, 5074.188129899198], "value": 4811.264278116631, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.4314859501824, 588.723300048977, 595.717034408656, 605.8212827215972, 606.7269728622122, 34619.30761384774, 38531.80734096333, 38636.420453693216, 38646.227075458475, 38748.80625596872, 38778.0, 39275.41086883699, 39304.80347598258, 39334.803325983405, 39419.0, 7750.573718445483, 7856.803579910519, 7885.526868387915, 7891.723789667363, 7920.207979202091, 7798.649060792278, 7859.29266366027, 7884.211578842099, 7895.8420831583335, 7932.246436588515, 7860.921390786105, 7908.565028923435, 7911.446198766089, 7919.445638805286, 7944.801379965489, 7802.726904558342, 7836.177201393829, 7891.1714270001685, 7906.169852165526, 7919.7228097016905, 7689.192634773324, 7760.689572417096, 7764.961175194145, 7773.611319434062, 7800.570968596725, 31574.36851262962, 31593.684063159533, 31758.0, 31761.0, 31812.522812157837, 2478.9752102478924, 2939.9853000735075, 3125.203073216338, 3534.0, 3754.2303827715255, 28115.57826632602, 28591.714082859115, 29104.0, 29337.853310733524, 29742.512874356195, 3093.7370323522528, 3100.8139511629374, 3101.65881753007, 3155.1796532901612, 3157.273827019775, 220909.0, 221694.0, 222076.0, 222126.0, 222905.0, 31278.0, 31452.21369465736, 32198.678013219567, 33054.3389132216, 33129.66870331314, 34670.47994280088, 34710.47934280988, 34715.65284347175, 34773.82613086969, 34841.30317393638, 11597.246178998337, 11672.124590655734, 11816.409179540988, 11833.763324733458, 11872.40637968098, 9335.673251436303, 9478.052194780466, 9484.762880928032, 9485.573149208301, 9533.570989305497, 7917.802054948673, 7921.287084162453, 7959.801004974806, 7964.721234756872, 7970.521768693781, 3097.829619370911, 3109.1449851291077, 3147.1345380020675, 3172.732085951474, 3180.9204769880475, 852.8379607874484, 925.9952951048053, 967.1295833749682, 982.1455333859587, 987.629638885418, 28426.0, 28780.856095719388, 29214.853925730236, 29275.414491710046, 29742.40515189684, 943.0616536546044, 1001.0690058245756, 1014.2291858187831, 1017.6183931025865, 1038.2732087538752, 14962.775558366633, 15012.47456339023, 15251.771223431657, 15423.0, 15645.608859778597, 404274.0, 410994.0, 411032.0, 412705.0, 413292.0, 51062.48937510652, 51613.74193129085, 51790.0, 51937.7403112982, 51948.0, 1123.224974767408, 1147.552454542729, 1171.822318569849, 1174.0842143128373, 1179.0508640544444, 27182.592261115704, 27634.447311053264, 28289.0, 28652.85673571619, 28869.42261154807, 44414.555854441045, 44701.0, 44767.776161118985, 44773.776131119135, 44854.77572612116, 327908.0, 331483.0, 332895.0, 333206.0, 333406.0, 25829.354266142745, 25933.08933654716, 26433.207003789918, 26619.20142395731, 26751.464970700865, 43474.565254348316, 43858.34212486879, 44200.0, 44227.0, 44518.10963780642, 37700.0, 38048.048798780255, 38101.0, 38421.807890960365, 38585.614143859326, 37463.43804842875, 38188.809055954545, 38344.233115338095, 38730.4190437138, 38900.027499312746, 34085.65914340825, 36678.0, 37322.0, 37401.43897841589, 38361.42457863079, 32838.0, 33932.49101263434, 34009.31981360309, 34278.0, 34689.82655086708, 26035.73964260333, 26437.0, 26476.73523264743, 26621.866890665424, 26661.866690666422], "value": 16258.093213988488, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.7639910457306, 374.08349543618135, 374.9006513273982, 379.1034204107287, 391.9059425737822, 16581.917090414547, 17174.39889603864, 17769.79452496615, 17895.910520447378, 18176.818231817662, 15838.366465341373, 16601.584960375967, 17430.0, 17432.3027078917, 17468.126593670328, 4691.061787642477, 4897.191963326047, 4934.605231581465, 4934.901301973959, 4935.136351138554, 3534.2754735279336, 4867.3915760529935, 5402.270693456392, 5673.290838645169, 5674.716264186774, 5737.454941780524, 5752.28096487939, 5763.884722305552, 5764.913526297109, 5776.653400795944, 5678.517326027272, 5748.7987920423, 5752.539796816265, 5757.654540727549, 5757.68332741699, 4560.156371071329, 5389.380221274564, 5487.42382049887, 5499.0, 5514.228008078872, 19957.401277961686, 20175.697364539545, 20441.182352705873, 20611.69082463764, 20641.690374644393, 1846.2984066054948, 1855.554666879939, 1938.6995015772436, 2010.9497262568407, 2233.9106435742715, 9079.546022698905, 9147.496887671176, 9202.493862837542, 9329.813403731956, 9410.95294523523, 1654.7600597913236, 1662.393226472341, 1678.2951160512614, 1679.6730582839664, 1746.8777185597014, 63785.68107159481, 66344.99999999952, 66875.0, 67660.0, 68252.6587367065, 9969.501524923724, 10090.899091009143, 10281.794364112677, 10358.0, 10454.790904182026, 14121.646958825906, 14196.29018549089, 14256.215908125152, 14264.144151350953, 14278.071925325028, 7143.178534468499, 7166.892496612555, 7186.856262874713, 7278.963605182046, 7352.96323518379, 6739.696713647898, 6786.966065169642, 6788.422984046312, 6877.552959057645, 6893.379595836399, 4439.1121775645, 4445.310976798602, 4451.198784218872, 4486.955130448654, 4528.728276303433, 1639.1722180298873, 1675.656490419461, 1759.9296028158985, 1826.2329821475012, 1847.7875044370069, 812.5409143833715, 845.6997765793178, 871.1984973824098, 883.8232353529191, 934.621478301289, 16598.75101873473, 16615.916920415322, 16939.830601694073, 16969.0, 16985.23566439513, 803.5299349880269, 838.3293365307729, 841.6591280531395, 869.517417833096, 940.6378544260372, 9264.0, 9388.389754665925, 9451.0, 9538.332316737762, 9617.903820961701, 400808.0, 402862.0, 405058.0, 412535.0, 413599.0, 77460.0, 77735.22264777393, 79054.604726976, 79232.60383698044, 79306.20693793104, 907.0566610724904, 919.3426699909596, 920.185635712386, 931.4644079654225, 934.7522906429801, 14707.41170353174, 15099.622509437351, 15165.24173791328, 15237.161956092077, 15348.693026139637, 35681.28637427289, 35721.285574287846, 36109.27781444304, 36537.63462365342, 36894.8155259222, 46525.53474465347, 48640.0, 51530.742346288025, 51914.74042629763, 52152.0, 7561.924380756122, 7651.617419129133, 7685.730999414994, 7864.764057078297, 7880.093789214085, 8542.530160841214, 11042.392668402994, 11320.62360713324, 11367.715807104558, 11801.704957376134, 9860.753481163028, 9993.950635183492, 10302.33034852732, 10646.095081918123, 10767.192460565646, 9865.704028879145, 9943.154831839374, 10187.898121018696, 10464.267501274837, 10618.1505479563, 10038.698839034842, 10191.337563058378, 10202.081812636898, 10385.584576616851, 10614.681559553226, 7623.199564045695, 7679.616019199129, 7744.341730952932, 7748.883766743616, 7848.529088254723, 9507.524623768923, 10039.247056470647, 10516.0, 10534.473276336306, 10571.36571805694], "value": 8197.149900840823, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.0706626560207, 1411.2590889782864, 1522.573679369776, 1700.9489715308546, 1702.1149002518698, 6803.4897382696245, 7405.814854628624, 7438.144613369464, 7911.999999999993, 7912.9604351978305, 7411.110666719987, 7483.925160748391, 7665.923340766591, 7687.461877668566, 7703.845923081535, 2154.762976072631, 2219.1678120704737, 2219.622664147099, 2220.04538048639, 2225.499262665903, 2179.8474106812528, 2214.8449608527408, 2238.0, 2245.9775402246014, 2250.1561914282142, 2197.450637340665, 2219.1123550579737, 2224.2993457061057, 2226.565819665166, 2236.575050740354, 2159.3845753960204, 2183.9454013649706, 2184.464806122502, 2185.6830759539857, 2191.0, 2140.646793279107, 2148.119271098842, 2149.795769401904, 2161.221960094365, 2162.7188465499544, 7766.262205090507, 7776.961115194445, 7779.183185765526, 7793.415493837985, 7821.178776228528, 4617.676762626617, 4725.1022305762135, 4736.881577960544, 4743.928841067353, 4763.404574428197, 2792.190264823199, 2816.5915942188267, 2900.9274768130754, 2902.274431392152, 2953.025501584472, 938.2212763406357, 999.5502024089117, 1039.6517166749147, 1042.306865934153, 1073.6564299424188, 10364.792704145875, 10577.100946419563, 10626.787464250749, 10724.302920310232, 10771.084457821094, 4136.73111247768, 4289.270823959934, 4299.183155200564, 4308.870733877989, 4368.934465983013, 9244.8613270801, 9259.768505787275, 9268.490233037113, 9300.162985331217, 9300.906990930003, 4686.625069994392, 4698.0, 4699.365585645963, 4704.012157446974, 4715.434147902273, 3785.886423407302, 4167.9583204168175, 4260.382244574519, 4311.50417701962, 4367.672424568106, 3665.9450108248398, 3681.5582130144553, 3759.721694623841, 3765.811709414518, 3783.0, 1161.9186656933935, 1175.717827721358, 1178.6876477733408, 1181.787278289916, 1182.030734797475, 724.6087112959049, 737.3363972424861, 740.76665850257, 756.1908757629394, 756.5007095317064, 4929.630277729185, 5152.793888244503, 5225.503577160163, 5236.1098613235845, 5263.684178949199, 418.332943221263, 423.07980143188445, 429.78295960539725, 431.40035350862325, 433.1142812947467, 3415.4023045966856, 3606.080449485417, 3661.1579336752698, 3674.356987527172, 3678.3746763050344, 9440.10319019692, 9716.465594392377, 9723.319367644339, 9787.412755234709, 9812.215022798158, 9086.86369704455, 9733.902660973441, 9751.268654850914, 9770.169535589555, 9781.364211326241, 7155.534890232118, 7341.045664063744, 7354.411647068222, 7401.851962960711, 7403.074615673041, 5169.793208271627, 5440.211169380338, 5505.6696598204235, 5511.338639363142, 5582.525485333792, 8964.193222609736, 8973.05782892787, 9061.501617411106, 9160.129787670161, 9269.212116970133, 9065.501397423204, 9184.49485278316, 9221.400608960395, 9320.906790932275, 9400.76498087526, 6033.155358249936, 6613.074169616161, 6735.0, 6854.451643868579, 6855.622940738307, 7468.813279668052, 7509.51188172767, 7514.323710866049, 7535.73624923125, 7578.81052973658, 6671.099401580725, 6879.174499060145, 6911.550749201286, 6922.134733158356, 6939.548929319578, 6665.900011499928, 6855.143107111611, 6859.725610975505, 6870.896936546056, 6878.174619045746, 6034.336223015553, 6054.273487181566, 6101.359357267423, 6115.969420152871, 6118.663473509, 4421.46942366918, 4486.304622783474, 4509.2559727644575, 4511.436070491189, 4535.863924082283, 4538.636909047203, 4544.341070544819, 4626.421697287839, 4678.228092364721, 4691.812327506998], "value": 4079.551165492535, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.47898572426874, 309.2901790391052, 313.34041841922755, 313.9623245210575, 317.6410655958766, 5034.723090230041, 5054.216596427555, 5055.393352797665, 5093.046033300686, 5103.438621751614, 5009.248612708096, 5011.774470148843, 5030.82392116276, 5040.319556859823, 5081.161608334621, 3786.2806066847347, 3867.7679339239594, 3967.36522156455, 3972.6226008529143, 3994.424989634276, 3966.841326346943, 3971.9205615887663, 3991.540972788123, 4021.537523184842, 4027.62370201581, 3991.1219531702977, 3994.940075898864, 4013.799310034501, 4018.2164477926817, 4038.9798051009852, 3803.6576708096404, 3976.284268831609, 3991.0, 4060.878173654795, 4065.87802365928, 3520.556571805573, 3521.330947120039, 3528.4530897710897, 3543.840527176283, 3547.9113022174392, 4979.526944940261, 4986.825461108844, 4989.226669866141, 5004.224345226496, 5039.47085556015, 4492.517469235145, 4515.143650048924, 4579.793909274057, 4613.400257966477, 4626.745528995903, 5319.0, 5319.627626066177, 5319.867003324909, 5334.226537152092, 5367.194920761878, 3838.942415863736, 3854.4411060396087, 3861.498005259298, 3865.323568375523, 3890.9027274318087, 5368.355797304349, 5591.384947655754, 5599.384067752585, 5599.832005039855, 5609.270794796691, 3809.1810260794064, 3815.3323168445413, 3823.885283441501, 3836.271108489378, 3836.3094642964534, 3870.43878637596, 3871.593482684334, 3875.2636998970106, 3877.689784817208, 3894.7078969077434, 4460.553944605514, 4485.887852803706, 4488.12481566098, 4490.775461226991, 4491.0, 5163.974180129076, 5314.707691077027, 5338.3060202173465, 5370.1407774756635, 5422.213779002102, 1396.9941642017732, 1401.7336706025822, 1408.0917808013774, 1418.2554159066367, 1418.4326269492285, 907.587047893207, 909.8771665825029, 927.1609193679731, 928.5774972387547, 948.4735971535864, 4571.794269257892, 4608.354830323758, 4609.9308510372375, 4625.676202665848, 4630.560096790799, 5377.848860455849, 5380.650257733235, 5392.811251606254, 5397.541208997279, 5448.809291674852, 4482.305242687324, 4496.910061798746, 4606.539346065367, 4616.3537104805355, 4624.838130665411, 2875.180573536532, 2879.467298549775, 2884.7115288471405, 2916.7520760735574, 2919.6204493416144, 5071.594272458195, 5129.281900533928, 5143.665661731976, 5148.330717006766, 5153.1497302945345, 5371.731413429313, 5603.215549822947, 5608.9439105609235, 5631.915521267184, 5653.123765816305, 5037.168867136955, 5062.924056139161, 5080.872978175576, 5092.745362731923, 5133.076046311699, 5437.8852335270385, 5442.673439593637, 5466.480684334982, 5475.945240547703, 5493.176023596492, 5149.639525233198, 5384.60385128614, 5453.727313634223, 5456.181572764117, 5485.835424937259, 5188.650950752756, 5196.792128314976, 5199.894042912626, 5233.424323324355, 5244.7639856207325, 3917.236138952877, 3920.843166273431, 3936.0750223697983, 3944.5463771665477, 3953.7430067046703, 5460.5085542301385, 5496.477834605706, 5574.163875418558, 5585.497305242548, 5588.133839254922, 5329.600279978939, 5385.973070134624, 5390.0, 5404.43253458397, 5404.918926216032, 5193.221016847503, 5319.973400132974, 5374.48942350476, 5381.515663590296, 5428.402875683751, 5263.421023687315, 5291.841244762663, 5332.173513105475, 5344.198370244339, 5344.893102137858, 5101.342063829196, 5231.738413079254, 5417.674939503485, 5432.511074003359, 5455.5908306876345, 5289.338832645919, 5295.126304159925, 5297.708626025606, 5299.708516031656, 5333.0], "value": 4023.896935195954, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.6406582423781, 602.2682440834385, 668.4084585142148, 691.4399336537407, 699.6222040098347, 12803.807942880852, 13026.348682565882, 13478.932605336984, 13511.391987360568, 13551.864481355184, 13187.538436154737, 13371.130876493022, 13395.397207125678, 13405.396757145927, 13503.25732084735, 627.7959663109485, 776.3556248313914, 777.8288776469168, 792.065362871811, 792.239450127878, 796.0487217774762, 796.0685997383076, 796.9163237860029, 799.6681377228443, 800.33572135128, 828.8342331533718, 829.8755186721979, 831.0276975938167, 831.6881169561415, 832.6835802395082, 812.4312980913326, 817.7097130518699, 823.3577809308719, 825.1171246765963, 826.9090400056019, 601.5007543738686, 603.4297588778606, 603.7132362127954, 603.7675494934438, 604.5737754882797, 13142.540011099662, 13219.206847589176, 13225.338733063309, 13228.669283267898, 13231.470741170342, 13838.861611383858, 14065.085769424955, 14286.357113929898, 14333.21167335796, 14529.0, 10163.796724065478, 10311.329763565343, 10393.116585090202, 10399.896001039968, 10409.115225205867, 3306.272620023591, 3311.1391038329966, 3316.585426821647, 3357.7985320880825, 3391.2030672791875, 62357.52849430087, 62863.0, 63130.684346577975, 66083.3391666082, 67030.32969670338, 11026.393548354918, 11032.669019929415, 11077.556897724162, 11112.555497779998, 11198.104151667847, 19211.51971200731, 19392.8060719391, 19405.611887762167, 19484.902575487315, 19558.511037224183, 7054.188768291609, 7064.32888875556, 7116.430685545144, 7153.0, 7176.282371762782, 3767.56672982605, 3818.8090595470117, 3841.615838416136, 3849.7690138591774, 3856.9421458678144, 2766.502029634685, 2859.3280579063903, 2876.8993085241914, 2878.409925965172, 2881.7406433421093, 483.3450674336294, 487.96584239102924, 494.15006189354256, 504.45518839653084, 505.4212926199481, 399.4924562342636, 418.8596820065312, 481.71097341595464, 488.3334248750501, 504.2008416659562, 7458.105027396638, 7631.900007469583, 7634.732784352632, 8029.7189598363775, 8497.405181637227, 412.87820093072617, 423.62509179376474, 425.05114052070985, 428.4259092815642, 457.5538849621659, 3666.2667466506805, 3722.8510859565854, 3769.7172712046704, 3866.478025466582, 4283.678724095706, 59684.70157649184, 76902.0, 100235.0, 100818.49590751999, 102562.0, 87362.56318718493, 90260.0, 91550.54224728968, 91767.54116229377, 92552.0, 47941.28088078681, 47976.52023479791, 62783.80256690994, 65396.67301663461, 66117.0, 7961.40289478303, 8080.434369594307, 8137.75586732399, 8187.3040791533385, 8435.861158743737, 41602.58397415987, 41610.58389416067, 42133.78933105315, 44021.0, 45387.77306113448, 61105.38894611175, 63464.0, 63650.0, 65614.0, 65809.34190658224, 10383.117435018108, 10417.791644167226, 10444.947775261075, 10482.21383396233, 10681.839772403575, 11087.279326843729, 11136.443177841238, 11321.03771179459, 12091.334976576372, 12127.401989846489, 10526.947365263431, 10531.526081326205, 11113.83329250078, 11140.0, 11452.942735286604, 11113.274327447709, 11221.495032723384, 11299.717507062389, 11326.37704926237, 12037.277763334228, 10523.052925236765, 10528.578856845947, 10581.947090264499, 10981.780364392507, 11397.943010284895, 9224.40041397307, 9355.0, 9374.625014999323, 9531.0, 9709.223262139154, 9450.952745236229, 9647.903520964981, 9847.0, 9847.359921605073, 9861.802763944537], "value": 6377.771790490417, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 107.0, 115.0, 113.0, 116.0, 115.0, 114.0, 114.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 133.0, 154.0, 192.0, 131.0, 171.0, 160.0, 133.0, 184.0, 134.0], "value": 155.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 175.0, 163.0, 161.0, 162.0, 164.0, 165.0, 162.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 149.0, 77.0, 76.0, 77.0, 75.0, 170.0, 75.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 137.0, 87.0, 87.0, 86.0, 141.0, 87.0, 86.0, 133.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 118.0, 120.0, 117.0, 118.0, 120.0, 119.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 149.0, 150.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 63.0, 65.0, 63.0, 63.0, 67.0, 65.0, 63.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 68.0, 64.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 84.0, 83.0, 84.0, 84.0, 91.0, 86.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 145.0, 136.0, 129.0, 152.0, 133.0, 133.0, 148.0, 134.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 180.0, 171.0, 164.0, 168.0, 167.0, 170.0, 169.0, 167.0, 167.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 68.0, 71.0, 69.0, 70.0, 66.0, 69.0, 67.0, 66.0], "value": 68.7, "unit": "score"}]}]} 15:32:17 INFO - Return code: 0 15:32:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:32:17 ERROR - # TBPL SUCCESS # 15:32:17 INFO - Running post-action listener: _resource_record_post_action 15:32:17 INFO - ##### 15:32:17 INFO - ##### Finished run-tests step (success) 15:32:17 INFO - ##### 15:32:17 INFO - Running post-run listener: _resource_record_post_run 15:32:17 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 7827456; Write bytes: 487763968; Read time: 1612; Write time: 447964 15:32:17 INFO - TinderboxPrint: CPU usage
13.4% 15:32:17 INFO - TinderboxPrint: I/O read bytes / time
7,827,456 / 1,612 15:32:17 INFO - TinderboxPrint: I/O write bytes / time
487,763,968 / 447,964 15:32:17 INFO - TinderboxPrint: CPU idle
8,307.1 (86.6%) 15:32:17 INFO - TinderboxPrint: CPU user
1,229.7 (12.8%) 15:32:17 INFO - TinderboxPrint: Swap in / out
0 / 0 15:32:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 71979008; Read time: 0; Write time: 48116 15:32:17 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 6066176; Write bytes: 415784960; Read time: 1576; Write time: 399848 15:32:18 INFO - Running post-run listener: _upload_blobber_files 15:32:18 INFO - Blob upload gear active. 15:32:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:32:18 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 15:32:18 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'] 15:32:18 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 15:32:18 INFO - (blobuploader) - INFO - Open directory for files ... 15:32:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:32:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:32:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:19 INFO - (blobuploader) - INFO - Done attempting. 15:32:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:32:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:32:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:20 INFO - (blobuploader) - INFO - Done attempting. 15:32:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:32:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:32:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:24 INFO - (blobuploader) - INFO - Done attempting. 15:32:24 INFO - (blobuploader) - INFO - Iteration through files over. 15:32:24 INFO - Return code: 0 15:32:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:32:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:32:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/22e08d1ca1ae3a502a348dcb291f68c41c8673982bda5282bc236372667b87f2c58f731d60a9b8b727969fe88b980b6222d4793e11e248f532519a4fc3bb1e95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6737b7a021fce7f57092fe0dc302288c9c8ff54327dc1ec2019f56373d4535d1b332107bf2084a27ab585a9aeac3c8e257c2b610ed447b9f458cfc0952b58db2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb23fb88f5fed806c17728f601da8db167b80562c764997effdfd0ae092fa598b83e64e974be985c594eb591175d212d9470dd8b4bb3d53a30d9e0b3891c9a72"} 15:32:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:32:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:32:24 INFO - Contents: 15:32:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/22e08d1ca1ae3a502a348dcb291f68c41c8673982bda5282bc236372667b87f2c58f731d60a9b8b727969fe88b980b6222d4793e11e248f532519a4fc3bb1e95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6737b7a021fce7f57092fe0dc302288c9c8ff54327dc1ec2019f56373d4535d1b332107bf2084a27ab585a9aeac3c8e257c2b610ed447b9f458cfc0952b58db2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb23fb88f5fed806c17728f601da8db167b80562c764997effdfd0ae092fa598b83e64e974be985c594eb591175d212d9470dd8b4bb3d53a30d9e0b3891c9a72"} 15:32:24 INFO - Running post-run listener: copy_logs_to_upload_dir 15:32:24 INFO - Copying logs to upload dir... 15:32:24 INFO - mkdir: /builds/slave/test/build/upload/logs 15:32:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.237340 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-06-27 15:32:24.316627) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 15:32:24.320109) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/22e08d1ca1ae3a502a348dcb291f68c41c8673982bda5282bc236372667b87f2c58f731d60a9b8b727969fe88b980b6222d4793e11e248f532519a4fc3bb1e95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6737b7a021fce7f57092fe0dc302288c9c8ff54327dc1ec2019f56373d4535d1b332107bf2084a27ab585a9aeac3c8e257c2b610ed447b9f458cfc0952b58db2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb23fb88f5fed806c17728f601da8db167b80562c764997effdfd0ae092fa598b83e64e974be985c594eb591175d212d9470dd8b4bb3d53a30d9e0b3891c9a72"} build_url:https://queue.taskcluster.net/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011095 build_url: 'https://queue.taskcluster.net/v1/task/Hckc1-H3Q3e9_7r7KqonMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/22e08d1ca1ae3a502a348dcb291f68c41c8673982bda5282bc236372667b87f2c58f731d60a9b8b727969fe88b980b6222d4793e11e248f532519a4fc3bb1e95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6737b7a021fce7f57092fe0dc302288c9c8ff54327dc1ec2019f56373d4535d1b332107bf2084a27ab585a9aeac3c8e257c2b610ed447b9f458cfc0952b58db2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb23fb88f5fed806c17728f601da8db167b80562c764997effdfd0ae092fa598b83e64e974be985c594eb591175d212d9470dd8b4bb3d53a30d9e0b3891c9a72"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 15:32:24.352879) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:32:24.353382) ========= 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=4ac8d263c7293b36a1be1aed000001be-1467063420.72356-1893822675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004347 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:32:24.433771) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 15:32:24.434043) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 15:32:24.434308) ========= ========= Total master_lag: 0.19 =========