builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1489581961.58 results: success (0) revision: 48006b97073128922d1f36361bca3134afabe8fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 05:46:01.584652) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 05:46:01.585090) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 05:46:01.585366) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 05:46:01.599639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:46:01.599903) ========= 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=32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-15 05:46:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-03-15 05:46:02 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148229 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:46:01.761609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:46:01.761919) ========= 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=32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013634 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:46:01.810804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:46:01.814184) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 48006b97073128922d1f36361bca3134afabe8fe --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 48006b97073128922d1f36361bca3134afabe8fe --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=32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-15 05:46:02,192 truncating revision to first 12 chars 2017-03-15 05:46:02,193 Setting DEBUG logging. 2017-03-15 05:46:02,193 attempt 1/10 2017-03-15 05:46:02,193 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/48006b970731?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-15 05:46:02,808 unpacking tar archive at: mozilla-central-48006b970731/testing/mozharness/ program finished with exit code 0 elapsedTime=0.931208 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:46:02.758705) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 05:46:02.759116) ========= script_repo_revision: 48006b97073128922d1f36361bca3134afabe8fe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 05:46:02.759566) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 05:46:02.759831) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 05:46:02.769075) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-15 05:46:02.769407) ========= /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=32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:46:03 INFO - MultiFileLogger online at 20170315 05:46:03 in /builds/slave/test 05:46:03 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 05:46:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:46:03 INFO - {'append_to_log': False, 05:46:03 INFO - 'base_work_dir': '/builds/slave/test', 05:46:03 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:46:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:46:03 INFO - 'branch': 'Firefox-Non-PGO', 05:46:03 INFO - 'buildbot_json_path': 'buildprops.json', 05:46:03 INFO - 'config_files': ('talos/linux_config.py',), 05:46:03 INFO - 'default_actions': ('clobber', 05:46:03 INFO - 'read-buildbot-config', 05:46:03 INFO - 'download-and-extract', 05:46:03 INFO - 'populate-webroot', 05:46:03 INFO - 'create-virtualenv', 05:46:03 INFO - 'install', 05:46:03 INFO - 'run-tests'), 05:46:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:46:03 INFO - 'download_minidump_stackwalk': True, 05:46:03 INFO - 'download_symbols': 'ondemand', 05:46:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:46:03 INFO - 'tooltool.py': '/tools/tooltool.py', 05:46:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:46:03 INFO - '/tools/misc-python/virtualenv.py')}, 05:46:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:46:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:46:03 INFO - 'gecko_profile': False, 05:46:03 INFO - 'gecko_profile_interval': 0, 05:46:03 INFO - 'installer_path': 'installer.exe', 05:46:03 INFO - 'log_level': 'info', 05:46:03 INFO - 'log_name': 'talos', 05:46:03 INFO - 'log_to_console': True, 05:46:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:46:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:46:03 INFO - 'opt_config_files': (), 05:46:03 INFO - 'pip_index': False, 05:46:03 INFO - 'suite': 'dromaeojs-e10s', 05:46:03 INFO - 'system_bits': '32', 05:46:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:46:03 INFO - 'title': 'talos-linux64-ix-008', 05:46:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:46:03 INFO - 'use_talos_json': True, 05:46:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:46:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:46:03 INFO - 'work_dir': 'build'} 05:46:03 INFO - [mozharness: 2017-03-15 12:46:03.249913Z] Running clobber step. 05:46:03 INFO - Running pre-action listener: _resource_record_pre_action 05:46:03 INFO - Running main action method: clobber 05:46:03 INFO - rmtree: /builds/slave/test/build 05:46:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:46:04 INFO - Running post-action listener: _resource_record_post_action 05:46:04 INFO - [mozharness: 2017-03-15 12:46:04.809256Z] Finished clobber step (success) 05:46:04 INFO - [mozharness: 2017-03-15 12:46:04.809372Z] Running read-buildbot-config step. 05:46:04 INFO - Running pre-action listener: _resource_record_pre_action 05:46:04 INFO - Running main action method: read_buildbot_config 05:46:04 INFO - Using buildbot properties: 05:46:04 INFO - { 05:46:04 INFO - "project": "", 05:46:04 INFO - "product": "firefox", 05:46:04 INFO - "who": "cbook@mozilla.com", 05:46:04 INFO - "installer_path": "public/build/target.tar.bz2", 05:46:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:46:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:46:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:46:04 INFO - "stage_platform": "linux64", 05:46:04 INFO - "basedir": "/builds/slave/test", 05:46:04 INFO - "buildnumber": 754, 05:46:04 INFO - "platform": "ubuntu64_hw", 05:46:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:46:04 INFO - "slavebuilddir": "test", 05:46:04 INFO - "taskId": "amWONPK2SduuO2oEb6LQhg", 05:46:04 INFO - "branch": "mozilla-central", 05:46:04 INFO - "script_repo_revision": "production", 05:46:04 INFO - "revision": "48006b97073128922d1f36361bca3134afabe8fe", 05:46:04 INFO - "slavename": "talos-linux64-ix-008", 05:46:04 INFO - "repo_path": "mozilla-central" 05:46:04 INFO - } 05:46:04 INFO - Finding installer, test and symbols from parent task. 05:46:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/amWONPK2SduuO2oEb6LQhg'}, attempt #1 05:46:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/amWONPK2SduuO2oEb6LQhg'}, attempt #1 05:46:05 INFO - Task dependencies: FW2JMJIcTvqIaC-sDfhKLA 05:46:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA'}, attempt #1 05:46:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.tar.bz2 05:46:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/test_packages.json 05:46:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.crashreporter-symbols.zip 05:46:06 INFO - Running post-action listener: _resource_record_post_action 05:46:06 INFO - [mozharness: 2017-03-15 12:46:06.211932Z] Finished read-buildbot-config step (success) 05:46:06 INFO - [mozharness: 2017-03-15 12:46:06.212146Z] Running download-and-extract step. 05:46:06 INFO - Running pre-action listener: _resource_record_pre_action 05:46:06 INFO - Running main action method: download_and_extract 05:46:06 INFO - mkdir: /builds/slave/test/build/tests 05:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:06 INFO - trying https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.test_packages.json 05:46:06 INFO - Downloading https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:46:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:46:06 INFO - Downloaded 896 bytes. 05:46:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:46:06 INFO - Using the following test package requirements: 05:46:06 INFO - {u'common': [u'target.common.tests.zip'], 05:46:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:46:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:46:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:46:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:46:06 INFO - u'mozbase': [u'target.common.tests.zip'], 05:46:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:46:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:46:06 INFO - u'web-platform': [u'target.common.tests.zip', 05:46:06 INFO - u'target.web-platform.tests.zip'], 05:46:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:46:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:46:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.common.tests.zip 05:46:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:46:06 INFO - Fetch https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.common.tests.zip into memory 05:46:07 INFO - Expected file size: 58185644 05:46:07 INFO - Obtained file size: 58185644 05:46:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:46:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.common.tests.zip 05:46:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:46:17 INFO - Fetch https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.common.tests.zip into memory 05:46:18 INFO - Expected file size: 58185644 05:46:18 INFO - Obtained file size: 58185644 05:46:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.talos.tests.zip 05:46:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:46:29 INFO - Fetch https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.talos.tests.zip into memory 05:46:30 INFO - Expected file size: 14404452 05:46:30 INFO - Obtained file size: 14404452 05:46: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:30 INFO - trying https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.tar.bz2 05:46:30 INFO - Downloading https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:46:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:46:31 INFO - Downloaded 61682718 bytes. 05:46:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.tar.bz2 05:46:31 INFO - mkdir: /builds/slave/test/properties 05:46:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:46:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:46:31 INFO - Contents: 05:46:31 INFO - build_url:https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.tar.bz2 05:46:31 INFO - Running post-action listener: _resource_record_post_action 05:46:31 INFO - Running post-action listener: set_extra_try_arguments 05:46:31 INFO - [mozharness: 2017-03-15 12:46:31.958286Z] Finished download-and-extract step (success) 05:46:31 INFO - [mozharness: 2017-03-15 12:46:31.958382Z] Running populate-webroot step. 05:46:31 INFO - Running pre-action listener: _resource_record_pre_action 05:46:31 INFO - Running main action method: populate_webroot 05:46:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:46:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:46:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:46:31 INFO - '--tppagecycles', 05:46:31 INFO - '7'], 05:46:31 INFO - 'tests': ['tsvgm']}}, 05:46:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:46:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:46:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:46:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:46:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:46:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:46:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:46:31 INFO - 'talos_options': ['--disable-e10s'], 05:46:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:46:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:46:31 INFO - 'talos_options': ['--disable-e10s'], 05:46:31 INFO - 'tests': ['damp', 'tps']}, 05:46:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:46:31 INFO - 'tests': ['damp', 'tps']}, 05:46:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:46:31 INFO - 'tests': ['dromaeo_dom']}, 05:46:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:46:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:46:31 INFO - 'tests': ['basic_compositor_video']}, 05:46:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:46:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:46:31 INFO - 'tests': ['a11yr', 05:46:31 INFO - 'ts_paint', 05:46:31 INFO - 'tpaint', 05:46:31 INFO - 'sessionrestore', 05:46:31 INFO - 'sessionrestore_no_auto_restore', 05:46:31 INFO - 'tabpaint']}, 05:46:31 INFO - 'other-e10s': {'tests': ['a11yr', 05:46:31 INFO - 'ts_paint', 05:46:31 INFO - 'tpaint', 05:46:31 INFO - 'sessionrestore', 05:46:31 INFO - 'sessionrestore_no_auto_restore', 05:46:31 INFO - 'tabpaint']}, 05:46:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:46:31 INFO - 'ts_paint', 05:46:31 INFO - 'tpaint', 05:46:31 INFO - 'sessionrestore', 05:46:31 INFO - 'sessionrestore_no_auto_restore', 05:46:31 INFO - 'tabpaint']}, 05:46:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:46:31 INFO - 'ts_paint', 05:46:31 INFO - 'tpaint', 05:46:31 INFO - 'sessionrestore', 05:46:31 INFO - 'sessionrestore_no_auto_restore', 05:46:31 INFO - 'tabpaint']}, 05:46:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:46:31 INFO - 'tests': ['a11yr', 05:46:31 INFO - 'ts_paint', 05:46:31 INFO - 'tpaint', 05:46:31 INFO - 'sessionrestore', 05:46:31 INFO - 'sessionrestore_no_auto_restore', 05:46:31 INFO - 'tabpaint']}, 05:46:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:46:31 INFO - 'tests': ['a11yr', 05:46:31 INFO - 'ts_paint', 05:46:31 INFO - 'tpaint', 05:46:31 INFO - 'sessionrestore', 05:46:31 INFO - 'sessionrestore_no_auto_restore', 05:46:31 INFO - 'tabpaint']}, 05:46:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:46:31 INFO - 'tests': ['tsvgx', 05:46:31 INFO - 'tsvgr_opacity', 05:46:31 INFO - 'tart', 05:46:31 INFO - 'tscrollx', 05:46:31 INFO - 'cart', 05:46:31 INFO - 'tsvg_static']}, 05:46:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:46:31 INFO - 'tsvgr_opacity', 05:46:31 INFO - 'tart', 05:46:31 INFO - 'tscrollx', 05:46:31 INFO - 'cart', 05:46:31 INFO - 'tsvg_static']}, 05:46:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:46:31 INFO - 'talos_options': ['--disable-e10s'], 05:46:31 INFO - 'tests': ['tp5o']}, 05:46:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:46:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:46:31 INFO - 'talos_options': ['--disable-e10s', 05:46:31 INFO - '--xperf_path', 05:46:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:31 INFO - 'tests': ['tp5n']}, 05:46:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:46:31 INFO - 'talos_options': ['--xperf_path', 05:46:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:31 INFO - 'tests': ['tp5n']}}, 05:46:31 INFO - 'talos.zip': {'path': '', 05:46:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:46:31 INFO - Running post-action listener: _resource_record_post_action 05:46:31 INFO - [mozharness: 2017-03-15 12:46:31.971373Z] Finished populate-webroot step (success) 05:46:31 INFO - [mozharness: 2017-03-15 12:46:31.971463Z] Running create-virtualenv step. 05:46:31 INFO - Running pre-action listener: _resource_record_pre_action 05:46:31 INFO - Running main action method: create_virtualenv 05:46:31 INFO - Creating virtualenv /builds/slave/test/build/venv 05:46:31 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 05:46:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:46:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:46:32 INFO - Using real prefix '/usr' 05:46:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:46:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:46:34 INFO - Installing pip.................done. 05:46:34 INFO - Return code: 0 05:46:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:46:34 INFO - Reading from file tmpfile_stdout 05:46:34 INFO - Output received: 05:46:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:46:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:34 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 0x106e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1166a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309290>, '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 0x1309b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a040>, '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': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', '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 05:46:34 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 05:46:34 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 05:46:34 INFO - Using env: {'DISPLAY': ':0', 05:46:34 INFO - 'HOME': '/home/cltbld', 05:46:34 INFO - 'LANG': 'en_US.UTF-8', 05:46:34 INFO - 'LANGUAGE': 'en_US:en', 05:46:34 INFO - 'LOGNAME': 'cltbld', 05:46:34 INFO - 'MAIL': '/var/mail/cltbld', 05:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:34 INFO - 'MOZ_NO_REMOTE': '1', 05:46:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:34 INFO - 'NO_EM_RESTART': '1', 05:46:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:34 INFO - 'PWD': '/builds/slave/test', 05:46:34 INFO - 'SHELL': '/bin/bash', 05:46:34 INFO - 'SHLVL': '1', 05:46:34 INFO - 'TERM': 'linux', 05:46:34 INFO - 'TMOUT': '86400', 05:46:34 INFO - 'USER': 'cltbld', 05:46:34 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', 05:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:34 INFO - '_': '/tools/buildbot/bin/python'} 05:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:34 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 05:46:34 INFO - Cleaning up... 05:46:34 INFO - Return code: 0 05:46:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:34 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 0x106e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1166a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309290>, '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 0x1309b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a040>, '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': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', '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 05:46:34 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 05:46:35 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 05:46:35 INFO - Using env: {'DISPLAY': ':0', 05:46:35 INFO - 'HOME': '/home/cltbld', 05:46:35 INFO - 'LANG': 'en_US.UTF-8', 05:46:35 INFO - 'LANGUAGE': 'en_US:en', 05:46:35 INFO - 'LOGNAME': 'cltbld', 05:46:35 INFO - 'MAIL': '/var/mail/cltbld', 05:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:35 INFO - 'MOZ_NO_REMOTE': '1', 05:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:35 INFO - 'NO_EM_RESTART': '1', 05:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:35 INFO - 'PWD': '/builds/slave/test', 05:46:35 INFO - 'SHELL': '/bin/bash', 05:46:35 INFO - 'SHLVL': '1', 05:46:35 INFO - 'TERM': 'linux', 05:46:35 INFO - 'TMOUT': '86400', 05:46:35 INFO - 'USER': 'cltbld', 05:46:35 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', 05:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:35 INFO - '_': '/tools/buildbot/bin/python'} 05:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:35 INFO - Downloading/unpacking psutil>=3.1.1 05:46:35 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 05:46:35 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 05:46:35 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 05:46:35 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 05:46:35 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 05:46:35 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 05:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:37 INFO - Installing collected packages: psutil 05:46:37 INFO - Running setup.py install for psutil 05:46:37 INFO - building 'psutil._psutil_linux' extension 05:46:37 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 05:46:37 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 05:46:37 INFO - building 'psutil._psutil_posix' extension 05:46:37 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 05:46:37 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 05:46:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:37 INFO - Successfully installed psutil 05:46:37 INFO - Cleaning up... 05:46:37 INFO - Return code: 0 05:46:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:37 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 0x106e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1166a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309290>, '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 0x1309b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a040>, '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': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', '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 05:46:37 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 05:46:37 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 05:46:37 INFO - Using env: {'DISPLAY': ':0', 05:46:37 INFO - 'HOME': '/home/cltbld', 05:46:37 INFO - 'LANG': 'en_US.UTF-8', 05:46:37 INFO - 'LANGUAGE': 'en_US:en', 05:46:37 INFO - 'LOGNAME': 'cltbld', 05:46:37 INFO - 'MAIL': '/var/mail/cltbld', 05:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:37 INFO - 'MOZ_NO_REMOTE': '1', 05:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:37 INFO - 'NO_EM_RESTART': '1', 05:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:37 INFO - 'PWD': '/builds/slave/test', 05:46:37 INFO - 'SHELL': '/bin/bash', 05:46:37 INFO - 'SHLVL': '1', 05:46:37 INFO - 'TERM': 'linux', 05:46:37 INFO - 'TMOUT': '86400', 05:46:37 INFO - 'USER': 'cltbld', 05:46:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', 05:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:37 INFO - '_': '/tools/buildbot/bin/python'} 05:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:46:41 INFO - Installing collected packages: mozsystemmonitor 05:46:41 INFO - Running setup.py install for mozsystemmonitor 05:46:41 INFO - Successfully installed mozsystemmonitor 05:46:41 INFO - Cleaning up... 05:46:41 INFO - Return code: 0 05:46:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1166a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309290>, '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 0x1309b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a040>, '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': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', '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 05:46:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:46:41 INFO - Using env: {'DISPLAY': ':0', 05:46:41 INFO - 'HOME': '/home/cltbld', 05:46:41 INFO - 'LANG': 'en_US.UTF-8', 05:46:41 INFO - 'LANGUAGE': 'en_US:en', 05:46:41 INFO - 'LOGNAME': 'cltbld', 05:46:41 INFO - 'MAIL': '/var/mail/cltbld', 05:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:41 INFO - 'MOZ_NO_REMOTE': '1', 05:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:41 INFO - 'NO_EM_RESTART': '1', 05:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:41 INFO - 'PWD': '/builds/slave/test', 05:46:41 INFO - 'SHELL': '/bin/bash', 05:46:41 INFO - 'SHLVL': '1', 05:46:41 INFO - 'TERM': 'linux', 05:46:41 INFO - 'TMOUT': '86400', 05:46:41 INFO - 'USER': 'cltbld', 05:46:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', 05:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:41 INFO - '_': '/tools/buildbot/bin/python'} 05:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:41 INFO - Downloading/unpacking jsonschema==2.5.1 05:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:43 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:43 INFO - warning: no files found matching '*.txt' 05:46:43 INFO - no previously-included directories found matching 'build' 05:46:43 INFO - no previously-included directories found matching 'dist' 05:46:43 INFO - no previously-included directories found matching '.git*' 05:46:43 INFO - Installing collected packages: jsonschema, functools32 05:46:43 INFO - Running setup.py install for functools32 05:46:43 INFO - warning: no files found matching '*.txt' 05:46:43 INFO - no previously-included directories found matching 'build' 05:46:43 INFO - no previously-included directories found matching 'dist' 05:46:43 INFO - no previously-included directories found matching '.git*' 05:46:43 INFO - Successfully installed jsonschema functools32 05:46:43 INFO - Cleaning up... 05:46:44 INFO - Return code: 0 05:46:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:46: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:44 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1166a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309290>, '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 0x1309b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a040>, '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': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', '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 05:46:44 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:46:44 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 functools32==3.2.3-2 05:46:44 INFO - Using env: {'DISPLAY': ':0', 05:46:44 INFO - 'HOME': '/home/cltbld', 05:46:44 INFO - 'LANG': 'en_US.UTF-8', 05:46:44 INFO - 'LANGUAGE': 'en_US:en', 05:46:44 INFO - 'LOGNAME': 'cltbld', 05:46:44 INFO - 'MAIL': '/var/mail/cltbld', 05:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:44 INFO - 'MOZ_NO_REMOTE': '1', 05:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:44 INFO - 'NO_EM_RESTART': '1', 05:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:44 INFO - 'PWD': '/builds/slave/test', 05:46:44 INFO - 'SHELL': '/bin/bash', 05:46:44 INFO - 'SHLVL': '1', 05:46:44 INFO - 'TERM': 'linux', 05:46:44 INFO - 'TMOUT': '86400', 05:46:44 INFO - 'USER': 'cltbld', 05:46:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', 05:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:44 INFO - '_': '/tools/buildbot/bin/python'} 05:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:46:44 INFO - Cleaning up... 05:46:44 INFO - Return code: 0 05:46:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:46: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:44 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 0x106e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1166a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309290>, '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 0x1309b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a040>, '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': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', '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 05:46:44 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 05:46:44 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 05:46:44 INFO - Using env: {'DISPLAY': ':0', 05:46:44 INFO - 'HOME': '/home/cltbld', 05:46:44 INFO - 'LANG': 'en_US.UTF-8', 05:46:44 INFO - 'LANGUAGE': 'en_US:en', 05:46:44 INFO - 'LOGNAME': 'cltbld', 05:46:44 INFO - 'MAIL': '/var/mail/cltbld', 05:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:44 INFO - 'MOZ_NO_REMOTE': '1', 05:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:44 INFO - 'NO_EM_RESTART': '1', 05:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:44 INFO - 'PWD': '/builds/slave/test', 05:46:44 INFO - 'SHELL': '/bin/bash', 05:46:44 INFO - 'SHLVL': '1', 05:46:44 INFO - 'TERM': 'linux', 05:46:44 INFO - 'TMOUT': '86400', 05:46:44 INFO - 'USER': 'cltbld', 05:46:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', 05:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:44 INFO - '_': '/tools/buildbot/bin/python'} 05:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:46:44 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 05:46:44 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 05:46:44 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 05:46:44 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 05:46:44 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 05:46:44 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 05:46:46 INFO - Downloading blobuploader-1.2.4.tar.gz 05:46:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:46:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:46:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:47 INFO - Downloading docopt-0.6.1.tar.gz 05:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:46:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:46:47 INFO - Running setup.py install for blobuploader 05:46:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:46:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:46:47 INFO - Running setup.py install for requests 05:46:47 INFO - Running setup.py install for docopt 05:46:47 INFO - Successfully installed blobuploader requests docopt 05:46:47 INFO - Cleaning up... 05:46:47 INFO - Return code: 0 05:46:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:47 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 0x106e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1166a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309290>, '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 0x1309b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a040>, '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': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', '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 05:46:47 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 05:46:47 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 05:46:47 INFO - Using env: {'DISPLAY': ':0', 05:46:47 INFO - 'HOME': '/home/cltbld', 05:46:47 INFO - 'LANG': 'en_US.UTF-8', 05:46:47 INFO - 'LANGUAGE': 'en_US:en', 05:46:47 INFO - 'LOGNAME': 'cltbld', 05:46:47 INFO - 'MAIL': '/var/mail/cltbld', 05:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:47 INFO - 'MOZ_NO_REMOTE': '1', 05:46:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:47 INFO - 'NO_EM_RESTART': '1', 05:46:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:47 INFO - 'PWD': '/builds/slave/test', 05:46:47 INFO - 'SHELL': '/bin/bash', 05:46:47 INFO - 'SHLVL': '1', 05:46:47 INFO - 'TERM': 'linux', 05:46:47 INFO - 'TMOUT': '86400', 05:46:47 INFO - 'USER': 'cltbld', 05:46:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', 05:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:47 INFO - '_': '/tools/buildbot/bin/python'} 05:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:48 INFO - Running setup.py (path:/tmp/pip-mHtK0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:48 INFO - Running setup.py (path:/tmp/pip-Hl66Rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:48 INFO - Running setup.py (path:/tmp/pip-UGGPm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:48 INFO - Running setup.py (path:/tmp/pip-uec1TZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:48 INFO - Running setup.py (path:/tmp/pip-SL7bDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:48 INFO - Running setup.py (path:/tmp/pip-h8tFIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:48 INFO - Running setup.py (path:/tmp/pip-1RKyau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:48 INFO - Running setup.py (path:/tmp/pip-TiCsAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:48 INFO - Running setup.py (path:/tmp/pip-6YL7aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:48 INFO - Running setup.py (path:/tmp/pip-C9z6oK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:48 INFO - Running setup.py (path:/tmp/pip-SV2JvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:48 INFO - Running setup.py (path:/tmp/pip-g2vcRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:48 INFO - Running setup.py (path:/tmp/pip-QiGDUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:49 INFO - Running setup.py (path:/tmp/pip-vDrdi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:49 INFO - Running setup.py (path:/tmp/pip-z54uLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:49 INFO - Running setup.py (path:/tmp/pip-MDx0eR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:49 INFO - Running setup.py (path:/tmp/pip-mqdpiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:46:49 INFO - Running setup.py install for manifestparser 05:46:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Running setup.py install for mozcrash 05:46:49 INFO - Running setup.py install for mozdebug 05:46:49 INFO - Running setup.py install for mozdevice 05:46:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Running setup.py install for mozfile 05:46:49 INFO - Running setup.py install for mozhttpd 05:46:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Running setup.py install for mozinfo 05:46:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Running setup.py install for mozInstall 05:46:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Running setup.py install for mozleak 05:46:50 INFO - Running setup.py install for mozlog 05:46:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Running setup.py install for moznetwork 05:46:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Running setup.py install for mozprocess 05:46:50 INFO - Running setup.py install for mozprofile 05:46:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Running setup.py install for mozrunner 05:46:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Running setup.py install for mozscreenshot 05:46:50 INFO - Running setup.py install for moztest 05:46:51 INFO - Running setup.py install for mozversion 05:46:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:46:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:46:51 INFO - Cleaning up... 05:46:51 INFO - Return code: 0 05:46:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:51 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 0x106e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1166a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309290>, '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 0x1309b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a040>, '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': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', '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 05:46:51 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 05:46:51 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 05:46:51 INFO - Using env: {'DISPLAY': ':0', 05:46:51 INFO - 'HOME': '/home/cltbld', 05:46:51 INFO - 'LANG': 'en_US.UTF-8', 05:46:51 INFO - 'LANGUAGE': 'en_US:en', 05:46:51 INFO - 'LOGNAME': 'cltbld', 05:46:51 INFO - 'MAIL': '/var/mail/cltbld', 05:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:51 INFO - 'MOZ_NO_REMOTE': '1', 05:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:51 INFO - 'NO_EM_RESTART': '1', 05:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:51 INFO - 'PWD': '/builds/slave/test', 05:46:51 INFO - 'SHELL': '/bin/bash', 05:46:51 INFO - 'SHLVL': '1', 05:46:51 INFO - 'TERM': 'linux', 05:46:51 INFO - 'TMOUT': '86400', 05:46:51 INFO - 'USER': 'cltbld', 05:46:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', 05:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:51 INFO - '_': '/tools/buildbot/bin/python'} 05:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:51 INFO - Running setup.py (path:/tmp/pip-50E9Nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:51 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)) 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:51 INFO - Running setup.py (path:/tmp/pip-hklZOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:51 INFO - Running setup.py (path:/tmp/pip-8q384C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:51 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)) 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:51 INFO - Running setup.py (path:/tmp/pip-6HLXWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:51 INFO - Running setup.py (path:/tmp/pip-YXdRtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:51 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)) 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:51 INFO - Running setup.py (path:/tmp/pip-slYoqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:51 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)) 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:51 INFO - Running setup.py (path:/tmp/pip-ZY_dLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:51 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)) 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:51 INFO - Running setup.py (path:/tmp/pip-86ifzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:51 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)) 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:51 INFO - Running setup.py (path:/tmp/pip-RkMNpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:52 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:52 INFO - Running setup.py (path:/tmp/pip-ryIIUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:52 INFO - Running setup.py (path:/tmp/pip-EXaY74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:52 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:52 INFO - Running setup.py (path:/tmp/pip-VoroEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:52 INFO - Running setup.py (path:/tmp/pip-5_rMde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:52 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:52 INFO - Running setup.py (path:/tmp/pip-4UU62n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:52 INFO - Running setup.py (path:/tmp/pip-dY_S8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:52 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:52 INFO - Running setup.py (path:/tmp/pip-97lIse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:52 INFO - Running setup.py (path:/tmp/pip-E9TdQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:52 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)) 05:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:52 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)) 05:46:52 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:52 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:52 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 05:46:52 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 05:46:52 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 05:46:52 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 05:46:52 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 05:46:52 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 05:46:54 INFO - Downloading blessings-1.6.tar.gz 05:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:54 INFO - Installing collected packages: blessings 05:46:54 INFO - Running setup.py install for blessings 05:46:54 INFO - Successfully installed blessings 05:46:54 INFO - Cleaning up... 05:46:54 INFO - Return code: 0 05:46:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:46:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:55 INFO - Reading from file tmpfile_stdout 05:46:55 INFO - Current package versions: 05:46:55 INFO - argparse == 1.2.1 05:46:55 INFO - blessings == 1.6 05:46:55 INFO - blobuploader == 1.2.4 05:46:55 INFO - docopt == 0.6.1 05:46:55 INFO - functools32 == 3.2.3-2 05:46:55 INFO - jsonschema == 2.5.1 05:46:55 INFO - manifestparser == 1.1 05:46:55 INFO - mozInstall == 1.12 05:46:55 INFO - mozcrash == 1.0 05:46:55 INFO - mozdebug == 0.1 05:46:55 INFO - mozdevice == 0.49 05:46:55 INFO - mozfile == 1.2 05:46:55 INFO - mozhttpd == 0.7 05:46:55 INFO - mozinfo == 0.9 05:46:55 INFO - mozleak == 0.1 05:46:55 INFO - mozlog == 3.4 05:46:55 INFO - moznetwork == 0.27 05:46:55 INFO - mozprocess == 0.25 05:46:55 INFO - mozprofile == 0.28 05:46:55 INFO - mozrunner == 6.13 05:46:55 INFO - mozscreenshot == 0.1 05:46:55 INFO - mozsystemmonitor == 0.3 05:46:55 INFO - moztest == 0.8 05:46:55 INFO - mozversion == 1.4 05:46:55 INFO - psutil == 3.1.1 05:46:55 INFO - requests == 1.2.3 05:46:55 INFO - wsgiref == 0.1.2 05:46:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:55 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 0x106e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1166a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309290>, '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 0x1309b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a040>, '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': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', '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 05:46:55 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 05:46:55 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 05:46:55 INFO - Using env: {'DISPLAY': ':0', 05:46:55 INFO - 'HOME': '/home/cltbld', 05:46:55 INFO - 'LANG': 'en_US.UTF-8', 05:46:55 INFO - 'LANGUAGE': 'en_US:en', 05:46:55 INFO - 'LOGNAME': 'cltbld', 05:46:55 INFO - 'MAIL': '/var/mail/cltbld', 05:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:55 INFO - 'MOZ_NO_REMOTE': '1', 05:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:55 INFO - 'NO_EM_RESTART': '1', 05:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:55 INFO - 'PWD': '/builds/slave/test', 05:46:55 INFO - 'SHELL': '/bin/bash', 05:46:55 INFO - 'SHLVL': '1', 05:46:55 INFO - 'TERM': 'linux', 05:46:55 INFO - 'TMOUT': '86400', 05:46:55 INFO - 'USER': 'cltbld', 05:46:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', 05:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:55 INFO - '_': '/tools/buildbot/bin/python'} 05:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:55 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)) 05:46:55 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)) 05:46:55 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)) 05:46:55 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)) 05:46:55 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)) 05:46:55 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)) 05:46:55 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)) 05:46:55 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)) 05:46:55 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)) 05:46:55 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)) 05:46:55 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)) 05:46:55 INFO - Cleaning up... 05:46:55 INFO - Return code: 0 05:46:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1166a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309290>, '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 0x1309b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a040>, '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': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', '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 05:46: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', 'jsonschema'] in /builds/slave/test/build 05:46: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 jsonschema 05:46:55 INFO - Using env: {'DISPLAY': ':0', 05:46:55 INFO - 'HOME': '/home/cltbld', 05:46:55 INFO - 'LANG': 'en_US.UTF-8', 05:46:55 INFO - 'LANGUAGE': 'en_US:en', 05:46:55 INFO - 'LOGNAME': 'cltbld', 05:46:55 INFO - 'MAIL': '/var/mail/cltbld', 05:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:55 INFO - 'MOZ_NO_REMOTE': '1', 05:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:55 INFO - 'NO_EM_RESTART': '1', 05:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:55 INFO - 'PWD': '/builds/slave/test', 05:46:55 INFO - 'SHELL': '/bin/bash', 05:46:55 INFO - 'SHLVL': '1', 05:46:55 INFO - 'TERM': 'linux', 05:46:55 INFO - 'TMOUT': '86400', 05:46:55 INFO - 'USER': 'cltbld', 05:46:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', 05:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:55 INFO - '_': '/tools/buildbot/bin/python'} 05:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:46:55 INFO - Cleaning up... 05:46:55 INFO - Return code: 0 05:46:55 INFO - Running post-action listener: _resource_record_post_action 05:46:55 INFO - Running post-action listener: _start_resource_monitoring 05:46:55 INFO - Starting resource monitoring. 05:46:55 INFO - [mozharness: 2017-03-15 12:46:55.621409Z] Finished create-virtualenv step (success) 05:46:55 INFO - [mozharness: 2017-03-15 12:46:55.621931Z] Running install step. 05:46:55 INFO - Running pre-action listener: _resource_record_pre_action 05:46:55 INFO - Running main action method: install 05:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:55 INFO - Reading from file tmpfile_stdout 05:46:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:55 INFO - Reading from file tmpfile_stdout 05:46:55 INFO - Output received: 05:46:55 INFO - Usage: mozinstall [options] installer 05:46:55 INFO - Options: 05:46:55 INFO - -h, --help show this help message and exit 05:46:55 INFO - -d DEST, --destination=DEST 05:46:55 INFO - Directory to install application into. [default: 05:46:55 INFO - "/builds/slave/test"] 05:46:55 INFO - --app=APP Application being installed. [default: firefox] 05:46:55 INFO - mkdir: /builds/slave/test/build/application 05:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:47:11 INFO - Reading from file tmpfile_stdout 05:47:11 INFO - Output received: 05:47:11 INFO - /builds/slave/test/build/application/firefox/firefox 05:47:11 INFO - Running post-action listener: _resource_record_post_action 05:47:11 INFO - [mozharness: 2017-03-15 12:47:11.971558Z] Finished install step (success) 05:47:11 INFO - [mozharness: 2017-03-15 12:47:11.971833Z] Running run-tests step. 05:47:11 INFO - Running pre-action listener: _resource_record_pre_action 05:47:11 INFO - Running main action method: run_tests 05:47:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:47:11 INFO - Python 2.7.3 05:47:11 INFO - Return code: 0 05:47:11 INFO - grabbing minidump binary from tooltool 05:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:11 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 0x1309290>, '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 0x1309b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:47:11 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 05:47:11 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 05:47:11 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 05:47:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:47:12 INFO - Return code: 0 05:47:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:47:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:47:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:47:12 INFO - ENV: RUST_BACKTRACE is now 1 05:47:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:47:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:47:12 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/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 05:47:12 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/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 05:47:12 INFO - Using env: {'DISPLAY': ':0', 05:47:12 INFO - 'HOME': '/home/cltbld', 05:47:12 INFO - 'LANG': 'en_US.UTF-8', 05:47:12 INFO - 'LANGUAGE': 'en_US:en', 05:47:12 INFO - 'LOGNAME': 'cltbld', 05:47:12 INFO - 'MAIL': '/var/mail/cltbld', 05:47:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:47:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:12 INFO - 'MOZ_NO_REMOTE': '1', 05:47:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:12 INFO - 'NO_EM_RESTART': '1', 05:47:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:12 INFO - 'PWD': '/builds/slave/test', 05:47:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:47:12 INFO - 'RUST_BACKTRACE': '1', 05:47:12 INFO - 'SHELL': '/bin/bash', 05:47:12 INFO - 'SHLVL': '1', 05:47:12 INFO - 'TERM': 'linux', 05:47:12 INFO - 'TMOUT': '86400', 05:47:12 INFO - 'USER': 'cltbld', 05:47:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223', 05:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:12 INFO - '_': '/tools/buildbot/bin/python'} 05:47:12 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/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 05:47:12 INFO - mozversion application_buildid: 20170315121300 05:47:12 INFO - mozversion application_changeset: 48006b97073128922d1f36361bca3134afabe8fe 05:47:12 INFO - mozversion application_display_name: Nightly 05:47:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:47:12 INFO - mozversion application_name: Firefox 05:47:12 INFO - mozversion application_remotingname: firefox 05:47:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:47:12 INFO - mozversion application_vendor: Mozilla 05:47:12 INFO - mozversion application_version: 55.0a1 05:47:12 INFO - mozversion platform_buildid: 20170315121300 05:47:12 INFO - mozversion platform_changeset: 48006b97073128922d1f36361bca3134afabe8fe 05:47:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:47:12 INFO - mozversion platform_version: 55.0a1 05:47:12 INFO - using testdate: 1489582032 05:47:12 INFO - actual date: 1489582032 05:47:12 INFO - starting webserver on 'localhost:42962' 05:47:12 INFO - SUITE-START | Running 2 tests 05:47:12 INFO - TEST-START | dromaeo_css 05:47:12 INFO - operating with platform_type : linux_ 05:47:12 INFO - Initialising browser for dromaeo_css test... 05:47:12 INFO - TEST-INFO | started process 8594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkuyBLv/profile http://localhost:42962/getInfo.html) 05:47:16 INFO - PID 8594 | __metrics Screen width/height:1600/1200 05:47:16 INFO - PID 8594 | colorDepth:24 05:47:16 INFO - PID 8594 | Browser inner width/height: 1024/697 05:47:16 INFO - PID 8594 | __metrics 05:47:17 ERROR - PID 8594 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 05:47:18 INFO - TEST-INFO | 8594: exit 0 05:47:18 INFO - Browser initialized. 05:47:18 INFO - Running cycle 1/1 for dromaeo_css test... 05:47:18 INFO - TEST-INFO | started process 8726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkuyBLv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:30 INFO - PID 8726 | RSS: Main: 159244288 05:47:30 INFO - PID 8726 | 05:50:34 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:42962/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42962/tests/dromaeo/cssquery-ext.html) 05:50:36 INFO - PID 8726 | RSS: Main: 165220352 05:50:36 INFO - PID 8726 | 05:52:18 INFO - PID 8726 | ************************* 05:52:18 INFO - PID 8726 | A coding exception was thrown and uncaught in a Task. 05:52:18 INFO - PID 8726 | 05:52:18 ERROR - PID 8726 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:52:18 INFO - PID 8726 | Full stack: 05:52:18 INFO - PID 8726 | ************************* 05:53:39 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:42962/tests/dromaeo/cssquery-ext.html (next: http://localhost:42962/tests/dromaeo/cssquery-jquery.html) 05:53:39 INFO - PID 8726 | RSS: Main: 161443840 05:53:39 INFO - PID 8726 | 05:56:41 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:42962/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42962/tests/dromaeo/cssquery-mootools.html) 05:56:42 INFO - PID 8726 | RSS: Main: 168640512 05:56:42 INFO - PID 8726 | 05:59:44 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:42962/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42962/tests/dromaeo/cssquery-prototype.html) 05:59:45 INFO - PID 8726 | RSS: Main: 161013760 05:59:45 INFO - PID 8726 | 06:02:48 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:42962/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42962/tests/dromaeo/cssquery-yui.html) 06:02:48 INFO - PID 8726 | RSS: Main: 167669760 06:02:48 INFO - PID 8726 | 06:05:51 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:42962/tests/dromaeo/cssquery-yui.html (next: http://localhost:42962/tests/dromaeo/cssquery-dojo.html) 06:05:51 INFO - PID 8726 | RSS: Main: 163004416 06:05:51 INFO - PID 8726 | 06:05:51 INFO - PID 8726 | __start_tp_report 06:05:51 INFO - PID 8726 | _x_x_mozilla_page_load 06:05:51 INFO - PID 8726 | _x_x_mozilla_page_load_details 06:05:51 INFO - PID 8726 | |i|pagename|runs| 06:05:51 INFO - PID 8726 | |0;dojo.html;2680.5309070912585;2680.9195724128276;2698;2723.754862062414;2728.072455365176;4962.1812400953795;5034.446210916796;5046.596272298221;5073.5941124710025;5078.492150784919;4989.251612258163;5049.545540901318;5080.161773307409;5119.6672216305915;5124.538791508763;4592.1963656360085;4623.8150473981;4627.8380256691025;4630.930536041962;4632.351470794091;4625.005623790884;4636.2581986882105;4638.234691275936;4656.394668693082;4711.929321060187;4553.612942899857;4584.243599806028;4586.54134586542;4594.333821595883;4609.400777898852;4621.2837010263465;4625.352450656911;4651.906961860777;4668.136394766979;4674.7845560154265;4567.132244873464;4617.58441740245;4617.58441740245;4640.3503509508355;4674.813007479696;4878.975605121987;4893.314935908976;4930.383702037246;4933.827316043958;5004.699718016931;5405.297311349499;5435.755391007375;5494.890102197974;5495.670259784386;5508.091164957777;5458.699771512565;5466.753996070147;5472.972635136839;5473.808416705396;5481.287432633772;5083.542481176675;5085.415177254663;5087.058894104529;5089.465606111379;5129.846104616868;5459.645123066988;5466.972665136649;5473.7263136843;5515.531179849678;5528.44715528444;5186.714730689849;5237.921431178459;5308.044551980681;5363.544098751572;5389.865253368697;5346.064438723208;5434.130539113723;5444.754986025639;5458.754356053987;5477.315335583052;5432.076546987022;5437.184422336682;5440.075187218104;5449.64577302482;5502.724863756796;5259.21111833228;5308.522232999048;5387.892242155135;5430.755615997289;5446.101393270066;4551.135284295973;4571.885702857455;4574.4739354973935;4599.425071866017;4612.262038073892;3934.5475270343704;3945.7829819359636;3948.2498325318097;3978.4629075074495;3993.1813978134414;4601.33280674307;4659.114768194032;4679.181143299909;4691.249400095969;4721.551452611996;5357.43746906577;5362.892742145135;5367.812126575551;5379.408265090837;5403.594730395236;4605.508881839417;4612.423447069116;4614.446266448048;4616.28447590624;4647.604953578983;4767.4994125617;4800.855974320776;4848.515148485194;4861.465238823726;4902.852914412573;5094;5094.643374963717;5098.107831129611;5110.4123025852505;5112.821051263188;5478.753456094565;5480.725963701879;5487.75305111263;5489.385290724747;5543.085390910454;5005.724685142352;5033.2701758245585;5090.592752579859;5091.389033316026;5107.208382700687;5163.845084647466;5185.859110995575;5187.974060129675;5222.791088356423;5232.947670523246;5303.2840566524565;5311.070562651444;5311.41574426805;5313.096773548584;5322.654027488201;5144;5144.794208231779;5147.9227811583605;5258.526732594085;5262.89474210506;5296.867578310419;5299.284596579412;5301.284326615858;5303.390110137384;5343.7862485500145;5146.408163061146;5173.120569503269;5216.947830521646;5230.712310822789;5248.580113590827;5225.764840582106;5262.052830490548;5263.23683065961;5311.123664595453;5321.600879933943;5131.127708289525;5132.3327967364;5152.5620322271525;5166.715830629351;5191.273221748883 06:05:51 INFO - PID 8726 | |1;ext.html;674.6559254780061;694.9791506254815;767.808047988003;775.2906090926803;828.7720876758895;30822.229444263903;32023.83988080059;32069.839650801772;32158.35683286333;32226.77732226782;30211;30431;30646.693533064663;30730;30755.846220768864;4625.62994960404;4689.109069276844;4691.272852707819;8899;9103.408278461911;9127.95436022819;9173.266138708921;9252.259819214447;9270;9284.257259419264;9351;9400.482973436458;9470.052994700543;9482.146606805387;9495.240380769523;9364.204042656349;9371.34400591959;9415;9415.152636262701;9455.669051583161;9183.49490778007;9218.35471516994;9224.446533207962;9272.350935434522;9337.766555836091;34341.14147146316;34619.65380346215;34644.82677586621;34798.30403391918;34847.128821779406;3292.242784159657;3350.0904484443877;3383.0865666270215;3402.8298585070647;3433.759636825423;23607.409814754596;23695.763042369526;23763.7623623765;24339.391515212083;24459.633105503253;3051.6948305169526;3054.8167109973474;3090.598222231118;3129.3741251749743;3233.3856567252146;155295;155767;156182;156187;156570.99999999886;32126.19684507906;32370.35259294801;38185.80907095447;42957.785211073744;43574.7821260898;43347.13305733867;43752.56247437549;43826.78086609547;43865.34201986973;43866.12267754691;13699.931500342434;13730.244836533886;13825.723485530232;13843.723125537634;13845;11072.557097716;11105.888941110485;11140.108791296676;11153.498092585853;11186.832197517044;13414.530491432753;13458.730825383633;13479.528216512375;13642.590722278348;13745.450181992608;5338.466153384708;5389.137737961907;5503.807366742145;5562.606809845991;5582.469665381782;846.1158089796178;892.0499667853844;1010.3836659637615;1081.7836432713489;1082.951267192978;21072.735635861896;21126.260580879596;21149.577008459746;21226.78773212279;21482.140714371562;1116.7822274656526;1122.820348744197;1127.4700890581414;1132.6375559820942;1133.4162906103363;10750.94624526888;11446;11559.017483513828;11560.947602286727;11860.347680877461;235683;236910;239189;239841;240131;44015.77992110019;44187.337189942176;44328;44348;44360.55639443564;1240.795268780641;1262.545483625894;1269.911106222574;1271.783796754554;1281.14803655568;20779.480512987295;21159.153633854472;22958.50769700031;23183.768162318836;23321.76678233196;40048;40658.69790182527;40666.59333406747;40724;40828;231748;235020;236218;237740;238812;28046.43907121887;28103;28317.433651327272;28458.146255612366;30407.695923040486;32863.67136328606;35365;35633.28733425265;36415.63584364123;36540.45189322109;29976.700232998264;30239.395212096075;30458.238544036576;30786.84606576953;31175.688243118188;30363;30676.539851901794;31091;31803;31965.68034319627;29946.700532995263;30184.585233181733;30216.69783302139;30849.228769280948;30861.537076943416;25611.231663050137;25664.486710266065;27073;28391.29021774472;28965.275868103465;22431.32706018822;22756;22856.20332125927;23013.194538191754;23081.65377519305 06:05:51 INFO - PID 8726 | |2;jquery.html;398.10227936004304;399.6463130129835;405.943167956486;409.70296535012113;411.8270326462885;17373.56566085847;18077.367292144776;18095.36666216684;18448.169832357544;19776.11007504662;18422;18571.442856714286;18974.335898243564;19166.137523811427;19170.808291917077;5481.287432633772;5619.775208991646;5730.3123625165035;5762.9135562966585;5865.208196893407;5719.656820590757;5783.739731712083;5802.216700745409;5811.970940145315;5816.854578635525;5633.183188437674;5744.454276843714;5765.971170144144;5785.103308987113;5856.853578660525;5679.914801277984;5700.572457065716;5750.884982300372;5751.4248575142365;5783.334916484616;6467.288598254188;6745.898811517831;6763.222229443579;6791.049253104569;6799.218089919624;20962.5807483851;22058.669119963215;22732.545349093092;22798.31605051851;23122.19072332477;2037.9898100509402;2081.20914052659;2081.250749730096;2088.2169186555043;2121.087932189158;13788.276639150998;14347;14648.707025859423;14894.776578351333;14930.2534873257;1807.3854889337556;1825.1148193126323;1837.421212318129;1843.9539011524819;1886.6792645250341;85041.57479212627;87008;87145;87431.56284218538;89372;16696.415625453294;16725.498235052968;16868.493945181664;16879.40922067722;16995.575110622332;29382.55926161109;29386.55920161199;29499.705002950126;29580.112596622137;29788.851055744584;8634.568271586395;8775.341849361323;8970.327225458117;9159.404638698463;9175.59571405729;7243.710251589982;7244.203137654854;7253.709851605877;7410;7446.106467223968;8840.778980525409;8938.46369217849;9007.279417646572;9125.174965007025;9142.680006199751;3396.3037577296595;3446.8993872622477;3480.2865412590863;3611.94582081269;3803.6576708096404;937.5780898595659;952.4428209497383;988.6292640259902;1014.3660212367271;1029.3566520924421;19514.31699890497;19923.601527969648;19924.800751992585;19935.202591896163;19963.500912477306;994.7015895231401;1005.2058873490007;1007.309992655019;1010.1918465227789;1010.2120346130031;10352.171826253882;10958.561657533768;10983.39591322485;10990.670279891616;11070.059044981106;463293;481711;492234;498935;503144;83799.03853338955;86913.56543217243;86965.56517217374;87221;91206.54396727974;1089.9891001090045;1104.7624760676333;1108.8669359676728;1111.222144498854;1122.4163435013747;16176.93083423174;16314.836851631806;16610.75083873767;17214.225359858585;17265.91367043207;37989;38603.2279354417;39299.803500982314;41358;42280.154396912505;44924.77537612422;45741.771291144665;47852.28221576609;47975.28037079377;54751.72624136854;10018.298719089593;10193.184545236216;10785.352878827296;11253.549858005588;11489;12225;12226.938865305616;12582.496700131893;12658.810117848056;12715.55495557651;10224.795504089729;10734.463276835972;10743.623973160902;10771;10788.676339709822;10191.439470829175;10458.424786636808;10612.734681632712;10689.091427228772;10693.625723099654;11110.222284440011;11316.886831131913;11413.258138220988;11734.647960561197;11939.164258501822;11163;11253.718657033312;11265.549378025114;11347.432628368713;11625.418729063682;11079.612213572485;11222.270552414067;11349.205555611357;11480.598179063692;11612.593559225725 06:05:51 INFO - PID 8726 | |3;mootools.html;1413.6889884225473;1429.842717301096;1452.150491962202;1462.9853701462982;1513.0089791186774;7708.152103268636;7956.721514746985;9025.729228123158;9416.576254068566;9697.175740062094;8686.261667758232;9067.365284430092;9068.954655226731;9075.773105672362;9383.953080234607;2010.3466373428657;2031.004807644251;2046.6316063108634;2050.0159923236856;2063.7007633893077;1943.9319623813099;1994.172418446343;1995.7704863940687;2011.155314767801;2012.2956965062258;2013.6174126915912;2040.0513761101085;2055.969160462594;2056.033664177834;2060.8248298894537;1909.6658084835237;1914.607505461377;1930.3243864647332;1930.5270208798793;1931.0344827586207;1737.0533059482611;1753.4914874686326;1761.7093179625347;2000.7999200080021;2004.098155829868;9689.32174747768;9721.368111072828;9757.90242097577;9764;9767;4599.609033232179;4796.736179510125;4799.760011999421;4808.903821923542;4816.879578010543;2480.85114893107;2676.531606968773;2726.5364887968894;2738.5070687276284;2751.697313295536;997.2670087485692;1044.2742294105599;1073.7906108308882;1092.9945350273197;1095.594629986902;12870.420831062625;12964.611061668165;13038.152520086163;13046.739065218642;13094.214347139203;3729.8881033569037;3888.2223555289056;3939.212157568498;3991.560928297885;4127.33962565988;11591.826122608167;11625.825612615818;11660.88339116615;11667.824982625267;11688.883111168949;4788.808447662054;4790.664653474223;4790.9938912828;4815.975920120377;4820.108279968217;3689.7417180797624;3722.925541489155;4201.978990105091;4229.6827737919775;4297;3460.2560449502976;3472.826358682056;3556.413191823372;3595.478655594924;3613.1509095362567;966.2221911361421;968.331851022792;971.7667759737612;976.7802244494932;976.9609215631295;844.6916875340456;846.2003406780657;857.7812657772229;874.2044739287218;878.0078511282338;5229.424763276036;5503.669779813224;5662.17898404729;5682.176084467729;5696.1455781633085;873.3013589128672;883.6288758721353;903.846346121161;907.1019690506351;907.1019690506351;3655.250673611903;3705.0922523981258;3712.8143592820793;3714.832832522543;3801.334766415866;11293.548258069584;11543.19197656156;11746.119041071783;11788.941055294668;11836.408179590986;11485.392045113691;11511.53953841837;11519.136064795173;11522.481488333045;11543.153095504847;8319.376046796393;8645.740627781177;8702.956485217534;8748.212660860552;8786.472811631194;5495.8446539875595;5580.9441905580425;5659.518940889906;5687.232223649754;5735.684537350486;9375.624975000923;9460.101290377403;9571.1864491519;9615;9632.807343852943;9699.757506062122;9881.258905581966;9903.801923961337;9923.305368624127;10050.798984020425;6687.866242675022;6930.757423490154;6959.130108736408;7856.214378562098;8006.879896801669;7849.60751962411;7948.205179482005;7961.044674639081;8013.959930200312;8070.556119413489;7089.61007144612;7105.32499412555;7178.353948144692;7180.640967951686;7316.853662926818;6866.588004719732;6935.861282774417;7059.5058345915295;7137.571745695275;7293.307135822089;6112.572119951561;6120.663363515049;6194.628322300677;6235.064740288812;6237.532185086227;4480.059187570647;4482.551744825491;4501;4552.88617784558;4625.722456652612;4706.92939605913;4708.199606067045;4762.190427627381;4797.760111994457;4839.564439200489 06:05:51 INFO - PID 8726 | |4;prototype.html;362.8530445169707;380.3040436002116;380.31922858084033;383.5186840515153;385.75697310694267;5216.452272511379;5363.570914326854;5469.699166545838;5477.205805158254;5508.944910550893;5175.637705360627;5321.201819727043;5371.435999220084;5390.487903649157;5396.1905714142895;4635.165670179366;4669.369635099269;4669.463011753658;4669.976650116745;4670.626349892001;4578.542145785428;4632.212523870933;4656.511066338019;4677.859664210079;4680.1747318545795;4616.122936642044;4631.120087183441;4636.2581986882105;4642.837500687477;4647;4633.745144017078;4638.11875743611;4647.767611619439;4648.326602423125;4650.0932318197965;4400.581944715247;4444.422225110748;4462.263726485158;4493.292548831456;4502.954970450286;5240.34495688039;5252.369715634149;5260.631755777097;5278.102722537178;5292.444293349181;5442.836714898559;5446.210299506589;5465.508104270595;5473.616846820724;5474.644148130359;5578.246936663539;5722.513586345166;5740.684262365568;5783.5951483396175;5788.18965344852;4892.706437613754;4904.705717656916;4905.484924082955;4912.852614421573;4945.505449455061;5683.2895888014;5824.204381896671;5915.1718759373725;6076.3316035236085;6080.574359794816;5102.260172275;5129.9996500682755;5138.563222126087;5148.6910785353;5172.965406918632;5205.6616319939085;5222.294990176353;5232.869178270497;5256.684598924;5263.078961181778;5297.390800057966;5308.654937429054;5390.137577987503;5405.837824865261;5412.538614574043;5683.829485115453;5703.914441283384;5724.513416359656;5725.713714314267;5726.513246374105;1601.2554162314348;1832.221305944968;1862.4878158506249;1864.7296142059326;1871.8970456624745;1218.5795900414344;1220.5972029230334;1258.314218750783;1265.9810102848464;1275.1392809853312;4950.18321976877;4954.380702412199;4955.851324460272;4957.892895519462;4979.128652485801;5803.361630220672;5837.88324233513;5908.940910590925;5919.496842768327;5930.525557955353;4735.384400027974;4931.186354251508;4971.577415919615;4972.950270497248;4976.576990955809;3108.580341653848;3135.5139953306816;3141.8271995040036;3143.732782713449;3147.1974646465465;5455.481729235717;5468.734387178008;5495.368032676213;5499.120140777456;5504.587155963319;5667.80162694312;5989.251343582052;6037.154798328237;6053.969730151409;6075.088736689532;5419.701916394557;5501.614886957955;5505.532029777513;5518.144687573513;5532.2531458253425;5801.883962320646;5919.437653422918;5938.673372964528;5947.6431414115295;5959.940400596112;5516.668999860021;5680.602357834912;5779.393163717749;5856.238688970407;5874.355180549453;5297.788088476418;5424.593155513273;5457.208704737712;5485;5487.149491828773;4653.488116307136;4691.132140554008;4707.411573553306;4721.480637129845;4726.220173671306;5749.965006298907;5854.268216472941;5890.617109887844;5892.551123901427;5928.140419639214;5683.346415162309;5714.3999880012;5727.8854422912145;5742.626729262584;5745.253117094751;5491.862703432446;5700.885982280414;5703.828885133453;5711.371749107512;5711.971440142773;5592.888142237051;5603.663780173202;5610.270664813548;5635.323761148688;5640.435956404327;5746.454086861741;5755.194272801895;5758.481736643722;5764.510016648632;5780.653160810365;5322.175062865262;5541.722913854211;5556.138798486241;5583.134614134816;5612.971935140462 06:05:51 INFO - PID 8726 | |5;yui.html;720.7981765105769;741.2920660768963;757.8219118507146;760.6919197724922;779.2402407652539;13286.202827830324;13847.792283115761;13856.722865542708;13865.722685546296;13896.791548126774;12480;12568.371581420937;12590.748185036316;12648.114631975743;13145.934270328635;839.1314988986401;843.0473564871686;870.5429649434066;872.8254349130168;874.8512752832033;868.3096937934357;868.7741187291318;872.6596627315353;873.2402809555696;874.8250349930007;920.7099763574486;920.9171174594285;920.9263258939269;921.1203300847708;923.6166990698852;899.3030401438872;907.0793144957873;907.7231444409452;908.3414524469706;909.3952521573146;665.8801415745164;667.8196886840575;667.9833004174886;668.2515582547578;671.711164199394;14490.855091449055;14540.70918581633;14559.70880582393;14786.18675972821;14993.625159370993;13674.726505469935;14290.285485725672;14293.571192864127;14311.928440357731;14382.640433989234;10706.571737130505;10764;10815.83776243357;10830.241883068189;10831.67504974852;3315.3203593263324;3319.8174100424467;3350.480675495302;3362.932741345184;3482.320947415255;46574.9452571167;56877.43122568763;60079;60945.69527152336;61759.07361389583;10482.842757358645;10483.47582620881;10490.583771190944;10686.412247326472;11140.442977851075;21449.034793434334;21457;21508.462288442603;21559;21560.784392155878;6567.605943643397;6665.533412661067;6741.8651626967185;6957.617331046841;6975.511714179958;3512.5258090158013;3547.840347184383;3557.964420355815;3582;3654.0499470137956;2685.9059932902255;2724.264448598867;2740.9725902741116;2750.106215479977;2753.931151721223;458.14098565190267;465.29043209106385;468.1760102220117;476.1738383903924;476.833108412053;599.2269971736412;615.9137720719103;627.1220291591808;629.6033498895666;649.636203725915;8567;9390.483523406278;9441.260030902575;9467.763305917408;9634.373765705206;617.7374615788361;641.7914177892204;649.8602800397842;650.905618685288;662.6156829039146;4096.242195193899;4341.479022517318;4425.712328698624;4478.820847166142;4509.098180363941;49098;53664.73167634215;60464;61774.69112654408;62616.68691656512;53231.136910208734;54108.72945635246;55145.724271378385;56570.717146414005;56698;41173;43771.56228437675;46448.5355146451;46551.30173047475;46978.5302146981;8952.14954579314;9283.907160928575;9691.585986625469;9702.385701747251;9937.701868943943;27798.5830212551;29177.416451670422;31918.52122218122;32284;32582;36882.533562549535;37238;38233;38248.235035299695;38304;11696.298222106361;11815.172937894265;11881.881181188077;11888.58389956382;12042.157049006486;12933.741325173256;13212.867871321549;13227.3386330685;13232;13681.931590341985;10833.187510936554;10975.231733778559;10995.780084398428;11115.499802509068;11220.2145849793;11643.941780291045;11742.882571174521;12140.514379424723;12439.937800310941;12468.688282793002;11375;11756.823647645464;11773.823392649289;11840;11845.348505832262;9697.951510242687;9716.805663886542;10066.396016239049;10117.342372745748;10467.267291289842;9781.85327220078;10156.238282129018;10216.744581385525;10242.487875606339;10279.280450368402 06:05:51 INFO - PID 8726 | __end_tp_report 06:05:51 INFO - PID 8726 | __start_cc_report 06:05:51 INFO - PID 8726 | _x_x_mozilla_cycle_collect,386 06:05:51 INFO - PID 8726 | __end_cc_report 06:05:51 INFO - PID 8726 | __startTimestamp1489583151718__endTimestamp 06:05:51 INFO - PID 8726 | 06:05:51 INFO - PID 8726 | ------- Summary: start ------- 06:05:51 INFO - PID 8726 | Number of tests: 6 06:05:51 INFO - PID 8726 | 06:05:51 INFO - PID 8726 | [#0] dojo.html Cycles:165 Average:4978.71 Median:5119.67 stddev:542.95 (10.6%) stddev-sans-first:513.81 06:05:51 INFO - PID 8726 | Values: 2680.5 2680.9 2698.0 2723.8 2728.1 4962.2 5034.4 5046.6 5073.6 5078.5 4989.3 5049.5 5080.2 5119.7 5124.5 4592.2 4623.8 4627.8 4630.9 4632.4 4625.0 4636.3 4638.2 4656.4 4711.9 4553.6 4584.2 4586.5 4594.3 4609.4 4621.3 4625.4 4651.9 4668.1 4674.8 4567.1 4617.6 4617.6 4640.4 4674.8 4879.0 4893.3 4930.4 4933.8 5004.7 5405.3 5435.8 5494.9 5495.7 5508.1 5458.7 5466.8 5473.0 5473.8 5481.3 5083.5 5085.4 5087.1 5089.5 5129.8 5459.6 5467.0 5473.7 5515.5 5528.4 5186.7 5237.9 5308.0 5363.5 5389.9 5346.1 5434.1 5444.8 5458.8 5477.3 5432.1 5437.2 5440.1 5449.6 5502.7 5259.2 5308.5 5387.9 5430.8 5446.1 4551.1 4571.9 4574.5 4599.4 4612.3 3934.5 3945.8 3948.2 3978.5 3993.2 4601.3 4659.1 4679.2 4691.2 4721.6 5357.4 5362.9 5367.8 5379.4 5403.6 4605.5 4612.4 4614.4 4616.3 4647.6 4767.5 4800.9 4848.5 4861.5 4902.9 5094.0 5094.6 5098.1 5110.4 5112.8 5478.8 5480.7 5487.8 5489.4 5543.1 5005.7 5033.3 5090.6 5091.4 5107.2 5163.8 5185.9 5188.0 5222.8 5232.9 5303.3 5311.1 5311.4 5313.1 5322.7 5144.0 5144.8 5147.9 5258.5 5262.9 5296.9 5299.3 5301.3 5303.4 5343.8 5146.4 5173.1 5216.9 5230.7 5248.6 5225.8 5262.1 5263.2 5311.1 5321.6 5131.1 5132.3 5152.6 5166.7 5191.3 06:05:51 INFO - PID 8726 | 06:05:51 INFO - PID 8726 | [#1] ext.html Cycles:180 Average:35472.67 Median:30703.27 stddev:55531.37 (180.9%) stddev-sans-first:55625.68 06:05:51 INFO - PID 8726 | Values: 674.7 695.0 767.8 775.3 828.8 30822.2 32023.8 32069.8 32158.4 32226.8 30211.0 30431.0 30646.7 30730.0 30755.8 4625.6 4689.1 4691.3 8899.0 9103.4 9128.0 9173.3 9252.3 9270.0 9284.3 9351.0 9400.5 9470.1 9482.1 9495.2 9364.2 9371.3 9415.0 9415.2 9455.7 9183.5 9218.4 9224.4 9272.4 9337.8 34341.1 34619.7 34644.8 34798.3 34847.1 3292.2 3350.1 3383.1 3402.8 3433.8 23607.4 23695.8 23763.8 24339.4 24459.6 3051.7 3054.8 3090.6 3129.4 3233.4 155295.0 155767.0 156182.0 156187.0 156571.0 32126.2 32370.4 38185.8 42957.8 43574.8 43347.1 43752.6 43826.8 43865.3 43866.1 13699.9 13730.2 13825.7 13843.7 13845.0 11072.6 11105.9 11140.1 11153.5 11186.8 13414.5 13458.7 13479.5 13642.6 13745.5 5338.5 5389.1 5503.8 5562.6 5582.5 846.1 892.0 1010.4 1081.8 1083.0 21072.7 21126.3 21149.6 21226.8 21482.1 1116.8 1122.8 1127.5 1132.6 1133.4 10750.9 11446.0 11559.0 11560.9 11860.3 235683.0 236910.0 239189.0 239841.0 240131.0 44015.8 44187.3 44328.0 44348.0 44360.6 1240.8 1262.5 1269.9 1271.8 1281.1 20779.5 21159.2 22958.5 23183.8 23321.8 40048.0 40658.7 40666.6 40724.0 40828.0 231748.0 235020.0 236218.0 237740.0 238812.0 28046.4 28103.0 28317.4 28458.1 30407.7 32863.7 35365.0 35633.3 36415.6 36540.5 29976.7 30239.4 30458.2 30786.8 31175.7 30363.0 30676.5 31091.0 31803.0 31965.7 29946.7 30184.6 30216.7 30849.2 30861.5 25611.2 25664.5 27073.0 28391.3 28965.3 22431.3 22756.0 22856.2 23013.2 23081.7 06:05:51 INFO - PID 8726 | 06:05:51 INFO - PID 8726 | [#2] jquery.html Cycles:180 Average:29523.16 Median:11541.83 stddev:80265.30 (695.4%) stddev-sans-first:80460.67 06:05:51 INFO - PID 8726 | Values: 398.1 399.6 405.9 409.7 411.8 17373.6 18077.4 18095.4 18448.2 19776.1 18422.0 18571.4 18974.3 19166.1 19170.8 5481.3 5619.8 5730.3 5762.9 5865.2 5719.7 5783.7 5802.2 5812.0 5816.9 5633.2 5744.5 5766.0 5785.1 5856.9 5679.9 5700.6 5750.9 5751.4 5783.3 6467.3 6745.9 6763.2 6791.0 6799.2 20962.6 22058.7 22732.5 22798.3 23122.2 2038.0 2081.2 2081.3 2088.2 2121.1 13788.3 14347.0 14648.7 14894.8 14930.3 1807.4 1825.1 1837.4 1844.0 1886.7 85041.6 87008.0 87145.0 87431.6 89372.0 16696.4 16725.5 16868.5 16879.4 16995.6 29382.6 29386.6 29499.7 29580.1 29788.9 8634.6 8775.3 8970.3 9159.4 9175.6 7243.7 7244.2 7253.7 7410.0 7446.1 8840.8 8938.5 9007.3 9125.2 9142.7 3396.3 3446.9 3480.3 3611.9 3803.7 937.6 952.4 988.6 1014.4 1029.4 19514.3 19923.6 19924.8 19935.2 19963.5 994.7 1005.2 1007.3 1010.2 1010.2 10352.2 10958.6 10983.4 10990.7 11070.1 463293.0 481711.0 492234.0 498935.0 503144.0 83799.0 86913.6 86965.6 87221.0 91206.5 1090.0 1104.8 1108.9 1111.2 1122.4 16176.9 16314.8 16610.8 17214.2 17265.9 37989.0 38603.2 39299.8 41358.0 42280.2 44924.8 45741.8 47852.3 47975.3 54751.7 10018.3 10193.2 10785.4 11253.5 11489.0 12225.0 12226.9 12582.5 12658.8 12715.6 10224.8 10734.5 10743.6 10771.0 10788.7 10191.4 10458.4 10612.7 10689.1 10693.6 11110.2 11316.9 11413.3 11734.6 11939.2 11163.0 11253.7 11265.5 11347.4 11625.4 11079.6 11222.3 11349.2 11480.6 11612.6 06:05:51 INFO - PID 8726 | 06:05:51 INFO - PID 8726 | [#3] mootools.html Cycles:180 Average:5614.77 Median:4790.83 stddev:3561.98 (74.3%) stddev-sans-first:3557.99 06:05:51 INFO - PID 8726 | Values: 1413.7 1429.8 1452.2 1463.0 1513.0 7708.2 7956.7 9025.7 9416.6 9697.2 8686.3 9067.4 9069.0 9075.8 9384.0 2010.3 2031.0 2046.6 2050.0 2063.7 1943.9 1994.2 1995.8 2011.2 2012.3 2013.6 2040.1 2056.0 2056.0 2060.8 1909.7 1914.6 1930.3 1930.5 1931.0 1737.1 1753.5 1761.7 2000.8 2004.1 9689.3 9721.4 9757.9 9764.0 9767.0 4599.6 4796.7 4799.8 4808.9 4816.9 2480.9 2676.5 2726.5 2738.5 2751.7 997.3 1044.3 1073.8 1093.0 1095.6 12870.4 12964.6 13038.2 13046.7 13094.2 3729.9 3888.2 3939.2 3991.6 4127.3 11591.8 11625.8 11660.9 11667.8 11688.9 4788.8 4790.7 4791.0 4816.0 4820.1 3689.7 3722.9 4202.0 4229.7 4297.0 3460.3 3472.8 3556.4 3595.5 3613.2 966.2 968.3 971.8 976.8 977.0 844.7 846.2 857.8 874.2 878.0 5229.4 5503.7 5662.2 5682.2 5696.1 873.3 883.6 903.8 907.1 907.1 3655.3 3705.1 3712.8 3714.8 3801.3 11293.5 11543.2 11746.1 11788.9 11836.4 11485.4 11511.5 11519.1 11522.5 11543.2 8319.4 8645.7 8703.0 8748.2 8786.5 5495.8 5580.9 5659.5 5687.2 5735.7 9375.6 9460.1 9571.2 9615.0 9632.8 9699.8 9881.3 9903.8 9923.3 10050.8 6687.9 6930.8 6959.1 7856.2 8006.9 7849.6 7948.2 7961.0 8014.0 8070.6 7089.6 7105.3 7178.4 7180.6 7316.9 6866.6 6935.9 7059.5 7137.6 7293.3 6112.6 6120.7 6194.6 6235.1 6237.5 4480.1 4482.6 4501.0 4552.9 4625.7 4706.9 4708.2 4762.2 4797.8 4839.6 06:05:51 INFO - PID 8726 | 06:05:51 INFO - PID 8726 | [#4] prototype.html Cycles:180 Average:4936.60 Median:5393.34 stddev:1287.52 (23.9%) stddev-sans-first:1244.52 06:05:51 INFO - PID 8726 | Values: 362.9 380.3 380.3 383.5 385.8 5216.5 5363.6 5469.7 5477.2 5508.9 5175.6 5321.2 5371.4 5390.5 5396.2 4635.2 4669.4 4669.5 4670.0 4670.6 4578.5 4632.2 4656.5 4677.9 4680.2 4616.1 4631.1 4636.3 4642.8 4647.0 4633.7 4638.1 4647.8 4648.3 4650.1 4400.6 4444.4 4462.3 4493.3 4503.0 5240.3 5252.4 5260.6 5278.1 5292.4 5442.8 5446.2 5465.5 5473.6 5474.6 5578.2 5722.5 5740.7 5783.6 5788.2 4892.7 4904.7 4905.5 4912.9 4945.5 5683.3 5824.2 5915.2 6076.3 6080.6 5102.3 5130.0 5138.6 5148.7 5173.0 5205.7 5222.3 5232.9 5256.7 5263.1 5297.4 5308.7 5390.1 5405.8 5412.5 5683.8 5703.9 5724.5 5725.7 5726.5 1601.3 1832.2 1862.5 1864.7 1871.9 1218.6 1220.6 1258.3 1266.0 1275.1 4950.2 4954.4 4955.9 4957.9 4979.1 5803.4 5837.9 5908.9 5919.5 5930.5 4735.4 4931.2 4971.6 4973.0 4976.6 3108.6 3135.5 3141.8 3143.7 3147.2 5455.5 5468.7 5495.4 5499.1 5504.6 5667.8 5989.3 6037.2 6054.0 6075.1 5419.7 5501.6 5505.5 5518.1 5532.3 5801.9 5919.4 5938.7 5947.6 5959.9 5516.7 5680.6 5779.4 5856.2 5874.4 5297.8 5424.6 5457.2 5485.0 5487.1 4653.5 4691.1 4707.4 4721.5 4726.2 5750.0 5854.3 5890.6 5892.6 5928.1 5683.3 5714.4 5727.9 5742.6 5745.3 5491.9 5700.9 5703.8 5711.4 5712.0 5592.9 5603.7 5610.3 5635.3 5640.4 5746.5 5755.2 5758.5 5764.5 5780.7 5322.2 5541.7 5556.1 5583.1 5613.0 06:05:51 INFO - PID 8726 | 06:05:51 INFO - PID 8726 | [#5] yui.html Cycles:180 Average:14115.29 Median:38276.12 stddev:16362.82 (42.7%) stddev-sans-first:16377.81 06:05:51 INFO - PID 8726 | Values: 720.8 741.3 757.8 760.7 779.2 13286.2 13847.8 13856.7 13865.7 13896.8 12480.0 12568.4 12590.7 12648.1 13145.9 839.1 843.0 870.5 872.8 874.9 868.3 868.8 872.7 873.2 874.8 920.7 920.9 920.9 921.1 923.6 899.3 907.1 907.7 908.3 909.4 665.9 667.8 668.0 668.3 671.7 14490.9 14540.7 14559.7 14786.2 14993.6 13674.7 14290.3 14293.6 14311.9 14382.6 10706.6 10764.0 10815.8 10830.2 10831.7 3315.3 3319.8 3350.5 3362.9 3482.3 46574.9 56877.4 60079.0 60945.7 61759.1 10482.8 10483.5 10490.6 10686.4 11140.4 21449.0 21457.0 21508.5 21559.0 21560.8 6567.6 6665.5 6741.9 6957.6 6975.5 3512.5 3547.8 3558.0 3582.0 3654.0 2685.9 2724.3 2741.0 2750.1 2753.9 458.1 465.3 468.2 476.2 476.8 599.2 615.9 627.1 629.6 649.6 8567.0 9390.5 9441.3 9467.8 9634.4 617.7 641.8 649.9 650.9 662.6 4096.2 4341.5 4425.7 4478.8 4509.1 49098.0 53664.7 60464.0 61774.7 62616.7 53231.1 54108.7 55145.7 56570.7 56698.0 41173.0 43771.6 46448.5 46551.3 46978.5 8952.1 9283.9 9691.6 9702.4 9937.7 27798.6 29177.4 31918.5 32284.0 32582.0 36882.5 37238.0 38233.0 38248.2 38304.0 11696.3 11815.2 11881.9 11888.6 12042.2 12933.7 13212.9 13227.3 13232.0 13681.9 10833.2 10975.2 10995.8 11115.5 11220.2 11643.9 11742.9 12140.5 12439.9 12468.7 11375.0 11756.8 11773.8 11840.0 11845.3 9698.0 9716.8 10066.4 10117.3 10467.3 9781.9 10156.2 10216.7 10242.5 10279.3 06:05:51 INFO - PID 8726 | -------- Summary: end -------- 06:05:51 INFO - PID 8726 | 06:05:52 INFO - TEST-INFO | 8726: exit 0 06:05:52 INFO - TEST-OK | dromaeo_css | took 1120324ms 06:05:52 INFO - TEST-START | kraken 06:05:52 INFO - operating with platform_type : linux_ 06:05:52 INFO - Initialising browser for kraken test... 06:05:52 INFO - TEST-INFO | started process 9102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppAcuBL/profile http://localhost:42962/getInfo.html) 06:05:56 INFO - PID 9102 | __metrics Screen width/height:1600/1200 06:05:56 INFO - PID 9102 | colorDepth:24 06:05:56 INFO - PID 9102 | Browser inner width/height: 1024/697 06:05:56 INFO - PID 9102 | __metrics 06:05:57 ERROR - PID 9102 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 06:05:58 INFO - TEST-INFO | 9102: exit 0 06:05:58 INFO - Browser initialized. 06:05:58 INFO - Running cycle 1/1 for kraken test... 06:05:58 INFO - TEST-INFO | started process 9234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppAcuBL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:10 INFO - PID 9234 | RSS: Main: 155725824 06:06:10 INFO - PID 9234 | 06:06:13 INFO - PID 9234 | Cycle 1(1): loaded http://localhost:42962/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42962/tests/kraken/driver.html?testName=audio-beat-detection) 06:06:14 INFO - PID 9234 | RSS: Main: 161288192 06:06:14 INFO - PID 9234 | 06:06:17 INFO - PID 9234 | Cycle 1(1): loaded http://localhost:42962/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42962/tests/kraken/driver.html?testName=audio-dft) 06:06:17 INFO - PID 9234 | RSS: Main: 160612352 06:06:17 INFO - PID 9234 | 06:06:20 INFO - PID 9234 | Cycle 1(1): loaded http://localhost:42962/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42962/tests/kraken/driver.html?testName=audio-fft) 06:06:21 INFO - PID 9234 | RSS: Main: 157425664 06:06:21 INFO - PID 9234 | 06:06:23 INFO - PID 9234 | Cycle 1(1): loaded http://localhost:42962/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42962/tests/kraken/driver.html?testName=audio-oscillator) 06:06:24 INFO - PID 9234 | RSS: Main: 157933568 06:06:24 INFO - PID 9234 | 06:06:26 INFO - PID 9234 | Cycle 1(1): loaded http://localhost:42962/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42962/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:06:26 INFO - PID 9234 | RSS: Main: 158547968 06:06:26 INFO - PID 9234 | 06:06:30 INFO - PID 9234 | Cycle 1(1): loaded http://localhost:42962/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42962/tests/kraken/driver.html?testName=imaging-darkroom) 06:06:30 INFO - PID 9234 | RSS: Main: 164184064 06:06:30 INFO - PID 9234 | 06:06:34 INFO - PID 9234 | Cycle 1(1): loaded http://localhost:42962/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42962/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:34 INFO - PID 9234 | RSS: Main: 161169408 06:06:34 INFO - PID 9234 | 06:06:37 INFO - PID 9234 | Cycle 1(1): loaded http://localhost:42962/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42962/tests/kraken/driver.html?testName=json-parse-financial) 06:06:38 INFO - PID 9234 | RSS: Main: 162021376 06:06:38 INFO - PID 9234 | 06:06:40 INFO - PID 9234 | Cycle 1(1): loaded http://localhost:42962/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42962/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:06:40 INFO - PID 9234 | RSS: Main: 162594816 06:06:40 INFO - PID 9234 | 06:06:42 INFO - PID 9234 | Cycle 1(1): loaded http://localhost:42962/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42962/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:06:43 INFO - PID 9234 | RSS: Main: 162639872 06:06:43 INFO - PID 9234 | 06:06:45 INFO - PID 9234 | Cycle 1(1): loaded http://localhost:42962/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42962/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:46 INFO - PID 9234 | RSS: Main: 163078144 06:06:46 INFO - PID 9234 | 06:06:49 INFO - PID 9234 | Cycle 1(1): loaded http://localhost:42962/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:49 INFO - PID 9234 | RSS: Main: 163356672 06:06:49 INFO - PID 9234 | 06:06:53 INFO - PID 9234 | Cycle 1(1): loaded http://localhost:42962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:53 INFO - PID 9234 | RSS: Main: 163131392 06:06:53 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | Cycle 1(1): loaded http://localhost:42962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42962/tests/kraken/driver.html?testName=ai-astar) 06:06:55 INFO - PID 9234 | RSS: Main: 164564992 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | __start_tp_report 06:06:55 INFO - PID 9234 | _x_x_mozilla_page_load 06:06:55 INFO - PID 9234 | _x_x_mozilla_page_load_details 06:06:55 INFO - PID 9234 | |i|pagename|runs| 06:06:55 INFO - PID 9234 | |0;ai-astar;112;118;119;119;119;123;120;118;120;120 06:06:55 INFO - PID 9234 | |1;audio-beat-detection;157;128;127;172;128;127;133;127;149;130 06:06:55 INFO - PID 9234 | |2;audio-dft;164;164;167;167;170;164;165;165;165;164 06:06:55 INFO - PID 9234 | |3;audio-fft;76;75;75;116;76;76;76;75;102;77 06:06:55 INFO - PID 9234 | |4;audio-oscillator;85;86;112;86;88;85;102;85;86;111 06:06:55 INFO - PID 9234 | |5;imaging-gaussian-blur;114;116;114;115;115;114;114;114;114;115 06:06:55 INFO - PID 9234 | |6;imaging-darkroom;151;150;151;150;151;151;151;151;150;150 06:06:55 INFO - PID 9234 | |7;imaging-desaturate;95;95;94;95;95;95;94;95;95;95 06:06:55 INFO - PID 9234 | |8;json-parse-financial;72;74;73;73;74;75;72;74;74;72 06:06:55 INFO - PID 9234 | |9;json-stringify-tinderbox;56;56;56;56;56;56;56;57;57;56 06:06:55 INFO - PID 9234 | |10;stanford-crypto-aes;83;91;81;83;91;82;82;82;82;82 06:06:55 INFO - PID 9234 | |11;stanford-crypto-ccm;136;140;134;149;135;155;158;136;179;143 06:06:55 INFO - PID 9234 | |12;stanford-crypto-pbkdf2;186;208;198;204;198;195;195;198;194;196 06:06:55 INFO - PID 9234 | |13;stanford-crypto-sha256-iterative;78;72;73;70;73;71;76;72;70;70 06:06:55 INFO - PID 9234 | __end_tp_report 06:06:55 INFO - PID 9234 | __start_cc_report 06:06:55 INFO - PID 9234 | _x_x_mozilla_cycle_collect,870 06:06:55 INFO - PID 9234 | __end_cc_report 06:06:55 INFO - PID 9234 | __startTimestamp1489583215861__endTimestamp 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | ------- Summary: start ------- 06:06:55 INFO - PID 9234 | Number of tests: 14 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | [#0] ai-astar Cycles:10 Average:118.80 Median:119.50 stddev:2.78 (2.3%) stddev-sans-first:1.51 06:06:55 INFO - PID 9234 | Values: 112.0 118.0 119.0 119.0 119.0 123.0 120.0 118.0 120.0 120.0 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:131.50 stddev:15.95 (12.1%) stddev-sans-first:15.33 06:06:55 INFO - PID 9234 | Values: 157.0 128.0 127.0 172.0 128.0 127.0 133.0 127.0 149.0 130.0 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:1.96 (1.2%) stddev-sans-first:2.00 06:06:55 INFO - PID 9234 | Values: 164.0 164.0 167.0 167.0 170.0 164.0 165.0 165.0 165.0 164.0 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:14.42 (19.0%) stddev-sans-first:15.10 06:06:55 INFO - PID 9234 | Values: 76.0 75.0 75.0 116.0 76.0 76.0 76.0 75.0 102.0 77.0 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:85.50 stddev:11.20 (13.1%) stddev-sans-first:11.53 06:06:55 INFO - PID 9234 | Values: 85.0 86.0 112.0 86.0 88.0 85.0 102.0 85.0 86.0 111.0 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 06:06:55 INFO - PID 9234 | Values: 114.0 116.0 114.0 115.0 115.0 114.0 114.0 114.0 114.0 115.0 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 06:06:55 INFO - PID 9234 | Values: 151.0 150.0 151.0 150.0 151.0 151.0 151.0 151.0 150.0 150.0 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:06:55 INFO - PID 9234 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | [#8] json-parse-financial Cycles:10 Average:73.30 Median:74.00 stddev:1.06 (1.4%) stddev-sans-first:1.01 06:06:55 INFO - PID 9234 | Values: 72.0 74.0 73.0 73.0 74.0 75.0 72.0 74.0 74.0 72.0 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 06:06:55 INFO - PID 9234 | Values: 56.0 56.0 56.0 56.0 56.0 56.0 56.0 57.0 57.0 56.0 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:82.50 stddev:3.78 (4.6%) stddev-sans-first:4.00 06:06:55 INFO - PID 9234 | Values: 83.0 91.0 81.0 83.0 91.0 82.0 82.0 82.0 82.0 82.0 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:146.00 stddev:14.26 (9.8%) stddev-sans-first:14.61 06:06:55 INFO - PID 9234 | Values: 136.0 140.0 134.0 149.0 135.0 155.0 158.0 136.0 179.0 143.0 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.20 Median:198.00 stddev:5.88 (3.0%) stddev-sans-first:4.64 06:06:55 INFO - PID 9234 | Values: 186.0 208.0 198.0 204.0 198.0 195.0 195.0 198.0 194.0 196.0 06:06:55 INFO - PID 9234 | 06:06:55 INFO - PID 9234 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.50 stddev:2.68 (3.7%) stddev-sans-first:1.96 06:06:55 INFO - PID 9234 | Values: 78.0 72.0 73.0 70.0 73.0 71.0 76.0 72.0 70.0 70.0 06:06:55 INFO - PID 9234 | -------- Summary: end -------- 06:06:55 INFO - PID 9234 | 06:06:56 INFO - TEST-INFO | 9234: exit 0 06:06:57 INFO - TEST-OK | kraken | took 64438ms 06:06:57 INFO - SUITE-END | took 1184s 06:06:57 INFO - Completed test suite (00:19:45) 06:06:57 INFO - javascript benchmark 06:06:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6781.28919531755, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2680.5309070912585, 2680.9195724128276, 2698.0, 2723.754862062414, 2728.072455365176, 4962.1812400953795, 5034.446210916796, 5046.596272298221, 5073.5941124710025, 5078.492150784919, 4989.251612258163, 5049.545540901318, 5080.161773307409, 5119.6672216305915, 5124.538791508763, 4592.1963656360085, 4623.8150473981, 4627.8380256691025, 4630.930536041962, 4632.351470794091, 4625.005623790884, 4636.2581986882105, 4638.234691275936, 4656.394668693082, 4711.929321060187, 4553.612942899857, 4584.243599806028, 4586.54134586542, 4594.333821595883, 4609.400777898852, 4621.2837010263465, 4625.352450656911, 4651.906961860777, 4668.136394766979, 4674.7845560154265, 4567.132244873464, 4617.58441740245, 4617.58441740245, 4640.3503509508355, 4674.813007479696, 4878.975605121987, 4893.314935908976, 4930.383702037246, 4933.827316043958, 5004.699718016931, 5405.297311349499, 5435.755391007375, 5494.890102197974, 5495.670259784386, 5508.091164957777, 5458.699771512565, 5466.753996070147, 5472.972635136839, 5473.808416705396, 5481.287432633772, 5083.542481176675, 5085.415177254663, 5087.058894104529, 5089.465606111379, 5129.846104616868, 5459.645123066988, 5466.972665136649, 5473.7263136843, 5515.531179849678, 5528.44715528444, 5186.714730689849, 5237.921431178459, 5308.044551980681, 5363.544098751572, 5389.865253368697, 5346.064438723208, 5434.130539113723, 5444.754986025639, 5458.754356053987, 5477.315335583052, 5432.076546987022, 5437.184422336682, 5440.075187218104, 5449.64577302482, 5502.724863756796, 5259.21111833228, 5308.522232999048, 5387.892242155135, 5430.755615997289, 5446.101393270066, 4551.135284295973, 4571.885702857455, 4574.4739354973935, 4599.425071866017, 4612.262038073892, 3934.5475270343704, 3945.7829819359636, 3948.2498325318097, 3978.4629075074495, 3993.1813978134414, 4601.33280674307, 4659.114768194032, 4679.181143299909, 4691.249400095969, 4721.551452611996, 5357.43746906577, 5362.892742145135, 5367.812126575551, 5379.408265090837, 5403.594730395236, 4605.508881839417, 4612.423447069116, 4614.446266448048, 4616.28447590624, 4647.604953578983, 4767.4994125617, 4800.855974320776, 4848.515148485194, 4861.465238823726, 4902.852914412573, 5094.0, 5094.643374963717, 5098.107831129611, 5110.4123025852505, 5112.821051263188, 5478.753456094565, 5480.725963701879, 5487.75305111263, 5489.385290724747, 5543.085390910454, 5005.724685142352, 5033.2701758245585, 5090.592752579859, 5091.389033316026, 5107.208382700687, 5163.845084647466, 5185.859110995575, 5187.974060129675, 5222.791088356423, 5232.947670523246, 5303.2840566524565, 5311.070562651444, 5311.41574426805, 5313.096773548584, 5322.654027488201, 5144.0, 5144.794208231779, 5147.9227811583605, 5258.526732594085, 5262.89474210506, 5296.867578310419, 5299.284596579412, 5301.284326615858, 5303.390110137384, 5343.7862485500145, 5146.408163061146, 5173.120569503269, 5216.947830521646, 5230.712310822789, 5248.580113590827, 5225.764840582106, 5262.052830490548, 5263.23683065961, 5311.123664595453, 5321.600879933943, 5131.127708289525, 5132.3327967364, 5152.5620322271525, 5166.715830629351, 5191.273221748883], "value": 4941.829711497745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.6559254780061, 694.9791506254815, 767.808047988003, 775.2906090926803, 828.7720876758895, 30822.229444263903, 32023.83988080059, 32069.839650801772, 32158.35683286333, 32226.77732226782, 30211.0, 30431.0, 30646.693533064663, 30730.0, 30755.846220768864, 4625.62994960404, 4689.109069276844, 4691.272852707819, 8899.0, 9103.408278461911, 9127.95436022819, 9173.266138708921, 9252.259819214447, 9270.0, 9284.257259419264, 9351.0, 9400.482973436458, 9470.052994700543, 9482.146606805387, 9495.240380769523, 9364.204042656349, 9371.34400591959, 9415.0, 9415.152636262701, 9455.669051583161, 9183.49490778007, 9218.35471516994, 9224.446533207962, 9272.350935434522, 9337.766555836091, 34341.14147146316, 34619.65380346215, 34644.82677586621, 34798.30403391918, 34847.128821779406, 3292.242784159657, 3350.0904484443877, 3383.0865666270215, 3402.8298585070647, 3433.759636825423, 23607.409814754596, 23695.763042369526, 23763.7623623765, 24339.391515212083, 24459.633105503253, 3051.6948305169526, 3054.8167109973474, 3090.598222231118, 3129.3741251749743, 3233.3856567252146, 155295.0, 155767.0, 156182.0, 156187.0, 156570.99999999886, 32126.19684507906, 32370.35259294801, 38185.80907095447, 42957.785211073744, 43574.7821260898, 43347.13305733867, 43752.56247437549, 43826.78086609547, 43865.34201986973, 43866.12267754691, 13699.931500342434, 13730.244836533886, 13825.723485530232, 13843.723125537634, 13845.0, 11072.557097716, 11105.888941110485, 11140.108791296676, 11153.498092585853, 11186.832197517044, 13414.530491432753, 13458.730825383633, 13479.528216512375, 13642.590722278348, 13745.450181992608, 5338.466153384708, 5389.137737961907, 5503.807366742145, 5562.606809845991, 5582.469665381782, 846.1158089796178, 892.0499667853844, 1010.3836659637615, 1081.7836432713489, 1082.951267192978, 21072.735635861896, 21126.260580879596, 21149.577008459746, 21226.78773212279, 21482.140714371562, 1116.7822274656526, 1122.820348744197, 1127.4700890581414, 1132.6375559820942, 1133.4162906103363, 10750.94624526888, 11446.0, 11559.017483513828, 11560.947602286727, 11860.347680877461, 235683.0, 236910.0, 239189.0, 239841.0, 240131.0, 44015.77992110019, 44187.337189942176, 44328.0, 44348.0, 44360.55639443564, 1240.795268780641, 1262.545483625894, 1269.911106222574, 1271.783796754554, 1281.14803655568, 20779.480512987295, 21159.153633854472, 22958.50769700031, 23183.768162318836, 23321.76678233196, 40048.0, 40658.69790182527, 40666.59333406747, 40724.0, 40828.0, 231748.0, 235020.0, 236218.0, 237740.0, 238812.0, 28046.43907121887, 28103.0, 28317.433651327272, 28458.146255612366, 30407.695923040486, 32863.67136328606, 35365.0, 35633.28733425265, 36415.63584364123, 36540.45189322109, 29976.700232998264, 30239.395212096075, 30458.238544036576, 30786.84606576953, 31175.688243118188, 30363.0, 30676.539851901794, 31091.0, 31803.0, 31965.68034319627, 29946.700532995263, 30184.585233181733, 30216.69783302139, 30849.228769280948, 30861.537076943416, 25611.231663050137, 25664.486710266065, 27073.0, 28391.29021774472, 28965.275868103465, 22431.32706018822, 22756.0, 22856.20332125927, 23013.194538191754, 23081.65377519305], "value": 15749.093119563371, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.10227936004304, 399.6463130129835, 405.943167956486, 409.70296535012113, 411.8270326462885, 17373.56566085847, 18077.367292144776, 18095.36666216684, 18448.169832357544, 19776.11007504662, 18422.0, 18571.442856714286, 18974.335898243564, 19166.137523811427, 19170.808291917077, 5481.287432633772, 5619.775208991646, 5730.3123625165035, 5762.9135562966585, 5865.208196893407, 5719.656820590757, 5783.739731712083, 5802.216700745409, 5811.970940145315, 5816.854578635525, 5633.183188437674, 5744.454276843714, 5765.971170144144, 5785.103308987113, 5856.853578660525, 5679.914801277984, 5700.572457065716, 5750.884982300372, 5751.4248575142365, 5783.334916484616, 6467.288598254188, 6745.898811517831, 6763.222229443579, 6791.049253104569, 6799.218089919624, 20962.5807483851, 22058.669119963215, 22732.545349093092, 22798.31605051851, 23122.19072332477, 2037.9898100509402, 2081.20914052659, 2081.250749730096, 2088.2169186555043, 2121.087932189158, 13788.276639150998, 14347.0, 14648.707025859423, 14894.776578351333, 14930.2534873257, 1807.3854889337556, 1825.1148193126323, 1837.421212318129, 1843.9539011524819, 1886.6792645250341, 85041.57479212627, 87008.0, 87145.0, 87431.56284218538, 89372.0, 16696.415625453294, 16725.498235052968, 16868.493945181664, 16879.40922067722, 16995.575110622332, 29382.55926161109, 29386.55920161199, 29499.705002950126, 29580.112596622137, 29788.851055744584, 8634.568271586395, 8775.341849361323, 8970.327225458117, 9159.404638698463, 9175.59571405729, 7243.710251589982, 7244.203137654854, 7253.709851605877, 7410.0, 7446.106467223968, 8840.778980525409, 8938.46369217849, 9007.279417646572, 9125.174965007025, 9142.680006199751, 3396.3037577296595, 3446.8993872622477, 3480.2865412590863, 3611.94582081269, 3803.6576708096404, 937.5780898595659, 952.4428209497383, 988.6292640259902, 1014.3660212367271, 1029.3566520924421, 19514.31699890497, 19923.601527969648, 19924.800751992585, 19935.202591896163, 19963.500912477306, 994.7015895231401, 1005.2058873490007, 1007.309992655019, 1010.1918465227789, 1010.2120346130031, 10352.171826253882, 10958.561657533768, 10983.39591322485, 10990.670279891616, 11070.059044981106, 463293.0, 481711.0, 492234.0, 498935.0, 503144.0, 83799.03853338955, 86913.56543217243, 86965.56517217374, 87221.0, 91206.54396727974, 1089.9891001090045, 1104.7624760676333, 1108.8669359676728, 1111.222144498854, 1122.4163435013747, 16176.93083423174, 16314.836851631806, 16610.75083873767, 17214.225359858585, 17265.91367043207, 37989.0, 38603.2279354417, 39299.803500982314, 41358.0, 42280.154396912505, 44924.77537612422, 45741.771291144665, 47852.28221576609, 47975.28037079377, 54751.72624136854, 10018.298719089593, 10193.184545236216, 10785.352878827296, 11253.549858005588, 11489.0, 12225.0, 12226.938865305616, 12582.496700131893, 12658.810117848056, 12715.55495557651, 10224.795504089729, 10734.463276835972, 10743.623973160902, 10771.0, 10788.676339709822, 10191.439470829175, 10458.424786636808, 10612.734681632712, 10689.091427228772, 10693.625723099654, 11110.222284440011, 11316.886831131913, 11413.258138220988, 11734.647960561197, 11939.164258501822, 11163.0, 11253.718657033312, 11265.549378025114, 11347.432628368713, 11625.418729063682, 11079.612213572485, 11222.270552414067, 11349.205555611357, 11480.598179063692, 11612.593559225725], "value": 9950.495068615648, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.6889884225473, 1429.842717301096, 1452.150491962202, 1462.9853701462982, 1513.0089791186774, 7708.152103268636, 7956.721514746985, 9025.729228123158, 9416.576254068566, 9697.175740062094, 8686.261667758232, 9067.365284430092, 9068.954655226731, 9075.773105672362, 9383.953080234607, 2010.3466373428657, 2031.004807644251, 2046.6316063108634, 2050.0159923236856, 2063.7007633893077, 1943.9319623813099, 1994.172418446343, 1995.7704863940687, 2011.155314767801, 2012.2956965062258, 2013.6174126915912, 2040.0513761101085, 2055.969160462594, 2056.033664177834, 2060.8248298894537, 1909.6658084835237, 1914.607505461377, 1930.3243864647332, 1930.5270208798793, 1931.0344827586207, 1737.0533059482611, 1753.4914874686326, 1761.7093179625347, 2000.7999200080021, 2004.098155829868, 9689.32174747768, 9721.368111072828, 9757.90242097577, 9764.0, 9767.0, 4599.609033232179, 4796.736179510125, 4799.760011999421, 4808.903821923542, 4816.879578010543, 2480.85114893107, 2676.531606968773, 2726.5364887968894, 2738.5070687276284, 2751.697313295536, 997.2670087485692, 1044.2742294105599, 1073.7906108308882, 1092.9945350273197, 1095.594629986902, 12870.420831062625, 12964.611061668165, 13038.152520086163, 13046.739065218642, 13094.214347139203, 3729.8881033569037, 3888.2223555289056, 3939.212157568498, 3991.560928297885, 4127.33962565988, 11591.826122608167, 11625.825612615818, 11660.88339116615, 11667.824982625267, 11688.883111168949, 4788.808447662054, 4790.664653474223, 4790.9938912828, 4815.975920120377, 4820.108279968217, 3689.7417180797624, 3722.925541489155, 4201.978990105091, 4229.6827737919775, 4297.0, 3460.2560449502976, 3472.826358682056, 3556.413191823372, 3595.478655594924, 3613.1509095362567, 966.2221911361421, 968.331851022792, 971.7667759737612, 976.7802244494932, 976.9609215631295, 844.6916875340456, 846.2003406780657, 857.7812657772229, 874.2044739287218, 878.0078511282338, 5229.424763276036, 5503.669779813224, 5662.17898404729, 5682.176084467729, 5696.1455781633085, 873.3013589128672, 883.6288758721353, 903.846346121161, 907.1019690506351, 907.1019690506351, 3655.250673611903, 3705.0922523981258, 3712.8143592820793, 3714.832832522543, 3801.334766415866, 11293.548258069584, 11543.19197656156, 11746.119041071783, 11788.941055294668, 11836.408179590986, 11485.392045113691, 11511.53953841837, 11519.136064795173, 11522.481488333045, 11543.153095504847, 8319.376046796393, 8645.740627781177, 8702.956485217534, 8748.212660860552, 8786.472811631194, 5495.8446539875595, 5580.9441905580425, 5659.518940889906, 5687.232223649754, 5735.684537350486, 9375.624975000923, 9460.101290377403, 9571.1864491519, 9615.0, 9632.807343852943, 9699.757506062122, 9881.258905581966, 9903.801923961337, 9923.305368624127, 10050.798984020425, 6687.866242675022, 6930.757423490154, 6959.130108736408, 7856.214378562098, 8006.879896801669, 7849.60751962411, 7948.205179482005, 7961.044674639081, 8013.959930200312, 8070.556119413489, 7089.61007144612, 7105.32499412555, 7178.353948144692, 7180.640967951686, 7316.853662926818, 6866.588004719732, 6935.861282774417, 7059.5058345915295, 7137.571745695275, 7293.307135822089, 6112.572119951561, 6120.663363515049, 6194.628322300677, 6235.064740288812, 6237.532185086227, 4480.059187570647, 4482.551744825491, 4501.0, 4552.88617784558, 4625.722456652612, 4706.92939605913, 4708.199606067045, 4762.190427627381, 4797.760111994457, 4839.564439200489], "value": 4308.6436650218775, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.8530445169707, 380.3040436002116, 380.31922858084033, 383.5186840515153, 385.75697310694267, 5216.452272511379, 5363.570914326854, 5469.699166545838, 5477.205805158254, 5508.944910550893, 5175.637705360627, 5321.201819727043, 5371.435999220084, 5390.487903649157, 5396.1905714142895, 4635.165670179366, 4669.369635099269, 4669.463011753658, 4669.976650116745, 4670.626349892001, 4578.542145785428, 4632.212523870933, 4656.511066338019, 4677.859664210079, 4680.1747318545795, 4616.122936642044, 4631.120087183441, 4636.2581986882105, 4642.837500687477, 4647.0, 4633.745144017078, 4638.11875743611, 4647.767611619439, 4648.326602423125, 4650.0932318197965, 4400.581944715247, 4444.422225110748, 4462.263726485158, 4493.292548831456, 4502.954970450286, 5240.34495688039, 5252.369715634149, 5260.631755777097, 5278.102722537178, 5292.444293349181, 5442.836714898559, 5446.210299506589, 5465.508104270595, 5473.616846820724, 5474.644148130359, 5578.246936663539, 5722.513586345166, 5740.684262365568, 5783.5951483396175, 5788.18965344852, 4892.706437613754, 4904.705717656916, 4905.484924082955, 4912.852614421573, 4945.505449455061, 5683.2895888014, 5824.204381896671, 5915.1718759373725, 6076.3316035236085, 6080.574359794816, 5102.260172275, 5129.9996500682755, 5138.563222126087, 5148.6910785353, 5172.965406918632, 5205.6616319939085, 5222.294990176353, 5232.869178270497, 5256.684598924, 5263.078961181778, 5297.390800057966, 5308.654937429054, 5390.137577987503, 5405.837824865261, 5412.538614574043, 5683.829485115453, 5703.914441283384, 5724.513416359656, 5725.713714314267, 5726.513246374105, 1601.2554162314348, 1832.221305944968, 1862.4878158506249, 1864.7296142059326, 1871.8970456624745, 1218.5795900414344, 1220.5972029230334, 1258.314218750783, 1265.9810102848464, 1275.1392809853312, 4950.18321976877, 4954.380702412199, 4955.851324460272, 4957.892895519462, 4979.128652485801, 5803.361630220672, 5837.88324233513, 5908.940910590925, 5919.496842768327, 5930.525557955353, 4735.384400027974, 4931.186354251508, 4971.577415919615, 4972.950270497248, 4976.576990955809, 3108.580341653848, 3135.5139953306816, 3141.8271995040036, 3143.732782713449, 3147.1974646465465, 5455.481729235717, 5468.734387178008, 5495.368032676213, 5499.120140777456, 5504.587155963319, 5667.80162694312, 5989.251343582052, 6037.154798328237, 6053.969730151409, 6075.088736689532, 5419.701916394557, 5501.614886957955, 5505.532029777513, 5518.144687573513, 5532.2531458253425, 5801.883962320646, 5919.437653422918, 5938.673372964528, 5947.6431414115295, 5959.940400596112, 5516.668999860021, 5680.602357834912, 5779.393163717749, 5856.238688970407, 5874.355180549453, 5297.788088476418, 5424.593155513273, 5457.208704737712, 5485.0, 5487.149491828773, 4653.488116307136, 4691.132140554008, 4707.411573553306, 4721.480637129845, 4726.220173671306, 5749.965006298907, 5854.268216472941, 5890.617109887844, 5892.551123901427, 5928.140419639214, 5683.346415162309, 5714.3999880012, 5727.8854422912145, 5742.626729262584, 5745.253117094751, 5491.862703432446, 5700.885982280414, 5703.828885133453, 5711.371749107512, 5711.971440142773, 5592.888142237051, 5603.663780173202, 5610.270664813548, 5635.323761148688, 5640.435956404327, 5746.454086861741, 5755.194272801895, 5758.481736643722, 5764.510016648632, 5780.653160810365, 5322.175062865262, 5541.722913854211, 5556.138798486241, 5583.134614134816, 5612.971935140462], "value": 4548.092405860701, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.7981765105769, 741.2920660768963, 757.8219118507146, 760.6919197724922, 779.2402407652539, 13286.202827830324, 13847.792283115761, 13856.722865542708, 13865.722685546296, 13896.791548126774, 12480.0, 12568.371581420937, 12590.748185036316, 12648.114631975743, 13145.934270328635, 839.1314988986401, 843.0473564871686, 870.5429649434066, 872.8254349130168, 874.8512752832033, 868.3096937934357, 868.7741187291318, 872.6596627315353, 873.2402809555696, 874.8250349930007, 920.7099763574486, 920.9171174594285, 920.9263258939269, 921.1203300847708, 923.6166990698852, 899.3030401438872, 907.0793144957873, 907.7231444409452, 908.3414524469706, 909.3952521573146, 665.8801415745164, 667.8196886840575, 667.9833004174886, 668.2515582547578, 671.711164199394, 14490.855091449055, 14540.70918581633, 14559.70880582393, 14786.18675972821, 14993.625159370993, 13674.726505469935, 14290.285485725672, 14293.571192864127, 14311.928440357731, 14382.640433989234, 10706.571737130505, 10764.0, 10815.83776243357, 10830.241883068189, 10831.67504974852, 3315.3203593263324, 3319.8174100424467, 3350.480675495302, 3362.932741345184, 3482.320947415255, 46574.9452571167, 56877.43122568763, 60079.0, 60945.69527152336, 61759.07361389583, 10482.842757358645, 10483.47582620881, 10490.583771190944, 10686.412247326472, 11140.442977851075, 21449.034793434334, 21457.0, 21508.462288442603, 21559.0, 21560.784392155878, 6567.605943643397, 6665.533412661067, 6741.8651626967185, 6957.617331046841, 6975.511714179958, 3512.5258090158013, 3547.840347184383, 3557.964420355815, 3582.0, 3654.0499470137956, 2685.9059932902255, 2724.264448598867, 2740.9725902741116, 2750.106215479977, 2753.931151721223, 458.14098565190267, 465.29043209106385, 468.1760102220117, 476.1738383903924, 476.833108412053, 599.2269971736412, 615.9137720719103, 627.1220291591808, 629.6033498895666, 649.636203725915, 8567.0, 9390.483523406278, 9441.260030902575, 9467.763305917408, 9634.373765705206, 617.7374615788361, 641.7914177892204, 649.8602800397842, 650.905618685288, 662.6156829039146, 4096.242195193899, 4341.479022517318, 4425.712328698624, 4478.820847166142, 4509.098180363941, 49098.0, 53664.73167634215, 60464.0, 61774.69112654408, 62616.68691656512, 53231.136910208734, 54108.72945635246, 55145.724271378385, 56570.717146414005, 56698.0, 41173.0, 43771.56228437675, 46448.5355146451, 46551.30173047475, 46978.5302146981, 8952.14954579314, 9283.907160928575, 9691.585986625469, 9702.385701747251, 9937.701868943943, 27798.5830212551, 29177.416451670422, 31918.52122218122, 32284.0, 32582.0, 36882.533562549535, 37238.0, 38233.0, 38248.235035299695, 38304.0, 11696.298222106361, 11815.172937894265, 11881.881181188077, 11888.58389956382, 12042.157049006486, 12933.741325173256, 13212.867871321549, 13227.3386330685, 13232.0, 13681.931590341985, 10833.187510936554, 10975.231733778559, 10995.780084398428, 11115.499802509068, 11220.2145849793, 11643.941780291045, 11742.882571174521, 12140.514379424723, 12439.937800310941, 12468.688282793002, 11375.0, 11756.823647645464, 11773.823392649289, 11840.0, 11845.348505832262, 9697.951510242687, 9716.805663886542, 10066.396016239049, 10117.342372745748, 10467.267291289842, 9781.85327220078, 10156.238282129018, 10216.744581385525, 10242.487875606339, 10279.280450368402], "value": 6407.325992569288, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 118.0, 119.0, 119.0, 119.0, 123.0, 120.0, 118.0, 120.0, 120.0], "value": 118.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 127.0, 172.0, 128.0, 127.0, 133.0, 127.0, 149.0, 130.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 167.0, 167.0, 170.0, 164.0, 165.0, 165.0, 165.0, 164.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 116.0, 76.0, 76.0, 76.0, 75.0, 102.0, 77.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 112.0, 86.0, 88.0, 85.0, 102.0, 85.0, 86.0, 111.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 151.0, 151.0, 151.0, 151.0, 150.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 73.0, 73.0, 74.0, 75.0, 72.0, 74.0, 74.0, 72.0], "value": 73.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 57.0, 57.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 91.0, 81.0, 83.0, 91.0, 82.0, 82.0, 82.0, 82.0, 82.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 140.0, 134.0, 149.0, 135.0, 155.0, 158.0, 136.0, 179.0, 143.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 208.0, 198.0, 204.0, 198.0, 195.0, 195.0, 198.0, 194.0, 196.0], "value": 197.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 72.0, 73.0, 70.0, 73.0, 71.0, 76.0, 72.0, 70.0, 70.0], "value": 72.5, "unit": "score"}]}]} 06:06:57 INFO - Return code: 0 06:06:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:06:57 ERROR - # TBPL SUCCESS # 06:06:57 INFO - Running post-action listener: _resource_record_post_action 06:06:57 INFO - [mozharness: 2017-03-15 13:06:57.664013Z] Finished run-tests step (success) 06:06:57 INFO - Running post-run listener: _resource_record_post_run 06:06:57 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 364474368; Read time: 16; Write time: 290888 06:06:57 INFO - TinderboxPrint: CPU usage
13.3% 06:06:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:06:57 INFO - TinderboxPrint: I/O write bytes / time
364,474,368 / 290,888 06:06:57 INFO - TinderboxPrint: CPU idle
8,307.4 (86.7%) 06:06:57 INFO - TinderboxPrint: CPU user
1,219.1 (12.7%) 06:06:57 INFO - TinderboxPrint: Swap in / out
0 / 0 06:06:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107110400; Read time: 0; Write time: 120224 06:06:57 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 256585728; Read time: 0; Write time: 170628 06:06:58 INFO - Running post-run listener: _upload_blobber_files 06:06:58 INFO - Blob upload gear active. 06:06:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:58 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 06:06:58 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'] 06:06:58 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 06:06:58 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:06:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:07:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:02 INFO - (blobuploader) - INFO - Done attempting. 06:07:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:07:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:07:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:03 INFO - (blobuploader) - INFO - Done attempting. 06:07:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:07:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:07:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:04 INFO - (blobuploader) - INFO - Done attempting. 06:07:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:07:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:07:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:05 INFO - (blobuploader) - INFO - Done attempting. 06:07:05 INFO - (blobuploader) - INFO - Iteration through files over. 06:07:05 INFO - Return code: 0 06:07:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:07:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:07:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3606470b368c491780639c3e2d8ed78ada8e8a18600ff15e4db0f90c4db9a9ac05b75798198eec4f2c508b61608ab7d44cdda93c0025448daf3f37ebd5376fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/604adcfc6b194191ae296b83b9a1859ffeaa50cf1a76e6d76a4da71f6f4c35d8af648f0517e7c54d4514e22b7db03101b0c8dafeb85e8b9af32e69c98854512b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5c2d226192e6f124ecda24cc7a30b200a3bc32b9ac76148487567c9257468bfb72c95edbe2e6d048cadf9a17c95070aefc7ba088d441eb68546efb541211e77a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15261b02005ab464833948eb9664950c500436ab398e4ad5024a16692e7d158dbb541c1f6f98c52cfdeea2568df9d078fd780d46f90279da89c09b6e11d67fde"} 06:07:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:07:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:07:05 INFO - Contents: 06:07:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3606470b368c491780639c3e2d8ed78ada8e8a18600ff15e4db0f90c4db9a9ac05b75798198eec4f2c508b61608ab7d44cdda93c0025448daf3f37ebd5376fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/604adcfc6b194191ae296b83b9a1859ffeaa50cf1a76e6d76a4da71f6f4c35d8af648f0517e7c54d4514e22b7db03101b0c8dafeb85e8b9af32e69c98854512b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5c2d226192e6f124ecda24cc7a30b200a3bc32b9ac76148487567c9257468bfb72c95edbe2e6d048cadf9a17c95070aefc7ba088d441eb68546efb541211e77a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15261b02005ab464833948eb9664950c500436ab398e4ad5024a16692e7d158dbb541c1f6f98c52cfdeea2568df9d078fd780d46f90279da89c09b6e11d67fde"} 06:07:05 INFO - Running post-run listener: copy_logs_to_upload_dir 06:07:05 INFO - Copying logs to upload dir... 06:07:05 INFO - mkdir: /builds/slave/test/build/upload/logs 06:07:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.013698 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-15 06:07:04.792256) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 06:07:04.795513) ========= 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=32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223 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/c3606470b368c491780639c3e2d8ed78ada8e8a18600ff15e4db0f90c4db9a9ac05b75798198eec4f2c508b61608ab7d44cdda93c0025448daf3f37ebd5376fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/604adcfc6b194191ae296b83b9a1859ffeaa50cf1a76e6d76a4da71f6f4c35d8af648f0517e7c54d4514e22b7db03101b0c8dafeb85e8b9af32e69c98854512b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5c2d226192e6f124ecda24cc7a30b200a3bc32b9ac76148487567c9257468bfb72c95edbe2e6d048cadf9a17c95070aefc7ba088d441eb68546efb541211e77a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15261b02005ab464833948eb9664950c500436ab398e4ad5024a16692e7d158dbb541c1f6f98c52cfdeea2568df9d078fd780d46f90279da89c09b6e11d67fde"} build_url:https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/FW2JMJIcTvqIaC-sDfhKLA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3606470b368c491780639c3e2d8ed78ada8e8a18600ff15e4db0f90c4db9a9ac05b75798198eec4f2c508b61608ab7d44cdda93c0025448daf3f37ebd5376fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/604adcfc6b194191ae296b83b9a1859ffeaa50cf1a76e6d76a4da71f6f4c35d8af648f0517e7c54d4514e22b7db03101b0c8dafeb85e8b9af32e69c98854512b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5c2d226192e6f124ecda24cc7a30b200a3bc32b9ac76148487567c9257468bfb72c95edbe2e6d048cadf9a17c95070aefc7ba088d441eb68546efb541211e77a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15261b02005ab464833948eb9664950c500436ab398e4ad5024a16692e7d158dbb541c1f6f98c52cfdeea2568df9d078fd780d46f90279da89c09b6e11d67fde"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 06:07:04.820838) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 06:07:04.821178) ========= 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=32c5991c409366f7fec8a718000001d2-1489581961.97482-2026790223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 06:07:04.907332) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 06:07:04.907720) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 06:07:04.908058) ========= ========= Total master_lag: 0.17 =========