builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1491454871.29 results: success (0) revision: ec8d1d3db50c85037e8077c32c8403570a5df493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 22:01:11.292795) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 22:01:11.293251) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 22:01:11.293534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 22:01:11.308227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:01:11.308581) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-05 22:01:12-- 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% 221M=0s 2017-04-05 22:01:12 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135885 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:01:11.458896) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:01:11.459269) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016757 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:01:11.508705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 22:01:11.509104) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ec8d1d3db50c85037e8077c32c8403570a5df493 --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 ec8d1d3db50c85037e8077c32c8403570a5df493 --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=a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-05 22:01:12,437 truncating revision to first 12 chars 2017-04-05 22:01:12,437 Setting DEBUG logging. 2017-04-05 22:01:12,437 attempt 1/10 2017-04-05 22:01:12,437 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ec8d1d3db50c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 22:01:13,260 unpacking tar archive at: mozilla-central-ec8d1d3db50c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.207227 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 22:01:12.730139) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 22:01:12.730466) ========= script_repo_revision: ec8d1d3db50c85037e8077c32c8403570a5df493 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 22:01:12.730889) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 22:01:12.731212) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 22:01:12.740678) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-04-05 22:01:12.740991) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:01:13 INFO - MultiFileLogger online at 20170405 22:01:13 in /builds/slave/test 22:01:13 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 22:01:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:01:13 INFO - {'append_to_log': False, 22:01:13 INFO - 'base_work_dir': '/builds/slave/test', 22:01:13 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:01:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:01:13 INFO - 'branch': 'Firefox-Non-PGO', 22:01:13 INFO - 'buildbot_json_path': 'buildprops.json', 22:01:13 INFO - 'config_files': ('talos/linux_config.py',), 22:01:13 INFO - 'default_actions': ('clobber', 22:01:13 INFO - 'read-buildbot-config', 22:01:13 INFO - 'download-and-extract', 22:01:13 INFO - 'populate-webroot', 22:01:13 INFO - 'create-virtualenv', 22:01:13 INFO - 'install', 22:01:13 INFO - 'run-tests'), 22:01:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:01:13 INFO - 'download_minidump_stackwalk': True, 22:01:13 INFO - 'download_symbols': 'ondemand', 22:01:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:01:13 INFO - 'tooltool.py': '/tools/tooltool.py', 22:01:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:01:13 INFO - '/tools/misc-python/virtualenv.py')}, 22:01:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:01:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:01:13 INFO - 'gecko_profile': False, 22:01:13 INFO - 'gecko_profile_interval': 0, 22:01:13 INFO - 'installer_path': 'installer.exe', 22:01:13 INFO - 'log_level': 'info', 22:01:13 INFO - 'log_name': 'talos', 22:01:13 INFO - 'log_to_console': True, 22:01:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:01:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:01:13 INFO - 'opt_config_files': (), 22:01:13 INFO - 'pip_index': False, 22:01:13 INFO - 'suite': 'dromaeojs-e10s', 22:01:13 INFO - 'system_bits': '32', 22:01:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:01:13 INFO - 'title': 'talos-linux64-ix-064', 22:01:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:01:13 INFO - 'use_talos_json': True, 22:01:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:01:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:01:13 INFO - 'work_dir': 'build'} 22:01:13 INFO - [mozharness: 2017-04-06 05:01:13.773866Z] Running clobber step. 22:01:13 INFO - Running pre-action listener: _resource_record_pre_action 22:01:13 INFO - Running main action method: clobber 22:01:13 INFO - rmtree: /builds/slave/test/build 22:01:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:01:14 INFO - Running post-action listener: _resource_record_post_action 22:01:14 INFO - [mozharness: 2017-04-06 05:01:14.706527Z] Finished clobber step (success) 22:01:14 INFO - [mozharness: 2017-04-06 05:01:14.706626Z] Running read-buildbot-config step. 22:01:14 INFO - Running pre-action listener: _resource_record_pre_action 22:01:14 INFO - Running main action method: read_buildbot_config 22:01:14 INFO - Using buildbot properties: 22:01:14 INFO - { 22:01:14 INFO - "project": "", 22:01:14 INFO - "product": "firefox", 22:01:14 INFO - "who": "philringnalda@gmail.com", 22:01:14 INFO - "installer_path": "public/build/target.tar.bz2", 22:01:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:01:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 22:01:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 22:01:14 INFO - "stage_platform": "linux64", 22:01:14 INFO - "basedir": "/builds/slave/test", 22:01:14 INFO - "buildnumber": 517, 22:01:14 INFO - "platform": "ubuntu64_hw", 22:01:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:01:14 INFO - "slavebuilddir": "test", 22:01:14 INFO - "taskId": "Q6d_A76FS0y0A2BmZGovOw", 22:01:14 INFO - "branch": "mozilla-central", 22:01:14 INFO - "script_repo_revision": "production", 22:01:14 INFO - "revision": "ec8d1d3db50c85037e8077c32c8403570a5df493", 22:01:14 INFO - "slavename": "talos-linux64-ix-064", 22:01:14 INFO - "repo_path": "mozilla-central" 22:01:14 INFO - } 22:01:14 INFO - Finding installer, test and symbols from parent task. 22:01:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q6d_A76FS0y0A2BmZGovOw'}, attempt #1 22:01:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q6d_A76FS0y0A2BmZGovOw'}, attempt #1 22:01:15 INFO - Task dependencies: e6TNkw5mQ_6tCd-jEbizhg 22:01:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg'}, attempt #1 22:01:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2 22:01:16 INFO - Set test_url: https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/test_packages.json 22:01:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.crashreporter-symbols.zip 22:01:16 INFO - Running post-action listener: _resource_record_post_action 22:01:16 INFO - [mozharness: 2017-04-06 05:01:16.079427Z] Finished read-buildbot-config step (success) 22:01:16 INFO - [mozharness: 2017-04-06 05:01:16.079728Z] Running download-and-extract step. 22:01:16 INFO - Running pre-action listener: _resource_record_pre_action 22:01:16 INFO - Running main action method: download_and_extract 22:01:16 INFO - mkdir: /builds/slave/test/build/tests 22:01:16 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')]} 22:01:16 INFO - trying https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.test_packages.json 22:01:16 INFO - Downloading https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:01:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:01:16 INFO - Downloaded 986 bytes. 22:01:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:01:16 INFO - Using the following test package requirements: 22:01:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 22:01:16 INFO - u'common': [u'target.common.tests.zip'], 22:01:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:01:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:01:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:01:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:01:16 INFO - u'mozbase': [u'target.common.tests.zip'], 22:01:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:01:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:01:16 INFO - u'web-platform': [u'target.common.tests.zip', 22:01:16 INFO - u'target.web-platform.tests.zip'], 22:01:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:01:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 22:01:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.common.tests.zip 22:01:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:01:16 INFO - Fetch https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.common.tests.zip into memory 22:01:17 INFO - Expected file size: 58244177 22:01:17 INFO - Obtained file size: 58244177 22:01:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 22:01:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.common.tests.zip 22:01:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:01:27 INFO - Fetch https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.common.tests.zip into memory 22:01:28 INFO - Expected file size: 58244177 22:01:28 INFO - Obtained file size: 58244177 22:01:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.talos.tests.zip 22:01:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:01:39 INFO - Fetch https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.talos.tests.zip into memory 22:01:40 INFO - Expected file size: 14404152 22:01:40 INFO - Obtained file size: 14404152 22:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:40 INFO - trying https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2 22:01:40 INFO - Downloading https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:01:41 INFO - Downloaded 57692474 bytes. 22:01:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2 22:01:41 INFO - mkdir: /builds/slave/test/properties 22:01:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:01:41 INFO - Writing to file /builds/slave/test/properties/build_url 22:01:41 INFO - Contents: 22:01:41 INFO - build_url:https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2 22:01:41 INFO - Running post-action listener: _resource_record_post_action 22:01:41 INFO - Running post-action listener: set_extra_try_arguments 22:01:41 INFO - [mozharness: 2017-04-06 05:01:41.545366Z] Finished download-and-extract step (success) 22:01:41 INFO - [mozharness: 2017-04-06 05:01:41.545461Z] Running populate-webroot step. 22:01:41 INFO - Running pre-action listener: _resource_record_pre_action 22:01:41 INFO - Running main action method: populate_webroot 22:01:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:01:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:01:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:01:41 INFO - '--tppagecycles', 22:01:41 INFO - '7'], 22:01:41 INFO - 'tests': ['tsvgm']}}, 22:01:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:01:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:01:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:01:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:01:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:01:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:01:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:01:41 INFO - 'talos_options': ['--disable-e10s'], 22:01:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:01:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:01:41 INFO - 'talos_options': ['--disable-e10s'], 22:01:41 INFO - 'tests': ['damp', 'tps']}, 22:01:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:01:41 INFO - 'tests': ['damp', 'tps']}, 22:01:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:01:41 INFO - 'tests': ['dromaeo_dom']}, 22:01:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:01:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:01:41 INFO - 'tests': ['basic_compositor_video']}, 22:01:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:01:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:01:41 INFO - 'tests': ['a11yr', 22:01:41 INFO - 'ts_paint', 22:01:41 INFO - 'tpaint', 22:01:41 INFO - 'sessionrestore', 22:01:41 INFO - 'sessionrestore_no_auto_restore', 22:01:41 INFO - 'tabpaint']}, 22:01:41 INFO - 'other-e10s': {'tests': ['a11yr', 22:01:41 INFO - 'ts_paint', 22:01:41 INFO - 'tpaint', 22:01:41 INFO - 'sessionrestore', 22:01:41 INFO - 'sessionrestore_no_auto_restore', 22:01:41 INFO - 'tabpaint']}, 22:01:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:01:41 INFO - 'ts_paint', 22:01:41 INFO - 'tpaint', 22:01:41 INFO - 'sessionrestore', 22:01:41 INFO - 'sessionrestore_no_auto_restore', 22:01:41 INFO - 'tabpaint']}, 22:01:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:01:41 INFO - 'ts_paint', 22:01:41 INFO - 'tpaint', 22:01:41 INFO - 'sessionrestore', 22:01:41 INFO - 'sessionrestore_no_auto_restore', 22:01:41 INFO - 'tabpaint']}, 22:01:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:01:41 INFO - 'tests': ['a11yr', 22:01:41 INFO - 'ts_paint', 22:01:41 INFO - 'tpaint', 22:01:41 INFO - 'sessionrestore', 22:01:41 INFO - 'sessionrestore_no_auto_restore', 22:01:41 INFO - 'tabpaint']}, 22:01:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:01:41 INFO - 'tests': ['a11yr', 22:01:41 INFO - 'ts_paint', 22:01:41 INFO - 'tpaint', 22:01:41 INFO - 'sessionrestore', 22:01:41 INFO - 'sessionrestore_no_auto_restore', 22:01:41 INFO - 'tabpaint']}, 22:01:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:01:41 INFO - 'tests': ['tsvgx', 22:01:41 INFO - 'tsvgr_opacity', 22:01:41 INFO - 'tart', 22:01:41 INFO - 'tscrollx', 22:01:41 INFO - 'cart', 22:01:41 INFO - 'tsvg_static']}, 22:01:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:01:41 INFO - 'tsvgr_opacity', 22:01:41 INFO - 'tart', 22:01:41 INFO - 'tscrollx', 22:01:41 INFO - 'cart', 22:01:41 INFO - 'tsvg_static']}, 22:01:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:01:41 INFO - 'talos_options': ['--disable-e10s'], 22:01:41 INFO - 'tests': ['tp5o']}, 22:01:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:01:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:01:41 INFO - 'talos_options': ['--disable-e10s', 22:01:41 INFO - '--xperf_path', 22:01:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:41 INFO - 'tests': ['tp5n']}, 22:01:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:01:41 INFO - 'talos_options': ['--xperf_path', 22:01:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:41 INFO - 'tests': ['tp5n']}}, 22:01:41 INFO - 'talos.zip': {'path': '', 22:01:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:01:41 INFO - Running post-action listener: _resource_record_post_action 22:01:41 INFO - [mozharness: 2017-04-06 05:01:41.558650Z] Finished populate-webroot step (success) 22:01:41 INFO - [mozharness: 2017-04-06 05:01:41.558739Z] Running create-virtualenv step. 22:01:41 INFO - Running pre-action listener: _resource_record_pre_action 22:01:41 INFO - Running main action method: create_virtualenv 22:01:41 INFO - Creating virtualenv /builds/slave/test/build/venv 22:01:41 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 22:01:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:01:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:01:41 INFO - Using real prefix '/usr' 22:01:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:01:42 INFO - Installing distribute.............................................................................................................................................................................................done. 22:01:44 INFO - Installing pip.................done. 22:01:44 INFO - Return code: 0 22:01:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:01:44 INFO - Reading from file tmpfile_stdout 22:01:44 INFO - Output received: 22:01:44 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) 22:01:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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')]} 22:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf290>, '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 0x25bfb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c0040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', '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 22:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:01:44 INFO - Using env: {'DISPLAY': ':0', 22:01:44 INFO - 'HOME': '/home/cltbld', 22:01:44 INFO - 'LANG': 'en_US.UTF-8', 22:01:44 INFO - 'LANGUAGE': 'en_US:en', 22:01:44 INFO - 'LOGNAME': 'cltbld', 22:01:44 INFO - 'MAIL': '/var/mail/cltbld', 22:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:44 INFO - 'MOZ_NO_REMOTE': '1', 22:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:44 INFO - 'NO_EM_RESTART': '1', 22:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:44 INFO - 'PWD': '/builds/slave/test', 22:01:44 INFO - 'SHELL': '/bin/bash', 22:01:44 INFO - 'SHLVL': '1', 22:01:44 INFO - 'TERM': 'linux', 22:01:44 INFO - 'TMOUT': '86400', 22:01:44 INFO - 'USER': 'cltbld', 22:01:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', 22:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:44 INFO - '_': '/tools/buildbot/bin/python'} 22:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:44 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 22:01:44 INFO - Cleaning up... 22:01:44 INFO - Return code: 0 22:01:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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')]} 22:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf290>, '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 0x25bfb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c0040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', '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 22:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:01:44 INFO - Using env: {'DISPLAY': ':0', 22:01:44 INFO - 'HOME': '/home/cltbld', 22:01:44 INFO - 'LANG': 'en_US.UTF-8', 22:01:44 INFO - 'LANGUAGE': 'en_US:en', 22:01:44 INFO - 'LOGNAME': 'cltbld', 22:01:44 INFO - 'MAIL': '/var/mail/cltbld', 22:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:44 INFO - 'MOZ_NO_REMOTE': '1', 22:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:44 INFO - 'NO_EM_RESTART': '1', 22:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:44 INFO - 'PWD': '/builds/slave/test', 22:01:44 INFO - 'SHELL': '/bin/bash', 22:01:44 INFO - 'SHLVL': '1', 22:01:44 INFO - 'TERM': 'linux', 22:01:44 INFO - 'TMOUT': '86400', 22:01:44 INFO - 'USER': 'cltbld', 22:01:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', 22:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:44 INFO - '_': '/tools/buildbot/bin/python'} 22:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:44 INFO - Downloading/unpacking psutil>=3.1.1 22:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:01:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:46 INFO - Installing collected packages: psutil 22:01:46 INFO - Running setup.py install for psutil 22:01:46 INFO - building 'psutil._psutil_linux' extension 22:01:46 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 22:01:47 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 22:01:47 INFO - building 'psutil._psutil_posix' extension 22:01:47 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 22:01:47 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 22:01:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:47 INFO - Successfully installed psutil 22:01:47 INFO - Cleaning up... 22:01:47 INFO - Return code: 0 22:01:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:47 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 0x23241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf290>, '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 0x25bfb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c0040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', '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 22:01:47 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 22:01:47 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 22:01:47 INFO - Using env: {'DISPLAY': ':0', 22:01:47 INFO - 'HOME': '/home/cltbld', 22:01:47 INFO - 'LANG': 'en_US.UTF-8', 22:01:47 INFO - 'LANGUAGE': 'en_US:en', 22:01:47 INFO - 'LOGNAME': 'cltbld', 22:01:47 INFO - 'MAIL': '/var/mail/cltbld', 22:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:47 INFO - 'MOZ_NO_REMOTE': '1', 22:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:47 INFO - 'NO_EM_RESTART': '1', 22:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:47 INFO - 'PWD': '/builds/slave/test', 22:01:47 INFO - 'SHELL': '/bin/bash', 22:01:47 INFO - 'SHLVL': '1', 22:01:47 INFO - 'TERM': 'linux', 22:01:47 INFO - 'TMOUT': '86400', 22:01:47 INFO - 'USER': 'cltbld', 22:01:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', 22:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:47 INFO - '_': '/tools/buildbot/bin/python'} 22:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:01:47 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 22:01:47 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 22:01:47 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 22:01:47 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 22:01:47 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 22:01:47 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 22:01:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:01:49 INFO - Installing collected packages: mozsystemmonitor 22:01:49 INFO - Running setup.py install for mozsystemmonitor 22:01:49 INFO - Successfully installed mozsystemmonitor 22:01:49 INFO - Cleaning up... 22:01:49 INFO - Return code: 0 22:01:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf290>, '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 0x25bfb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c0040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', '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 22:01:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:01:49 INFO - Using env: {'DISPLAY': ':0', 22:01:49 INFO - 'HOME': '/home/cltbld', 22:01:49 INFO - 'LANG': 'en_US.UTF-8', 22:01:49 INFO - 'LANGUAGE': 'en_US:en', 22:01:49 INFO - 'LOGNAME': 'cltbld', 22:01:49 INFO - 'MAIL': '/var/mail/cltbld', 22:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:49 INFO - 'MOZ_NO_REMOTE': '1', 22:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:49 INFO - 'NO_EM_RESTART': '1', 22:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:49 INFO - 'PWD': '/builds/slave/test', 22:01:49 INFO - 'SHELL': '/bin/bash', 22:01:49 INFO - 'SHLVL': '1', 22:01:49 INFO - 'TERM': 'linux', 22:01:49 INFO - 'TMOUT': '86400', 22:01:49 INFO - 'USER': 'cltbld', 22:01:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', 22:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:49 INFO - '_': '/tools/buildbot/bin/python'} 22:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:50 INFO - Downloading/unpacking jsonschema==2.5.1 22:01:50 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 22:01:50 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 22:01:50 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 22:01:50 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 22:01:50 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 22:01:50 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 22:01:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:01:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:52 INFO - Downloading functools32-3.2.3-2.tar.gz 22:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:01:52 INFO - warning: no files found matching '*.txt' 22:01:52 INFO - no previously-included directories found matching 'build' 22:01:52 INFO - no previously-included directories found matching 'dist' 22:01:52 INFO - no previously-included directories found matching '.git*' 22:01:52 INFO - Installing collected packages: jsonschema, functools32 22:01:52 INFO - Running setup.py install for functools32 22:01:52 INFO - warning: no files found matching '*.txt' 22:01:52 INFO - no previously-included directories found matching 'build' 22:01:52 INFO - no previously-included directories found matching 'dist' 22:01:52 INFO - no previously-included directories found matching '.git*' 22:01:52 INFO - Successfully installed jsonschema functools32 22:01:52 INFO - Cleaning up... 22:01:52 INFO - Return code: 0 22:01:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:01:52 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')]} 22:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:52 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')]} 22:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:52 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 0x23241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf290>, '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 0x25bfb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c0040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', '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 22:01:52 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 22:01:52 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 22:01:52 INFO - Using env: {'DISPLAY': ':0', 22:01:52 INFO - 'HOME': '/home/cltbld', 22:01:52 INFO - 'LANG': 'en_US.UTF-8', 22:01:52 INFO - 'LANGUAGE': 'en_US:en', 22:01:52 INFO - 'LOGNAME': 'cltbld', 22:01:52 INFO - 'MAIL': '/var/mail/cltbld', 22:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:52 INFO - 'MOZ_NO_REMOTE': '1', 22:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:52 INFO - 'NO_EM_RESTART': '1', 22:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:52 INFO - 'PWD': '/builds/slave/test', 22:01:52 INFO - 'SHELL': '/bin/bash', 22:01:52 INFO - 'SHLVL': '1', 22:01:52 INFO - 'TERM': 'linux', 22:01:52 INFO - 'TMOUT': '86400', 22:01:52 INFO - 'USER': 'cltbld', 22:01:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', 22:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:52 INFO - '_': '/tools/buildbot/bin/python'} 22:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:01:52 INFO - Cleaning up... 22:01:52 INFO - Return code: 0 22:01:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:01:52 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')]} 22:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:52 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')]} 22:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:52 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 0x23241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf290>, '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 0x25bfb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c0040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', '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 22:01:52 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 22:01:52 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 22:01:52 INFO - Using env: {'DISPLAY': ':0', 22:01:52 INFO - 'HOME': '/home/cltbld', 22:01:52 INFO - 'LANG': 'en_US.UTF-8', 22:01:52 INFO - 'LANGUAGE': 'en_US:en', 22:01:52 INFO - 'LOGNAME': 'cltbld', 22:01:52 INFO - 'MAIL': '/var/mail/cltbld', 22:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:52 INFO - 'MOZ_NO_REMOTE': '1', 22:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:52 INFO - 'NO_EM_RESTART': '1', 22:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:52 INFO - 'PWD': '/builds/slave/test', 22:01:52 INFO - 'SHELL': '/bin/bash', 22:01:52 INFO - 'SHLVL': '1', 22:01:52 INFO - 'TERM': 'linux', 22:01:52 INFO - 'TMOUT': '86400', 22:01:52 INFO - 'USER': 'cltbld', 22:01:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', 22:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:52 INFO - '_': '/tools/buildbot/bin/python'} 22:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:53 INFO - Downloading/unpacking blobuploader==1.2.4 22:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:55 INFO - Downloading blobuploader-1.2.4.tar.gz 22:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:01:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:01:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:55 INFO - Downloading docopt-0.6.1.tar.gz 22:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:01:55 INFO - Installing collected packages: blobuploader, requests, docopt 22:01:55 INFO - Running setup.py install for blobuploader 22:01:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:01:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:01:55 INFO - Running setup.py install for requests 22:01:56 INFO - Running setup.py install for docopt 22:01:56 INFO - Successfully installed blobuploader requests docopt 22:01:56 INFO - Cleaning up... 22:01:56 INFO - Return code: 0 22:01:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01:56 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')]} 22:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:56 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')]} 22:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:56 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 0x23241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf290>, '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 0x25bfb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c0040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', '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 22:01:56 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 22:01:56 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 22:01:56 INFO - Using env: {'DISPLAY': ':0', 22:01:56 INFO - 'HOME': '/home/cltbld', 22:01:56 INFO - 'LANG': 'en_US.UTF-8', 22:01:56 INFO - 'LANGUAGE': 'en_US:en', 22:01:56 INFO - 'LOGNAME': 'cltbld', 22:01:56 INFO - 'MAIL': '/var/mail/cltbld', 22:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:56 INFO - 'MOZ_NO_REMOTE': '1', 22:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:56 INFO - 'NO_EM_RESTART': '1', 22:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:56 INFO - 'PWD': '/builds/slave/test', 22:01:56 INFO - 'SHELL': '/bin/bash', 22:01:56 INFO - 'SHLVL': '1', 22:01:56 INFO - 'TERM': 'linux', 22:01:56 INFO - 'TMOUT': '86400', 22:01:56 INFO - 'USER': 'cltbld', 22:01:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', 22:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:56 INFO - '_': '/tools/buildbot/bin/python'} 22:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:01:56 INFO - Running setup.py (path:/tmp/pip-Wv4b52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:01:56 INFO - Running setup.py (path:/tmp/pip-iIbqZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:01:56 INFO - Running setup.py (path:/tmp/pip-liujsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:01:56 INFO - Running setup.py (path:/tmp/pip-fYBS65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:01:57 INFO - Running setup.py (path:/tmp/pip-ub_Ihb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:01:57 INFO - Running setup.py (path:/tmp/pip-E9QQrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:01:57 INFO - Running setup.py (path:/tmp/pip-pW_tSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:01:57 INFO - Running setup.py (path:/tmp/pip-8b14dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:01:57 INFO - Running setup.py (path:/tmp/pip-mGpMFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:01:57 INFO - Running setup.py (path:/tmp/pip-Fc0JmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:01:57 INFO - Running setup.py (path:/tmp/pip-KAcBQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:01:57 INFO - Running setup.py (path:/tmp/pip-mL1kJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:01:57 INFO - Running setup.py (path:/tmp/pip-d80d76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:01:57 INFO - Running setup.py (path:/tmp/pip-7PfOal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:57 INFO - Running setup.py (path:/tmp/pip-4aIQV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:01:57 INFO - Running setup.py (path:/tmp/pip-ZPUmyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:01:57 INFO - Running setup.py (path:/tmp/pip-aQS2RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:01:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:01:57 INFO - Running setup.py install for manifestparser 22:01:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:01:58 INFO - Running setup.py install for mozcrash 22:01:58 INFO - Running setup.py install for mozdebug 22:01:58 INFO - Running setup.py install for mozdevice 22:01:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:01:58 INFO - Running setup.py install for mozfile 22:01:58 INFO - Running setup.py install for mozhttpd 22:01:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:01:58 INFO - Running setup.py install for mozinfo 22:01:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:01:58 INFO - Running setup.py install for mozInstall 22:01:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:01:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:01:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:01:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:01:58 INFO - Running setup.py install for mozleak 22:01:58 INFO - Running setup.py install for mozlog 22:01:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:01:58 INFO - Running setup.py install for moznetwork 22:01:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:01:59 INFO - Running setup.py install for mozprocess 22:01:59 INFO - Running setup.py install for mozprofile 22:01:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:01:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:01:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:01:59 INFO - Running setup.py install for mozrunner 22:01:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:01:59 INFO - Running setup.py install for mozscreenshot 22:01:59 INFO - Running setup.py install for moztest 22:01:59 INFO - Running setup.py install for mozversion 22:01:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:01:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:01:59 INFO - Cleaning up... 22:01:59 INFO - Return code: 0 22:01:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01:59 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')]} 22:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:59 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')]} 22:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:59 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 0x23241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf290>, '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 0x25bfb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c0040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', '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 22:01:59 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 22:01:59 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 22:01:59 INFO - Using env: {'DISPLAY': ':0', 22:01:59 INFO - 'HOME': '/home/cltbld', 22:01:59 INFO - 'LANG': 'en_US.UTF-8', 22:01:59 INFO - 'LANGUAGE': 'en_US:en', 22:01:59 INFO - 'LOGNAME': 'cltbld', 22:01:59 INFO - 'MAIL': '/var/mail/cltbld', 22:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:59 INFO - 'MOZ_NO_REMOTE': '1', 22:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:59 INFO - 'NO_EM_RESTART': '1', 22:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:59 INFO - 'PWD': '/builds/slave/test', 22:01:59 INFO - 'SHELL': '/bin/bash', 22:01:59 INFO - 'SHLVL': '1', 22:01:59 INFO - 'TERM': 'linux', 22:01:59 INFO - 'TMOUT': '86400', 22:01:59 INFO - 'USER': 'cltbld', 22:01:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', 22:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:59 INFO - '_': '/tools/buildbot/bin/python'} 22:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:01:59 INFO - Running setup.py (path:/tmp/pip-yPS7R3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:02:00 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)) 22:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:02:00 INFO - Running setup.py (path:/tmp/pip-BzsME0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:02:00 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)) 22:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:02:00 INFO - Running setup.py (path:/tmp/pip-j8WbIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:02:00 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)) 22:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:02:00 INFO - Running setup.py (path:/tmp/pip-UjQkze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:02:00 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)) 22:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:02:00 INFO - Running setup.py (path:/tmp/pip-U4Hmow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:02:00 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)) 22:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:02:00 INFO - Running setup.py (path:/tmp/pip-6UR2he-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:02:00 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)) 22:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:02:00 INFO - Running setup.py (path:/tmp/pip-1RdlZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:02:00 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)) 22:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:02:00 INFO - Running setup.py (path:/tmp/pip-mWt3tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:02:00 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)) 22:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:02:00 INFO - Running setup.py (path:/tmp/pip-Bygqw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:02:00 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)) 22:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:02:00 INFO - Running setup.py (path:/tmp/pip-f3aKeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:02:00 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)) 22:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:02:00 INFO - Running setup.py (path:/tmp/pip-dw41aS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:02:00 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)) 22:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:02:00 INFO - Running setup.py (path:/tmp/pip-stTx8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:02:00 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)) 22:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:02:00 INFO - Running setup.py (path:/tmp/pip-Xvz7_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:02:00 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)) 22:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:02:00 INFO - Running setup.py (path:/tmp/pip-uS0UBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:02:00 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)) 22:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:02:00 INFO - Running setup.py (path:/tmp/pip-3AB8Rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:02:01 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)) 22:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:02:01 INFO - Running setup.py (path:/tmp/pip-FcMK8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:02:01 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)) 22:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:02:01 INFO - Running setup.py (path:/tmp/pip-F4BzD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:02:01 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)) 22:02:01 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)) 22:02:01 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)) 22:02:01 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)) 22:02:01 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)) 22:02:01 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)) 22:02:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:02:01 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 22:02:01 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 22:02:01 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 22:02:01 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 22:02:01 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 22:02:01 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 22:02:03 INFO - Downloading blessings-1.6.tar.gz 22:02:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:02:03 INFO - Installing collected packages: blessings 22:02:03 INFO - Running setup.py install for blessings 22:02:03 INFO - Successfully installed blessings 22:02:03 INFO - Cleaning up... 22:02:03 INFO - Return code: 0 22:02:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:02:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:02:03 INFO - Reading from file tmpfile_stdout 22:02:03 INFO - Current package versions: 22:02:03 INFO - argparse == 1.2.1 22:02:03 INFO - blessings == 1.6 22:02:03 INFO - blobuploader == 1.2.4 22:02:03 INFO - docopt == 0.6.1 22:02:03 INFO - functools32 == 3.2.3-2 22:02:03 INFO - jsonschema == 2.5.1 22:02:03 INFO - manifestparser == 1.1 22:02:03 INFO - mozInstall == 1.12 22:02:03 INFO - mozcrash == 1.0 22:02:03 INFO - mozdebug == 0.1 22:02:03 INFO - mozdevice == 0.49 22:02:03 INFO - mozfile == 1.2 22:02:03 INFO - mozhttpd == 0.7 22:02:03 INFO - mozinfo == 0.9 22:02:03 INFO - mozleak == 0.1 22:02:03 INFO - mozlog == 3.4 22:02:03 INFO - moznetwork == 0.27 22:02:03 INFO - mozprocess == 0.25 22:02:03 INFO - mozprofile == 0.28 22:02:03 INFO - mozrunner == 6.13 22:02:03 INFO - mozscreenshot == 0.1 22:02:03 INFO - mozsystemmonitor == 0.3 22:02:03 INFO - moztest == 0.8 22:02:03 INFO - mozversion == 1.4 22:02:03 INFO - psutil == 3.1.1 22:02:03 INFO - requests == 1.2.3 22:02:03 INFO - wsgiref == 0.1.2 22:02:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:03 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 0x23241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf290>, '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 0x25bfb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c0040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', '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 22:02:03 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 22:02:03 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 22:02:03 INFO - Using env: {'DISPLAY': ':0', 22:02:03 INFO - 'HOME': '/home/cltbld', 22:02:03 INFO - 'LANG': 'en_US.UTF-8', 22:02:03 INFO - 'LANGUAGE': 'en_US:en', 22:02:03 INFO - 'LOGNAME': 'cltbld', 22:02:03 INFO - 'MAIL': '/var/mail/cltbld', 22:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:03 INFO - 'MOZ_NO_REMOTE': '1', 22:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:03 INFO - 'NO_EM_RESTART': '1', 22:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:03 INFO - 'PWD': '/builds/slave/test', 22:02:03 INFO - 'SHELL': '/bin/bash', 22:02:03 INFO - 'SHLVL': '1', 22:02:03 INFO - 'TERM': 'linux', 22:02:03 INFO - 'TMOUT': '86400', 22:02:03 INFO - 'USER': 'cltbld', 22:02:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', 22:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:03 INFO - '_': '/tools/buildbot/bin/python'} 22:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:03 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)) 22:02:03 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)) 22:02:03 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)) 22:02:03 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)) 22:02:03 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)) 22:02:03 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)) 22:02:03 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)) 22:02:03 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)) 22:02:03 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)) 22:02:03 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)) 22:02:03 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)) 22:02:03 INFO - Cleaning up... 22:02:03 INFO - Return code: 0 22:02:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:03 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 0x23241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf290>, '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 0x25bfb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c0040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', '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 22:02:03 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 22:02:03 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 22:02:03 INFO - Using env: {'DISPLAY': ':0', 22:02:03 INFO - 'HOME': '/home/cltbld', 22:02:03 INFO - 'LANG': 'en_US.UTF-8', 22:02:03 INFO - 'LANGUAGE': 'en_US:en', 22:02:03 INFO - 'LOGNAME': 'cltbld', 22:02:03 INFO - 'MAIL': '/var/mail/cltbld', 22:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:03 INFO - 'MOZ_NO_REMOTE': '1', 22:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:03 INFO - 'NO_EM_RESTART': '1', 22:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:03 INFO - 'PWD': '/builds/slave/test', 22:02:03 INFO - 'SHELL': '/bin/bash', 22:02:03 INFO - 'SHLVL': '1', 22:02:03 INFO - 'TERM': 'linux', 22:02:03 INFO - 'TMOUT': '86400', 22:02:03 INFO - 'USER': 'cltbld', 22:02:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', 22:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:03 INFO - '_': '/tools/buildbot/bin/python'} 22:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:02:04 INFO - Cleaning up... 22:02:04 INFO - Return code: 0 22:02:04 INFO - Running post-action listener: _resource_record_post_action 22:02:04 INFO - Running post-action listener: _start_resource_monitoring 22:02:04 INFO - Starting resource monitoring. 22:02:04 INFO - [mozharness: 2017-04-06 05:02:04.174817Z] Finished create-virtualenv step (success) 22:02:04 INFO - [mozharness: 2017-04-06 05:02:04.175288Z] Running install step. 22:02:04 INFO - Running pre-action listener: _resource_record_pre_action 22:02:04 INFO - Running main action method: install 22:02:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:02:04 INFO - Reading from file tmpfile_stdout 22:02:04 INFO - Detecting whether we're running mozinstall >=1.0... 22:02:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:02:04 INFO - Reading from file tmpfile_stdout 22:02:04 INFO - Output received: 22:02:04 INFO - Usage: mozinstall [options] installer 22:02:04 INFO - Options: 22:02:04 INFO - -h, --help show this help message and exit 22:02:04 INFO - -d DEST, --destination=DEST 22:02:04 INFO - Directory to install application into. [default: 22:02:04 INFO - "/builds/slave/test"] 22:02:04 INFO - --app=APP Application being installed. [default: firefox] 22:02:04 INFO - mkdir: /builds/slave/test/build/application 22:02:04 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'] 22:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:02:19 INFO - Reading from file tmpfile_stdout 22:02:19 INFO - Output received: 22:02:19 INFO - /builds/slave/test/build/application/firefox/firefox 22:02:19 INFO - Running post-action listener: _resource_record_post_action 22:02:19 INFO - [mozharness: 2017-04-06 05:02:19.168041Z] Finished install step (success) 22:02:19 INFO - [mozharness: 2017-04-06 05:02:19.168310Z] Running run-tests step. 22:02:19 INFO - Running pre-action listener: _resource_record_pre_action 22:02:19 INFO - Running main action method: run_tests 22:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:02:19 INFO - Python 2.7.3 22:02:19 INFO - Return code: 0 22:02:19 INFO - grabbing minidump binary from tooltool 22:02:19 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')]} 22:02:19 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 0x25bf290>, '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 0x25bfb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c0040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:02:19 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 22:02:19 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 22:02:19 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 22:02:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:02:19 INFO - Return code: 0 22:02:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:02:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:02:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:02:19 INFO - ENV: RUST_BACKTRACE is now 1 22:02:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:02:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:02:19 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/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 22:02:19 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/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 22:02:19 INFO - Using env: {'DISPLAY': ':0', 22:02:19 INFO - 'HOME': '/home/cltbld', 22:02:19 INFO - 'LANG': 'en_US.UTF-8', 22:02:19 INFO - 'LANGUAGE': 'en_US:en', 22:02:19 INFO - 'LOGNAME': 'cltbld', 22:02:19 INFO - 'MAIL': '/var/mail/cltbld', 22:02:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:02:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:19 INFO - 'MOZ_NO_REMOTE': '1', 22:02:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:19 INFO - 'NO_EM_RESTART': '1', 22:02:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:19 INFO - 'PWD': '/builds/slave/test', 22:02:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:02:19 INFO - 'RUST_BACKTRACE': '1', 22:02:19 INFO - 'SHELL': '/bin/bash', 22:02:19 INFO - 'SHLVL': '1', 22:02:19 INFO - 'TERM': 'linux', 22:02:19 INFO - 'TMOUT': '86400', 22:02:19 INFO - 'USER': 'cltbld', 22:02:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320', 22:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:19 INFO - '_': '/tools/buildbot/bin/python'} 22:02:19 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/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 22:02:19 INFO - mozversion application_buildid: 20170406043223 22:02:19 INFO - mozversion application_changeset: ec8d1d3db50c85037e8077c32c8403570a5df493 22:02:19 INFO - mozversion application_display_name: Nightly 22:02:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:02:19 INFO - mozversion application_name: Firefox 22:02:19 INFO - mozversion application_remotingname: firefox 22:02:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:02:19 INFO - mozversion application_vendor: Mozilla 22:02:19 INFO - mozversion application_version: 55.0a1 22:02:19 INFO - mozversion platform_buildid: 20170406043223 22:02:19 INFO - mozversion platform_changeset: ec8d1d3db50c85037e8077c32c8403570a5df493 22:02:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:02:19 INFO - mozversion platform_version: 55.0a1 22:02:19 INFO - using testdate: 1491454939 22:02:19 INFO - actual date: 1491454939 22:02:19 INFO - starting webserver on 'localhost:39803' 22:02:19 INFO - SUITE-START | Running 2 tests 22:02:19 INFO - TEST-START | dromaeo_css 22:02:19 INFO - operating with platform_type : linux_ 22:02:19 INFO - Initialising browser for dromaeo_css test... 22:02:19 INFO - TEST-INFO | started process 10462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIPp1XX/profile http://localhost:39803/getInfo.html) 22:02:24 INFO - PID 10462 | __metrics Screen width/height:1600/1200 22:02:24 INFO - PID 10462 | colorDepth:24 22:02:24 INFO - PID 10462 | Browser inner width/height: 1024/697 22:02:24 INFO - PID 10462 | __metrics 22:02:25 ERROR - PID 10462 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 22:02:26 INFO - TEST-INFO | 10462: exit 0 22:02:26 INFO - Browser initialized. 22:02:26 INFO - Running cycle 1/1 for dromaeo_css test... 22:02:26 INFO - TEST-INFO | started process 10591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIPp1XX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:02:38 INFO - PID 10591 | RSS: Main: 160935936 22:02:38 INFO - PID 10591 | 22:05:43 INFO - PID 10591 | Cycle 1(1): loaded http://localhost:39803/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39803/tests/dromaeo/cssquery-ext.html) 22:05:46 INFO - PID 10591 | RSS: Main: 165416960 22:05:46 INFO - PID 10591 | 22:07:27 INFO - PID 10591 | ************************* 22:07:27 INFO - PID 10591 | A coding exception was thrown and uncaught in a Task. 22:07:27 INFO - PID 10591 | 22:07:27 ERROR - PID 10591 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:07:27 INFO - PID 10591 | Full stack: 22:07:27 INFO - PID 10591 | ************************* 22:07:27 INFO - PID 10591 | ************************* 22:07:27 INFO - PID 10591 | A coding exception was thrown and uncaught in a Task. 22:07:27 INFO - PID 10591 | 22:07:27 ERROR - PID 10591 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:07:27 INFO - PID 10591 | Full stack: 22:07:27 INFO - PID 10591 | ************************* 22:07:27 INFO - PID 10591 | ************************* 22:07:27 INFO - PID 10591 | A coding exception was thrown and uncaught in a Task. 22:07:27 INFO - PID 10591 | 22:07:27 ERROR - PID 10591 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:07:27 INFO - PID 10591 | Full stack: 22:07:27 INFO - PID 10591 | ************************* 22:07:27 INFO - PID 10591 | ************************* 22:07:27 INFO - PID 10591 | A coding exception was thrown and uncaught in a Task. 22:07:27 INFO - PID 10591 | 22:07:27 ERROR - PID 10591 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:07:27 INFO - PID 10591 | Full stack: 22:07:27 INFO - PID 10591 | ************************* 22:08:48 INFO - PID 10591 | Cycle 1(1): loaded http://localhost:39803/tests/dromaeo/cssquery-ext.html (next: http://localhost:39803/tests/dromaeo/cssquery-jquery.html) 22:08:49 INFO - PID 10591 | RSS: Main: 160591872 22:08:49 INFO - PID 10591 | 22:11:50 INFO - PID 10591 | Cycle 1(1): loaded http://localhost:39803/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39803/tests/dromaeo/cssquery-mootools.html) 22:11:51 INFO - PID 10591 | RSS: Main: 167137280 22:11:51 INFO - PID 10591 | 22:14:53 INFO - PID 10591 | Cycle 1(1): loaded http://localhost:39803/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39803/tests/dromaeo/cssquery-prototype.html) 22:14:54 INFO - PID 10591 | RSS: Main: 161521664 22:14:54 INFO - PID 10591 | 22:17:56 INFO - PID 10591 | Cycle 1(1): loaded http://localhost:39803/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39803/tests/dromaeo/cssquery-yui.html) 22:17:57 INFO - PID 10591 | RSS: Main: 167825408 22:17:57 INFO - PID 10591 | 22:21:00 INFO - PID 10591 | Cycle 1(1): loaded http://localhost:39803/tests/dromaeo/cssquery-yui.html (next: http://localhost:39803/tests/dromaeo/cssquery-dojo.html) 22:21:00 INFO - PID 10591 | RSS: Main: 162410496 22:21:00 INFO - PID 10591 | 22:21:00 INFO - PID 10591 | __start_tp_report 22:21:00 INFO - PID 10591 | _x_x_mozilla_page_load 22:21:00 INFO - PID 10591 | _x_x_mozilla_page_load_details 22:21:00 INFO - PID 10591 | |i|pagename|runs| 22:21:00 INFO - PID 10591 | |0;dojo.html;2697.352635367512;2744.4511097780423;2769.9889540317777;2782.1375373634187;2785.9582106268404;5221.399539053001;5363.785448582057;5387.4612538746105;5412.323459567554;5431.809886653968;5226.55574276187;5310.15037593985;5312.07038768215;5325.813596524123;5359.276497672813;4723.055388922212;4790.712557246577;4793.664443488957;4820.734859582722;4847.878803029917;4466.508684044752;4783.832565860195;4829.082474329884;4847.248676455138;4853.635977301698;4690.343351930733;4710.811567537295;4722.574968252839;4775;4791.592714619227;4743.95256047442;4764.332993380929;4770.45139808923;4803.663743537953;4813.879653008703;4699.577038066591;4713.929291060636;4714.929276060861;4737.810487580493;4765.380500534943;5186.559142472895;5235.895282094375;5286.180642000496;5331.733413329318;5363.758630861621;5821.970890145522;5831.212786273841;5853.1220316952795;5889.02831032879;5923.259592550931;5871.324797648283;5875.794347197828;5882.411758824083;5884.6763428011445;5893.440123188333;5322.441143679858;5398.541124004503;5404.783808647689;5439.945600543944;5459.836204913859;5950.613210141327;5961.821145365646;5984.371640977722;6011.909821352683;6020.187274717857;5608.10270356741;5654;5659.462351076641;5662.631928924607;5668.546516278688;5676.347220069745;5696.971515142481;5731.455511726379;5733.31200255972;5753.626014309057;5671.149327600893;5684.772609095672;5704.286964129484;5706;5716.056850619601;5681.9431805681415;5690;5690.573207009491;5694.117411801095;5696.544276457874;4746.169420351424;4757.500462451462;4759.976200118977;4787.569118779326;4796.5203479651755;4123.876283711494;4165.91668166635;4168.062186008124;4178.12259425524;4227.239096962515;4931.630127740362;4939.90120197594;4956.578690811321;4962.528559786814;4982.402111746614;5829.562782791223;5840.912386314209;5846.736896839652;5847.415258474119;5888.852778680567;5000.724960127228;5001.199808030698;5004.149294619923;5007.524285192901;5065.037642847848;5018.924716129261;5079.415867175248;5160.40655324635;5184.481551844785;5211.817586384458;5392.164214546751;5450.754716037867;5451.809186678447;5455.509004189642;5465.37148227943;5803.999999999831;5837.591368604157;5843.094320380348;5844.6785426801935;5854.677992710442;5310.123829568232;5332.733363331896;5377.300950876361;5412.485813847678;5428.402875683751;5739.540836733135;5741.598088133957;5750.9424905752085;5791.9131213031;5808.215890854681;5786.3056433228285;5821.38875418075;5840.8247752567495;5843.094320380348;5843.766249349978;5543.223948647112;5597.384287728428;5600.943990560205;5605.915911261252;5649.943500564942;5548.750306236148;5583.966966111282;5592.3009623797025;5601.663900166003;5605.131204663284;5474.863128421662;5519.337679478488;5532.446755324436;5534.39121696605;5537.1140617502615;5637.830865074055;5648.23748793924;5649.954758369715;5664.150377443417;5704.942950570441;5515.393306736336;5520.309961254843;5525.060739674345;5528.419515950928;5542.8337149885565 22:21:00 INFO - PID 10591 | |1;ext.html;722.9602371869547;742.6361083069297;1045.8431235314702;1072.244067932108;1178.0987544528443;31289.687103128963;32433;32628.510572341434;32716.836415817947;32747.345053098925;30895.536566951512;31291.530627040556;31296.843515782446;31314.68685313146;31348.68651313486;6703.229128650219;6858.622775747332;6865.828354291158;7085.220625731191;7261;7273.272672732711;7328.890066649004;7388.076490438695;7389.704411823547;7393.815154621124;7317.524360916524;7337.2662733726465;7351.228121047293;7368.852622947537;7390.297921697457;7305.817354566125;7320.999999999974;7329.120505539369;7330.486865919388;7348.1182258129365;7187.7843664690145;7243.239459856692;7245.4928155029165;7271.309225623558;7276.5634061955925;30884.8455757722;31230;31332.686673133205;31427.37145257105;31472;2398.952020959571;2416.891239894209;2436.415260337524;2438.1222759806456;2439.7072351317956;23802.64296035561;23813.404664883517;23932.880335598384;23997.520049599087;24039.639405408932;3081.6302043754667;3120.2199450137464;3127.6559578446354;3145.858436370369;3176.3488484860777;136493.3175334127;136861.3156934219;137118;137272;137344;32483;32920.83539582335;38061.429078563844;39450;40154.59845401509;39796.403053954215;39968.2006359877;40191.79904100461;40226.39660405096;40333.39499907504;11063.944680276709;11154.10767138627;11169.888301117047;11192.888071119347;11206.439678016066;8678.86981695275;8691.608877600524;8695.478271303742;8724;8731.432456890281;12327.198732082386;12367.505299788088;12384.81422778659;12392;12675.985921126288;5322.467753224647;5343.732813359316;5349.1010691204065;5385.219143224211;5516.365617953987;837.3719710217337;880.7886107334193;885.8494056010494;895.6775560798108;897.9281657467387;20594.27920022792;23867.510959571333;25389.74833179224;25535;25658.101966431084;944.5938246554048;946.8437707778139;964.7346979580531;974.9025097490336;982.2829334585792;10308.896911030793;11153.442327883735;11207;11226.382548959886;11249.887501124884;196740.03259967503;198264;198280;198983;199035;38790;38913.41629875554;39068.21863562713;39087.218255634725;39247.41128883069;1183.1907373068111;1229.1764517773113;1234.796258617318;1236.8763123687738;1246.507629486348;19054.71268964472;19258.22967081301;20266.392008239778;20399.592008159456;20456.488587785425;29115.7088429113;29238.41523169567;29286.853565732035;29320.56019159757;29327.853360733912;183378;183748;185002;185113;185618;26949.595756064067;27125.59311610288;28522.42955140927;28753;28936.13191604171;33930.151746205556;34282.48576271308;34763.826180868935;34965.30069398547;35205.471917921765;26764.464710705288;27038.729612704406;27301.726982730714;27524;27881;26625;26769.464610708066;27549.862250688617;27637.447251054466;27661.72338276672;28650.713492864805;29332.41335173242;29414.558781617863;29700;29786.255343616584;26221.868890655423;26315.342116447242;26759.598606020536;26926.192214232822;27239.319017024733;20880.164793408094;21926.122955081617;22190.556188876453;22290.88854555717;22504 22:21:00 INFO - PID 10591 | |2;jquery.html;412.2990915443746;422.5837550013234;426.6394896312615;432.07967030225615;432.52422335431027;17283.91358043208;17574.82425175748;18317.63364732706;18345.174467148976;19069.90465047676;18696.25214991402;18872.905635471805;19359.128839202236;19509.21963121477;19675.31136410226;5493.258410114643;5577.6653400796085;5658.603897727161;5683.119116536923;5693.715314234292;5613.045782217033;5625.606207565452;5654.349749778787;5694.231278777374;5709.714514274269;5482.369527504348;5606.383297837235;5632.042552766019;5649.8587535311535;5657.038303488417;5598.384177740445;5629.071203251458;5664.915026274609;5682.119271512943;5684.658920464785;4993.950060499385;5085.491450854922;5109.718965456898;5119.59043276537;5121.8463446096675;22390.55218895629;22450.775492245033;22474.55050898989;22483.55032899333;22720.545589088124;1577.3217516467914;1613.5159452164303;1620.0360785332707;1624.5613684305172;1629.5844559637335;14796.18620975846;14873.70252594953;15228.390864365412;15366.231688415646;15572.454964076203;2046.8055534724178;2123.161351266241;2138.4653836540865;2163.718716566836;2167.360628614547;88652.55673721655;91112.54443727739;91381.94798572219;91887.54056229744;92477.99999999933;10850.403227822388;10929.781404371868;11157.38634375101;11227.943860280646;11336.546538138547;15434.228288585751;15475.613109672124;15512.767308490382;15543.222838858012;15631.68736625261;7350.08123984502;7394.482386232912;7524.774256772305;7671.156172820985;7681.3854891608535;6755.1556055493065;6764.661766911635;6940.30596940312;7002.439804815603;7024.683889224997;6960.477964152708;7005;7083;7168.498205125591;7204.963975180195;1990.3133418970433;2044.734184556028;2047.2834507922107;2075.5330050738767;2195.9341219763432;803.4375936844233;835.4903508859591;877.5787621941377;885.4769795950954;885.8926342072409;16232.350705971865;16456.424025159064;16971.575710607085;17317.30730770755;17498.65002699939;856.4005196362571;858.274757829633;859.1236938322876;866.5623859950811;880.691757884748;8771.780705482413;9389.483578403117;9417.199538039207;9461.763455913657;9536.2371010319;471080;476714;497365.13174341136;504812;505068;90204;90402.54798725965;92047.53976230076;95705;97646;1056.4295280548417;1096.9670909872716;1125.0268517732102;1136.7840110379002;1143.0969534067992;17533;17605.647887042443;18302.26790928348;18427.26290948347;18631.44105676832;42331.576684232765;42449;42638.78680606577;42683;43293.3505997404;54785.72607136939;55394;55701;55859;57317.42682573121;8126.715564955198;8276.751697449086;8331.875021874797;8417.70538031166;8597.355198360023;12210.145289829627;12303.56937507183;12311.19977201479;12619.74760504803;13265.137766045176;9765.267604929517;10154.289199755945;10301.227407944285;10824.404657743584;10998.835017474585;10097.141742951637;10212.336198147097;10303.124234440156;10311.175105991653;10311.639092631722;10489.580416783549;10561.471926403803;10896.291741036806;11118.61084862026;11148.721281968015;8159.143289954469;8179.182081791773;8260.628271727666;8295.170482951899;8603.139686031347;9553.570089346134;9770.36492627977;10655.733606659896;10794.460276986276;11270.661880143609 22:21:00 INFO - PID 10591 | |3;mootools.html;1230.2372529032002;1260.300533204072;1280.7438512297542;1294.4045738960078;1302.2837439408322;9596.472194029335;10095.798084038315;10103.848442273362;10314.948425257882;10574.365538067721;10275.537600807962;10446.26876118672;10457.372557646528;10464.162866970624;10509.474526273694;2269.4212975691175;2313.560423519526;2324.6280595104786;2325.5232677301196;2332.242021343062;2172.2940044485526;2272.2842304673973;2273.6816845641624;2275.6472746724285;2283.931482055541;2248.786365295294;2260.7174103237094;2264.33202205349;2290.9885450572806;2310.803581695558;2079.4073688998715;2104.947376315589;2110.5964533585147;2110.915563377471;2123.5115923337567;1929.7008963610522;2001.8798872067723;2169.1215057901577;2182.847200695952;2185.0495034659975;10332.638357657446;10398.324108932895;10428.739281517946;10449.791004179873;10453.268271221017;5637.182608521742;5836.474717275466;5901.3508514063415;5901.3508514063415;5909.497692696083;3299.538064670948;3518.4546395308766;3562.608113107556;3576.2311103112697;3598.6221446747977;1064.9893501064967;1118.7818375416798;1134.9148813838995;1147.6499667601379;1158.4092113022418;13842.792358114637;13876.514321998682;13894.23581703006;14044.087134336236;14083.436662533486;4598.149342371672;4765.666403351802;4989.376327959005;4995.425526064477;5088.262201980692;11224.775504489864;11312.660620181408;11322.660320190244;11329.660110196708;11340.886591133984;5567.053600887859;5583.776648933997;5599.356074051455;5608.831735047955;5627.71861406928;5136.691798492103;5205.167173252337;5245.895082098336;5278.683279003272;5332.773462103738;3776.169242766587;3851.171998020439;3880.1569254603837;3918.0988372673874;3935.0752573145287;1134.9602763903224;1139.3619573039125;1151.1826603111717;1155.8728539860608;1160.182071639492;644.7775517446473;668.5687731413309;674.3728332650584;676.2628734679223;677.6848765324148;5132.3327967364;5172.844814655567;5246.947530524722;5249.9237656280375;5305.124654432053;518.271828081546;538.9730513474389;540.3245942571785;540.7323374929435;550.6585916731652;3380.4591265397416;3496.8601255949984;3519.894403167909;3531.69980551656;3655;12636.431360588796;13456.529021484397;13474.932625337007;13494.122882012638;13534.661633459045;12835.807462888064;13320;13399.330033498287;13417;13436.865631343562;9406.38858474197;9664.99999999986;9686.515674216402;9687.41875487473;9703.223742100616;5143.974280128576;5180.7409629519125;5234.659747116425;5249.501297376743;5382.6878705932595;11618.302901825917;11642.53429862796;11732.12009099338;11778.469968851594;11848.881511184778;12031.75936481248;12048.75902481963;12055.939720301343;12182.451789669309;12208.572699955814;7856.135825059353;7883.093444253755;7928.365730741411;7932.444728868923;7935.325497332791;9233.630654774002;9336.673216437392;9439.575219115293;9462.905370946477;9516.143547080796;8069.112397636138;8252;8303.418760686694;8343.916560834557;8542.103079176846;7911.406644501571;7981.680732770857;8045.557494337868;8170.305524030524;8284;7045.647717613996;7198.856022879618;7232.529885557422;7241.203467618452;7243.348098671145;4635.397398338329;5045.11710450677;5056.292119103255;5208;5437.700926449083;5107.310513080835;5137.691738495702;5184.611154163528;5211.583073354198;5275.261463395204 22:21:00 INFO - PID 10591 | |4;prototype.html;369.27806138998244;396.1700238001386;399.2673444229838;407.12265068776776;411.14276733011667;5533.916991245134;5570.136628822534;5602.439756024395;5613.80351687691;5631.746571404286;5471.781128754845;5492.500912085002;5494.80768173114;5496.615236933416;5498.230247765306;4178.498580170384;4272.893177670568;4302.161078589676;4303.720258183223;4304.397384366175;4296.582127897802;4296.763677997709;4298.419713338706;4301.182775272689;4302.236083205887;4274.123804620061;4287.5498072702385;4298.118885628454;4303.139372125572;4309.59058889405;4178.456800615901;4221.366794980747;4224.7675142555045;4283.164782867342;4299;3794.6964242860504;3825.5409350877794;3828.8277027533827;3838.9424158637644;3845;5343.679379237219;5345.583420393599;5346.224797404355;5358.732063396815;5363.785448582052;5019.924701129486;5060.772265248036;5083.364579427572;5119.923201151985;5124.1801311790305;5788.65559448424;5790.855228619276;5810.448007439287;5824.475797178275;5831.591788574801;4370.781460926973;4371.235033869092;4383.364412160219;4384.517703052662;4384.6492280617795;5978.342382337983;6050.979275620742;6106.48094911933;6117.724702388358;6166.475849552793;4478.328250762346;4480.529544397857;4482.148391805546;4503.707259028152;4516.9159401743345;4565.634749220055;4575.3823233863;4575.473820510617;4578.130155270488;4600.493945665974;4968.453470118284;5025.045241404195;5071.442141364447;5079.97460012705;5087.618428617869;5828.0767346775465;5837.941620583825;5857.502112320415;5859.388668116302;5865.384134665884;1572.316042521507;1583.6674298397236;1597.6804639072;1598.9680206395808;1602.717825739404;1051.8106740786732;1112.8553288072499;1113;1119.3787447966295;1132.4620805117504;5075.771590278447;5094.490550944876;5131.820386286462;5142.6914385137015;5163.509466600667;6027.383569858138;6030.306514750772;6073.544484163705;6092.908606370908;6115.724792384353;4906.552566992746;5087.898242035212;5123.513266239701;5129;5162.638615296968;3188.3623275345026;3227.306129182237;3227.919302017421;3232.69289417505;3241.8541165647603;5408.378036525771;5626.411850548793;5627.831165065055;5632.225848857679;5646.71308120212;6062.9090563641585;6236.688165591702;6259.874802504016;6304.810855674337;6315.894718424349;5653.152027195872;5661.886762264731;5692.402297758676;5696;5708.800191993343;6092.208012958287;6102;6113.930062239001;6128.63228206309;6133.539984501091;5686.289213848269;5993.730282137227;6014.36849130835;6032.4570788629235;6057.666828324484;5639.88720225585;5658.151277308437;5674.829755107354;5691.117876729114;5692.7722891083895;4111.047252555012;4172.3532852407925;4194.853180138681;4201.936970945377;4214.957850421579;6026.758929642765;6080.513558915188;6115.174451449176;6121.357257488078;6128.785492507741;5877.617954832922;5896.764129434946;5897.174395584708;5912.201852749824;5917.970410148094;5633.169669392159;5816.47651711348;5822.417758224313;5887.20522729426;5928.762849485972;5800.738966746591;5803.506701930383;5814.680192589448;5818.6217895836635;5842.1820945066875;5728.617607530159;5962.821115366546;5968.343482216866;5976.7908123215475;5990.981533139464;5723.599348045597;5742.5405967521665;5754.53963682896;5772.480476757112;5782.971085144715 22:21:00 INFO - PID 10591 | |5;yui.html;702.195985596492;704.8625518023986;713.8679344321298;717.6304203335284;719.5466855880794;13269.933650331746;13867.375968081435;14200.928995355034;14416.279186040681;14440.855591444095;13366.933165334183;13556.72886542271;13586.116902401362;13658.93170534146;13671.384787684554;909.7998440343114;913.3469569257979;916.7708072981754;921.5254144115786;926.1201858234671;884.3367474394204;921.7280902133887;922.8569571716395;924.8242833861578;928.2620316848122;959.3092973059386;966.1015255812092;968.0416387776121;971.504532688327;977.081543349253;964.8745663063792;969.743018100204;970.1462712812751;973.0172525748974;974.6637410093506;714.382059518518;715.5492040014809;716.7419728897593;718.1597530888872;721.2823240875363;13545;14101;14570.4900328488;14616.561503154922;14622.341994610268;13290.73418531624;14467.56597302072;14484.56546303602;14521.564353069425;14546.70906581873;11904.464299106561;12369.814452783125;12440.875591244063;12450;12557.874421255761;2878.784091193148;2891.421715656877;2924.268932766808;2934.7798915081453;2949.188973032412;65237.3476265236;66066.66966665136;66159.66920165416;66639.66680166617;67702;10594.470276486145;10681.674553769213;10704.197185210984;10744.30162039465;10885.945570272099;21672;21781;22064.44838879041;22066.44833879166;22361.105555777587;6716.1604799400075;6748.570514614735;6789.25318214996;7030.824229394306;7104.609246491389;3318.2202182487094;3353.3460975110106;3374.392609330295;3378.6283508814013;3407.693307602328;3515.9472607910902;3565.447355659877;3566;3588.9282214355567;3623.1304486923477;707.3492387003969;714.257172540552;715.7172916697875;721.0446158839559;721.1202333153544;527.7097596322008;533;537.4517991648497;539.6519245086897;559.233849626015;8178.836423271501;8435.536045517432;8726.607302671267;9050.547472626342;9264.305177111608;539.3877948528449;543.8531596469011;547.8301726464808;558.1488230448598;566.5127989928658;3847.0574709195866;3885.708571857122;4007.078371974404;4038.290005431602;4114.485689288839;61894.38105618976;63750.36249637537;64006.35993640097;65928.67035664791;67521.66239168773;58692;59051.704741476016;59188;59313.40686593079;59695.403045969855;37132.44301335482;46213.60582306882;47190.5280947193;52956.47043529592;53156.468435315925;9047.95476022642;9612.855807163038;9731.367461115287;9861.852072219066;9889.901100989186;25003.624945626194;25476.74523254818;25542.489150217265;25685.3578660535;25963.870180648977;41243.587564123976;42944.78527607342;43009;44233;45351.092978140914;11949.283043017447;12034.879651203726;12078.27530348182;12204.938975305067;12262.754744904874;13243.689077730567;13482.345254946711;13579.86420135786;13609.52366667162;14053.859461405254;12232.327222002876;12237.877621223673;12473.251604903735;12650.557230496888;13018;12506.374681266083;12551.309677967434;12744.171628844095;12752.74494510123;12784.105112642026;11856.913383164012;11919.404029798648;12047.216930899463;12064.75870482568;12379.89541777918;8972.730818075208;9008.41445306053;9087.636494540144;9177.403468774508;9271.30465215125;9554.187894028808;9879;10090.545925433225;10096.242781791541;10138.543765530421 22:21:00 INFO - PID 10591 | __end_tp_report 22:21:00 INFO - PID 10591 | __start_cc_report 22:21:00 INFO - PID 10591 | _x_x_mozilla_cycle_collect,371 22:21:00 INFO - PID 10591 | __end_cc_report 22:21:00 INFO - PID 10591 | __startTimestamp1491456060257__endTimestamp 22:21:00 INFO - PID 10591 | 22:21:00 INFO - PID 10591 | ------- Summary: start ------- 22:21:00 INFO - PID 10591 | Number of tests: 6 22:21:00 INFO - PID 10591 | 22:21:00 INFO - PID 10591 | [#0] dojo.html Cycles:165 Average:5285.66 Median:5455.51 stddev:630.43 (11.6%) stddev-sans-first:598.77 22:21:00 INFO - PID 10591 | Values: 2697.4 2744.5 2770.0 2782.1 2786.0 5221.4 5363.8 5387.5 5412.3 5431.8 5226.6 5310.2 5312.1 5325.8 5359.3 4723.1 4790.7 4793.7 4820.7 4847.9 4466.5 4783.8 4829.1 4847.2 4853.6 4690.3 4710.8 4722.6 4775.0 4791.6 4744.0 4764.3 4770.5 4803.7 4813.9 4699.6 4713.9 4714.9 4737.8 4765.4 5186.6 5235.9 5286.2 5331.7 5363.8 5822.0 5831.2 5853.1 5889.0 5923.3 5871.3 5875.8 5882.4 5884.7 5893.4 5322.4 5398.5 5404.8 5439.9 5459.8 5950.6 5961.8 5984.4 6011.9 6020.2 5608.1 5654.0 5659.5 5662.6 5668.5 5676.3 5697.0 5731.5 5733.3 5753.6 5671.1 5684.8 5704.3 5706.0 5716.1 5681.9 5690.0 5690.6 5694.1 5696.5 4746.2 4757.5 4760.0 4787.6 4796.5 4123.9 4165.9 4168.1 4178.1 4227.2 4931.6 4939.9 4956.6 4962.5 4982.4 5829.6 5840.9 5846.7 5847.4 5888.9 5000.7 5001.2 5004.1 5007.5 5065.0 5018.9 5079.4 5160.4 5184.5 5211.8 5392.2 5450.8 5451.8 5455.5 5465.4 5804.0 5837.6 5843.1 5844.7 5854.7 5310.1 5332.7 5377.3 5412.5 5428.4 5739.5 5741.6 5750.9 5791.9 5808.2 5786.3 5821.4 5840.8 5843.1 5843.8 5543.2 5597.4 5600.9 5605.9 5649.9 5548.8 5584.0 5592.3 5601.7 5605.1 5474.9 5519.3 5532.4 5534.4 5537.1 5637.8 5648.2 5650.0 5664.2 5704.9 5515.4 5520.3 5525.1 5528.4 5542.8 22:21:00 INFO - PID 10591 | 22:21:00 INFO - PID 10591 | [#1] ext.html Cycles:180 Average:31041.71 Median:29557.28 stddev:45365.94 (153.5%) stddev-sans-first:45436.08 22:21:00 INFO - PID 10591 | Values: 723.0 742.6 1045.8 1072.2 1178.1 31289.7 32433.0 32628.5 32716.8 32747.3 30895.5 31291.5 31296.8 31314.7 31348.7 6703.2 6858.6 6865.8 7085.2 7261.0 7273.3 7328.9 7388.1 7389.7 7393.8 7317.5 7337.3 7351.2 7368.9 7390.3 7305.8 7321.0 7329.1 7330.5 7348.1 7187.8 7243.2 7245.5 7271.3 7276.6 30884.8 31230.0 31332.7 31427.4 31472.0 2399.0 2416.9 2436.4 2438.1 2439.7 23802.6 23813.4 23932.9 23997.5 24039.6 3081.6 3120.2 3127.7 3145.9 3176.3 136493.3 136861.3 137118.0 137272.0 137344.0 32483.0 32920.8 38061.4 39450.0 40154.6 39796.4 39968.2 40191.8 40226.4 40333.4 11063.9 11154.1 11169.9 11192.9 11206.4 8678.9 8691.6 8695.5 8724.0 8731.4 12327.2 12367.5 12384.8 12392.0 12676.0 5322.5 5343.7 5349.1 5385.2 5516.4 837.4 880.8 885.8 895.7 897.9 20594.3 23867.5 25389.7 25535.0 25658.1 944.6 946.8 964.7 974.9 982.3 10308.9 11153.4 11207.0 11226.4 11249.9 196740.0 198264.0 198280.0 198983.0 199035.0 38790.0 38913.4 39068.2 39087.2 39247.4 1183.2 1229.2 1234.8 1236.9 1246.5 19054.7 19258.2 20266.4 20399.6 20456.5 29115.7 29238.4 29286.9 29320.6 29327.9 183378.0 183748.0 185002.0 185113.0 185618.0 26949.6 27125.6 28522.4 28753.0 28936.1 33930.2 34282.5 34763.8 34965.3 35205.5 26764.5 27038.7 27301.7 27524.0 27881.0 26625.0 26769.5 27549.9 27637.4 27661.7 28650.7 29332.4 29414.6 29700.0 29786.3 26221.9 26315.3 26759.6 26926.2 27239.3 20880.2 21926.1 22190.6 22290.9 22504.0 22:21:00 INFO - PID 10591 | 22:21:00 INFO - PID 10591 | [#2] jquery.html Cycles:180 Average:29140.13 Median:21862.94 stddev:81229.44 (371.5%) stddev-sans-first:81428.67 22:21:00 INFO - PID 10591 | Values: 412.3 422.6 426.6 432.1 432.5 17283.9 17574.8 18317.6 18345.2 19069.9 18696.3 18872.9 19359.1 19509.2 19675.3 5493.3 5577.7 5658.6 5683.1 5693.7 5613.0 5625.6 5654.3 5694.2 5709.7 5482.4 5606.4 5632.0 5649.9 5657.0 5598.4 5629.1 5664.9 5682.1 5684.7 4994.0 5085.5 5109.7 5119.6 5121.8 22390.6 22450.8 22474.6 22483.6 22720.5 1577.3 1613.5 1620.0 1624.6 1629.6 14796.2 14873.7 15228.4 15366.2 15572.5 2046.8 2123.2 2138.5 2163.7 2167.4 88652.6 91112.5 91381.9 91887.5 92478.0 10850.4 10929.8 11157.4 11227.9 11336.5 15434.2 15475.6 15512.8 15543.2 15631.7 7350.1 7394.5 7524.8 7671.2 7681.4 6755.2 6764.7 6940.3 7002.4 7024.7 6960.5 7005.0 7083.0 7168.5 7205.0 1990.3 2044.7 2047.3 2075.5 2195.9 803.4 835.5 877.6 885.5 885.9 16232.4 16456.4 16971.6 17317.3 17498.7 856.4 858.3 859.1 866.6 880.7 8771.8 9389.5 9417.2 9461.8 9536.2 471080.0 476714.0 497365.1 504812.0 505068.0 90204.0 90402.5 92047.5 95705.0 97646.0 1056.4 1097.0 1125.0 1136.8 1143.1 17533.0 17605.6 18302.3 18427.3 18631.4 42331.6 42449.0 42638.8 42683.0 43293.4 54785.7 55394.0 55701.0 55859.0 57317.4 8126.7 8276.8 8331.9 8417.7 8597.4 12210.1 12303.6 12311.2 12619.7 13265.1 9765.3 10154.3 10301.2 10824.4 10998.8 10097.1 10212.3 10303.1 10311.2 10311.6 10489.6 10561.5 10896.3 11118.6 11148.7 8159.1 8179.2 8260.6 8295.2 8603.1 9553.6 9770.4 10655.7 10794.5 11270.7 22:21:00 INFO - PID 10591 | 22:21:00 INFO - PID 10591 | [#3] mootools.html Cycles:180 Average:6281.96 Median:3569.42 stddev:4034.36 (113.0%) stddev-sans-first:4027.82 22:21:00 INFO - PID 10591 | Values: 1230.2 1260.3 1280.7 1294.4 1302.3 9596.5 10095.8 10103.8 10314.9 10574.4 10275.5 10446.3 10457.4 10464.2 10509.5 2269.4 2313.6 2324.6 2325.5 2332.2 2172.3 2272.3 2273.7 2275.6 2283.9 2248.8 2260.7 2264.3 2291.0 2310.8 2079.4 2104.9 2110.6 2110.9 2123.5 1929.7 2001.9 2169.1 2182.8 2185.0 10332.6 10398.3 10428.7 10449.8 10453.3 5637.2 5836.5 5901.4 5901.4 5909.5 3299.5 3518.5 3562.6 3576.2 3598.6 1065.0 1118.8 1134.9 1147.6 1158.4 13842.8 13876.5 13894.2 14044.1 14083.4 4598.1 4765.7 4989.4 4995.4 5088.3 11224.8 11312.7 11322.7 11329.7 11340.9 5567.1 5583.8 5599.4 5608.8 5627.7 5136.7 5205.2 5245.9 5278.7 5332.8 3776.2 3851.2 3880.2 3918.1 3935.1 1135.0 1139.4 1151.2 1155.9 1160.2 644.8 668.6 674.4 676.3 677.7 5132.3 5172.8 5246.9 5249.9 5305.1 518.3 539.0 540.3 540.7 550.7 3380.5 3496.9 3519.9 3531.7 3655.0 12636.4 13456.5 13474.9 13494.1 13534.7 12835.8 13320.0 13399.3 13417.0 13436.9 9406.4 9665.0 9686.5 9687.4 9703.2 5144.0 5180.7 5234.7 5249.5 5382.7 11618.3 11642.5 11732.1 11778.5 11848.9 12031.8 12048.8 12055.9 12182.5 12208.6 7856.1 7883.1 7928.4 7932.4 7935.3 9233.6 9336.7 9439.6 9462.9 9516.1 8069.1 8252.0 8303.4 8343.9 8542.1 7911.4 7981.7 8045.6 8170.3 8284.0 7045.6 7198.9 7232.5 7241.2 7243.3 4635.4 5045.1 5056.3 5208.0 5437.7 5107.3 5137.7 5184.6 5211.6 5275.3 22:21:00 INFO - PID 10591 | 22:21:00 INFO - PID 10591 | [#4] prototype.html Cycles:180 Average:4889.28 Median:5440.08 stddev:1397.28 (25.7%) stddev-sans-first:1359.39 22:21:00 INFO - PID 10591 | Values: 369.3 396.2 399.3 407.1 411.1 5533.9 5570.1 5602.4 5613.8 5631.7 5471.8 5492.5 5494.8 5496.6 5498.2 4178.5 4272.9 4302.2 4303.7 4304.4 4296.6 4296.8 4298.4 4301.2 4302.2 4274.1 4287.5 4298.1 4303.1 4309.6 4178.5 4221.4 4224.8 4283.2 4299.0 3794.7 3825.5 3828.8 3838.9 3845.0 5343.7 5345.6 5346.2 5358.7 5363.8 5019.9 5060.8 5083.4 5119.9 5124.2 5788.7 5790.9 5810.4 5824.5 5831.6 4370.8 4371.2 4383.4 4384.5 4384.6 5978.3 6051.0 6106.5 6117.7 6166.5 4478.3 4480.5 4482.1 4503.7 4516.9 4565.6 4575.4 4575.5 4578.1 4600.5 4968.5 5025.0 5071.4 5080.0 5087.6 5828.1 5837.9 5857.5 5859.4 5865.4 1572.3 1583.7 1597.7 1599.0 1602.7 1051.8 1112.9 1113.0 1119.4 1132.5 5075.8 5094.5 5131.8 5142.7 5163.5 6027.4 6030.3 6073.5 6092.9 6115.7 4906.6 5087.9 5123.5 5129.0 5162.6 3188.4 3227.3 3227.9 3232.7 3241.9 5408.4 5626.4 5627.8 5632.2 5646.7 6062.9 6236.7 6259.9 6304.8 6315.9 5653.2 5661.9 5692.4 5696.0 5708.8 6092.2 6102.0 6113.9 6128.6 6133.5 5686.3 5993.7 6014.4 6032.5 6057.7 5639.9 5658.2 5674.8 5691.1 5692.8 4111.0 4172.4 4194.9 4201.9 4215.0 6026.8 6080.5 6115.2 6121.4 6128.8 5877.6 5896.8 5897.2 5912.2 5918.0 5633.2 5816.5 5822.4 5887.2 5928.8 5800.7 5803.5 5814.7 5818.6 5842.2 5728.6 5962.8 5968.3 5976.8 5991.0 5723.6 5742.5 5754.5 5772.5 5783.0 22:21:00 INFO - PID 10591 | 22:21:00 INFO - PID 10591 | [#5] yui.html Cycles:180 Average:14880.10 Median:42976.89 stddev:18086.96 (42.1%) stddev-sans-first:18106.36 22:21:00 INFO - PID 10591 | Values: 702.2 704.9 713.9 717.6 719.5 13269.9 13867.4 14200.9 14416.3 14440.9 13366.9 13556.7 13586.1 13658.9 13671.4 909.8 913.3 916.8 921.5 926.1 884.3 921.7 922.9 924.8 928.3 959.3 966.1 968.0 971.5 977.1 964.9 969.7 970.1 973.0 974.7 714.4 715.5 716.7 718.2 721.3 13545.0 14101.0 14570.5 14616.6 14622.3 13290.7 14467.6 14484.6 14521.6 14546.7 11904.5 12369.8 12440.9 12450.0 12557.9 2878.8 2891.4 2924.3 2934.8 2949.2 65237.3 66066.7 66159.7 66639.7 67702.0 10594.5 10681.7 10704.2 10744.3 10885.9 21672.0 21781.0 22064.4 22066.4 22361.1 6716.2 6748.6 6789.3 7030.8 7104.6 3318.2 3353.3 3374.4 3378.6 3407.7 3515.9 3565.4 3566.0 3588.9 3623.1 707.3 714.3 715.7 721.0 721.1 527.7 533.0 537.5 539.7 559.2 8178.8 8435.5 8726.6 9050.5 9264.3 539.4 543.9 547.8 558.1 566.5 3847.1 3885.7 4007.1 4038.3 4114.5 61894.4 63750.4 64006.4 65928.7 67521.7 58692.0 59051.7 59188.0 59313.4 59695.4 37132.4 46213.6 47190.5 52956.5 53156.5 9048.0 9612.9 9731.4 9861.9 9889.9 25003.6 25476.7 25542.5 25685.4 25963.9 41243.6 42944.8 43009.0 44233.0 45351.1 11949.3 12034.9 12078.3 12204.9 12262.8 13243.7 13482.3 13579.9 13609.5 14053.9 12232.3 12237.9 12473.3 12650.6 13018.0 12506.4 12551.3 12744.2 12752.7 12784.1 11856.9 11919.4 12047.2 12064.8 12379.9 8972.7 9008.4 9087.6 9177.4 9271.3 9554.2 9879.0 10090.5 10096.2 10138.5 22:21:00 INFO - PID 10591 | -------- Summary: end -------- 22:21:00 INFO - PID 10591 | 22:21:01 INFO - TEST-INFO | 10591: exit 0 22:21:01 INFO - TEST-OK | dromaeo_css | took 1121708ms 22:21:01 INFO - TEST-START | kraken 22:21:01 INFO - operating with platform_type : linux_ 22:21:01 INFO - Initialising browser for kraken test... 22:21:01 INFO - TEST-INFO | started process 10975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFMlyid/profile http://localhost:39803/getInfo.html) 22:21:06 INFO - PID 10975 | __metrics Screen width/height:1600/1200 22:21:06 INFO - PID 10975 | colorDepth:24 22:21:06 INFO - PID 10975 | Browser inner width/height: 1024/697 22:21:06 INFO - PID 10975 | __metrics 22:21:07 ERROR - PID 10975 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 22:21:08 INFO - TEST-INFO | 10975: exit 0 22:21:08 INFO - Browser initialized. 22:21:08 INFO - Running cycle 1/1 for kraken test... 22:21:08 INFO - TEST-INFO | started process 11109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFMlyid/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:21:20 INFO - PID 11109 | RSS: Main: 160710656 22:21:20 INFO - PID 11109 | 22:21:23 INFO - PID 11109 | Cycle 1(1): loaded http://localhost:39803/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39803/tests/kraken/driver.html?testName=audio-beat-detection) 22:21:24 INFO - PID 11109 | RSS: Main: 167038976 22:21:24 INFO - PID 11109 | 22:21:27 INFO - PID 11109 | Cycle 1(1): loaded http://localhost:39803/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39803/tests/kraken/driver.html?testName=audio-dft) 22:21:27 INFO - PID 11109 | RSS: Main: 165728256 22:21:27 INFO - PID 11109 | 22:21:30 INFO - PID 11109 | Cycle 1(1): loaded http://localhost:39803/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39803/tests/kraken/driver.html?testName=audio-fft) 22:21:31 INFO - PID 11109 | RSS: Main: 162521088 22:21:31 INFO - PID 11109 | 22:21:33 INFO - PID 11109 | Cycle 1(1): loaded http://localhost:39803/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39803/tests/kraken/driver.html?testName=audio-oscillator) 22:21:34 INFO - PID 11109 | RSS: Main: 163090432 22:21:34 INFO - PID 11109 | 22:21:36 INFO - PID 11109 | Cycle 1(1): loaded http://localhost:39803/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39803/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:21:36 INFO - PID 11109 | RSS: Main: 163540992 22:21:36 INFO - PID 11109 | 22:21:40 INFO - PID 11109 | Cycle 1(1): loaded http://localhost:39803/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39803/tests/kraken/driver.html?testName=imaging-darkroom) 22:21:40 INFO - PID 11109 | RSS: Main: 167374848 22:21:40 INFO - PID 11109 | 22:21:44 INFO - PID 11109 | Cycle 1(1): loaded http://localhost:39803/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39803/tests/kraken/driver.html?testName=imaging-desaturate) 22:21:44 INFO - PID 11109 | RSS: Main: 166203392 22:21:44 INFO - PID 11109 | 22:21:47 INFO - PID 11109 | Cycle 1(1): loaded http://localhost:39803/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39803/tests/kraken/driver.html?testName=json-parse-financial) 22:21:48 INFO - PID 11109 | RSS: Main: 167108608 22:21:48 INFO - PID 11109 | 22:21:50 INFO - PID 11109 | Cycle 1(1): loaded http://localhost:39803/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39803/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:21:50 INFO - PID 11109 | RSS: Main: 167297024 22:21:50 INFO - PID 11109 | 22:21:52 INFO - PID 11109 | Cycle 1(1): loaded http://localhost:39803/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39803/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:21:53 INFO - PID 11109 | RSS: Main: 167395328 22:21:53 INFO - PID 11109 | 22:21:55 INFO - PID 11109 | Cycle 1(1): loaded http://localhost:39803/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39803/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:21:56 INFO - PID 11109 | RSS: Main: 167518208 22:21:56 INFO - PID 11109 | 22:21:58 INFO - PID 11109 | Cycle 1(1): loaded http://localhost:39803/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:21:59 INFO - PID 11109 | RSS: Main: 167915520 22:21:59 INFO - PID 11109 | 22:22:02 INFO - PID 11109 | Cycle 1(1): loaded http://localhost:39803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:22:03 INFO - PID 11109 | RSS: Main: 167804928 22:22:03 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | Cycle 1(1): loaded http://localhost:39803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39803/tests/kraken/driver.html?testName=ai-astar) 22:22:05 INFO - PID 11109 | RSS: Main: 169553920 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | __start_tp_report 22:22:05 INFO - PID 11109 | _x_x_mozilla_page_load 22:22:05 INFO - PID 11109 | _x_x_mozilla_page_load_details 22:22:05 INFO - PID 11109 | |i|pagename|runs| 22:22:05 INFO - PID 11109 | |0;ai-astar;105;112;112;113;114;114;112;113;113;113 22:22:05 INFO - PID 11109 | |1;audio-beat-detection;156;125;124;175;131;125;126;126;156;128 22:22:05 INFO - PID 11109 | |2;audio-dft;168;165;168;173;170;171;167;167;167;166 22:22:05 INFO - PID 11109 | |3;audio-fft;75;76;77;112;77;77;75;77;94;78 22:22:05 INFO - PID 11109 | |4;audio-oscillator;84;83;108;84;84;84;104;84;83;109 22:22:05 INFO - PID 11109 | |5;imaging-gaussian-blur;115;116;115;115;114;119;114;114;115;114 22:22:05 INFO - PID 11109 | |6;imaging-darkroom;152;151;152;153;152;153;153;153;152;152 22:22:05 INFO - PID 11109 | |7;imaging-desaturate;96;97;95;95;95;95;95;95;95;96 22:22:05 INFO - PID 11109 | |8;json-parse-financial;54;54;54;55;57;63;56;56;56;56 22:22:05 INFO - PID 11109 | |9;json-stringify-tinderbox;55;56;55;55;55;57;55;56;56;55 22:22:05 INFO - PID 11109 | |10;stanford-crypto-aes;82;82;83;89;83;83;84;83;82;82 22:22:05 INFO - PID 11109 | |11;stanford-crypto-ccm;142;146;137;143;136;136;141;143;197;138 22:22:05 INFO - PID 11109 | |12;stanford-crypto-pbkdf2;187;198;197;198;194;197;196;198;194;197 22:22:05 INFO - PID 11109 | |13;stanford-crypto-sha256-iterative;74;74;73;72;74;72;72;72;70;73 22:22:05 INFO - PID 11109 | __end_tp_report 22:22:05 INFO - PID 11109 | __start_cc_report 22:22:05 INFO - PID 11109 | _x_x_mozilla_cycle_collect,866 22:22:05 INFO - PID 11109 | __end_cc_report 22:22:05 INFO - PID 11109 | __startTimestamp1491456125654__endTimestamp 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | ------- Summary: start ------- 22:22:05 INFO - PID 11109 | Number of tests: 14 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.60 (2.3%) stddev-sans-first:0.78 22:22:05 INFO - PID 11109 | Values: 105.0 112.0 112.0 113.0 114.0 114.0 112.0 113.0 113.0 113.0 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:129.50 stddev:18.20 (14.1%) stddev-sans-first:17.99 22:22:05 INFO - PID 11109 | Values: 156.0 125.0 124.0 175.0 131.0 125.0 126.0 126.0 156.0 128.0 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | [#2] audio-dft Cycles:10 Average:168.20 Median:168.00 stddev:2.44 (1.5%) stddev-sans-first:2.59 22:22:05 INFO - PID 11109 | Values: 168.0 165.0 168.0 173.0 170.0 171.0 167.0 167.0 167.0 166.0 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.00 stddev:11.99 (15.6%) stddev-sans-first:12.46 22:22:05 INFO - PID 11109 | Values: 75.0 76.0 77.0 112.0 77.0 77.0 75.0 77.0 94.0 78.0 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:84.00 stddev:11.32 (13.5%) stddev-sans-first:11.75 22:22:05 INFO - PID 11109 | Values: 84.0 83.0 108.0 84.0 84.0 84.0 104.0 84.0 83.0 109.0 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 22:22:05 INFO - PID 11109 | Values: 115.0 116.0 115.0 115.0 114.0 119.0 114.0 114.0 115.0 114.0 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | [#6] imaging-darkroom Cycles:10 Average:152.30 Median:152.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 22:22:05 INFO - PID 11109 | Values: 152.0 151.0 152.0 153.0 152.0 153.0 153.0 153.0 152.0 152.0 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 22:22:05 INFO - PID 11109 | Values: 96.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:2.64 (4.7%) stddev-sans-first:2.69 22:22:05 INFO - PID 11109 | Values: 54.0 54.0 54.0 55.0 57.0 63.0 56.0 56.0 56.0 56.0 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 22:22:05 INFO - PID 11109 | Values: 55.0 56.0 55.0 55.0 55.0 57.0 55.0 56.0 56.0 55.0 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:2.11 (2.5%) stddev-sans-first:2.19 22:22:05 INFO - PID 11109 | Values: 82.0 82.0 83.0 89.0 83.0 83.0 84.0 83.0 82.0 82.0 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:142.50 stddev:18.27 (12.8%) stddev-sans-first:19.33 22:22:05 INFO - PID 11109 | Values: 142.0 146.0 137.0 143.0 136.0 136.0 141.0 143.0 197.0 138.0 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.60 Median:197.00 stddev:3.37 (1.7%) stddev-sans-first:1.59 22:22:05 INFO - PID 11109 | Values: 187.0 198.0 197.0 198.0 194.0 197.0 196.0 198.0 194.0 197.0 22:22:05 INFO - PID 11109 | 22:22:05 INFO - PID 11109 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.00 stddev:1.26 (1.7%) stddev-sans-first:1.24 22:22:05 INFO - PID 11109 | Values: 74.0 74.0 73.0 72.0 74.0 72.0 72.0 72.0 70.0 73.0 22:22:05 INFO - PID 11109 | -------- Summary: end -------- 22:22:05 INFO - PID 11109 | 22:22:07 INFO - TEST-INFO | 11109: exit 0 22:22:07 INFO - TEST-OK | kraken | took 65888ms 22:22:07 INFO - SUITE-END | took 1187s 22:22:07 INFO - Completed test suite (00:19:47) 22:22:07 INFO - javascript benchmark 22:22:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6738.811919733941, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2697.352635367512, 2744.4511097780423, 2769.9889540317777, 2782.1375373634187, 2785.9582106268404, 5221.399539053001, 5363.785448582057, 5387.4612538746105, 5412.323459567554, 5431.809886653968, 5226.55574276187, 5310.15037593985, 5312.07038768215, 5325.813596524123, 5359.276497672813, 4723.055388922212, 4790.712557246577, 4793.664443488957, 4820.734859582722, 4847.878803029917, 4466.508684044752, 4783.832565860195, 4829.082474329884, 4847.248676455138, 4853.635977301698, 4690.343351930733, 4710.811567537295, 4722.574968252839, 4775.0, 4791.592714619227, 4743.95256047442, 4764.332993380929, 4770.45139808923, 4803.663743537953, 4813.879653008703, 4699.577038066591, 4713.929291060636, 4714.929276060861, 4737.810487580493, 4765.380500534943, 5186.559142472895, 5235.895282094375, 5286.180642000496, 5331.733413329318, 5363.758630861621, 5821.970890145522, 5831.212786273841, 5853.1220316952795, 5889.02831032879, 5923.259592550931, 5871.324797648283, 5875.794347197828, 5882.411758824083, 5884.6763428011445, 5893.440123188333, 5322.441143679858, 5398.541124004503, 5404.783808647689, 5439.945600543944, 5459.836204913859, 5950.613210141327, 5961.821145365646, 5984.371640977722, 6011.909821352683, 6020.187274717857, 5608.10270356741, 5654.0, 5659.462351076641, 5662.631928924607, 5668.546516278688, 5676.347220069745, 5696.971515142481, 5731.455511726379, 5733.31200255972, 5753.626014309057, 5671.149327600893, 5684.772609095672, 5704.286964129484, 5706.0, 5716.056850619601, 5681.9431805681415, 5690.0, 5690.573207009491, 5694.117411801095, 5696.544276457874, 4746.169420351424, 4757.500462451462, 4759.976200118977, 4787.569118779326, 4796.5203479651755, 4123.876283711494, 4165.91668166635, 4168.062186008124, 4178.12259425524, 4227.239096962515, 4931.630127740362, 4939.90120197594, 4956.578690811321, 4962.528559786814, 4982.402111746614, 5829.562782791223, 5840.912386314209, 5846.736896839652, 5847.415258474119, 5888.852778680567, 5000.724960127228, 5001.199808030698, 5004.149294619923, 5007.524285192901, 5065.037642847848, 5018.924716129261, 5079.415867175248, 5160.40655324635, 5184.481551844785, 5211.817586384458, 5392.164214546751, 5450.754716037867, 5451.809186678447, 5455.509004189642, 5465.37148227943, 5803.999999999831, 5837.591368604157, 5843.094320380348, 5844.6785426801935, 5854.677992710442, 5310.123829568232, 5332.733363331896, 5377.300950876361, 5412.485813847678, 5428.402875683751, 5739.540836733135, 5741.598088133957, 5750.9424905752085, 5791.9131213031, 5808.215890854681, 5786.3056433228285, 5821.38875418075, 5840.8247752567495, 5843.094320380348, 5843.766249349978, 5543.223948647112, 5597.384287728428, 5600.943990560205, 5605.915911261252, 5649.943500564942, 5548.750306236148, 5583.966966111282, 5592.3009623797025, 5601.663900166003, 5605.131204663284, 5474.863128421662, 5519.337679478488, 5532.446755324436, 5534.39121696605, 5537.1140617502615, 5637.830865074055, 5648.23748793924, 5649.954758369715, 5664.150377443417, 5704.942950570441, 5515.393306736336, 5520.309961254843, 5525.060739674345, 5528.419515950928, 5542.8337149885565], "value": 5239.013049529284, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.9602371869547, 742.6361083069297, 1045.8431235314702, 1072.244067932108, 1178.0987544528443, 31289.687103128963, 32433.0, 32628.510572341434, 32716.836415817947, 32747.345053098925, 30895.536566951512, 31291.530627040556, 31296.843515782446, 31314.68685313146, 31348.68651313486, 6703.229128650219, 6858.622775747332, 6865.828354291158, 7085.220625731191, 7261.0, 7273.272672732711, 7328.890066649004, 7388.076490438695, 7389.704411823547, 7393.815154621124, 7317.524360916524, 7337.2662733726465, 7351.228121047293, 7368.852622947537, 7390.297921697457, 7305.817354566125, 7320.999999999974, 7329.120505539369, 7330.486865919388, 7348.1182258129365, 7187.7843664690145, 7243.239459856692, 7245.4928155029165, 7271.309225623558, 7276.5634061955925, 30884.8455757722, 31230.0, 31332.686673133205, 31427.37145257105, 31472.0, 2398.952020959571, 2416.891239894209, 2436.415260337524, 2438.1222759806456, 2439.7072351317956, 23802.64296035561, 23813.404664883517, 23932.880335598384, 23997.520049599087, 24039.639405408932, 3081.6302043754667, 3120.2199450137464, 3127.6559578446354, 3145.858436370369, 3176.3488484860777, 136493.3175334127, 136861.3156934219, 137118.0, 137272.0, 137344.0, 32483.0, 32920.83539582335, 38061.429078563844, 39450.0, 40154.59845401509, 39796.403053954215, 39968.2006359877, 40191.79904100461, 40226.39660405096, 40333.39499907504, 11063.944680276709, 11154.10767138627, 11169.888301117047, 11192.888071119347, 11206.439678016066, 8678.86981695275, 8691.608877600524, 8695.478271303742, 8724.0, 8731.432456890281, 12327.198732082386, 12367.505299788088, 12384.81422778659, 12392.0, 12675.985921126288, 5322.467753224647, 5343.732813359316, 5349.1010691204065, 5385.219143224211, 5516.365617953987, 837.3719710217337, 880.7886107334193, 885.8494056010494, 895.6775560798108, 897.9281657467387, 20594.27920022792, 23867.510959571333, 25389.74833179224, 25535.0, 25658.101966431084, 944.5938246554048, 946.8437707778139, 964.7346979580531, 974.9025097490336, 982.2829334585792, 10308.896911030793, 11153.442327883735, 11207.0, 11226.382548959886, 11249.887501124884, 196740.03259967503, 198264.0, 198280.0, 198983.0, 199035.0, 38790.0, 38913.41629875554, 39068.21863562713, 39087.218255634725, 39247.41128883069, 1183.1907373068111, 1229.1764517773113, 1234.796258617318, 1236.8763123687738, 1246.507629486348, 19054.71268964472, 19258.22967081301, 20266.392008239778, 20399.592008159456, 20456.488587785425, 29115.7088429113, 29238.41523169567, 29286.853565732035, 29320.56019159757, 29327.853360733912, 183378.0, 183748.0, 185002.0, 185113.0, 185618.0, 26949.595756064067, 27125.59311610288, 28522.42955140927, 28753.0, 28936.13191604171, 33930.151746205556, 34282.48576271308, 34763.826180868935, 34965.30069398547, 35205.471917921765, 26764.464710705288, 27038.729612704406, 27301.726982730714, 27524.0, 27881.0, 26625.0, 26769.464610708066, 27549.862250688617, 27637.447251054466, 27661.72338276672, 28650.713492864805, 29332.41335173242, 29414.558781617863, 29700.0, 29786.255343616584, 26221.868890655423, 26315.342116447242, 26759.598606020536, 26926.192214232822, 27239.319017024733, 20880.164793408094, 21926.122955081617, 22190.556188876453, 22290.88854555717, 22504.0], "value": 14319.599251452157, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.2990915443746, 422.5837550013234, 426.6394896312615, 432.07967030225615, 432.52422335431027, 17283.91358043208, 17574.82425175748, 18317.63364732706, 18345.174467148976, 19069.90465047676, 18696.25214991402, 18872.905635471805, 19359.128839202236, 19509.21963121477, 19675.31136410226, 5493.258410114643, 5577.6653400796085, 5658.603897727161, 5683.119116536923, 5693.715314234292, 5613.045782217033, 5625.606207565452, 5654.349749778787, 5694.231278777374, 5709.714514274269, 5482.369527504348, 5606.383297837235, 5632.042552766019, 5649.8587535311535, 5657.038303488417, 5598.384177740445, 5629.071203251458, 5664.915026274609, 5682.119271512943, 5684.658920464785, 4993.950060499385, 5085.491450854922, 5109.718965456898, 5119.59043276537, 5121.8463446096675, 22390.55218895629, 22450.775492245033, 22474.55050898989, 22483.55032899333, 22720.545589088124, 1577.3217516467914, 1613.5159452164303, 1620.0360785332707, 1624.5613684305172, 1629.5844559637335, 14796.18620975846, 14873.70252594953, 15228.390864365412, 15366.231688415646, 15572.454964076203, 2046.8055534724178, 2123.161351266241, 2138.4653836540865, 2163.718716566836, 2167.360628614547, 88652.55673721655, 91112.54443727739, 91381.94798572219, 91887.54056229744, 92477.99999999933, 10850.403227822388, 10929.781404371868, 11157.38634375101, 11227.943860280646, 11336.546538138547, 15434.228288585751, 15475.613109672124, 15512.767308490382, 15543.222838858012, 15631.68736625261, 7350.08123984502, 7394.482386232912, 7524.774256772305, 7671.156172820985, 7681.3854891608535, 6755.1556055493065, 6764.661766911635, 6940.30596940312, 7002.439804815603, 7024.683889224997, 6960.477964152708, 7005.0, 7083.0, 7168.498205125591, 7204.963975180195, 1990.3133418970433, 2044.734184556028, 2047.2834507922107, 2075.5330050738767, 2195.9341219763432, 803.4375936844233, 835.4903508859591, 877.5787621941377, 885.4769795950954, 885.8926342072409, 16232.350705971865, 16456.424025159064, 16971.575710607085, 17317.30730770755, 17498.65002699939, 856.4005196362571, 858.274757829633, 859.1236938322876, 866.5623859950811, 880.691757884748, 8771.780705482413, 9389.483578403117, 9417.199538039207, 9461.763455913657, 9536.2371010319, 471080.0, 476714.0, 497365.13174341136, 504812.0, 505068.0, 90204.0, 90402.54798725965, 92047.53976230076, 95705.0, 97646.0, 1056.4295280548417, 1096.9670909872716, 1125.0268517732102, 1136.7840110379002, 1143.0969534067992, 17533.0, 17605.647887042443, 18302.26790928348, 18427.26290948347, 18631.44105676832, 42331.576684232765, 42449.0, 42638.78680606577, 42683.0, 43293.3505997404, 54785.72607136939, 55394.0, 55701.0, 55859.0, 57317.42682573121, 8126.715564955198, 8276.751697449086, 8331.875021874797, 8417.70538031166, 8597.355198360023, 12210.145289829627, 12303.56937507183, 12311.19977201479, 12619.74760504803, 13265.137766045176, 9765.267604929517, 10154.289199755945, 10301.227407944285, 10824.404657743584, 10998.835017474585, 10097.141742951637, 10212.336198147097, 10303.124234440156, 10311.175105991653, 10311.639092631722, 10489.580416783549, 10561.471926403803, 10896.291741036806, 11118.61084862026, 11148.721281968015, 8159.143289954469, 8179.182081791773, 8260.628271727666, 8295.170482951899, 8603.139686031347, 9553.570089346134, 9770.36492627977, 10655.733606659896, 10794.460276986276, 11270.661880143609], "value": 9059.988217588087, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.2372529032002, 1260.300533204072, 1280.7438512297542, 1294.4045738960078, 1302.2837439408322, 9596.472194029335, 10095.798084038315, 10103.848442273362, 10314.948425257882, 10574.365538067721, 10275.537600807962, 10446.26876118672, 10457.372557646528, 10464.162866970624, 10509.474526273694, 2269.4212975691175, 2313.560423519526, 2324.6280595104786, 2325.5232677301196, 2332.242021343062, 2172.2940044485526, 2272.2842304673973, 2273.6816845641624, 2275.6472746724285, 2283.931482055541, 2248.786365295294, 2260.7174103237094, 2264.33202205349, 2290.9885450572806, 2310.803581695558, 2079.4073688998715, 2104.947376315589, 2110.5964533585147, 2110.915563377471, 2123.5115923337567, 1929.7008963610522, 2001.8798872067723, 2169.1215057901577, 2182.847200695952, 2185.0495034659975, 10332.638357657446, 10398.324108932895, 10428.739281517946, 10449.791004179873, 10453.268271221017, 5637.182608521742, 5836.474717275466, 5901.3508514063415, 5901.3508514063415, 5909.497692696083, 3299.538064670948, 3518.4546395308766, 3562.608113107556, 3576.2311103112697, 3598.6221446747977, 1064.9893501064967, 1118.7818375416798, 1134.9148813838995, 1147.6499667601379, 1158.4092113022418, 13842.792358114637, 13876.514321998682, 13894.23581703006, 14044.087134336236, 14083.436662533486, 4598.149342371672, 4765.666403351802, 4989.376327959005, 4995.425526064477, 5088.262201980692, 11224.775504489864, 11312.660620181408, 11322.660320190244, 11329.660110196708, 11340.886591133984, 5567.053600887859, 5583.776648933997, 5599.356074051455, 5608.831735047955, 5627.71861406928, 5136.691798492103, 5205.167173252337, 5245.895082098336, 5278.683279003272, 5332.773462103738, 3776.169242766587, 3851.171998020439, 3880.1569254603837, 3918.0988372673874, 3935.0752573145287, 1134.9602763903224, 1139.3619573039125, 1151.1826603111717, 1155.8728539860608, 1160.182071639492, 644.7775517446473, 668.5687731413309, 674.3728332650584, 676.2628734679223, 677.6848765324148, 5132.3327967364, 5172.844814655567, 5246.947530524722, 5249.9237656280375, 5305.124654432053, 518.271828081546, 538.9730513474389, 540.3245942571785, 540.7323374929435, 550.6585916731652, 3380.4591265397416, 3496.8601255949984, 3519.894403167909, 3531.69980551656, 3655.0, 12636.431360588796, 13456.529021484397, 13474.932625337007, 13494.122882012638, 13534.661633459045, 12835.807462888064, 13320.0, 13399.330033498287, 13417.0, 13436.865631343562, 9406.38858474197, 9664.99999999986, 9686.515674216402, 9687.41875487473, 9703.223742100616, 5143.974280128576, 5180.7409629519125, 5234.659747116425, 5249.501297376743, 5382.6878705932595, 11618.302901825917, 11642.53429862796, 11732.12009099338, 11778.469968851594, 11848.881511184778, 12031.75936481248, 12048.75902481963, 12055.939720301343, 12182.451789669309, 12208.572699955814, 7856.135825059353, 7883.093444253755, 7928.365730741411, 7932.444728868923, 7935.325497332791, 9233.630654774002, 9336.673216437392, 9439.575219115293, 9462.905370946477, 9516.143547080796, 8069.112397636138, 8252.0, 8303.418760686694, 8343.916560834557, 8542.103079176846, 7911.406644501571, 7981.680732770857, 8045.557494337868, 8170.305524030524, 8284.0, 7045.647717613996, 7198.856022879618, 7232.529885557422, 7241.203467618452, 7243.348098671145, 4635.397398338329, 5045.11710450677, 5056.292119103255, 5208.0, 5437.700926449083, 5107.310513080835, 5137.691738495702, 5184.611154163528, 5211.583073354198, 5275.261463395204], "value": 4680.113568008411, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.27806138998244, 396.1700238001386, 399.2673444229838, 407.12265068776776, 411.14276733011667, 5533.916991245134, 5570.136628822534, 5602.439756024395, 5613.80351687691, 5631.746571404286, 5471.781128754845, 5492.500912085002, 5494.80768173114, 5496.615236933416, 5498.230247765306, 4178.498580170384, 4272.893177670568, 4302.161078589676, 4303.720258183223, 4304.397384366175, 4296.582127897802, 4296.763677997709, 4298.419713338706, 4301.182775272689, 4302.236083205887, 4274.123804620061, 4287.5498072702385, 4298.118885628454, 4303.139372125572, 4309.59058889405, 4178.456800615901, 4221.366794980747, 4224.7675142555045, 4283.164782867342, 4299.0, 3794.6964242860504, 3825.5409350877794, 3828.8277027533827, 3838.9424158637644, 3845.0, 5343.679379237219, 5345.583420393599, 5346.224797404355, 5358.732063396815, 5363.785448582052, 5019.924701129486, 5060.772265248036, 5083.364579427572, 5119.923201151985, 5124.1801311790305, 5788.65559448424, 5790.855228619276, 5810.448007439287, 5824.475797178275, 5831.591788574801, 4370.781460926973, 4371.235033869092, 4383.364412160219, 4384.517703052662, 4384.6492280617795, 5978.342382337983, 6050.979275620742, 6106.48094911933, 6117.724702388358, 6166.475849552793, 4478.328250762346, 4480.529544397857, 4482.148391805546, 4503.707259028152, 4516.9159401743345, 4565.634749220055, 4575.3823233863, 4575.473820510617, 4578.130155270488, 4600.493945665974, 4968.453470118284, 5025.045241404195, 5071.442141364447, 5079.97460012705, 5087.618428617869, 5828.0767346775465, 5837.941620583825, 5857.502112320415, 5859.388668116302, 5865.384134665884, 1572.316042521507, 1583.6674298397236, 1597.6804639072, 1598.9680206395808, 1602.717825739404, 1051.8106740786732, 1112.8553288072499, 1113.0, 1119.3787447966295, 1132.4620805117504, 5075.771590278447, 5094.490550944876, 5131.820386286462, 5142.6914385137015, 5163.509466600667, 6027.383569858138, 6030.306514750772, 6073.544484163705, 6092.908606370908, 6115.724792384353, 4906.552566992746, 5087.898242035212, 5123.513266239701, 5129.0, 5162.638615296968, 3188.3623275345026, 3227.306129182237, 3227.919302017421, 3232.69289417505, 3241.8541165647603, 5408.378036525771, 5626.411850548793, 5627.831165065055, 5632.225848857679, 5646.71308120212, 6062.9090563641585, 6236.688165591702, 6259.874802504016, 6304.810855674337, 6315.894718424349, 5653.152027195872, 5661.886762264731, 5692.402297758676, 5696.0, 5708.800191993343, 6092.208012958287, 6102.0, 6113.930062239001, 6128.63228206309, 6133.539984501091, 5686.289213848269, 5993.730282137227, 6014.36849130835, 6032.4570788629235, 6057.666828324484, 5639.88720225585, 5658.151277308437, 5674.829755107354, 5691.117876729114, 5692.7722891083895, 4111.047252555012, 4172.3532852407925, 4194.853180138681, 4201.936970945377, 4214.957850421579, 6026.758929642765, 6080.513558915188, 6115.174451449176, 6121.357257488078, 6128.785492507741, 5877.617954832922, 5896.764129434946, 5897.174395584708, 5912.201852749824, 5917.970410148094, 5633.169669392159, 5816.47651711348, 5822.417758224313, 5887.20522729426, 5928.762849485972, 5800.738966746591, 5803.506701930383, 5814.680192589448, 5818.6217895836635, 5842.1820945066875, 5728.617607530159, 5962.821115366546, 5968.343482216866, 5976.7908123215475, 5990.981533139464, 5723.599348045597, 5742.5405967521665, 5754.53963682896, 5772.480476757112, 5782.971085144715], "value": 4468.071817527672, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.195985596492, 704.8625518023986, 713.8679344321298, 717.6304203335284, 719.5466855880794, 13269.933650331746, 13867.375968081435, 14200.928995355034, 14416.279186040681, 14440.855591444095, 13366.933165334183, 13556.72886542271, 13586.116902401362, 13658.93170534146, 13671.384787684554, 909.7998440343114, 913.3469569257979, 916.7708072981754, 921.5254144115786, 926.1201858234671, 884.3367474394204, 921.7280902133887, 922.8569571716395, 924.8242833861578, 928.2620316848122, 959.3092973059386, 966.1015255812092, 968.0416387776121, 971.504532688327, 977.081543349253, 964.8745663063792, 969.743018100204, 970.1462712812751, 973.0172525748974, 974.6637410093506, 714.382059518518, 715.5492040014809, 716.7419728897593, 718.1597530888872, 721.2823240875363, 13545.0, 14101.0, 14570.4900328488, 14616.561503154922, 14622.341994610268, 13290.73418531624, 14467.56597302072, 14484.56546303602, 14521.564353069425, 14546.70906581873, 11904.464299106561, 12369.814452783125, 12440.875591244063, 12450.0, 12557.874421255761, 2878.784091193148, 2891.421715656877, 2924.268932766808, 2934.7798915081453, 2949.188973032412, 65237.3476265236, 66066.66966665136, 66159.66920165416, 66639.66680166617, 67702.0, 10594.470276486145, 10681.674553769213, 10704.197185210984, 10744.30162039465, 10885.945570272099, 21672.0, 21781.0, 22064.44838879041, 22066.44833879166, 22361.105555777587, 6716.1604799400075, 6748.570514614735, 6789.25318214996, 7030.824229394306, 7104.609246491389, 3318.2202182487094, 3353.3460975110106, 3374.392609330295, 3378.6283508814013, 3407.693307602328, 3515.9472607910902, 3565.447355659877, 3566.0, 3588.9282214355567, 3623.1304486923477, 707.3492387003969, 714.257172540552, 715.7172916697875, 721.0446158839559, 721.1202333153544, 527.7097596322008, 533.0, 537.4517991648497, 539.6519245086897, 559.233849626015, 8178.836423271501, 8435.536045517432, 8726.607302671267, 9050.547472626342, 9264.305177111608, 539.3877948528449, 543.8531596469011, 547.8301726464808, 558.1488230448598, 566.5127989928658, 3847.0574709195866, 3885.708571857122, 4007.078371974404, 4038.290005431602, 4114.485689288839, 61894.38105618976, 63750.36249637537, 64006.35993640097, 65928.67035664791, 67521.66239168773, 58692.0, 59051.704741476016, 59188.0, 59313.40686593079, 59695.403045969855, 37132.44301335482, 46213.60582306882, 47190.5280947193, 52956.47043529592, 53156.468435315925, 9047.95476022642, 9612.855807163038, 9731.367461115287, 9861.852072219066, 9889.901100989186, 25003.624945626194, 25476.74523254818, 25542.489150217265, 25685.3578660535, 25963.870180648977, 41243.587564123976, 42944.78527607342, 43009.0, 44233.0, 45351.092978140914, 11949.283043017447, 12034.879651203726, 12078.27530348182, 12204.938975305067, 12262.754744904874, 13243.689077730567, 13482.345254946711, 13579.86420135786, 13609.52366667162, 14053.859461405254, 12232.327222002876, 12237.877621223673, 12473.251604903735, 12650.557230496888, 13018.0, 12506.374681266083, 12551.309677967434, 12744.171628844095, 12752.74494510123, 12784.105112642026, 11856.913383164012, 11919.404029798648, 12047.216930899463, 12064.75870482568, 12379.89541777918, 8972.730818075208, 9008.41445306053, 9087.636494540144, 9177.403468774508, 9271.30465215125, 9554.187894028808, 9879.0, 10090.545925433225, 10096.242781791541, 10138.543765530421], "value": 6588.478219748988, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1561.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 112.0, 113.0, 114.0, 114.0, 112.0, 113.0, 113.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 124.0, 175.0, 131.0, 125.0, 126.0, 126.0, 156.0, 128.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 168.0, 173.0, 170.0, 171.0, 167.0, 167.0, 167.0, 166.0], "value": 168.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 112.0, 77.0, 77.0, 75.0, 77.0, 94.0, 78.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 108.0, 84.0, 84.0, 84.0, 104.0, 84.0, 83.0, 109.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 115.0, 115.0, 114.0, 119.0, 114.0, 114.0, 115.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 152.0, 153.0, 152.0, 153.0, 153.0, 153.0, 152.0, 152.0], "value": 152.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 57.0, 63.0, 56.0, 56.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 55.0, 57.0, 55.0, 56.0, 56.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 89.0, 83.0, 83.0, 84.0, 83.0, 82.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 146.0, 137.0, 143.0, 136.0, 136.0, 141.0, 143.0, 197.0, 138.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 198.0, 197.0, 198.0, 194.0, 197.0, 196.0, 198.0, 194.0, 197.0], "value": 195.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 72.0, 74.0, 72.0, 72.0, 72.0, 70.0, 73.0], "value": 72.6, "unit": "score"}]}]} 22:22:07 INFO - Return code: 0 22:22:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:22:07 ERROR - # TBPL SUCCESS # 22:22:07 INFO - Running post-action listener: _resource_record_post_action 22:22:07 INFO - [mozharness: 2017-04-06 05:22:07.466748Z] Finished run-tests step (success) 22:22:07 INFO - Running post-run listener: _resource_record_post_run 22:22:07 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 355008512; Read time: 16; Write time: 206244 22:22:07 INFO - TinderboxPrint: CPU usage
13.3% 22:22:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 22:22:07 INFO - TinderboxPrint: I/O write bytes / time
355,008,512 / 206,244 22:22:07 INFO - TinderboxPrint: CPU idle
8,318.5 (86.6%) 22:22:07 INFO - TinderboxPrint: CPU user
1,221.0 (12.7%) 22:22:07 INFO - TinderboxPrint: Swap in / out
0 / 0 22:22:07 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 100995072; Read time: 0; Write time: 69864 22:22:07 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254013440; Read time: 16; Write time: 136380 22:22:08 INFO - Running post-run listener: _upload_blobber_files 22:22:08 INFO - Blob upload gear active. 22:22:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:22:08 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 22:22:08 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'] 22:22:08 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 22:22:08 INFO - (blobuploader) - INFO - Open directory for files ... 22:22:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:22:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:22:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:09 INFO - (blobuploader) - INFO - Done attempting. 22:22:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:22:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:22:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:10 INFO - (blobuploader) - INFO - Done attempting. 22:22:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:22:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:22:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:13 INFO - (blobuploader) - INFO - Done attempting. 22:22:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:22:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:22:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:14 INFO - (blobuploader) - INFO - Done attempting. 22:22:14 INFO - (blobuploader) - INFO - Iteration through files over. 22:22:14 INFO - Return code: 0 22:22:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:22:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:22:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d9dfbdcb066393d6395f72a36a2fd3ffe91a0fd5729323aef701afa6c1f9e4ab60288ac36f8ebc261c795d9309b21ee070bbf5783e6dae1fbb6fee8c698e792", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/487a98741f28ac2eddc195dcb1c37d6811a2dcb0277f31481ae03f26aa3337e5cbd20a7d93d5c9904d4317549cd381f4920c36e06f3ff137c3792e0b366a6ecf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7032c0b05cf51290cfaecafbccd4c2fab857795b244e3766472c9ad2937df0f5eb15182244472ce6fbdcfdfcee46db3fcda20014c232004c028b235ce281f62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/331585322708bb58b9a4f6a7be760cc81b77a49c37223c1713c6b9d6d3cf8c07ffaf4ecfe7672cf6f0fa9af9ca23d8937a7a2a6f8ad5a828aa86d727a9237a8b"} 22:22:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:22:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:22:14 INFO - Contents: 22:22:14 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d9dfbdcb066393d6395f72a36a2fd3ffe91a0fd5729323aef701afa6c1f9e4ab60288ac36f8ebc261c795d9309b21ee070bbf5783e6dae1fbb6fee8c698e792", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/487a98741f28ac2eddc195dcb1c37d6811a2dcb0277f31481ae03f26aa3337e5cbd20a7d93d5c9904d4317549cd381f4920c36e06f3ff137c3792e0b366a6ecf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7032c0b05cf51290cfaecafbccd4c2fab857795b244e3766472c9ad2937df0f5eb15182244472ce6fbdcfdfcee46db3fcda20014c232004c028b235ce281f62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/331585322708bb58b9a4f6a7be760cc81b77a49c37223c1713c6b9d6d3cf8c07ffaf4ecfe7672cf6f0fa9af9ca23d8937a7a2a6f8ad5a828aa86d727a9237a8b"} 22:22:14 INFO - Running post-run listener: copy_logs_to_upload_dir 22:22:14 INFO - Copying logs to upload dir... 22:22:14 INFO - mkdir: /builds/slave/test/build/upload/logs 22:22:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.874532 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-04-05 22:22:13.606174) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 22:22:13.609980) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d9dfbdcb066393d6395f72a36a2fd3ffe91a0fd5729323aef701afa6c1f9e4ab60288ac36f8ebc261c795d9309b21ee070bbf5783e6dae1fbb6fee8c698e792", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/487a98741f28ac2eddc195dcb1c37d6811a2dcb0277f31481ae03f26aa3337e5cbd20a7d93d5c9904d4317549cd381f4920c36e06f3ff137c3792e0b366a6ecf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7032c0b05cf51290cfaecafbccd4c2fab857795b244e3766472c9ad2937df0f5eb15182244472ce6fbdcfdfcee46db3fcda20014c232004c028b235ce281f62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/331585322708bb58b9a4f6a7be760cc81b77a49c37223c1713c6b9d6d3cf8c07ffaf4ecfe7672cf6f0fa9af9ca23d8937a7a2a6f8ad5a828aa86d727a9237a8b"} build_url:https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/e6TNkw5mQ_6tCd-jEbizhg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d9dfbdcb066393d6395f72a36a2fd3ffe91a0fd5729323aef701afa6c1f9e4ab60288ac36f8ebc261c795d9309b21ee070bbf5783e6dae1fbb6fee8c698e792", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/487a98741f28ac2eddc195dcb1c37d6811a2dcb0277f31481ae03f26aa3337e5cbd20a7d93d5c9904d4317549cd381f4920c36e06f3ff137c3792e0b366a6ecf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7032c0b05cf51290cfaecafbccd4c2fab857795b244e3766472c9ad2937df0f5eb15182244472ce6fbdcfdfcee46db3fcda20014c232004c028b235ce281f62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/331585322708bb58b9a4f6a7be760cc81b77a49c37223c1713c6b9d6d3cf8c07ffaf4ecfe7672cf6f0fa9af9ca23d8937a7a2a6f8ad5a828aa86d727a9237a8b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 22:22:13.635775) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:22:13.636100) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1491454871.454528-909107320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:22:13.718965) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 22:22:13.719278) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 22:22:13.719655) ========= ========= Total master_lag: 0.14 =========