builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1490275232.05 results: success (0) revision: 89b93d310da5bc7f86ebcdb8fe580d47a610757a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 06:20:32.050650) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 06:20:32.051092) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 06:20:32.051373) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 06:20:32.081309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 06:20:32.081673) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-23 06:20:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 43.0M=0s 2017-03-23 06:20:32 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.209576 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 06:20:32.310787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 06:20:32.311091) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.044519 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 06:20:32.370858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 06:20:32.371179) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 89b93d310da5bc7f86ebcdb8fe580d47a610757a --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 89b93d310da5bc7f86ebcdb8fe580d47a610757a --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=8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-23 06:20:32,821 truncating revision to first 12 chars 2017-03-23 06:20:32,822 Setting DEBUG logging. 2017-03-23 06:20:32,822 attempt 1/10 2017-03-23 06:20:32,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/89b93d310da5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 06:20:34,204 unpacking tar archive at: mozilla-central-89b93d310da5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.695856 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 06:20:34.084578) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 06:20:34.084905) ========= script_repo_revision: 89b93d310da5bc7f86ebcdb8fe580d47a610757a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 06:20:34.085351) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 06:20:34.085610) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 06:20:34.092915) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-03-23 06:20:34.093218) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:20:34 INFO - MultiFileLogger online at 20170323 06:20:34 in /builds/slave/test 06:20:34 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 06:20:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:20:34 INFO - {'append_to_log': False, 06:20:34 INFO - 'base_work_dir': '/builds/slave/test', 06:20:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:20:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:20:34 INFO - 'branch': 'Firefox-Non-PGO', 06:20:34 INFO - 'buildbot_json_path': 'buildprops.json', 06:20:34 INFO - 'config_files': ('talos/linux_config.py',), 06:20:34 INFO - 'default_actions': ('clobber', 06:20:34 INFO - 'read-buildbot-config', 06:20:34 INFO - 'download-and-extract', 06:20:34 INFO - 'populate-webroot', 06:20:34 INFO - 'create-virtualenv', 06:20:34 INFO - 'install', 06:20:34 INFO - 'run-tests'), 06:20:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:20:34 INFO - 'download_minidump_stackwalk': True, 06:20:34 INFO - 'download_symbols': 'ondemand', 06:20:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:20:34 INFO - 'tooltool.py': '/tools/tooltool.py', 06:20:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:20:34 INFO - '/tools/misc-python/virtualenv.py')}, 06:20:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:20:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:20:34 INFO - 'gecko_profile': False, 06:20:34 INFO - 'gecko_profile_interval': 0, 06:20:34 INFO - 'installer_path': 'installer.exe', 06:20:34 INFO - 'log_level': 'info', 06:20:34 INFO - 'log_name': 'talos', 06:20:34 INFO - 'log_to_console': True, 06:20:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:20:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:20:34 INFO - 'opt_config_files': (), 06:20:34 INFO - 'pip_index': False, 06:20:34 INFO - 'suite': 'dromaeojs-e10s', 06:20:34 INFO - 'system_bits': '32', 06:20:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:20:34 INFO - 'title': 'talos-linux64-ix-041', 06:20:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:20:34 INFO - 'use_talos_json': True, 06:20:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:20:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:20:34 INFO - 'work_dir': 'build'} 06:20:34 INFO - [mozharness: 2017-03-23 13:20:34.766394Z] Running clobber step. 06:20:34 INFO - Running pre-action listener: _resource_record_pre_action 06:20:34 INFO - Running main action method: clobber 06:20:34 INFO - rmtree: /builds/slave/test/build 06:20:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:20:36 INFO - Running post-action listener: _resource_record_post_action 06:20:36 INFO - [mozharness: 2017-03-23 13:20:36.743373Z] Finished clobber step (success) 06:20:36 INFO - [mozharness: 2017-03-23 13:20:36.743607Z] Running read-buildbot-config step. 06:20:36 INFO - Running pre-action listener: _resource_record_pre_action 06:20:36 INFO - Running main action method: read_buildbot_config 06:20:36 INFO - Using buildbot properties: 06:20:36 INFO - { 06:20:36 INFO - "project": "", 06:20:36 INFO - "product": "firefox", 06:20:36 INFO - "who": "cbook@mozilla.com", 06:20:36 INFO - "installer_path": "public/build/target.tar.bz2", 06:20:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:20:36 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:20:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:20:36 INFO - "stage_platform": "linux64", 06:20:36 INFO - "basedir": "/builds/slave/test", 06:20:36 INFO - "buildnumber": 480, 06:20:36 INFO - "platform": "ubuntu64_hw", 06:20:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:20:36 INFO - "slavebuilddir": "test", 06:20:36 INFO - "taskId": "DpqvdzNKSHKjDo-XocuOPg", 06:20:36 INFO - "branch": "mozilla-central", 06:20:36 INFO - "script_repo_revision": "production", 06:20:36 INFO - "revision": "89b93d310da5bc7f86ebcdb8fe580d47a610757a", 06:20:36 INFO - "slavename": "talos-linux64-ix-041", 06:20:36 INFO - "repo_path": "mozilla-central" 06:20:36 INFO - } 06:20:36 INFO - Finding installer, test and symbols from parent task. 06:20:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpqvdzNKSHKjDo-XocuOPg'}, attempt #1 06:20:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpqvdzNKSHKjDo-XocuOPg'}, attempt #1 06:20:37 INFO - Task dependencies: EH2rkn2cRbqtk1aw4ZiV-Q 06:20:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q'}, attempt #1 06:20:38 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.tar.bz2 06:20:38 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/test_packages.json 06:20:38 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.crashreporter-symbols.zip 06:20:38 INFO - Running post-action listener: _resource_record_post_action 06:20:38 INFO - [mozharness: 2017-03-23 13:20:38.265904Z] Finished read-buildbot-config step (success) 06:20:38 INFO - [mozharness: 2017-03-23 13:20:38.266125Z] Running download-and-extract step. 06:20:38 INFO - Running pre-action listener: _resource_record_pre_action 06:20:38 INFO - Running main action method: download_and_extract 06:20:38 INFO - mkdir: /builds/slave/test/build/tests 06:20:38 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')]} 06:20:38 INFO - trying https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.test_packages.json 06:20:38 INFO - Downloading https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:20:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:20:38 INFO - Downloaded 986 bytes. 06:20:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:20:38 INFO - Using the following test package requirements: 06:20:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:20:38 INFO - u'common': [u'target.common.tests.zip'], 06:20:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:20:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:20:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:20:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:20:38 INFO - u'mozbase': [u'target.common.tests.zip'], 06:20:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:20:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:20:38 INFO - u'web-platform': [u'target.common.tests.zip', 06:20:38 INFO - u'target.web-platform.tests.zip'], 06:20:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:20:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:20:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.common.tests.zip 06:20:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:20:38 INFO - Fetch https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.common.tests.zip into memory 06:20:39 INFO - Expected file size: 58123615 06:20:39 INFO - Obtained file size: 58123615 06:20:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:20:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.common.tests.zip 06:20:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:20:49 INFO - Fetch https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.common.tests.zip into memory 06:20:50 INFO - Expected file size: 58123615 06:20:50 INFO - Obtained file size: 58123615 06:21:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.talos.tests.zip 06:21:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:21:01 INFO - Fetch https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.talos.tests.zip into memory 06:21:02 INFO - Expected file size: 14404171 06:21:02 INFO - Obtained file size: 14404171 06:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:02 INFO - trying https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.tar.bz2 06:21:02 INFO - Downloading https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:21:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:21:03 INFO - Downloaded 61999097 bytes. 06:21:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.tar.bz2 06:21:03 INFO - mkdir: /builds/slave/test/properties 06:21:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:21:03 INFO - Writing to file /builds/slave/test/properties/build_url 06:21:03 INFO - Contents: 06:21:03 INFO - build_url:https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.tar.bz2 06:21:03 INFO - Running post-action listener: _resource_record_post_action 06:21:03 INFO - Running post-action listener: set_extra_try_arguments 06:21:03 INFO - [mozharness: 2017-03-23 13:21:03.846930Z] Finished download-and-extract step (success) 06:21:03 INFO - [mozharness: 2017-03-23 13:21:03.847026Z] Running populate-webroot step. 06:21:03 INFO - Running pre-action listener: _resource_record_pre_action 06:21:03 INFO - Running main action method: populate_webroot 06:21:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:21:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:21:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:21:03 INFO - '--tppagecycles', 06:21:03 INFO - '7'], 06:21:03 INFO - 'tests': ['tsvgm']}}, 06:21:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:21:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:21:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:21:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:21:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:21:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:21:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:21:03 INFO - 'talos_options': ['--disable-e10s'], 06:21:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:21:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:21:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:21:03 INFO - 'talos_options': ['--disable-e10s'], 06:21:03 INFO - 'tests': ['damp', 'tps']}, 06:21:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:21:03 INFO - 'tests': ['damp', 'tps']}, 06:21:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:21:03 INFO - 'tests': ['dromaeo_dom']}, 06:21:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:21:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:21:03 INFO - 'tests': ['basic_compositor_video']}, 06:21:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:21:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:21:03 INFO - 'tests': ['a11yr', 06:21:03 INFO - 'ts_paint', 06:21:03 INFO - 'tpaint', 06:21:03 INFO - 'sessionrestore', 06:21:03 INFO - 'sessionrestore_no_auto_restore', 06:21:03 INFO - 'tabpaint']}, 06:21:03 INFO - 'other-e10s': {'tests': ['a11yr', 06:21:03 INFO - 'ts_paint', 06:21:03 INFO - 'tpaint', 06:21:03 INFO - 'sessionrestore', 06:21:03 INFO - 'sessionrestore_no_auto_restore', 06:21:03 INFO - 'tabpaint']}, 06:21:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:21:03 INFO - 'ts_paint', 06:21:03 INFO - 'tpaint', 06:21:03 INFO - 'sessionrestore', 06:21:03 INFO - 'sessionrestore_no_auto_restore', 06:21:03 INFO - 'tabpaint']}, 06:21:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:21:03 INFO - 'ts_paint', 06:21:03 INFO - 'tpaint', 06:21:03 INFO - 'sessionrestore', 06:21:03 INFO - 'sessionrestore_no_auto_restore', 06:21:03 INFO - 'tabpaint']}, 06:21:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:21:03 INFO - 'tests': ['a11yr', 06:21:03 INFO - 'ts_paint', 06:21:03 INFO - 'tpaint', 06:21:03 INFO - 'sessionrestore', 06:21:03 INFO - 'sessionrestore_no_auto_restore', 06:21:03 INFO - 'tabpaint']}, 06:21:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:21:03 INFO - 'tests': ['a11yr', 06:21:03 INFO - 'ts_paint', 06:21:03 INFO - 'tpaint', 06:21:03 INFO - 'sessionrestore', 06:21:03 INFO - 'sessionrestore_no_auto_restore', 06:21:03 INFO - 'tabpaint']}, 06:21:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:21:03 INFO - 'tests': ['tsvgx', 06:21:03 INFO - 'tsvgr_opacity', 06:21:03 INFO - 'tart', 06:21:03 INFO - 'tscrollx', 06:21:03 INFO - 'cart', 06:21:03 INFO - 'tsvg_static']}, 06:21:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:21:03 INFO - 'tsvgr_opacity', 06:21:03 INFO - 'tart', 06:21:03 INFO - 'tscrollx', 06:21:03 INFO - 'cart', 06:21:03 INFO - 'tsvg_static']}, 06:21:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:21:03 INFO - 'talos_options': ['--disable-e10s'], 06:21:03 INFO - 'tests': ['tp5o']}, 06:21:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:21:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:21:03 INFO - 'talos_options': ['--disable-e10s', 06:21:03 INFO - '--xperf_path', 06:21:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:03 INFO - 'tests': ['tp5n']}, 06:21:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:21:03 INFO - 'talos_options': ['--xperf_path', 06:21:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:21:03 INFO - 'tests': ['tp5n']}}, 06:21:03 INFO - 'talos.zip': {'path': '', 06:21:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:21:03 INFO - Running post-action listener: _resource_record_post_action 06:21:03 INFO - [mozharness: 2017-03-23 13:21:03.860231Z] Finished populate-webroot step (success) 06:21:03 INFO - [mozharness: 2017-03-23 13:21:03.860320Z] Running create-virtualenv step. 06:21:03 INFO - Running pre-action listener: _resource_record_pre_action 06:21:03 INFO - Running main action method: create_virtualenv 06:21:03 INFO - Creating virtualenv /builds/slave/test/build/venv 06:21:03 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 06:21:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:21:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:21:03 INFO - Using real prefix '/usr' 06:21:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:21:04 INFO - Installing distribute.............................................................................................................................................................................................done. 06:21:07 INFO - Installing pip.................done. 06:21:07 INFO - Return code: 0 06:21:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:21:07 INFO - Reading from file tmpfile_stdout 06:21:07 INFO - Output received: 06:21:07 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) 06:21:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:07 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 0xdce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069290>, '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 0x1069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', '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 06:21:07 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 06:21:07 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 06:21:07 INFO - Using env: {'DISPLAY': ':0', 06:21:07 INFO - 'HOME': '/home/cltbld', 06:21:07 INFO - 'LANG': 'en_US.UTF-8', 06:21:07 INFO - 'LANGUAGE': 'en_US:en', 06:21:07 INFO - 'LOGNAME': 'cltbld', 06:21:07 INFO - 'MAIL': '/var/mail/cltbld', 06:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:07 INFO - 'MOZ_NO_REMOTE': '1', 06:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:07 INFO - 'NO_EM_RESTART': '1', 06:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:07 INFO - 'PWD': '/builds/slave/test', 06:21:07 INFO - 'SHELL': '/bin/bash', 06:21:07 INFO - 'SHLVL': '1', 06:21:07 INFO - 'TERM': 'linux', 06:21:07 INFO - 'TMOUT': '86400', 06:21:07 INFO - 'USER': 'cltbld', 06:21:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', 06:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:07 INFO - '_': '/tools/buildbot/bin/python'} 06:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:08 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 06:21:08 INFO - Cleaning up... 06:21:08 INFO - Return code: 0 06:21:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:21:08 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')]} 06:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:08 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')]} 06:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:08 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 0xdce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069290>, '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 0x1069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', '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 06:21:08 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 06:21:08 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 06:21:08 INFO - Using env: {'DISPLAY': ':0', 06:21:08 INFO - 'HOME': '/home/cltbld', 06:21:08 INFO - 'LANG': 'en_US.UTF-8', 06:21:08 INFO - 'LANGUAGE': 'en_US:en', 06:21:08 INFO - 'LOGNAME': 'cltbld', 06:21:08 INFO - 'MAIL': '/var/mail/cltbld', 06:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:08 INFO - 'MOZ_NO_REMOTE': '1', 06:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:08 INFO - 'NO_EM_RESTART': '1', 06:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:08 INFO - 'PWD': '/builds/slave/test', 06:21:08 INFO - 'SHELL': '/bin/bash', 06:21:08 INFO - 'SHLVL': '1', 06:21:08 INFO - 'TERM': 'linux', 06:21:08 INFO - 'TMOUT': '86400', 06:21:08 INFO - 'USER': 'cltbld', 06:21:08 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', 06:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:08 INFO - '_': '/tools/buildbot/bin/python'} 06:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:08 INFO - Downloading/unpacking psutil>=3.1.1 06:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:21:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:10 INFO - Installing collected packages: psutil 06:21:10 INFO - Running setup.py install for psutil 06:21:10 INFO - building 'psutil._psutil_linux' extension 06:21:10 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 06:21:11 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 06:21:11 INFO - building 'psutil._psutil_posix' extension 06:21:11 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 06:21:11 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 06:21:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:21:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:21:12 INFO - Successfully installed psutil 06:21:12 INFO - Cleaning up... 06:21:12 INFO - Return code: 0 06:21:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069290>, '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 0x1069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', '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 06:21:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:21:12 INFO - Using env: {'DISPLAY': ':0', 06:21:12 INFO - 'HOME': '/home/cltbld', 06:21:12 INFO - 'LANG': 'en_US.UTF-8', 06:21:12 INFO - 'LANGUAGE': 'en_US:en', 06:21:12 INFO - 'LOGNAME': 'cltbld', 06:21:12 INFO - 'MAIL': '/var/mail/cltbld', 06:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:12 INFO - 'MOZ_NO_REMOTE': '1', 06:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:12 INFO - 'NO_EM_RESTART': '1', 06:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:12 INFO - 'PWD': '/builds/slave/test', 06:21:12 INFO - 'SHELL': '/bin/bash', 06:21:12 INFO - 'SHLVL': '1', 06:21:12 INFO - 'TERM': 'linux', 06:21:12 INFO - 'TMOUT': '86400', 06:21:12 INFO - 'USER': 'cltbld', 06:21:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', 06:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:12 INFO - '_': '/tools/buildbot/bin/python'} 06:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:21:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:21:14 INFO - Installing collected packages: mozsystemmonitor 06:21:14 INFO - Running setup.py install for mozsystemmonitor 06:21:14 INFO - Successfully installed mozsystemmonitor 06:21:14 INFO - Cleaning up... 06:21:14 INFO - Return code: 0 06:21:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069290>, '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 0x1069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', '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 06:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:21:14 INFO - Using env: {'DISPLAY': ':0', 06:21:14 INFO - 'HOME': '/home/cltbld', 06:21:14 INFO - 'LANG': 'en_US.UTF-8', 06:21:14 INFO - 'LANGUAGE': 'en_US:en', 06:21:14 INFO - 'LOGNAME': 'cltbld', 06:21:14 INFO - 'MAIL': '/var/mail/cltbld', 06:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:14 INFO - 'MOZ_NO_REMOTE': '1', 06:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:14 INFO - 'NO_EM_RESTART': '1', 06:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:14 INFO - 'PWD': '/builds/slave/test', 06:21:14 INFO - 'SHELL': '/bin/bash', 06:21:14 INFO - 'SHLVL': '1', 06:21:14 INFO - 'TERM': 'linux', 06:21:14 INFO - 'TMOUT': '86400', 06:21:14 INFO - 'USER': 'cltbld', 06:21:14 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', 06:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:14 INFO - '_': '/tools/buildbot/bin/python'} 06:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:14 INFO - Downloading/unpacking jsonschema==2.5.1 06:21:14 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 06:21:14 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 06:21:14 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 06:21:14 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 06:21:14 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 06:21:14 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 06:21:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:21:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:21:16 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 06:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:16 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 06:21:16 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 06:21:16 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 06:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:17 INFO - Downloading functools32-3.2.3-2.tar.gz 06:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:21:17 INFO - warning: no files found matching '*.txt' 06:21:17 INFO - no previously-included directories found matching 'build' 06:21:17 INFO - no previously-included directories found matching 'dist' 06:21:17 INFO - no previously-included directories found matching '.git*' 06:21:17 INFO - Installing collected packages: jsonschema, functools32 06:21:17 INFO - Running setup.py install for functools32 06:21:17 INFO - warning: no files found matching '*.txt' 06:21:17 INFO - no previously-included directories found matching 'build' 06:21:17 INFO - no previously-included directories found matching 'dist' 06:21:17 INFO - no previously-included directories found matching '.git*' 06:21:17 INFO - Successfully installed jsonschema functools32 06:21:17 INFO - Cleaning up... 06:21:17 INFO - Return code: 0 06:21:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069290>, '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 0x1069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', '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 06:21:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:21:17 INFO - Using env: {'DISPLAY': ':0', 06:21:17 INFO - 'HOME': '/home/cltbld', 06:21:17 INFO - 'LANG': 'en_US.UTF-8', 06:21:17 INFO - 'LANGUAGE': 'en_US:en', 06:21:17 INFO - 'LOGNAME': 'cltbld', 06:21:17 INFO - 'MAIL': '/var/mail/cltbld', 06:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:17 INFO - 'MOZ_NO_REMOTE': '1', 06:21:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:17 INFO - 'NO_EM_RESTART': '1', 06:21:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:17 INFO - 'PWD': '/builds/slave/test', 06:21:17 INFO - 'SHELL': '/bin/bash', 06:21:17 INFO - 'SHLVL': '1', 06:21:17 INFO - 'TERM': 'linux', 06:21:17 INFO - 'TMOUT': '86400', 06:21:17 INFO - 'USER': 'cltbld', 06:21:17 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', 06:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:17 INFO - '_': '/tools/buildbot/bin/python'} 06:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:21:17 INFO - Cleaning up... 06:21:17 INFO - Return code: 0 06:21:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069290>, '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 0x1069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', '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 06:21:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:21:17 INFO - Using env: {'DISPLAY': ':0', 06:21:17 INFO - 'HOME': '/home/cltbld', 06:21:17 INFO - 'LANG': 'en_US.UTF-8', 06:21:17 INFO - 'LANGUAGE': 'en_US:en', 06:21:17 INFO - 'LOGNAME': 'cltbld', 06:21:17 INFO - 'MAIL': '/var/mail/cltbld', 06:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:17 INFO - 'MOZ_NO_REMOTE': '1', 06:21:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:17 INFO - 'NO_EM_RESTART': '1', 06:21:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:17 INFO - 'PWD': '/builds/slave/test', 06:21:17 INFO - 'SHELL': '/bin/bash', 06:21:17 INFO - 'SHLVL': '1', 06:21:17 INFO - 'TERM': 'linux', 06:21:17 INFO - 'TMOUT': '86400', 06:21:17 INFO - 'USER': 'cltbld', 06:21:17 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', 06:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:17 INFO - '_': '/tools/buildbot/bin/python'} 06:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:17 INFO - Downloading/unpacking blobuploader==1.2.4 06:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:19 INFO - Downloading blobuploader-1.2.4.tar.gz 06:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:21:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:21:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:20 INFO - Downloading docopt-0.6.1.tar.gz 06:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:21:20 INFO - Installing collected packages: blobuploader, requests, docopt 06:21:20 INFO - Running setup.py install for blobuploader 06:21:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:21:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:21:20 INFO - Running setup.py install for requests 06:21:21 INFO - Running setup.py install for docopt 06:21:21 INFO - Successfully installed blobuploader requests docopt 06:21:21 INFO - Cleaning up... 06:21:21 INFO - Return code: 0 06:21:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:21 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')]} 06:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:21 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')]} 06:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:21 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 0xdce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069290>, '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 0x1069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', '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 06:21:21 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 06:21:21 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 06:21:21 INFO - Using env: {'DISPLAY': ':0', 06:21:21 INFO - 'HOME': '/home/cltbld', 06:21:21 INFO - 'LANG': 'en_US.UTF-8', 06:21:21 INFO - 'LANGUAGE': 'en_US:en', 06:21:21 INFO - 'LOGNAME': 'cltbld', 06:21:21 INFO - 'MAIL': '/var/mail/cltbld', 06:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:21 INFO - 'MOZ_NO_REMOTE': '1', 06:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:21 INFO - 'NO_EM_RESTART': '1', 06:21:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:21 INFO - 'PWD': '/builds/slave/test', 06:21:21 INFO - 'SHELL': '/bin/bash', 06:21:21 INFO - 'SHLVL': '1', 06:21:21 INFO - 'TERM': 'linux', 06:21:21 INFO - 'TMOUT': '86400', 06:21:21 INFO - 'USER': 'cltbld', 06:21:21 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', 06:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:21 INFO - '_': '/tools/buildbot/bin/python'} 06:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:21 INFO - Running setup.py (path:/tmp/pip-WKLzUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:21 INFO - Running setup.py (path:/tmp/pip-qdpa7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:21 INFO - Running setup.py (path:/tmp/pip-GiZszM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:21 INFO - Running setup.py (path:/tmp/pip-pPTDkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:21 INFO - Running setup.py (path:/tmp/pip-IsMPo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:21 INFO - Running setup.py (path:/tmp/pip-bQBwcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:21 INFO - Running setup.py (path:/tmp/pip-Y9qjbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:21 INFO - Running setup.py (path:/tmp/pip-qdXDfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:22 INFO - Running setup.py (path:/tmp/pip-5sFpOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:22 INFO - Running setup.py (path:/tmp/pip-lAmt4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:22 INFO - Running setup.py (path:/tmp/pip-Fd5OnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:22 INFO - Running setup.py (path:/tmp/pip-HPzNlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:22 INFO - Running setup.py (path:/tmp/pip-MluDOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:22 INFO - Running setup.py (path:/tmp/pip-bTmmE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:22 INFO - Running setup.py (path:/tmp/pip-vRCS2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:22 INFO - Running setup.py (path:/tmp/pip-3qXT3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:22 INFO - Running setup.py (path:/tmp/pip-Hfvsx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:21:22 INFO - Running setup.py install for manifestparser 06:21:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:21:22 INFO - Running setup.py install for mozcrash 06:21:22 INFO - Running setup.py install for mozdebug 06:21:22 INFO - Running setup.py install for mozdevice 06:21:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:21:23 INFO - Running setup.py install for mozfile 06:21:23 INFO - Running setup.py install for mozhttpd 06:21:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:21:23 INFO - Running setup.py install for mozinfo 06:21:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:21:23 INFO - Running setup.py install for mozInstall 06:21:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:21:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:21:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:21:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:21:23 INFO - Running setup.py install for mozleak 06:21:23 INFO - Running setup.py install for mozlog 06:21:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:21:23 INFO - Running setup.py install for moznetwork 06:21:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:21:23 INFO - Running setup.py install for mozprocess 06:21:23 INFO - Running setup.py install for mozprofile 06:21:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:21:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:21:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:21:24 INFO - Running setup.py install for mozrunner 06:21:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:21:24 INFO - Running setup.py install for mozscreenshot 06:21:24 INFO - Running setup.py install for moztest 06:21:24 INFO - Running setup.py install for mozversion 06:21:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:21:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:21:24 INFO - Cleaning up... 06:21:24 INFO - Return code: 0 06:21:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069290>, '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 0x1069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', '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 06:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:21:24 INFO - Using env: {'DISPLAY': ':0', 06:21:24 INFO - 'HOME': '/home/cltbld', 06:21:24 INFO - 'LANG': 'en_US.UTF-8', 06:21:24 INFO - 'LANGUAGE': 'en_US:en', 06:21:24 INFO - 'LOGNAME': 'cltbld', 06:21:24 INFO - 'MAIL': '/var/mail/cltbld', 06:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:24 INFO - 'MOZ_NO_REMOTE': '1', 06:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:24 INFO - 'NO_EM_RESTART': '1', 06:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:24 INFO - 'PWD': '/builds/slave/test', 06:21:24 INFO - 'SHELL': '/bin/bash', 06:21:24 INFO - 'SHLVL': '1', 06:21:24 INFO - 'TERM': 'linux', 06:21:24 INFO - 'TMOUT': '86400', 06:21:24 INFO - 'USER': 'cltbld', 06:21:24 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', 06:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:24 INFO - '_': '/tools/buildbot/bin/python'} 06:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:21:24 INFO - Running setup.py (path:/tmp/pip-_isoSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:21:24 INFO - Running setup.py (path:/tmp/pip-3DeptK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:21:24 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)) 06:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:21:24 INFO - Running setup.py (path:/tmp/pip-34Q3kA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:21:24 INFO - Running setup.py (path:/tmp/pip-UswI4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:21:24 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)) 06:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:21:24 INFO - Running setup.py (path:/tmp/pip-JD6x5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:21:25 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)) 06:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:21:25 INFO - Running setup.py (path:/tmp/pip-VCAhTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:21:25 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)) 06:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:21:25 INFO - Running setup.py (path:/tmp/pip-QQgVCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:21:25 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)) 06:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:21:25 INFO - Running setup.py (path:/tmp/pip-B80Tje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:21:25 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)) 06:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:21:25 INFO - Running setup.py (path:/tmp/pip-Q8Y_SJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:21:25 INFO - Running setup.py (path:/tmp/pip-dMqC4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:21:25 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)) 06:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:21:25 INFO - Running setup.py (path:/tmp/pip-oQOb2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:21:25 INFO - Running setup.py (path:/tmp/pip-ucg_zA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:21:25 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)) 06:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:21:25 INFO - Running setup.py (path:/tmp/pip-o4RGLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:21:25 INFO - Running setup.py (path:/tmp/pip-ahoQi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:21:25 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)) 06:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:25 INFO - Running setup.py (path:/tmp/pip-E3qSH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:21:25 INFO - Running setup.py (path:/tmp/pip-jCPx4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:21:25 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)) 06:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:21:25 INFO - Running setup.py (path:/tmp/pip-z9W_Va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:21:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:21:27 INFO - Downloading blessings-1.6.tar.gz 06:21:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:21:28 INFO - Installing collected packages: blessings 06:21:28 INFO - Running setup.py install for blessings 06:21:28 INFO - Successfully installed blessings 06:21:28 INFO - Cleaning up... 06:21:28 INFO - Return code: 0 06:21:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:21:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:28 INFO - Reading from file tmpfile_stdout 06:21:28 INFO - Current package versions: 06:21:28 INFO - argparse == 1.2.1 06:21:28 INFO - blessings == 1.6 06:21:28 INFO - blobuploader == 1.2.4 06:21:28 INFO - docopt == 0.6.1 06:21:28 INFO - functools32 == 3.2.3-2 06:21:28 INFO - jsonschema == 2.5.1 06:21:28 INFO - manifestparser == 1.1 06:21:28 INFO - mozInstall == 1.12 06:21:28 INFO - mozcrash == 1.0 06:21:28 INFO - mozdebug == 0.1 06:21:28 INFO - mozdevice == 0.49 06:21:28 INFO - mozfile == 1.2 06:21:28 INFO - mozhttpd == 0.7 06:21:28 INFO - mozinfo == 0.9 06:21:28 INFO - mozleak == 0.1 06:21:28 INFO - mozlog == 3.4 06:21:28 INFO - moznetwork == 0.27 06:21:28 INFO - mozprocess == 0.25 06:21:28 INFO - mozprofile == 0.28 06:21:28 INFO - mozrunner == 6.13 06:21:28 INFO - mozscreenshot == 0.1 06:21:28 INFO - mozsystemmonitor == 0.3 06:21:28 INFO - moztest == 0.8 06:21:28 INFO - mozversion == 1.4 06:21:28 INFO - psutil == 3.1.1 06:21:28 INFO - requests == 1.2.3 06:21:28 INFO - wsgiref == 0.1.2 06:21:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:28 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 0xdce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069290>, '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 0x1069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', '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 06:21:28 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 06:21:28 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 06:21:28 INFO - Using env: {'DISPLAY': ':0', 06:21:28 INFO - 'HOME': '/home/cltbld', 06:21:28 INFO - 'LANG': 'en_US.UTF-8', 06:21:28 INFO - 'LANGUAGE': 'en_US:en', 06:21:28 INFO - 'LOGNAME': 'cltbld', 06:21:28 INFO - 'MAIL': '/var/mail/cltbld', 06:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:28 INFO - 'MOZ_NO_REMOTE': '1', 06:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:28 INFO - 'NO_EM_RESTART': '1', 06:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:28 INFO - 'PWD': '/builds/slave/test', 06:21:28 INFO - 'SHELL': '/bin/bash', 06:21:28 INFO - 'SHLVL': '1', 06:21:28 INFO - 'TERM': 'linux', 06:21:28 INFO - 'TMOUT': '86400', 06:21:28 INFO - 'USER': 'cltbld', 06:21:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', 06:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:28 INFO - '_': '/tools/buildbot/bin/python'} 06:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:21:28 INFO - Cleaning up... 06:21:28 INFO - Return code: 0 06:21:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069290>, '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 0x1069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a040>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', '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 06:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:21:28 INFO - Using env: {'DISPLAY': ':0', 06:21:28 INFO - 'HOME': '/home/cltbld', 06:21:28 INFO - 'LANG': 'en_US.UTF-8', 06:21:28 INFO - 'LANGUAGE': 'en_US:en', 06:21:28 INFO - 'LOGNAME': 'cltbld', 06:21:28 INFO - 'MAIL': '/var/mail/cltbld', 06:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:28 INFO - 'MOZ_NO_REMOTE': '1', 06:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:28 INFO - 'NO_EM_RESTART': '1', 06:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:28 INFO - 'PWD': '/builds/slave/test', 06:21:28 INFO - 'SHELL': '/bin/bash', 06:21:28 INFO - 'SHLVL': '1', 06:21:28 INFO - 'TERM': 'linux', 06:21:28 INFO - 'TMOUT': '86400', 06:21:28 INFO - 'USER': 'cltbld', 06:21:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', 06:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:28 INFO - '_': '/tools/buildbot/bin/python'} 06:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:21:28 INFO - Cleaning up... 06:21:28 INFO - Return code: 0 06:21:28 INFO - Running post-action listener: _resource_record_post_action 06:21:28 INFO - Running post-action listener: _start_resource_monitoring 06:21:28 INFO - Starting resource monitoring. 06:21:29 INFO - [mozharness: 2017-03-23 13:21:29.011016Z] Finished create-virtualenv step (success) 06:21:29 INFO - [mozharness: 2017-03-23 13:21:29.011953Z] Running install step. 06:21:29 INFO - Running pre-action listener: _resource_record_pre_action 06:21:29 INFO - Running main action method: install 06:21:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:21:29 INFO - Reading from file tmpfile_stdout 06:21:29 INFO - Detecting whether we're running mozinstall >=1.0... 06:21:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:21:29 INFO - Reading from file tmpfile_stdout 06:21:29 INFO - Output received: 06:21:29 INFO - Usage: mozinstall [options] installer 06:21:29 INFO - Options: 06:21:29 INFO - -h, --help show this help message and exit 06:21:29 INFO - -d DEST, --destination=DEST 06:21:29 INFO - Directory to install application into. [default: 06:21:29 INFO - "/builds/slave/test"] 06:21:29 INFO - --app=APP Application being installed. [default: firefox] 06:21:29 INFO - mkdir: /builds/slave/test/build/application 06:21:29 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'] 06:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:21:44 INFO - Reading from file tmpfile_stdout 06:21:44 INFO - Output received: 06:21:44 INFO - /builds/slave/test/build/application/firefox/firefox 06:21:44 INFO - Running post-action listener: _resource_record_post_action 06:21:44 INFO - [mozharness: 2017-03-23 13:21:44.817173Z] Finished install step (success) 06:21:44 INFO - [mozharness: 2017-03-23 13:21:44.817501Z] Running run-tests step. 06:21:44 INFO - Running pre-action listener: _resource_record_pre_action 06:21:44 INFO - Running main action method: run_tests 06:21:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:21:44 INFO - Python 2.7.3 06:21:44 INFO - Return code: 0 06:21:44 INFO - grabbing minidump binary from tooltool 06:21: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')]} 06:21:44 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 0x1069290>, '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 0x1069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:21:44 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 06:21:44 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 06:21:44 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 06:21:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:21:44 INFO - Return code: 0 06:21:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:21:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:21:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:21:44 INFO - ENV: RUST_BACKTRACE is now 1 06:21:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:21:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:21:44 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/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 06:21:44 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/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 06:21:44 INFO - Using env: {'DISPLAY': ':0', 06:21:44 INFO - 'HOME': '/home/cltbld', 06:21:44 INFO - 'LANG': 'en_US.UTF-8', 06:21:44 INFO - 'LANGUAGE': 'en_US:en', 06:21:44 INFO - 'LOGNAME': 'cltbld', 06:21:44 INFO - 'MAIL': '/var/mail/cltbld', 06:21:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:21:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:21:44 INFO - 'MOZ_NO_REMOTE': '1', 06:21:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:21:44 INFO - 'NO_EM_RESTART': '1', 06:21:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:21:44 INFO - 'PWD': '/builds/slave/test', 06:21:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:21:44 INFO - 'RUST_BACKTRACE': '1', 06:21:44 INFO - 'SHELL': '/bin/bash', 06:21:44 INFO - 'SHLVL': '1', 06:21:44 INFO - 'TERM': 'linux', 06:21:44 INFO - 'TMOUT': '86400', 06:21:44 INFO - 'USER': 'cltbld', 06:21:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734', 06:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:21:44 INFO - '_': '/tools/buildbot/bin/python'} 06:21:44 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/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 06:21:45 INFO - mozversion application_buildid: 20170323124304 06:21:45 INFO - mozversion application_changeset: 89b93d310da5bc7f86ebcdb8fe580d47a610757a 06:21:45 INFO - mozversion application_display_name: Nightly 06:21:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:21:45 INFO - mozversion application_name: Firefox 06:21:45 INFO - mozversion application_remotingname: firefox 06:21:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:21:45 INFO - mozversion application_vendor: Mozilla 06:21:45 INFO - mozversion application_version: 55.0a1 06:21:45 INFO - mozversion platform_buildid: 20170323124304 06:21:45 INFO - mozversion platform_changeset: 89b93d310da5bc7f86ebcdb8fe580d47a610757a 06:21:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:21:45 INFO - mozversion platform_version: 55.0a1 06:21:45 INFO - using testdate: 1490275305 06:21:45 INFO - actual date: 1490275305 06:21:45 INFO - starting webserver on 'localhost:60997' 06:21:45 INFO - SUITE-START | Running 2 tests 06:21:45 INFO - TEST-START | dromaeo_css 06:21:45 INFO - operating with platform_type : linux_ 06:21:45 INFO - Initialising browser for dromaeo_css test... 06:21:45 INFO - TEST-INFO | started process 3289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp72jjO7/profile http://localhost:60997/getInfo.html) 06:21:50 INFO - PID 3289 | __metrics Screen width/height:1600/1200 06:21:50 INFO - PID 3289 | colorDepth:24 06:21:50 INFO - PID 3289 | Browser inner width/height: 1024/697 06:21:50 INFO - PID 3289 | __metrics 06:21:51 ERROR - PID 3289 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3388: TypeError: this.tabs is undefined 06:21:52 INFO - TEST-INFO | 3289: exit 0 06:21:52 INFO - Browser initialized. 06:21:52 INFO - Running cycle 1/1 for dromaeo_css test... 06:21:52 INFO - TEST-INFO | started process 3421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp72jjO7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:04 INFO - PID 3421 | RSS: Main: 155824128 06:22:04 INFO - PID 3421 | 06:25:09 INFO - PID 3421 | Cycle 1(1): loaded http://localhost:60997/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60997/tests/dromaeo/cssquery-ext.html) 06:25:10 INFO - PID 3421 | RSS: Main: 167088128 06:25:10 INFO - PID 3421 | 06:26:52 INFO - PID 3421 | ************************* 06:26:52 INFO - PID 3421 | A coding exception was thrown and uncaught in a Task. 06:26:52 INFO - PID 3421 | 06:26:52 ERROR - PID 3421 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:26:52 INFO - PID 3421 | Full stack: 06:26:52 INFO - PID 3421 | ************************* 06:28:13 INFO - PID 3421 | Cycle 1(1): loaded http://localhost:60997/tests/dromaeo/cssquery-ext.html (next: http://localhost:60997/tests/dromaeo/cssquery-jquery.html) 06:28:13 INFO - PID 3421 | RSS: Main: 160776192 06:28:13 INFO - PID 3421 | 06:31:15 INFO - PID 3421 | Cycle 1(1): loaded http://localhost:60997/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60997/tests/dromaeo/cssquery-mootools.html) 06:31:16 INFO - PID 3421 | RSS: Main: 169263104 06:31:16 INFO - PID 3421 | 06:34:18 INFO - PID 3421 | Cycle 1(1): loaded http://localhost:60997/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60997/tests/dromaeo/cssquery-prototype.html) 06:34:18 INFO - PID 3421 | RSS: Main: 161296384 06:34:18 INFO - PID 3421 | 06:37:21 INFO - PID 3421 | Cycle 1(1): loaded http://localhost:60997/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60997/tests/dromaeo/cssquery-yui.html) 06:37:22 INFO - PID 3421 | RSS: Main: 168906752 06:37:22 INFO - PID 3421 | 06:40:24 INFO - PID 3421 | Cycle 1(1): loaded http://localhost:60997/tests/dromaeo/cssquery-yui.html (next: http://localhost:60997/tests/dromaeo/cssquery-dojo.html) 06:40:25 INFO - PID 3421 | RSS: Main: 161701888 06:40:25 INFO - PID 3421 | 06:40:25 INFO - PID 3421 | __start_tp_report 06:40:25 INFO - PID 3421 | _x_x_mozilla_page_load 06:40:25 INFO - PID 3421 | _x_x_mozilla_page_load_details 06:40:25 INFO - PID 3421 | |i|pagename|runs| 06:40:25 INFO - PID 3421 | |0;dojo.html;2680.6468669253863;2710.5798601216807;2726.6319046928656;2752.972470275298;2764.57149141883;5121.052605268028;5205.817796377128;5245.973770131149;5252.8161514347;5281.867953301169;5198.974005129979;5221.1385121455005;5253;5290.629655924087;5321.308229930104;4731.266653668687;4799.640026997971;4801.4718380978065;4812.350332705075;4825.638077144211;4804.303376010476;4827.275908613701;4849.927251091236;4861.829835955742;4892.608591312704;4702.130105930414;4713.929291060636;4734.4081989751285;4734.857954261378;4748.5251474852585;4757.5718185363485;4769.356136921506;4781.880452988668;4792.688475249098;4820;4634.397528321297;4703.7883295251795;4727.598154156901;4737.857864264078;4766.547178018082;5102.821401250975;5137.3064636274;5204.4014938281825;5227.242049902781;5282.181261904372;5611.943880561183;5631.099024156116;5664.0937450007805;5668.716564171817;5674.914876276818;5674.319081710221;5687.630304030225;5699.629524080921;5702.087665973424;5708.857278568027;5158.896822063538;5271.446498117719;5279.551238144801;5285.022270879899;5347.358317001985;5676.318841739017;5737.799177028867;5742.397048309951;5749.913751293734;5767.740451679684;5503.174523821459;5514.448555144453;5550.805721799798;5555.30558680165;5574.554035677136;5648.63283886546;5653.66078035311;5660.179274005246;5664.8867022659315;5667.1782591524;5598.300212473441;5615.185798059259;5616.269884914935;5621.494065534122;5627.746751396197;5401.729913504388;5470.316210473691;5577.191307260506;5580.079286917694;5615.578831587647;4585.266357382803;4591.334256532784;4610;4622.653301002371;4635.258358662598;3953.920921581552;3961.5246170459727;3969.6030396960073;3977.741446806006;4007.318755811519;4716.622670186377;4755.429348478205;4760.761961901961;4814.735189564538;4887.877803054952;5576.163575463713;5596.496315331639;5637.661740295595;5639.915401268902;5706.71466426677;4831.154547954094;4841.055994081191;4845.9757701211975;4849.393825771778;4909.754512274372;4932.531409516162;4933.58064564516;4935.90128197434;4951.059298733229;4979.2033274676605;5155.896882062413;5202.739863006759;5210.426853046238;5214.582833373397;5248.632595718415;5509.779608815603;5617.943820561742;5621.9156712650165;5628.183913332626;5681.857953551194;5209.791608335624;5233.895322093461;5264.763085661231;5266.0257852297445;5278.313819203479;5538.086215774513;5572.192032155396;5574;5605.019121653776;5646.887062258814;5471.206675032177;5549.861253468534;5632.155176723524;5640.4077571856005;5677.77288908439;5432.1308590626895;5487.42382049895;5492.148716948879;5494.36814766291;5500.1749737539685;5364.463553644604;5435.972820135874;5454.10007348783;5475.863103422446;5480.753366098615;5282.943411317675;5321.2816269804625;5351.929614077278;5395.649282796606;5423.2407462954425;5510.228568000403;5524.779008839601;5529.917051244315;5559.777608895599;5588.022096133242;5313.574914006793;5341.519263266325;5345.037893179265;5360.088784906653;5390.434004429635 06:40:25 INFO - PID 3421 | |1;ext.html;723.197251051333;1079.9946000269997;1095.9726006849828;1195.2171327780295;1204.58441837566;31851.203719907015;32457;32503.349933001355;32539.349213015754;34960;32331.515027274552;32834;32897;32924.835375823146;32962.50556241658;7024.051753013355;7127.857442851166;7170.569765814042;7295.8540829183385;7321.926780732204;7341.229170937028;7394.408447324201;7479.813004674872;7484.850302993937;7485.9251407486045;7410.03669522964;7489.550626962372;7497.512661677001;7498.4001279897475;7510.248975102473;7419.443541734391;7435.628218589049;7458.179600243969;7459.925400745978;7462.440316976248;7250.891236631454;7378.557286562824;7391.519551229153;7392.482526223166;7403.259674032607;34805.30389392198;34911.825440872635;35015.4747678785;35021.29957400863;35024.29951400957;2617.764401203901;2631.8026148038975;2639.366552027519;2664.6402735630636;2671.18152614829;24227.636585451233;24273.514529709482;24520.14179503709;24548;24910.37724056895;2934.8826046958097;2977.166393409827;2989.656189538209;2989.910302690923;2990.3421247325773;156425.99999999886;156819;157495;158354.20822895927;158994;32207.677923220937;32252.516212256836;37419.62580374216;37843.4323485148;42399.57600424018;39641;39641.40537891934;39735.60264397319;39739.20521589552;39791.20417591632;12145.574904878464;12165.14843960932;12181.451834667461;12208.816867746991;12290.877091229153;9726.221902247804;9775.071368220008;9811.362261452983;9816.558254878548;9877.209823214125;13065.804012939814;13142.4085916134;13154.4080516377;13280.136791108547;13296.468141274434;5525.171224316385;5669.773209071674;5683.914741278884;5700.914486282709;5749.425057494217;848.9320854331638;890.2121622364255;892.8973168085623;898.4654130792168;929.5212965322864;20236;21076;21264.681029784566;21332.36002919915;21541.56916861654;977.5503268496429;986.9407835529892;999.7450650084328;1006.5219020964983;1015.421209910344;10379.948100259602;10960;11077.556897724;11081.556737730562;11167.218294719292;210264;212024;212038;212149;212613;42167.36748948768;42301;42434.787826060674;42444.78777606092;42538.57461425408;1230.2925817654884;1236.140882086941;1256.591607727474;1264.4057293072242;1266.5060626355728;19846;19871;20879.033063629886;20935.790642093383;21128.78871211268;29933.401331973673;29949.55075673823;30026.399472010875;30072;30139.397212056076;209202;210645;212126;212166;212958;26943.461130776883;27419;27433.177004689893;28020;28239.57640635351;32923.50614740733;32975.34049318952;33661.66338336683;33697;33703.83148084244;24403.755962440857;25192.874035629706;25446;25791.355216119748;26458.470830582897;24741.25776226716;24960.126395576066;25741.099061532757;26010.73989260159;27389;28247;30549.23626909345;30684.693153068183;30694.539581906734;30767.384652307275;25502.872485637454;25667;26927.326816829736;26953;27940.161795146178;20883.895580522;22168;22178.889105554368;22281.220157294418;22352.329430117123 06:40:25 INFO - PID 3421 | |2;jquery.html;419.5385076415945;432.89826890680683;437.84675363622716;438.145616048705;446.0788471805721;16592.33630654774;16780.328786848513;16841.708193531733;17264.48206553802;17355.652886942255;17290.740638890427;17323.22045507952;17421.651566968652;17467.82532174678;18219.544511387223;5581.804636837712;5627.634203776762;5639.915401268984;5671.347795003566;5813;5549.250851135105;5638.492535671789;5639.661620302774;5647.09646456567;5685.118806584986;5473.781048758045;5543.25166102575;5597.6641401516035;5663.5186009189265;5667.206591077253;5454.699991500466;5464.371597266306;5477.287952566161;5493.23094766733;5522.861928451781;4882.170031094723;4907.950920490821;4987.675801072919;4991.176455884774;4996.650234483587;20018.69971950422;20401.183952641877;20583.691244631344;20897.05963231658;21064.789352106436;1554.1529866222936;1556.8520990505883;1583.2400447785012;1585.2232406121034;1594.4658539389202;13303.933480332536;13476.25880576568;13914.37385317653;13993.230372329517;14237.43050277998;1728.1877517566722;1800.5138612574663;1807.7288406739094;1822.362173239369;1844.8524118070522;73557;75016;75525.62237188834;76412.23587764162;76739;10583.682489525327;10860.782784344268;10862.239643225057;10889.945550272198;10963;15098.622534436507;15204.239788010555;15219.923900380427;15227.390904363701;15234.466793662168;7470.59571181355;7513.511621744678;7668.309852113337;7767.067951845702;7837.882431763414;7039.472039597051;7123.928760712327;7305.196428392873;7317.231690672403;7321.707131714672;6643.608301011632;6725.125733654593;6740;6753.189617245962;6814.829629259309;1918.0026386279335;1935.554822390858;1970.0346830053456;1986.5430950881378;1990.601325402886;846.221476241859;847.9109693482095;868.5136323658771;871.6469829718974;874.0778478705028;15807.841921580866;16243.187840607923;16557;16794.916025419796;16880.409185678443;875.7022612311845;875.7766769473743;879.9032106468284;893.1024320557798;900.1673452056821;8646.870296945552;9211.493367864832;9214.90785092154;9397.107274808883;9406.623735050658;353970;397475;399495;401792;409785;83418;83789;85446.57276713701;85643;90020.5498972501;1074.99462502687;1084.5932775209296;1088.9455527223606;1094.370736826328;1099.1097211258907;13817.930910345383;13857.514986975408;13903;13939.09395889264;14500;39720.801395992836;40824.183516328914;41282.38076428916;41341.37987930123;41558.7920710929;52266.69323304556;53607.46392536024;54002.72998634982;54645.72677136589;55520.11359204817;7602.809929751579;7721.498102623312;7777.183395743592;7969.880451793112;8076.878846817185;11062.557497700001;11089.889101108885;11751.764964700487;11793.469293881968;12050.288685045794;9964.451955142536;10207.438590877277;10311.793764124826;10379.53292101842;10548.314359566604;9102.544872756469;9136.223421009023;9516.666916657883;9573.32986690925;9737.853932191165;9715.514224288898;9999.900000999896;10146.340487868265;10480.161587073168;10512.684619461428;7328.853422931618;7372.926270737438;7487.588182650006;7517.473776835788;7720.884186737091;9051.547422628973;9693.905534032256;9707.271954603575;9808.705738827846;9979.201663866728 06:40:25 INFO - PID 3421 | |3;mootools.html;1291.2317171283087;1316.4602512969684;1320.702841860581;1322.3586560518147;1326.138010293309;9518;9906.801863962717;9906.801863962717;9972.601095956172;10182.389056656606;9879.308448408614;10076.294659373847;10093.243006774484;10111.898881011188;10115.330970389896;2228.342638921518;2271.8750468724215;2272.3864556569797;2274.1358283852196;2277.202978957368;2188.627933251343;2214.1807531213394;2236.798688118069;2240.4174914522177;2250.324902529243;2229.9554008919813;2232.162938897913;2234.117523578194;2247.5617254635354;2253.9323820285335;2011.5775687105725;2106.631339515586;2109.0193060226993;2118.8304935605115;2119.6290649136417;1889.527618095476;1952.492351988479;2168.479564904427;2213.192184852517;2214.047959377467;9609.951950240204;9806.16647584956;9854.802903941953;9866.062724041205;9882.11061004513;5338.546223571001;5592.328920529521;5599.6640201587625;5609.831705048855;5609.887802243932;3068.6164229471315;3098.690130986906;3118.1269244611544;3200.6639302873095;3246.350729854015;1006.3408467453829;1014.2697257974247;1018.1294992781139;1045.7019749371468;1057.6404022632341;14148.717025659533;14161.079529830527;14228.786568201382;14260.643483912881;14262.57212283633;4729.62840776171;4804.111239420718;4925.11347957364;4951.752412379366;5019.799208031711;11052.502637381338;11066.778664426667;11096.889031109586;11128.777424451466;11131.610393636183;5631;5632.633878797865;5641.802536911188;5642.210090587321;5665.971670141623;5056.570191533688;5070.923936140961;5110.233464980282;5200.531952124327;5212.374515058142;3747.1756213632957;3886.300465916162;3886.7667939923695;3920.09837737322;3958.2281455115976;1114.5820317380983;1119.9776004479866;1127.7800828838297;1146.7133216695827;1156.8149096144577;660.131926516629;685.5680921019725;692.6640579319027;694.0595493106767;706.5725236232006;5779.537636989031;5862.765489380462;5884.411558844081;5886.823395298148;6062.242219722535;811.7199566149669;817.4686453804956;817.8895849060419;844.5312851367427;861.4056301152185;3395.2021275000357;3465.653434656514;3498.370293347171;3543.7165026797793;3577.0520811984843;13142.277174755289;13423.798643020362;13492.730145397038;13562.389692463863;13620.795688064687;13246.271455069871;13458.394372253271;13473.797893031613;13505.932470337586;13515.25666088355;9032.8645070324;9647.372920760128;9823.557939892722;9828.803423931624;9837.557309920927;5775.740091695968;5844.181814545882;5899.46904778572;5971.343152253336;6062.090686397076;11629.302241865515;11737.647870563897;11902.642920712393;12002.519899204284;12063.939680301542;12281.877181228074;12297.938510307391;12340.444679989243;12417.813732793835;12425.37873106359;7713.652885620048;7761.146273909978;7828.569428681477;7837.216278372345;7874.291313781787;9020;9067.909320906707;9100.726978190665;9150.313726470675;9157.542122893696;8092.797680058045;8122.959385203036;8243.299319557666;8332.16678332162;8391.706290279812;7387.1135463744695;7440.255974402517;7466.066741657293;7478.887816682863;7614.961925190339;7193.82015449597;7241.4206863451855;7261.745838895613;7296.562206267641;7377.704891804267;5305.734713264244;5352.116900711339;5373.93417802224;5436.7553460093595;5540.63985840919;5239.47605239473;5322.38792538863;5373.4417019065595;5415.458454154711;5471.835844924659 06:40:25 INFO - PID 3421 | |4;prototype.html;368.91354959643843;398.47600405466807;401.19960678446495;402.93955906614;404.70860980094324;5506.659669640402;5540.252065971093;5545.667259964405;5564.248826408434;5580.190872323511;5433.347998240217;5433.782648694058;5437;5437.6465529740535;5450.1931505274815;4251.638610718085;4323.978380108095;4355.477342718862;4356.237658409781;4363.890902727441;4311.210847498284;4344.066025804452;4352.586504282088;4355.259605866994;4357;4309.116631090635;4342.044750154961;4344.45694288214;4353.521112677603;4380.408644832939;4240.703150779431;4309.870703878857;4335.544767799399;4361.389405483234;4365.301551751721;3901.43429202764;3908.530976282836;3920.137569734654;3920.9607903920883;3929.548101968253;5341.919871201935;5353.384360798519;5377.139657654796;5377.435369286208;5401.7299135043095;4620.676552641316;4827.831025914112;4882.292067650171;5056.873578160538;5101.15830887903;5729.656220626775;5736.971315143439;5738;5755.769769209227;5769.855753606152;4047.6357127858632;4068.7151899367054;4069.1454794493193;4073.205724883649;4087.162131763011;6002.169338351801;6052.668412949144;6073.483753880925;6128.877422451571;6151.446369826737;4134.813933373005;4154.543000269968;4155.221495280452;4156.376543518496;4160.729552579072;4229.59818817218;4232.597903199191;4235.618794308527;4243.936340954888;4248.978755106266;4699.449181770007;4781.856544303677;4836.395450568679;4837.9032419351415;4874.561289483963;5756.597038207286;5765.88468230633;5775.913361299584;5788.221653606209;5789.797357092481;1453.8805120057707;1456.7450696128135;1466.0763718857265;1473.4179998900588;1475.852414758537;940.2665920581957;994.7662299359645;997.7655251016006;1002.3484734922358;1012.4684540616088;4993.875153121128;5021.347224860745;5035.874103147451;5046.1673823818655;5053.46938571452;5975.820725378246;5981.940180598225;5993.760249589967;6017.969910150421;6043.848903777441;4854.17479028566;4927;4992.450830408652;5002.374703162105;5003.024410240041;3171.5242713592684;3202.9359412811614;3203.9679603204136;3209.5667084943234;3222.5810644616517;5574.832755017356;5591.384947655754;5597.356304025089;5609.635373700697;5614.663120212718;5868.618539794899;5945.40545945402;6128.540359473057;6183.196184496077;6199.659018753921;5542.279503664578;5568;5593.552515798727;5606.299212598426;5625.099984002458;6007.189029481139;6015.608985415934;6042.637441753509;6050.6369617823075;6052.394760523913;5711.171880077282;5867.325257595431;5898.06976802247;5923.763049477972;5938.257717785277;5556.860843527148;5582.609217354746;5588.105903055492;5597.692126933058;5636.2954630671165;4157.584241575818;4164.02208950746;4172.728772629769;4176.812043458112;4189.392538082022;5810.389909059657;5955.40445955401;5984.341722410619;6008.339082700987;6016.578839481194;5757.798477053283;5764.135379692912;5769.1634712967225;5786.594938354275;5824.563157763269;5442.374126975448;5780.976658169607;5783.710814459344;5794.246747922743;5801.564882633735;5746.2529871116485;5787.363390027178;5789.768409263583;5789.884202315846;5791.594588378773;5912.408759124053;5917.289925209003;5917.698106416581;5940.584159108821;5940.7920722776225;5565.165225216088;5687.1753595729215;5691.2032315475035;5712.400197979152;5733.770649174153 06:40:25 INFO - PID 3421 | |5;yui.html;685.4208194076006;685.6126288646917;689.2142957028984;696.5124412910964;702.5749421599934;14691.706165876689;15299.082055076704;15307.387704491835;15337.463188788395;15341;13543.796843047363;13554.728905421885;13648.45406183754;13683;13786.379612917417;816.2694388522254;816.4407380944043;832.1013305629936;834.9123342049088;836.4646626159263;812.1066826490871;844.4848642328175;849.0448245723561;849.6389034660275;851.0978362935277;879.4767113567417;883.2139395937621;883.575883575884;885.6767279942807;889.0753616239136;871.533729454745;877.3244601656688;878.8418084744743;879.7184900831736;890.3455959869491;647.6988200486796;647.7085311609794;648.099142192353;648.8118445650756;651.0234648027958;13356.465741370333;13485.123466974615;13516.12145210558;13692.315384230847;14241.78637320441;12285.452610213142;12786.680332991657;12932.612021639367;13327.866721332759;13390.732185356335;9700.369475984038;9750.268729845218;9841.409515429026;9889.554970026295;10461.476926153739;2540.7840333571485;2547.6942766868096;2566.4995325911455;2630.302969713008;2638.6569745933098;62176;63084.68457657728;63177;64278.35721642771;64456.355436445505;9900.851487227697;10093.394396336244;10235.43705096212;10263.640772572924;10415.947920260502;21708.348749537538;21780.45548861291;21961.78038219629;21965;21989.340319790434;6306.369363063657;6311.798046348202;6328.778492752732;6518.57629254097;6604.900926486107;3219.2917558137174;3296.489044198153;3325.966740332614;3332.7333813294877;3440.3291358184915;3498.3003399320237;3609.061643972586;3643.4899114124046;3645.434957581579;3680.9263814723554;680.6494655252549;690.1545606631936;691.1153723234269;712.9572225666477;718.9137303523506;540.446042806119;547.2448021729987;551.3383939272888;566.498648695907;569.9373068962411;8374.581270936429;8901.198892099743;8917.821643567093;8984.32617553686;9089.181973622406;527.8231792349605;541.894330605536;559.7089513452981;560.8502569732033;561.9297587801525;3853.344931361675;3863.7102217333813;3871.728978971445;3971.146203566247;3980.8877775852366;60268;60335.396646033856;61004.169874903826;61899.38100618936;62248.64259501791;45327.09345813131;52159.217611735854;52232;53693;55108;49107.26339104845;49711.25433118506;50374.74812625913;50535;50895.49104508982;7593.5823529706395;7909.446338756232;7970.123286438603;8012.439129260896;8072.878906816285;25771.226863194133;25895.0936717214;26311.60532592051;26763.19710408691;26836.194914152606;30636.234094147825;31172.37655246928;31518;31899.840500798276;32449.51325730163;9751.804963900824;9803.803923921625;9827.803443930938;9902.356346837432;10365.06714395708;10463.738406539593;10565.671813378762;10605.204609654153;10742.04104738863;10760.677179684622;9782.9021709782;10584.629537966135;10626.73433164177;10663.253572250178;11054.944725276322;10177;10288.12550933179;10449.895501045195;10665.146788256765;10794.460276986276;10205.489725513844;10207.234457415576;10445;10506.159507239556;10740.087092597218;6824.454043676395;7075.575465472089;7298.160711518243;7325.963370183115;7479.88780168287;7944.960275198819;8017.839643206987;8710.956445217733;8802.64789408442;8957.641694332153 06:40:25 INFO - PID 3421 | __end_tp_report 06:40:25 INFO - PID 3421 | __start_cc_report 06:40:25 INFO - PID 3421 | _x_x_mozilla_cycle_collect,381 06:40:25 INFO - PID 3421 | __end_cc_report 06:40:25 INFO - PID 3421 | __startTimestamp1490276425239__endTimestamp 06:40:25 INFO - PID 3421 | 06:40:25 INFO - PID 3421 | ------- Summary: start ------- 06:40:25 INFO - PID 3421 | Number of tests: 6 06:40:25 INFO - PID 3421 | 06:40:25 INFO - PID 3421 | [#0] dojo.html Cycles:165 Average:5156.94 Median:5285.02 stddev:593.39 (11.2%) stddev-sans-first:562.51 06:40:25 INFO - PID 3421 | Values: 2680.6 2710.6 2726.6 2753.0 2764.6 5121.1 5205.8 5246.0 5252.8 5281.9 5199.0 5221.1 5253.0 5290.6 5321.3 4731.3 4799.6 4801.5 4812.4 4825.6 4804.3 4827.3 4849.9 4861.8 4892.6 4702.1 4713.9 4734.4 4734.9 4748.5 4757.6 4769.4 4781.9 4792.7 4820.0 4634.4 4703.8 4727.6 4737.9 4766.5 5102.8 5137.3 5204.4 5227.2 5282.2 5611.9 5631.1 5664.1 5668.7 5674.9 5674.3 5687.6 5699.6 5702.1 5708.9 5158.9 5271.4 5279.6 5285.0 5347.4 5676.3 5737.8 5742.4 5749.9 5767.7 5503.2 5514.4 5550.8 5555.3 5574.6 5648.6 5653.7 5660.2 5664.9 5667.2 5598.3 5615.2 5616.3 5621.5 5627.7 5401.7 5470.3 5577.2 5580.1 5615.6 4585.3 4591.3 4610.0 4622.7 4635.3 3953.9 3961.5 3969.6 3977.7 4007.3 4716.6 4755.4 4760.8 4814.7 4887.9 5576.2 5596.5 5637.7 5639.9 5706.7 4831.2 4841.1 4846.0 4849.4 4909.8 4932.5 4933.6 4935.9 4951.1 4979.2 5155.9 5202.7 5210.4 5214.6 5248.6 5509.8 5617.9 5621.9 5628.2 5681.9 5209.8 5233.9 5264.8 5266.0 5278.3 5538.1 5572.2 5574.0 5605.0 5646.9 5471.2 5549.9 5632.2 5640.4 5677.8 5432.1 5487.4 5492.1 5494.4 5500.2 5364.5 5436.0 5454.1 5475.9 5480.8 5282.9 5321.3 5351.9 5395.6 5423.2 5510.2 5524.8 5529.9 5559.8 5588.0 5313.6 5341.5 5345.0 5360.1 5390.4 06:40:25 INFO - PID 3421 | 06:40:25 INFO - PID 3421 | [#1] ext.html Cycles:180 Average:32934.19 Median:2990.13 stddev:50688.86 (1695.2%) stddev-sans-first:50773.36 06:40:25 INFO - PID 3421 | Values: 723.2 1080.0 1096.0 1195.2 1204.6 31851.2 32457.0 32503.3 32539.3 34960.0 32331.5 32834.0 32897.0 32924.8 32962.5 7024.1 7127.9 7170.6 7295.9 7321.9 7341.2 7394.4 7479.8 7484.9 7485.9 7410.0 7489.6 7497.5 7498.4 7510.2 7419.4 7435.6 7458.2 7459.9 7462.4 7250.9 7378.6 7391.5 7392.5 7403.3 34805.3 34911.8 35015.5 35021.3 35024.3 2617.8 2631.8 2639.4 2664.6 2671.2 24227.6 24273.5 24520.1 24548.0 24910.4 2934.9 2977.2 2989.7 2989.9 2990.3 156426.0 156819.0 157495.0 158354.2 158994.0 32207.7 32252.5 37419.6 37843.4 42399.6 39641.0 39641.4 39735.6 39739.2 39791.2 12145.6 12165.1 12181.5 12208.8 12290.9 9726.2 9775.1 9811.4 9816.6 9877.2 13065.8 13142.4 13154.4 13280.1 13296.5 5525.2 5669.8 5683.9 5700.9 5749.4 848.9 890.2 892.9 898.5 929.5 20236.0 21076.0 21264.7 21332.4 21541.6 977.6 986.9 999.7 1006.5 1015.4 10379.9 10960.0 11077.6 11081.6 11167.2 210264.0 212024.0 212038.0 212149.0 212613.0 42167.4 42301.0 42434.8 42444.8 42538.6 1230.3 1236.1 1256.6 1264.4 1266.5 19846.0 19871.0 20879.0 20935.8 21128.8 29933.4 29949.6 30026.4 30072.0 30139.4 209202.0 210645.0 212126.0 212166.0 212958.0 26943.5 27419.0 27433.2 28020.0 28239.6 32923.5 32975.3 33661.7 33697.0 33703.8 24403.8 25192.9 25446.0 25791.4 26458.5 24741.3 24960.1 25741.1 26010.7 27389.0 28247.0 30549.2 30684.7 30694.5 30767.4 25502.9 25667.0 26927.3 26953.0 27940.2 20883.9 22168.0 22178.9 22281.2 22352.3 06:40:25 INFO - PID 3421 | 06:40:25 INFO - PID 3421 | [#2] jquery.html Cycles:180 Average:25195.60 Median:4993.91 stddev:65223.55 (1306.1%) stddev-sans-first:65379.99 06:40:25 INFO - PID 3421 | Values: 419.5 432.9 437.8 438.1 446.1 16592.3 16780.3 16841.7 17264.5 17355.7 17290.7 17323.2 17421.7 17467.8 18219.5 5581.8 5627.6 5639.9 5671.3 5813.0 5549.3 5638.5 5639.7 5647.1 5685.1 5473.8 5543.3 5597.7 5663.5 5667.2 5454.7 5464.4 5477.3 5493.2 5522.9 4882.2 4908.0 4987.7 4991.2 4996.7 20018.7 20401.2 20583.7 20897.1 21064.8 1554.2 1556.9 1583.2 1585.2 1594.5 13303.9 13476.3 13914.4 13993.2 14237.4 1728.2 1800.5 1807.7 1822.4 1844.9 73557.0 75016.0 75525.6 76412.2 76739.0 10583.7 10860.8 10862.2 10889.9 10963.0 15098.6 15204.2 15219.9 15227.4 15234.5 7470.6 7513.5 7668.3 7767.1 7837.9 7039.5 7123.9 7305.2 7317.2 7321.7 6643.6 6725.1 6740.0 6753.2 6814.8 1918.0 1935.6 1970.0 1986.5 1990.6 846.2 847.9 868.5 871.6 874.1 15807.8 16243.2 16557.0 16794.9 16880.4 875.7 875.8 879.9 893.1 900.2 8646.9 9211.5 9214.9 9397.1 9406.6 353970.0 397475.0 399495.0 401792.0 409785.0 83418.0 83789.0 85446.6 85643.0 90020.5 1075.0 1084.6 1088.9 1094.4 1099.1 13817.9 13857.5 13903.0 13939.1 14500.0 39720.8 40824.2 41282.4 41341.4 41558.8 52266.7 53607.5 54002.7 54645.7 55520.1 7602.8 7721.5 7777.2 7969.9 8076.9 11062.6 11089.9 11751.8 11793.5 12050.3 9964.5 10207.4 10311.8 10379.5 10548.3 9102.5 9136.2 9516.7 9573.3 9737.9 9715.5 9999.9 10146.3 10480.2 10512.7 7328.9 7372.9 7487.6 7517.5 7720.9 9051.5 9693.9 9707.3 9808.7 9979.2 06:40:25 INFO - PID 3421 | 06:40:25 INFO - PID 3421 | [#3] mootools.html Cycles:180 Average:6275.18 Median:4766.87 stddev:4017.53 (84.3%) stddev-sans-first:4011.35 06:40:25 INFO - PID 3421 | Values: 1291.2 1316.5 1320.7 1322.4 1326.1 9518.0 9906.8 9906.8 9972.6 10182.4 9879.3 10076.3 10093.2 10111.9 10115.3 2228.3 2271.9 2272.4 2274.1 2277.2 2188.6 2214.2 2236.8 2240.4 2250.3 2230.0 2232.2 2234.1 2247.6 2253.9 2011.6 2106.6 2109.0 2118.8 2119.6 1889.5 1952.5 2168.5 2213.2 2214.0 9610.0 9806.2 9854.8 9866.1 9882.1 5338.5 5592.3 5599.7 5609.8 5609.9 3068.6 3098.7 3118.1 3200.7 3246.4 1006.3 1014.3 1018.1 1045.7 1057.6 14148.7 14161.1 14228.8 14260.6 14262.6 4729.6 4804.1 4925.1 4951.8 5019.8 11052.5 11066.8 11096.9 11128.8 11131.6 5631.0 5632.6 5641.8 5642.2 5666.0 5056.6 5070.9 5110.2 5200.5 5212.4 3747.2 3886.3 3886.8 3920.1 3958.2 1114.6 1120.0 1127.8 1146.7 1156.8 660.1 685.6 692.7 694.1 706.6 5779.5 5862.8 5884.4 5886.8 6062.2 811.7 817.5 817.9 844.5 861.4 3395.2 3465.7 3498.4 3543.7 3577.1 13142.3 13423.8 13492.7 13562.4 13620.8 13246.3 13458.4 13473.8 13505.9 13515.3 9032.9 9647.4 9823.6 9828.8 9837.6 5775.7 5844.2 5899.5 5971.3 6062.1 11629.3 11737.6 11902.6 12002.5 12063.9 12281.9 12297.9 12340.4 12417.8 12425.4 7713.7 7761.1 7828.6 7837.2 7874.3 9020.0 9067.9 9100.7 9150.3 9157.5 8092.8 8123.0 8243.3 8332.2 8391.7 7387.1 7440.3 7466.1 7478.9 7615.0 7193.8 7241.4 7261.7 7296.6 7377.7 5305.7 5352.1 5373.9 5436.8 5540.6 5239.5 5322.4 5373.4 5415.5 5471.8 06:40:25 INFO - PID 3421 | 06:40:25 INFO - PID 3421 | [#4] prototype.html Cycles:180 Average:4810.51 Median:5440.01 stddev:1394.39 (25.6%) stddev-sans-first:1357.86 06:40:25 INFO - PID 3421 | Values: 368.9 398.5 401.2 402.9 404.7 5506.7 5540.3 5545.7 5564.2 5580.2 5433.3 5433.8 5437.0 5437.6 5450.2 4251.6 4324.0 4355.5 4356.2 4363.9 4311.2 4344.1 4352.6 4355.3 4357.0 4309.1 4342.0 4344.5 4353.5 4380.4 4240.7 4309.9 4335.5 4361.4 4365.3 3901.4 3908.5 3920.1 3921.0 3929.5 5341.9 5353.4 5377.1 5377.4 5401.7 4620.7 4827.8 4882.3 5056.9 5101.2 5729.7 5737.0 5738.0 5755.8 5769.9 4047.6 4068.7 4069.1 4073.2 4087.2 6002.2 6052.7 6073.5 6128.9 6151.4 4134.8 4154.5 4155.2 4156.4 4160.7 4229.6 4232.6 4235.6 4243.9 4249.0 4699.4 4781.9 4836.4 4837.9 4874.6 5756.6 5765.9 5775.9 5788.2 5789.8 1453.9 1456.7 1466.1 1473.4 1475.9 940.3 994.8 997.8 1002.3 1012.5 4993.9 5021.3 5035.9 5046.2 5053.5 5975.8 5981.9 5993.8 6018.0 6043.8 4854.2 4927.0 4992.5 5002.4 5003.0 3171.5 3202.9 3204.0 3209.6 3222.6 5574.8 5591.4 5597.4 5609.6 5614.7 5868.6 5945.4 6128.5 6183.2 6199.7 5542.3 5568.0 5593.6 5606.3 5625.1 6007.2 6015.6 6042.6 6050.6 6052.4 5711.2 5867.3 5898.1 5923.8 5938.3 5556.9 5582.6 5588.1 5597.7 5636.3 4157.6 4164.0 4172.7 4176.8 4189.4 5810.4 5955.4 5984.3 6008.3 6016.6 5757.8 5764.1 5769.2 5786.6 5824.6 5442.4 5781.0 5783.7 5794.2 5801.6 5746.3 5787.4 5789.8 5789.9 5791.6 5912.4 5917.3 5917.7 5940.6 5940.8 5565.2 5687.2 5691.2 5712.4 5733.8 06:40:25 INFO - PID 3421 | 06:40:25 INFO - PID 3421 | [#5] yui.html Cycles:180 Average:13682.47 Median:541.17 stddev:16930.33 (3128.5%) stddev-sans-first:16949.69 06:40:25 INFO - PID 3421 | Values: 685.4 685.6 689.2 696.5 702.6 14691.7 15299.1 15307.4 15337.5 15341.0 13543.8 13554.7 13648.5 13683.0 13786.4 816.3 816.4 832.1 834.9 836.5 812.1 844.5 849.0 849.6 851.1 879.5 883.2 883.6 885.7 889.1 871.5 877.3 878.8 879.7 890.3 647.7 647.7 648.1 648.8 651.0 13356.5 13485.1 13516.1 13692.3 14241.8 12285.5 12786.7 12932.6 13327.9 13390.7 9700.4 9750.3 9841.4 9889.6 10461.5 2540.8 2547.7 2566.5 2630.3 2638.7 62176.0 63084.7 63177.0 64278.4 64456.4 9900.9 10093.4 10235.4 10263.6 10415.9 21708.3 21780.5 21961.8 21965.0 21989.3 6306.4 6311.8 6328.8 6518.6 6604.9 3219.3 3296.5 3326.0 3332.7 3440.3 3498.3 3609.1 3643.5 3645.4 3680.9 680.6 690.2 691.1 713.0 718.9 540.4 547.2 551.3 566.5 569.9 8374.6 8901.2 8917.8 8984.3 9089.2 527.8 541.9 559.7 560.9 561.9 3853.3 3863.7 3871.7 3971.1 3980.9 60268.0 60335.4 61004.2 61899.4 62248.6 45327.1 52159.2 52232.0 53693.0 55108.0 49107.3 49711.3 50374.7 50535.0 50895.5 7593.6 7909.4 7970.1 8012.4 8072.9 25771.2 25895.1 26311.6 26763.2 26836.2 30636.2 31172.4 31518.0 31899.8 32449.5 9751.8 9803.8 9827.8 9902.4 10365.1 10463.7 10565.7 10605.2 10742.0 10760.7 9782.9 10584.6 10626.7 10663.3 11054.9 10177.0 10288.1 10449.9 10665.1 10794.5 10205.5 10207.2 10445.0 10506.2 10740.1 6824.5 7075.6 7298.2 7326.0 7479.9 7945.0 8017.8 8711.0 8802.6 8957.6 06:40:25 INFO - PID 3421 | -------- Summary: end -------- 06:40:25 INFO - PID 3421 | 06:40:26 INFO - TEST-INFO | 3421: exit 0 06:40:26 INFO - TEST-OK | dromaeo_css | took 1120826ms 06:40:26 INFO - TEST-START | kraken 06:40:26 INFO - operating with platform_type : linux_ 06:40:26 INFO - Initialising browser for kraken test... 06:40:26 INFO - TEST-INFO | started process 3834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYahNzC/profile http://localhost:60997/getInfo.html) 06:40:30 INFO - PID 3834 | __metrics Screen width/height:1600/1200 06:40:30 INFO - PID 3834 | colorDepth:24 06:40:30 INFO - PID 3834 | Browser inner width/height: 1024/697 06:40:30 INFO - PID 3834 | __metrics 06:40:31 ERROR - PID 3834 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3388: TypeError: this.tabs is undefined 06:40:32 INFO - TEST-INFO | 3834: exit 0 06:40:32 INFO - Browser initialized. 06:40:32 INFO - Running cycle 1/1 for kraken test... 06:40:32 INFO - TEST-INFO | started process 3964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYahNzC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:44 INFO - PID 3964 | RSS: Main: 155967488 06:40:44 INFO - PID 3964 | 06:40:47 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60997/tests/kraken/driver.html?testName=audio-beat-detection) 06:40:48 INFO - PID 3964 | RSS: Main: 161533952 06:40:48 INFO - PID 3964 | 06:40:50 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60997/tests/kraken/driver.html?testName=audio-dft) 06:40:51 INFO - PID 3964 | RSS: Main: 160903168 06:40:51 INFO - PID 3964 | 06:40:54 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60997/tests/kraken/driver.html?testName=audio-fft) 06:40:55 INFO - PID 3964 | RSS: Main: 157650944 06:40:55 INFO - PID 3964 | 06:40:57 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60997/tests/kraken/driver.html?testName=audio-oscillator) 06:40:57 INFO - PID 3964 | RSS: Main: 158449664 06:40:57 INFO - PID 3964 | 06:41:00 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60997/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:41:00 INFO - PID 3964 | RSS: Main: 158810112 06:41:00 INFO - PID 3964 | 06:41:03 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60997/tests/kraken/driver.html?testName=imaging-darkroom) 06:41:04 INFO - PID 3964 | RSS: Main: 163819520 06:41:04 INFO - PID 3964 | 06:41:08 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60997/tests/kraken/driver.html?testName=imaging-desaturate) 06:41:08 INFO - PID 3964 | RSS: Main: 161042432 06:41:08 INFO - PID 3964 | 06:41:11 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60997/tests/kraken/driver.html?testName=json-parse-financial) 06:41:12 INFO - PID 3964 | RSS: Main: 162263040 06:41:12 INFO - PID 3964 | 06:41:14 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60997/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:41:14 INFO - PID 3964 | RSS: Main: 162705408 06:41:14 INFO - PID 3964 | 06:41:16 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:41:17 INFO - PID 3964 | RSS: Main: 162594816 06:41:17 INFO - PID 3964 | 06:41:19 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:41:20 INFO - PID 3964 | RSS: Main: 162963456 06:41:20 INFO - PID 3964 | 06:41:22 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:41:23 INFO - PID 3964 | RSS: Main: 163545088 06:41:23 INFO - PID 3964 | 06:41:26 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:41:27 INFO - PID 3964 | RSS: Main: 166617088 06:41:27 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:60997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60997/tests/kraken/driver.html?testName=ai-astar) 06:41:29 INFO - PID 3964 | RSS: Main: 167534592 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | __start_tp_report 06:41:29 INFO - PID 3964 | _x_x_mozilla_page_load 06:41:29 INFO - PID 3964 | _x_x_mozilla_page_load_details 06:41:29 INFO - PID 3964 | |i|pagename|runs| 06:41:29 INFO - PID 3964 | |0;ai-astar;104;111;110;113;111;111;111;110;111;111 06:41:29 INFO - PID 3964 | |1;audio-beat-detection;154;126;128;174;125;127;134;129;148;127 06:41:29 INFO - PID 3964 | |2;audio-dft;163;167;163;169;173;165;169;165;164;163 06:41:29 INFO - PID 3964 | |3;audio-fft;75;75;75;108;76;75;75;77;92;75 06:41:29 INFO - PID 3964 | |4;audio-oscillator;86;84;116;85;86;85;97;84;85;111 06:41:29 INFO - PID 3964 | |5;imaging-gaussian-blur;114;115;115;114;115;114;115;114;114;114 06:41:29 INFO - PID 3964 | |6;imaging-darkroom;150;150;151;150;150;151;151;150;151;151 06:41:29 INFO - PID 3964 | |7;imaging-desaturate;95;95;95;95;94;95;94;96;94;95 06:41:29 INFO - PID 3964 | |8;json-parse-financial;68;69;74;70;69;70;71;69;71;71 06:41:29 INFO - PID 3964 | |9;json-stringify-tinderbox;55;56;55;56;55;59;55;56;55;55 06:41:29 INFO - PID 3964 | |10;stanford-crypto-aes;85;92;84;84;82;83;89;82;83;82 06:41:29 INFO - PID 3964 | |11;stanford-crypto-ccm;137;135;137;146;136;148;134;136;223;142 06:41:29 INFO - PID 3964 | |12;stanford-crypto-pbkdf2;203;204;190;197;195;185;192;185;194;191 06:41:29 INFO - PID 3964 | |13;stanford-crypto-sha256-iterative;73;73;75;75;71;71;74;72;71;69 06:41:29 INFO - PID 3964 | __end_tp_report 06:41:29 INFO - PID 3964 | __start_cc_report 06:41:29 INFO - PID 3964 | _x_x_mozilla_cycle_collect,859 06:41:29 INFO - PID 3964 | __end_cc_report 06:41:29 INFO - PID 3964 | __startTimestamp1490276489614__endTimestamp 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | ------- Summary: start ------- 06:41:29 INFO - PID 3964 | Number of tests: 14 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.36 (2.1%) stddev-sans-first:0.87 06:41:29 INFO - PID 3964 | Values: 104.0 111.0 110.0 113.0 111.0 111.0 111.0 110.0 111.0 111.0 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:131.50 stddev:16.32 (12.4%) stddev-sans-first:16.14 06:41:29 INFO - PID 3964 | Values: 154.0 126.0 128.0 174.0 125.0 127.0 134.0 129.0 148.0 127.0 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.00 stddev:3.35 (2.0%) stddev-sans-first:3.36 06:41:29 INFO - PID 3964 | Values: 163.0 167.0 163.0 169.0 173.0 165.0 169.0 165.0 164.0 163.0 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:11.07 (14.8%) stddev-sans-first:11.57 06:41:29 INFO - PID 3964 | Values: 75.0 75.0 75.0 108.0 76.0 75.0 75.0 77.0 92.0 75.0 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:85.00 stddev:12.06 (14.2%) stddev-sans-first:12.60 06:41:29 INFO - PID 3964 | Values: 86.0 84.0 116.0 85.0 86.0 85.0 97.0 84.0 85.0 111.0 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:41:29 INFO - PID 3964 | Values: 114.0 115.0 115.0 114.0 115.0 114.0 115.0 114.0 114.0 114.0 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 06:41:29 INFO - PID 3964 | Values: 150.0 150.0 151.0 150.0 150.0 151.0 151.0 150.0 151.0 151.0 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 06:41:29 INFO - PID 3964 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 96.0 94.0 95.0 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | [#8] json-parse-financial Cycles:10 Average:70.20 Median:70.50 stddev:1.69 (2.4%) stddev-sans-first:1.59 06:41:29 INFO - PID 3964 | Values: 68.0 69.0 74.0 70.0 69.0 70.0 71.0 69.0 71.0 71.0 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:55.50 stddev:1.25 (2.3%) stddev-sans-first:1.30 06:41:29 INFO - PID 3964 | Values: 55.0 56.0 55.0 56.0 55.0 59.0 55.0 56.0 55.0 55.0 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:3.34 (4.0%) stddev-sans-first:3.54 06:41:29 INFO - PID 3964 | Values: 85.0 92.0 84.0 84.0 82.0 83.0 89.0 82.0 83.0 82.0 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:139.50 stddev:26.99 (19.3%) stddev-sans-first:28.36 06:41:29 INFO - PID 3964 | Values: 137.0 135.0 137.0 146.0 136.0 148.0 134.0 136.0 223.0 142.0 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.60 Median:194.50 stddev:6.50 (3.3%) stddev-sans-first:5.94 06:41:29 INFO - PID 3964 | Values: 203.0 204.0 190.0 197.0 195.0 185.0 192.0 185.0 194.0 191.0 06:41:29 INFO - PID 3964 | 06:41:29 INFO - PID 3964 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.00 stddev:1.96 (2.7%) stddev-sans-first:2.06 06:41:29 INFO - PID 3964 | Values: 73.0 73.0 75.0 75.0 71.0 71.0 74.0 72.0 71.0 69.0 06:41:29 INFO - PID 3964 | -------- Summary: end -------- 06:41:29 INFO - PID 3964 | 06:41:30 INFO - TEST-INFO | 3964: exit 0 06:41:30 INFO - TEST-OK | kraken | took 64930ms 06:41:30 INFO - SUITE-END | took 1185s 06:41:31 INFO - Completed test suite (00:19:46) 06:41:31 INFO - javascript benchmark 06:41:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6575.126227665003, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2680.6468669253863, 2710.5798601216807, 2726.6319046928656, 2752.972470275298, 2764.57149141883, 5121.052605268028, 5205.817796377128, 5245.973770131149, 5252.8161514347, 5281.867953301169, 5198.974005129979, 5221.1385121455005, 5253.0, 5290.629655924087, 5321.308229930104, 4731.266653668687, 4799.640026997971, 4801.4718380978065, 4812.350332705075, 4825.638077144211, 4804.303376010476, 4827.275908613701, 4849.927251091236, 4861.829835955742, 4892.608591312704, 4702.130105930414, 4713.929291060636, 4734.4081989751285, 4734.857954261378, 4748.5251474852585, 4757.5718185363485, 4769.356136921506, 4781.880452988668, 4792.688475249098, 4820.0, 4634.397528321297, 4703.7883295251795, 4727.598154156901, 4737.857864264078, 4766.547178018082, 5102.821401250975, 5137.3064636274, 5204.4014938281825, 5227.242049902781, 5282.181261904372, 5611.943880561183, 5631.099024156116, 5664.0937450007805, 5668.716564171817, 5674.914876276818, 5674.319081710221, 5687.630304030225, 5699.629524080921, 5702.087665973424, 5708.857278568027, 5158.896822063538, 5271.446498117719, 5279.551238144801, 5285.022270879899, 5347.358317001985, 5676.318841739017, 5737.799177028867, 5742.397048309951, 5749.913751293734, 5767.740451679684, 5503.174523821459, 5514.448555144453, 5550.805721799798, 5555.30558680165, 5574.554035677136, 5648.63283886546, 5653.66078035311, 5660.179274005246, 5664.8867022659315, 5667.1782591524, 5598.300212473441, 5615.185798059259, 5616.269884914935, 5621.494065534122, 5627.746751396197, 5401.729913504388, 5470.316210473691, 5577.191307260506, 5580.079286917694, 5615.578831587647, 4585.266357382803, 4591.334256532784, 4610.0, 4622.653301002371, 4635.258358662598, 3953.920921581552, 3961.5246170459727, 3969.6030396960073, 3977.741446806006, 4007.318755811519, 4716.622670186377, 4755.429348478205, 4760.761961901961, 4814.735189564538, 4887.877803054952, 5576.163575463713, 5596.496315331639, 5637.661740295595, 5639.915401268902, 5706.71466426677, 4831.154547954094, 4841.055994081191, 4845.9757701211975, 4849.393825771778, 4909.754512274372, 4932.531409516162, 4933.58064564516, 4935.90128197434, 4951.059298733229, 4979.2033274676605, 5155.896882062413, 5202.739863006759, 5210.426853046238, 5214.582833373397, 5248.632595718415, 5509.779608815603, 5617.943820561742, 5621.9156712650165, 5628.183913332626, 5681.857953551194, 5209.791608335624, 5233.895322093461, 5264.763085661231, 5266.0257852297445, 5278.313819203479, 5538.086215774513, 5572.192032155396, 5574.0, 5605.019121653776, 5646.887062258814, 5471.206675032177, 5549.861253468534, 5632.155176723524, 5640.4077571856005, 5677.77288908439, 5432.1308590626895, 5487.42382049895, 5492.148716948879, 5494.36814766291, 5500.1749737539685, 5364.463553644604, 5435.972820135874, 5454.10007348783, 5475.863103422446, 5480.753366098615, 5282.943411317675, 5321.2816269804625, 5351.929614077278, 5395.649282796606, 5423.2407462954425, 5510.228568000403, 5524.779008839601, 5529.917051244315, 5559.777608895599, 5588.022096133242, 5313.574914006793, 5341.519263266325, 5345.037893179265, 5360.088784906653, 5390.434004429635], "value": 5114.24534381387, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.197251051333, 1079.9946000269997, 1095.9726006849828, 1195.2171327780295, 1204.58441837566, 31851.203719907015, 32457.0, 32503.349933001355, 32539.349213015754, 34960.0, 32331.515027274552, 32834.0, 32897.0, 32924.835375823146, 32962.50556241658, 7024.051753013355, 7127.857442851166, 7170.569765814042, 7295.8540829183385, 7321.926780732204, 7341.229170937028, 7394.408447324201, 7479.813004674872, 7484.850302993937, 7485.9251407486045, 7410.03669522964, 7489.550626962372, 7497.512661677001, 7498.4001279897475, 7510.248975102473, 7419.443541734391, 7435.628218589049, 7458.179600243969, 7459.925400745978, 7462.440316976248, 7250.891236631454, 7378.557286562824, 7391.519551229153, 7392.482526223166, 7403.259674032607, 34805.30389392198, 34911.825440872635, 35015.4747678785, 35021.29957400863, 35024.29951400957, 2617.764401203901, 2631.8026148038975, 2639.366552027519, 2664.6402735630636, 2671.18152614829, 24227.636585451233, 24273.514529709482, 24520.14179503709, 24548.0, 24910.37724056895, 2934.8826046958097, 2977.166393409827, 2989.656189538209, 2989.910302690923, 2990.3421247325773, 156425.99999999886, 156819.0, 157495.0, 158354.20822895927, 158994.0, 32207.677923220937, 32252.516212256836, 37419.62580374216, 37843.4323485148, 42399.57600424018, 39641.0, 39641.40537891934, 39735.60264397319, 39739.20521589552, 39791.20417591632, 12145.574904878464, 12165.14843960932, 12181.451834667461, 12208.816867746991, 12290.877091229153, 9726.221902247804, 9775.071368220008, 9811.362261452983, 9816.558254878548, 9877.209823214125, 13065.804012939814, 13142.4085916134, 13154.4080516377, 13280.136791108547, 13296.468141274434, 5525.171224316385, 5669.773209071674, 5683.914741278884, 5700.914486282709, 5749.425057494217, 848.9320854331638, 890.2121622364255, 892.8973168085623, 898.4654130792168, 929.5212965322864, 20236.0, 21076.0, 21264.681029784566, 21332.36002919915, 21541.56916861654, 977.5503268496429, 986.9407835529892, 999.7450650084328, 1006.5219020964983, 1015.421209910344, 10379.948100259602, 10960.0, 11077.556897724, 11081.556737730562, 11167.218294719292, 210264.0, 212024.0, 212038.0, 212149.0, 212613.0, 42167.36748948768, 42301.0, 42434.787826060674, 42444.78777606092, 42538.57461425408, 1230.2925817654884, 1236.140882086941, 1256.591607727474, 1264.4057293072242, 1266.5060626355728, 19846.0, 19871.0, 20879.033063629886, 20935.790642093383, 21128.78871211268, 29933.401331973673, 29949.55075673823, 30026.399472010875, 30072.0, 30139.397212056076, 209202.0, 210645.0, 212126.0, 212166.0, 212958.0, 26943.461130776883, 27419.0, 27433.177004689893, 28020.0, 28239.57640635351, 32923.50614740733, 32975.34049318952, 33661.66338336683, 33697.0, 33703.83148084244, 24403.755962440857, 25192.874035629706, 25446.0, 25791.355216119748, 26458.470830582897, 24741.25776226716, 24960.126395576066, 25741.099061532757, 26010.73989260159, 27389.0, 28247.0, 30549.23626909345, 30684.693153068183, 30694.539581906734, 30767.384652307275, 25502.872485637454, 25667.0, 26927.326816829736, 26953.0, 27940.161795146178, 20883.895580522, 22168.0, 22178.889105554368, 22281.220157294418, 22352.329430117123], "value": 14718.99953403215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.5385076415945, 432.89826890680683, 437.84675363622716, 438.145616048705, 446.0788471805721, 16592.33630654774, 16780.328786848513, 16841.708193531733, 17264.48206553802, 17355.652886942255, 17290.740638890427, 17323.22045507952, 17421.651566968652, 17467.82532174678, 18219.544511387223, 5581.804636837712, 5627.634203776762, 5639.915401268984, 5671.347795003566, 5813.0, 5549.250851135105, 5638.492535671789, 5639.661620302774, 5647.09646456567, 5685.118806584986, 5473.781048758045, 5543.25166102575, 5597.6641401516035, 5663.5186009189265, 5667.206591077253, 5454.699991500466, 5464.371597266306, 5477.287952566161, 5493.23094766733, 5522.861928451781, 4882.170031094723, 4907.950920490821, 4987.675801072919, 4991.176455884774, 4996.650234483587, 20018.69971950422, 20401.183952641877, 20583.691244631344, 20897.05963231658, 21064.789352106436, 1554.1529866222936, 1556.8520990505883, 1583.2400447785012, 1585.2232406121034, 1594.4658539389202, 13303.933480332536, 13476.25880576568, 13914.37385317653, 13993.230372329517, 14237.43050277998, 1728.1877517566722, 1800.5138612574663, 1807.7288406739094, 1822.362173239369, 1844.8524118070522, 73557.0, 75016.0, 75525.62237188834, 76412.23587764162, 76739.0, 10583.682489525327, 10860.782784344268, 10862.239643225057, 10889.945550272198, 10963.0, 15098.622534436507, 15204.239788010555, 15219.923900380427, 15227.390904363701, 15234.466793662168, 7470.59571181355, 7513.511621744678, 7668.309852113337, 7767.067951845702, 7837.882431763414, 7039.472039597051, 7123.928760712327, 7305.196428392873, 7317.231690672403, 7321.707131714672, 6643.608301011632, 6725.125733654593, 6740.0, 6753.189617245962, 6814.829629259309, 1918.0026386279335, 1935.554822390858, 1970.0346830053456, 1986.5430950881378, 1990.601325402886, 846.221476241859, 847.9109693482095, 868.5136323658771, 871.6469829718974, 874.0778478705028, 15807.841921580866, 16243.187840607923, 16557.0, 16794.916025419796, 16880.409185678443, 875.7022612311845, 875.7766769473743, 879.9032106468284, 893.1024320557798, 900.1673452056821, 8646.870296945552, 9211.493367864832, 9214.90785092154, 9397.107274808883, 9406.623735050658, 353970.0, 397475.0, 399495.0, 401792.0, 409785.0, 83418.0, 83789.0, 85446.57276713701, 85643.0, 90020.5498972501, 1074.99462502687, 1084.5932775209296, 1088.9455527223606, 1094.370736826328, 1099.1097211258907, 13817.930910345383, 13857.514986975408, 13903.0, 13939.09395889264, 14500.0, 39720.801395992836, 40824.183516328914, 41282.38076428916, 41341.37987930123, 41558.7920710929, 52266.69323304556, 53607.46392536024, 54002.72998634982, 54645.72677136589, 55520.11359204817, 7602.809929751579, 7721.498102623312, 7777.183395743592, 7969.880451793112, 8076.878846817185, 11062.557497700001, 11089.889101108885, 11751.764964700487, 11793.469293881968, 12050.288685045794, 9964.451955142536, 10207.438590877277, 10311.793764124826, 10379.53292101842, 10548.314359566604, 9102.544872756469, 9136.223421009023, 9516.666916657883, 9573.32986690925, 9737.853932191165, 9715.514224288898, 9999.900000999896, 10146.340487868265, 10480.161587073168, 10512.684619461428, 7328.853422931618, 7372.926270737438, 7487.588182650006, 7517.473776835788, 7720.884186737091, 9051.547422628973, 9693.905534032256, 9707.271954603575, 9808.705738827846, 9979.201663866728], "value": 8569.56063466568, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1291.2317171283087, 1316.4602512969684, 1320.702841860581, 1322.3586560518147, 1326.138010293309, 9518.0, 9906.801863962717, 9906.801863962717, 9972.601095956172, 10182.389056656606, 9879.308448408614, 10076.294659373847, 10093.243006774484, 10111.898881011188, 10115.330970389896, 2228.342638921518, 2271.8750468724215, 2272.3864556569797, 2274.1358283852196, 2277.202978957368, 2188.627933251343, 2214.1807531213394, 2236.798688118069, 2240.4174914522177, 2250.324902529243, 2229.9554008919813, 2232.162938897913, 2234.117523578194, 2247.5617254635354, 2253.9323820285335, 2011.5775687105725, 2106.631339515586, 2109.0193060226993, 2118.8304935605115, 2119.6290649136417, 1889.527618095476, 1952.492351988479, 2168.479564904427, 2213.192184852517, 2214.047959377467, 9609.951950240204, 9806.16647584956, 9854.802903941953, 9866.062724041205, 9882.11061004513, 5338.546223571001, 5592.328920529521, 5599.6640201587625, 5609.831705048855, 5609.887802243932, 3068.6164229471315, 3098.690130986906, 3118.1269244611544, 3200.6639302873095, 3246.350729854015, 1006.3408467453829, 1014.2697257974247, 1018.1294992781139, 1045.7019749371468, 1057.6404022632341, 14148.717025659533, 14161.079529830527, 14228.786568201382, 14260.643483912881, 14262.57212283633, 4729.62840776171, 4804.111239420718, 4925.11347957364, 4951.752412379366, 5019.799208031711, 11052.502637381338, 11066.778664426667, 11096.889031109586, 11128.777424451466, 11131.610393636183, 5631.0, 5632.633878797865, 5641.802536911188, 5642.210090587321, 5665.971670141623, 5056.570191533688, 5070.923936140961, 5110.233464980282, 5200.531952124327, 5212.374515058142, 3747.1756213632957, 3886.300465916162, 3886.7667939923695, 3920.09837737322, 3958.2281455115976, 1114.5820317380983, 1119.9776004479866, 1127.7800828838297, 1146.7133216695827, 1156.8149096144577, 660.131926516629, 685.5680921019725, 692.6640579319027, 694.0595493106767, 706.5725236232006, 5779.537636989031, 5862.765489380462, 5884.411558844081, 5886.823395298148, 6062.242219722535, 811.7199566149669, 817.4686453804956, 817.8895849060419, 844.5312851367427, 861.4056301152185, 3395.2021275000357, 3465.653434656514, 3498.370293347171, 3543.7165026797793, 3577.0520811984843, 13142.277174755289, 13423.798643020362, 13492.730145397038, 13562.389692463863, 13620.795688064687, 13246.271455069871, 13458.394372253271, 13473.797893031613, 13505.932470337586, 13515.25666088355, 9032.8645070324, 9647.372920760128, 9823.557939892722, 9828.803423931624, 9837.557309920927, 5775.740091695968, 5844.181814545882, 5899.46904778572, 5971.343152253336, 6062.090686397076, 11629.302241865515, 11737.647870563897, 11902.642920712393, 12002.519899204284, 12063.939680301542, 12281.877181228074, 12297.938510307391, 12340.444679989243, 12417.813732793835, 12425.37873106359, 7713.652885620048, 7761.146273909978, 7828.569428681477, 7837.216278372345, 7874.291313781787, 9020.0, 9067.909320906707, 9100.726978190665, 9150.313726470675, 9157.542122893696, 8092.797680058045, 8122.959385203036, 8243.299319557666, 8332.16678332162, 8391.706290279812, 7387.1135463744695, 7440.255974402517, 7466.066741657293, 7478.887816682863, 7614.961925190339, 7193.82015449597, 7241.4206863451855, 7261.745838895613, 7296.562206267641, 7377.704891804267, 5305.734713264244, 5352.116900711339, 5373.93417802224, 5436.7553460093595, 5540.63985840919, 5239.47605239473, 5322.38792538863, 5373.4417019065595, 5415.458454154711, 5471.835844924659], "value": 4720.357016329896, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.91354959643843, 398.47600405466807, 401.19960678446495, 402.93955906614, 404.70860980094324, 5506.659669640402, 5540.252065971093, 5545.667259964405, 5564.248826408434, 5580.190872323511, 5433.347998240217, 5433.782648694058, 5437.0, 5437.6465529740535, 5450.1931505274815, 4251.638610718085, 4323.978380108095, 4355.477342718862, 4356.237658409781, 4363.890902727441, 4311.210847498284, 4344.066025804452, 4352.586504282088, 4355.259605866994, 4357.0, 4309.116631090635, 4342.044750154961, 4344.45694288214, 4353.521112677603, 4380.408644832939, 4240.703150779431, 4309.870703878857, 4335.544767799399, 4361.389405483234, 4365.301551751721, 3901.43429202764, 3908.530976282836, 3920.137569734654, 3920.9607903920883, 3929.548101968253, 5341.919871201935, 5353.384360798519, 5377.139657654796, 5377.435369286208, 5401.7299135043095, 4620.676552641316, 4827.831025914112, 4882.292067650171, 5056.873578160538, 5101.15830887903, 5729.656220626775, 5736.971315143439, 5738.0, 5755.769769209227, 5769.855753606152, 4047.6357127858632, 4068.7151899367054, 4069.1454794493193, 4073.205724883649, 4087.162131763011, 6002.169338351801, 6052.668412949144, 6073.483753880925, 6128.877422451571, 6151.446369826737, 4134.813933373005, 4154.543000269968, 4155.221495280452, 4156.376543518496, 4160.729552579072, 4229.59818817218, 4232.597903199191, 4235.618794308527, 4243.936340954888, 4248.978755106266, 4699.449181770007, 4781.856544303677, 4836.395450568679, 4837.9032419351415, 4874.561289483963, 5756.597038207286, 5765.88468230633, 5775.913361299584, 5788.221653606209, 5789.797357092481, 1453.8805120057707, 1456.7450696128135, 1466.0763718857265, 1473.4179998900588, 1475.852414758537, 940.2665920581957, 994.7662299359645, 997.7655251016006, 1002.3484734922358, 1012.4684540616088, 4993.875153121128, 5021.347224860745, 5035.874103147451, 5046.1673823818655, 5053.46938571452, 5975.820725378246, 5981.940180598225, 5993.760249589967, 6017.969910150421, 6043.848903777441, 4854.17479028566, 4927.0, 4992.450830408652, 5002.374703162105, 5003.024410240041, 3171.5242713592684, 3202.9359412811614, 3203.9679603204136, 3209.5667084943234, 3222.5810644616517, 5574.832755017356, 5591.384947655754, 5597.356304025089, 5609.635373700697, 5614.663120212718, 5868.618539794899, 5945.40545945402, 6128.540359473057, 6183.196184496077, 6199.659018753921, 5542.279503664578, 5568.0, 5593.552515798727, 5606.299212598426, 5625.099984002458, 6007.189029481139, 6015.608985415934, 6042.637441753509, 6050.6369617823075, 6052.394760523913, 5711.171880077282, 5867.325257595431, 5898.06976802247, 5923.763049477972, 5938.257717785277, 5556.860843527148, 5582.609217354746, 5588.105903055492, 5597.692126933058, 5636.2954630671165, 4157.584241575818, 4164.02208950746, 4172.728772629769, 4176.812043458112, 4189.392538082022, 5810.389909059657, 5955.40445955401, 5984.341722410619, 6008.339082700987, 6016.578839481194, 5757.798477053283, 5764.135379692912, 5769.1634712967225, 5786.594938354275, 5824.563157763269, 5442.374126975448, 5780.976658169607, 5783.710814459344, 5794.246747922743, 5801.564882633735, 5746.2529871116485, 5787.363390027178, 5789.768409263583, 5789.884202315846, 5791.594588378773, 5912.408759124053, 5917.289925209003, 5917.698106416581, 5940.584159108821, 5940.7920722776225, 5565.165225216088, 5687.1753595729215, 5691.2032315475035, 5712.400197979152, 5733.770649174153], "value": 4382.052548713911, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.4208194076006, 685.6126288646917, 689.2142957028984, 696.5124412910964, 702.5749421599934, 14691.706165876689, 15299.082055076704, 15307.387704491835, 15337.463188788395, 15341.0, 13543.796843047363, 13554.728905421885, 13648.45406183754, 13683.0, 13786.379612917417, 816.2694388522254, 816.4407380944043, 832.1013305629936, 834.9123342049088, 836.4646626159263, 812.1066826490871, 844.4848642328175, 849.0448245723561, 849.6389034660275, 851.0978362935277, 879.4767113567417, 883.2139395937621, 883.575883575884, 885.6767279942807, 889.0753616239136, 871.533729454745, 877.3244601656688, 878.8418084744743, 879.7184900831736, 890.3455959869491, 647.6988200486796, 647.7085311609794, 648.099142192353, 648.8118445650756, 651.0234648027958, 13356.465741370333, 13485.123466974615, 13516.12145210558, 13692.315384230847, 14241.78637320441, 12285.452610213142, 12786.680332991657, 12932.612021639367, 13327.866721332759, 13390.732185356335, 9700.369475984038, 9750.268729845218, 9841.409515429026, 9889.554970026295, 10461.476926153739, 2540.7840333571485, 2547.6942766868096, 2566.4995325911455, 2630.302969713008, 2638.6569745933098, 62176.0, 63084.68457657728, 63177.0, 64278.35721642771, 64456.355436445505, 9900.851487227697, 10093.394396336244, 10235.43705096212, 10263.640772572924, 10415.947920260502, 21708.348749537538, 21780.45548861291, 21961.78038219629, 21965.0, 21989.340319790434, 6306.369363063657, 6311.798046348202, 6328.778492752732, 6518.57629254097, 6604.900926486107, 3219.2917558137174, 3296.489044198153, 3325.966740332614, 3332.7333813294877, 3440.3291358184915, 3498.3003399320237, 3609.061643972586, 3643.4899114124046, 3645.434957581579, 3680.9263814723554, 680.6494655252549, 690.1545606631936, 691.1153723234269, 712.9572225666477, 718.9137303523506, 540.446042806119, 547.2448021729987, 551.3383939272888, 566.498648695907, 569.9373068962411, 8374.581270936429, 8901.198892099743, 8917.821643567093, 8984.32617553686, 9089.181973622406, 527.8231792349605, 541.894330605536, 559.7089513452981, 560.8502569732033, 561.9297587801525, 3853.344931361675, 3863.7102217333813, 3871.728978971445, 3971.146203566247, 3980.8877775852366, 60268.0, 60335.396646033856, 61004.169874903826, 61899.38100618936, 62248.64259501791, 45327.09345813131, 52159.217611735854, 52232.0, 53693.0, 55108.0, 49107.26339104845, 49711.25433118506, 50374.74812625913, 50535.0, 50895.49104508982, 7593.5823529706395, 7909.446338756232, 7970.123286438603, 8012.439129260896, 8072.878906816285, 25771.226863194133, 25895.0936717214, 26311.60532592051, 26763.19710408691, 26836.194914152606, 30636.234094147825, 31172.37655246928, 31518.0, 31899.840500798276, 32449.51325730163, 9751.804963900824, 9803.803923921625, 9827.803443930938, 9902.356346837432, 10365.06714395708, 10463.738406539593, 10565.671813378762, 10605.204609654153, 10742.04104738863, 10760.677179684622, 9782.9021709782, 10584.629537966135, 10626.73433164177, 10663.253572250178, 11054.944725276322, 10177.0, 10288.12550933179, 10449.895501045195, 10665.146788256765, 10794.460276986276, 10205.489725513844, 10207.234457415576, 10445.0, 10506.159507239556, 10740.087092597218, 6824.454043676395, 7075.575465472089, 7298.160711518243, 7325.963370183115, 7479.88780168287, 7944.960275198819, 8017.839643206987, 8710.956445217733, 8802.64789408442, 8957.641694332153], "value": 6055.111031681762, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 110.0, 113.0, 111.0, 111.0, 111.0, 110.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 128.0, 174.0, 125.0, 127.0, 134.0, 129.0, 148.0, 127.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 163.0, 169.0, 173.0, 165.0, 169.0, 165.0, 164.0, 163.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 108.0, 76.0, 75.0, 75.0, 77.0, 92.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 116.0, 85.0, 86.0, 85.0, 97.0, 84.0, 85.0, 111.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 115.0, 114.0, 115.0, 114.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 150.0, 150.0, 151.0, 151.0, 150.0, 151.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 96.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 74.0, 70.0, 69.0, 70.0, 71.0, 69.0, 71.0, 71.0], "value": 70.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 55.0, 59.0, 55.0, 56.0, 55.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 92.0, 84.0, 84.0, 82.0, 83.0, 89.0, 82.0, 83.0, 82.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 137.0, 146.0, 136.0, 148.0, 134.0, 136.0, 223.0, 142.0], "value": 147.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 204.0, 190.0, 197.0, 195.0, 185.0, 192.0, 185.0, 194.0, 191.0], "value": 193.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 75.0, 75.0, 71.0, 71.0, 74.0, 72.0, 71.0, 69.0], "value": 72.4, "unit": "score"}]}]} 06:41:31 INFO - Return code: 0 06:41:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:41:31 ERROR - # TBPL SUCCESS # 06:41:31 INFO - Running post-action listener: _resource_record_post_action 06:41:31 INFO - [mozharness: 2017-03-23 13:41:31.412749Z] Finished run-tests step (success) 06:41:31 INFO - Running post-run listener: _resource_record_post_run 06:41:31 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 9994240; Write bytes: 371355648; Read time: 2480; Write time: 205164 06:41:31 INFO - TinderboxPrint: CPU usage
13.3% 06:41:31 INFO - TinderboxPrint: I/O read bytes / time
9,994,240 / 2,480 06:41:31 INFO - TinderboxPrint: I/O write bytes / time
371,355,648 / 205,164 06:41:31 INFO - TinderboxPrint: CPU idle
8,315.2 (86.7%) 06:41:31 INFO - TinderboxPrint: CPU user
1,218.3 (12.7%) 06:41:31 INFO - TinderboxPrint: Swap in / out
0 / 0 06:41:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 112340992; Read time: 40; Write time: 92900 06:41:31 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 8245248; Write bytes: 258609152; Read time: 2412; Write time: 112244 06:41:32 INFO - Running post-run listener: _upload_blobber_files 06:41:32 INFO - Blob upload gear active. 06:41:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:41:32 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:41:32 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:41:32 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:41:32 INFO - (blobuploader) - INFO - Open directory for files ... 06:41:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:41:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:41:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:37 INFO - (blobuploader) - INFO - Done attempting. 06:41:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:41:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:41:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:38 INFO - (blobuploader) - INFO - Done attempting. 06:41:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:41:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:41:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:38 INFO - (blobuploader) - INFO - Done attempting. 06:41:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:41:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:41:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:41:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:41:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:41:39 INFO - (blobuploader) - INFO - Done attempting. 06:41:39 INFO - (blobuploader) - INFO - Iteration through files over. 06:41:39 INFO - Return code: 0 06:41:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:41:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:41:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3309c1ce058449d1e460e9bfaa113ca717ba3cac2d1435daec170e0b9bc65a1cfc84e4a07b12edb3e371993c8a19390c50720e94447b26cbe0e1faccc95289b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bafe20b77cd87df059392417a0d2675aff60fbcd04d82cd320099dddb9b39316737abb0de77851610eebcb5c7d8a089b18b677a1d73f3b63127d1e06ae1b0b71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93fe266187f9b70410ca515bba94cf1949127eddeb2c7369a55ebf5b78f9a62b76ef8fb0450d7b276922b35d4c03b82c4626017ad5ab44f7aa160ad6c6a162ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/de8d6eaa13ba497751e2c6036d48601272b35c85538bac4227e98215aa4102c3e1136d1b748132b759d56d5baf84fb1246406260f964152a690572f695cd2368"} 06:41:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:41:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:41:39 INFO - Contents: 06:41:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3309c1ce058449d1e460e9bfaa113ca717ba3cac2d1435daec170e0b9bc65a1cfc84e4a07b12edb3e371993c8a19390c50720e94447b26cbe0e1faccc95289b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bafe20b77cd87df059392417a0d2675aff60fbcd04d82cd320099dddb9b39316737abb0de77851610eebcb5c7d8a089b18b677a1d73f3b63127d1e06ae1b0b71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93fe266187f9b70410ca515bba94cf1949127eddeb2c7369a55ebf5b78f9a62b76ef8fb0450d7b276922b35d4c03b82c4626017ad5ab44f7aa160ad6c6a162ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/de8d6eaa13ba497751e2c6036d48601272b35c85538bac4227e98215aa4102c3e1136d1b748132b759d56d5baf84fb1246406260f964152a690572f695cd2368"} 06:41:39 INFO - Running post-run listener: copy_logs_to_upload_dir 06:41:39 INFO - Copying logs to upload dir... 06:41:39 INFO - mkdir: /builds/slave/test/build/upload/logs 06:41:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.307565 ========= master_lag: 0.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-03-23 06:41:39.907595) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 06:41:39.910713) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734 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/3309c1ce058449d1e460e9bfaa113ca717ba3cac2d1435daec170e0b9bc65a1cfc84e4a07b12edb3e371993c8a19390c50720e94447b26cbe0e1faccc95289b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bafe20b77cd87df059392417a0d2675aff60fbcd04d82cd320099dddb9b39316737abb0de77851610eebcb5c7d8a089b18b677a1d73f3b63127d1e06ae1b0b71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93fe266187f9b70410ca515bba94cf1949127eddeb2c7369a55ebf5b78f9a62b76ef8fb0450d7b276922b35d4c03b82c4626017ad5ab44f7aa160ad6c6a162ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/de8d6eaa13ba497751e2c6036d48601272b35c85538bac4227e98215aa4102c3e1136d1b748132b759d56d5baf84fb1246406260f964152a690572f695cd2368"} build_url:https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/EH2rkn2cRbqtk1aw4ZiV-Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3309c1ce058449d1e460e9bfaa113ca717ba3cac2d1435daec170e0b9bc65a1cfc84e4a07b12edb3e371993c8a19390c50720e94447b26cbe0e1faccc95289b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bafe20b77cd87df059392417a0d2675aff60fbcd04d82cd320099dddb9b39316737abb0de77851610eebcb5c7d8a089b18b677a1d73f3b63127d1e06ae1b0b71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93fe266187f9b70410ca515bba94cf1949127eddeb2c7369a55ebf5b78f9a62b76ef8fb0450d7b276922b35d4c03b82c4626017ad5ab44f7aa160ad6c6a162ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/de8d6eaa13ba497751e2c6036d48601272b35c85538bac4227e98215aa4102c3e1136d1b748132b759d56d5baf84fb1246406260f964152a690572f695cd2368"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 06:41:39.937710) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 06:41:39.938062) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1490275231.197883-720370734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 06:41:40.020218) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 06:41:40.020573) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 06:41:40.020917) ========= ========= Total master_lag: 0.65 =========