builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1490494318.49 results: success (0) revision: d57834d60548d3003d8c0725e7b0f103c1346da3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:58.493285) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:58.493752) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:58.494022) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:58.527133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:58.527401) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-25 19:12:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.0M=0s 2017-03-25 19:12:00 (87.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111963 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:58.653109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:58.653459) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021179 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:58.702809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:58.703116) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d57834d60548d3003d8c0725e7b0f103c1346da3 --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 d57834d60548d3003d8c0725e7b0f103c1346da3 --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=74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-25 19:12:00,571 truncating revision to first 12 chars 2017-03-25 19:12:00,571 Setting DEBUG logging. 2017-03-25 19:12:00,571 attempt 1/10 2017-03-25 19:12:00,571 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d57834d60548?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-25 19:12:00,904 unpacking tar archive at: mozilla-central-d57834d60548/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677758 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:59.394668) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:59.394965) ========= script_repo_revision: d57834d60548d3003d8c0725e7b0f103c1346da3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:59.395339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:59.395598) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-25 19:11:59.406267) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-25 19:11:59.406537) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:12:01 INFO - MultiFileLogger online at 20170325 19:12:01 in /builds/slave/test 19:12:01 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 19:12:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:12:01 INFO - {'append_to_log': False, 19:12:01 INFO - 'base_work_dir': '/builds/slave/test', 19:12:01 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:12:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:12:01 INFO - 'branch': 'Firefox-Non-PGO', 19:12:01 INFO - 'buildbot_json_path': 'buildprops.json', 19:12:01 INFO - 'config_files': ('talos/linux_config.py',), 19:12:01 INFO - 'default_actions': ('clobber', 19:12:01 INFO - 'read-buildbot-config', 19:12:01 INFO - 'download-and-extract', 19:12:01 INFO - 'populate-webroot', 19:12:01 INFO - 'create-virtualenv', 19:12:01 INFO - 'install', 19:12:01 INFO - 'run-tests'), 19:12:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:12:01 INFO - 'download_minidump_stackwalk': True, 19:12:01 INFO - 'download_symbols': 'ondemand', 19:12:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:12:01 INFO - 'tooltool.py': '/tools/tooltool.py', 19:12:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:12:01 INFO - '/tools/misc-python/virtualenv.py')}, 19:12:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:12:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:12:01 INFO - 'gecko_profile': False, 19:12:01 INFO - 'gecko_profile_interval': 0, 19:12:01 INFO - 'installer_path': 'installer.exe', 19:12:01 INFO - 'log_level': 'info', 19:12:01 INFO - 'log_name': 'talos', 19:12:01 INFO - 'log_to_console': True, 19:12:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:12:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:12:01 INFO - 'opt_config_files': (), 19:12:01 INFO - 'pip_index': False, 19:12:01 INFO - 'suite': 'dromaeojs-e10s', 19:12:01 INFO - 'system_bits': '32', 19:12:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:12:01 INFO - 'title': 'talos-linux64-ix-042', 19:12:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:12:01 INFO - 'use_talos_json': True, 19:12:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:12:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:12:01 INFO - 'work_dir': 'build'} 19:12:01 INFO - [mozharness: 2017-03-26 02:12:01.369471Z] Running clobber step. 19:12:01 INFO - Running pre-action listener: _resource_record_pre_action 19:12:01 INFO - Running main action method: clobber 19:12:01 INFO - rmtree: /builds/slave/test/build 19:12:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:12:02 INFO - Running post-action listener: _resource_record_post_action 19:12:02 INFO - [mozharness: 2017-03-26 02:12:02.299955Z] Finished clobber step (success) 19:12:02 INFO - [mozharness: 2017-03-26 02:12:02.300055Z] Running read-buildbot-config step. 19:12:02 INFO - Running pre-action listener: _resource_record_pre_action 19:12:02 INFO - Running main action method: read_buildbot_config 19:12:02 INFO - Using buildbot properties: 19:12:02 INFO - { 19:12:02 INFO - "project": "", 19:12:02 INFO - "product": "firefox", 19:12:02 INFO - "who": "philringnalda@gmail.com", 19:12:02 INFO - "installer_path": "public/build/target.tar.bz2", 19:12:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:12:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:12:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:12:02 INFO - "stage_platform": "linux64", 19:12:02 INFO - "basedir": "/builds/slave/test", 19:12:02 INFO - "buildnumber": 488, 19:12:02 INFO - "platform": "ubuntu64_hw", 19:12:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:12:02 INFO - "slavebuilddir": "test", 19:12:02 INFO - "taskId": "Ygz0y10lTU-KWDN1FmC5fA", 19:12:02 INFO - "branch": "mozilla-central", 19:12:02 INFO - "script_repo_revision": "production", 19:12:02 INFO - "revision": "d57834d60548d3003d8c0725e7b0f103c1346da3", 19:12:02 INFO - "slavename": "talos-linux64-ix-042", 19:12:02 INFO - "repo_path": "mozilla-central" 19:12:02 INFO - } 19:12:02 INFO - Finding installer, test and symbols from parent task. 19:12:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ygz0y10lTU-KWDN1FmC5fA'}, attempt #1 19:12:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ygz0y10lTU-KWDN1FmC5fA'}, attempt #1 19:12:03 INFO - Task dependencies: aUKtNe-LRZ-9XMJQTLAWjg 19:12:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg'}, attempt #1 19:12:03 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2 19:12:03 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/test_packages.json 19:12:03 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.crashreporter-symbols.zip 19:12:03 INFO - Running post-action listener: _resource_record_post_action 19:12:03 INFO - [mozharness: 2017-03-26 02:12:03.770956Z] Finished read-buildbot-config step (success) 19:12:03 INFO - [mozharness: 2017-03-26 02:12:03.771176Z] Running download-and-extract step. 19:12:03 INFO - Running pre-action listener: _resource_record_pre_action 19:12:03 INFO - Running main action method: download_and_extract 19:12:03 INFO - mkdir: /builds/slave/test/build/tests 19:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:03 INFO - trying https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.test_packages.json 19:12:03 INFO - Downloading https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:12:04 INFO - Downloaded 986 bytes. 19:12:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:12:04 INFO - Using the following test package requirements: 19:12:04 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:12:04 INFO - u'common': [u'target.common.tests.zip'], 19:12:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:12:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:12:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:12:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:12:04 INFO - u'mozbase': [u'target.common.tests.zip'], 19:12:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:12:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:12:04 INFO - u'web-platform': [u'target.common.tests.zip', 19:12:04 INFO - u'target.web-platform.tests.zip'], 19:12:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:12:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:12:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.common.tests.zip 19:12:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:12:04 INFO - Fetch https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.common.tests.zip into memory 19:12:05 INFO - Expected file size: 58128617 19:12:05 INFO - Obtained file size: 58128617 19:12:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:12:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.common.tests.zip 19:12:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:12:15 INFO - Fetch https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.common.tests.zip into memory 19:12:16 INFO - Expected file size: 58128617 19:12:16 INFO - Obtained file size: 58128617 19:12:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.talos.tests.zip 19:12:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:12:27 INFO - Fetch https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.talos.tests.zip into memory 19:12:27 INFO - Expected file size: 14404171 19:12:27 INFO - Obtained file size: 14404171 19:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:28 INFO - trying https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2 19:12:28 INFO - Downloading https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:12:30 INFO - Downloaded 62578384 bytes. 19:12:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2 19:12:30 INFO - mkdir: /builds/slave/test/properties 19:12:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:12:30 INFO - Writing to file /builds/slave/test/properties/build_url 19:12:30 INFO - Contents: 19:12:30 INFO - build_url:https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2 19:12:30 INFO - Running post-action listener: _resource_record_post_action 19:12:30 INFO - Running post-action listener: set_extra_try_arguments 19:12:30 INFO - [mozharness: 2017-03-26 02:12:30.517809Z] Finished download-and-extract step (success) 19:12:30 INFO - [mozharness: 2017-03-26 02:12:30.517997Z] Running populate-webroot step. 19:12:30 INFO - Running pre-action listener: _resource_record_pre_action 19:12:30 INFO - Running main action method: populate_webroot 19:12:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:12:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:12:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:12:30 INFO - '--tppagecycles', 19:12:30 INFO - '7'], 19:12:30 INFO - 'tests': ['tsvgm']}}, 19:12:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:12:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:12:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:12:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:12:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:12:30 INFO - 'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:12:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:12:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:12:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:12:30 INFO - 'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['damp', 'tps']}, 19:12:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:12:30 INFO - 'tests': ['damp', 'tps']}, 19:12:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['dromaeo_dom']}, 19:12:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:12:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['basic_compositor_video']}, 19:12:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:12:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['a11yr', 19:12:30 INFO - 'ts_paint', 19:12:30 INFO - 'tpaint', 19:12:30 INFO - 'sessionrestore', 19:12:30 INFO - 'sessionrestore_no_auto_restore', 19:12:30 INFO - 'tabpaint']}, 19:12:30 INFO - 'other-e10s': {'tests': ['a11yr', 19:12:30 INFO - 'ts_paint', 19:12:30 INFO - 'tpaint', 19:12:30 INFO - 'sessionrestore', 19:12:30 INFO - 'sessionrestore_no_auto_restore', 19:12:30 INFO - 'tabpaint']}, 19:12:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:12:30 INFO - 'ts_paint', 19:12:30 INFO - 'tpaint', 19:12:30 INFO - 'sessionrestore', 19:12:30 INFO - 'sessionrestore_no_auto_restore', 19:12:30 INFO - 'tabpaint']}, 19:12:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:12:30 INFO - 'ts_paint', 19:12:30 INFO - 'tpaint', 19:12:30 INFO - 'sessionrestore', 19:12:30 INFO - 'sessionrestore_no_auto_restore', 19:12:30 INFO - 'tabpaint']}, 19:12:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['a11yr', 19:12:30 INFO - 'ts_paint', 19:12:30 INFO - 'tpaint', 19:12:30 INFO - 'sessionrestore', 19:12:30 INFO - 'sessionrestore_no_auto_restore', 19:12:30 INFO - 'tabpaint']}, 19:12:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['a11yr', 19:12:30 INFO - 'ts_paint', 19:12:30 INFO - 'tpaint', 19:12:30 INFO - 'sessionrestore', 19:12:30 INFO - 'sessionrestore_no_auto_restore', 19:12:30 INFO - 'tabpaint']}, 19:12:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['tsvgx', 19:12:30 INFO - 'tsvgr_opacity', 19:12:30 INFO - 'tart', 19:12:30 INFO - 'tscrollx', 19:12:30 INFO - 'cart', 19:12:30 INFO - 'tsvg_static']}, 19:12:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:12:30 INFO - 'tsvgr_opacity', 19:12:30 INFO - 'tart', 19:12:30 INFO - 'tscrollx', 19:12:30 INFO - 'cart', 19:12:30 INFO - 'tsvg_static']}, 19:12:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:12:30 INFO - 'talos_options': ['--disable-e10s'], 19:12:30 INFO - 'tests': ['tp5o']}, 19:12:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:12:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:12:30 INFO - 'talos_options': ['--disable-e10s', 19:12:30 INFO - '--xperf_path', 19:12:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:12:30 INFO - 'tests': ['tp5n']}, 19:12:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:12:30 INFO - 'talos_options': ['--xperf_path', 19:12:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:12:30 INFO - 'tests': ['tp5n']}}, 19:12:30 INFO - 'talos.zip': {'path': '', 19:12:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:12:30 INFO - Running post-action listener: _resource_record_post_action 19:12:30 INFO - [mozharness: 2017-03-26 02:12:30.535050Z] Finished populate-webroot step (success) 19:12:30 INFO - [mozharness: 2017-03-26 02:12:30.535139Z] Running create-virtualenv step. 19:12:30 INFO - Running pre-action listener: _resource_record_pre_action 19:12:30 INFO - Running main action method: create_virtualenv 19:12:30 INFO - Creating virtualenv /builds/slave/test/build/venv 19:12:30 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 19:12:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:12:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:12:30 INFO - Using real prefix '/usr' 19:12:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:12:31 INFO - Installing distribute.............................................................................................................................................................................................done. 19:12:33 INFO - Installing pip.................done. 19:12:33 INFO - Return code: 0 19:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:12:33 INFO - Reading from file tmpfile_stdout 19:12:33 INFO - Output received: 19:12:33 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) 19:12:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:12:33 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')]} 19:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:33 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')]} 19:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:33 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 0xc541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef290>, '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 0xeefb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef0040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', '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 19:12:33 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 19:12:33 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 19:12:33 INFO - Using env: {'DISPLAY': ':0', 19:12:33 INFO - 'HOME': '/home/cltbld', 19:12:33 INFO - 'LANG': 'en_US.UTF-8', 19:12:33 INFO - 'LANGUAGE': 'en_US:en', 19:12:33 INFO - 'LOGNAME': 'cltbld', 19:12:33 INFO - 'MAIL': '/var/mail/cltbld', 19:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:33 INFO - 'MOZ_NO_REMOTE': '1', 19:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:33 INFO - 'NO_EM_RESTART': '1', 19:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:33 INFO - 'PWD': '/builds/slave/test', 19:12:33 INFO - 'SHELL': '/bin/bash', 19:12:33 INFO - 'SHLVL': '1', 19:12:33 INFO - 'TERM': 'linux', 19:12:33 INFO - 'TMOUT': '86400', 19:12:33 INFO - 'USER': 'cltbld', 19:12:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', 19:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:33 INFO - '_': '/tools/buildbot/bin/python'} 19:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:33 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 19:12:33 INFO - Cleaning up... 19:12:33 INFO - Return code: 0 19:12:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:12:33 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')]} 19:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:33 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')]} 19:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:33 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 0xc541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef290>, '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 0xeefb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef0040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', '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 19:12:33 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 19:12:33 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 19:12:33 INFO - Using env: {'DISPLAY': ':0', 19:12:33 INFO - 'HOME': '/home/cltbld', 19:12:33 INFO - 'LANG': 'en_US.UTF-8', 19:12:33 INFO - 'LANGUAGE': 'en_US:en', 19:12:33 INFO - 'LOGNAME': 'cltbld', 19:12:33 INFO - 'MAIL': '/var/mail/cltbld', 19:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:33 INFO - 'MOZ_NO_REMOTE': '1', 19:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:33 INFO - 'NO_EM_RESTART': '1', 19:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:33 INFO - 'PWD': '/builds/slave/test', 19:12:33 INFO - 'SHELL': '/bin/bash', 19:12:33 INFO - 'SHLVL': '1', 19:12:33 INFO - 'TERM': 'linux', 19:12:33 INFO - 'TMOUT': '86400', 19:12:33 INFO - 'USER': 'cltbld', 19:12:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', 19:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:33 INFO - '_': '/tools/buildbot/bin/python'} 19:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:33 INFO - Downloading/unpacking psutil>=3.1.1 19:12:33 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 19:12:33 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 19:12:33 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 19:12:33 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 19:12:33 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 19:12:33 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 19:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:12:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:12:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:12:35 INFO - Installing collected packages: psutil 19:12:35 INFO - Running setup.py install for psutil 19:12:35 INFO - building 'psutil._psutil_linux' extension 19:12:35 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 19:12:36 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 19:12:36 INFO - building 'psutil._psutil_posix' extension 19:12:36 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 19:12:36 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 19:12:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:12:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:12:36 INFO - Successfully installed psutil 19:12:36 INFO - Cleaning up... 19:12:36 INFO - Return code: 0 19:12:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:12:36 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')]} 19:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:36 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')]} 19:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:36 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 0xc541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef290>, '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 0xeefb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef0040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', '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 19:12:36 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 19:12:36 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 19:12:36 INFO - Using env: {'DISPLAY': ':0', 19:12:36 INFO - 'HOME': '/home/cltbld', 19:12:36 INFO - 'LANG': 'en_US.UTF-8', 19:12:36 INFO - 'LANGUAGE': 'en_US:en', 19:12:36 INFO - 'LOGNAME': 'cltbld', 19:12:36 INFO - 'MAIL': '/var/mail/cltbld', 19:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:36 INFO - 'MOZ_NO_REMOTE': '1', 19:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:36 INFO - 'NO_EM_RESTART': '1', 19:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:36 INFO - 'PWD': '/builds/slave/test', 19:12:36 INFO - 'SHELL': '/bin/bash', 19:12:36 INFO - 'SHLVL': '1', 19:12:36 INFO - 'TERM': 'linux', 19:12:36 INFO - 'TMOUT': '86400', 19:12:36 INFO - 'USER': 'cltbld', 19:12:36 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', 19:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:36 INFO - '_': '/tools/buildbot/bin/python'} 19:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:12:36 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 19:12:36 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 19:12:36 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 19:12:36 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 19:12:36 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 19:12:36 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 19:12:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:12:38 INFO - Installing collected packages: mozsystemmonitor 19:12:38 INFO - Running setup.py install for mozsystemmonitor 19:12:38 INFO - Successfully installed mozsystemmonitor 19:12:38 INFO - Cleaning up... 19:12:38 INFO - Return code: 0 19:12:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:38 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 0xc541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef290>, '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 0xeefb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef0040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', '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 19:12:38 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 19:12:38 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 19:12:38 INFO - Using env: {'DISPLAY': ':0', 19:12:38 INFO - 'HOME': '/home/cltbld', 19:12:38 INFO - 'LANG': 'en_US.UTF-8', 19:12:38 INFO - 'LANGUAGE': 'en_US:en', 19:12:38 INFO - 'LOGNAME': 'cltbld', 19:12:38 INFO - 'MAIL': '/var/mail/cltbld', 19:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:38 INFO - 'MOZ_NO_REMOTE': '1', 19:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:38 INFO - 'NO_EM_RESTART': '1', 19:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:38 INFO - 'PWD': '/builds/slave/test', 19:12:38 INFO - 'SHELL': '/bin/bash', 19:12:38 INFO - 'SHLVL': '1', 19:12:38 INFO - 'TERM': 'linux', 19:12:38 INFO - 'TMOUT': '86400', 19:12:38 INFO - 'USER': 'cltbld', 19:12:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', 19:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:38 INFO - '_': '/tools/buildbot/bin/python'} 19:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:39 INFO - Downloading/unpacking jsonschema==2.5.1 19:12:39 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 19:12:39 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 19:12:39 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 19:12:39 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 19:12:39 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 19:12:39 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 19:12:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:12:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:41 INFO - Downloading functools32-3.2.3-2.tar.gz 19:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:12:41 INFO - warning: no files found matching '*.txt' 19:12:41 INFO - no previously-included directories found matching 'build' 19:12:41 INFO - no previously-included directories found matching 'dist' 19:12:41 INFO - no previously-included directories found matching '.git*' 19:12:41 INFO - Installing collected packages: jsonschema, functools32 19:12:41 INFO - Running setup.py install for functools32 19:12:41 INFO - warning: no files found matching '*.txt' 19:12:41 INFO - no previously-included directories found matching 'build' 19:12:41 INFO - no previously-included directories found matching 'dist' 19:12:41 INFO - no previously-included directories found matching '.git*' 19:12:41 INFO - Successfully installed jsonschema functools32 19:12:41 INFO - Cleaning up... 19:12:41 INFO - Return code: 0 19:12:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef290>, '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 0xeefb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef0040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', '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 19:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:12:41 INFO - Using env: {'DISPLAY': ':0', 19:12:41 INFO - 'HOME': '/home/cltbld', 19:12:41 INFO - 'LANG': 'en_US.UTF-8', 19:12:41 INFO - 'LANGUAGE': 'en_US:en', 19:12:41 INFO - 'LOGNAME': 'cltbld', 19:12:41 INFO - 'MAIL': '/var/mail/cltbld', 19:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:41 INFO - 'MOZ_NO_REMOTE': '1', 19:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:41 INFO - 'NO_EM_RESTART': '1', 19:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:41 INFO - 'PWD': '/builds/slave/test', 19:12:41 INFO - 'SHELL': '/bin/bash', 19:12:41 INFO - 'SHLVL': '1', 19:12:41 INFO - 'TERM': 'linux', 19:12:41 INFO - 'TMOUT': '86400', 19:12:41 INFO - 'USER': 'cltbld', 19:12:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', 19:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:41 INFO - '_': '/tools/buildbot/bin/python'} 19:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:12:41 INFO - Cleaning up... 19:12:41 INFO - Return code: 0 19:12:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef290>, '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 0xeefb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef0040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', '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 19:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:12:41 INFO - Using env: {'DISPLAY': ':0', 19:12:41 INFO - 'HOME': '/home/cltbld', 19:12:41 INFO - 'LANG': 'en_US.UTF-8', 19:12:41 INFO - 'LANGUAGE': 'en_US:en', 19:12:41 INFO - 'LOGNAME': 'cltbld', 19:12:41 INFO - 'MAIL': '/var/mail/cltbld', 19:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:41 INFO - 'MOZ_NO_REMOTE': '1', 19:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:41 INFO - 'NO_EM_RESTART': '1', 19:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:41 INFO - 'PWD': '/builds/slave/test', 19:12:41 INFO - 'SHELL': '/bin/bash', 19:12:41 INFO - 'SHLVL': '1', 19:12:41 INFO - 'TERM': 'linux', 19:12:41 INFO - 'TMOUT': '86400', 19:12:41 INFO - 'USER': 'cltbld', 19:12:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', 19:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:41 INFO - '_': '/tools/buildbot/bin/python'} 19:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:42 INFO - Downloading/unpacking blobuploader==1.2.4 19:12:42 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 19:12:42 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 19:12:42 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 19:12:42 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 19:12:42 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 19:12:42 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 19:12:44 INFO - Downloading blobuploader-1.2.4.tar.gz 19:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:12:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:12: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 19:12: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 19:12: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 19:12: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 19:12: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 19:12: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 19:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:12:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:12: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 19:12: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 19:12: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 19:12: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 19:12: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 19:12: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 19:12:44 INFO - Downloading docopt-0.6.1.tar.gz 19:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:12:44 INFO - Installing collected packages: blobuploader, requests, docopt 19:12:44 INFO - Running setup.py install for blobuploader 19:12:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:12:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:12:44 INFO - Running setup.py install for requests 19:12:45 INFO - Running setup.py install for docopt 19:12:45 INFO - Successfully installed blobuploader requests docopt 19:12:45 INFO - Cleaning up... 19:12:45 INFO - Return code: 0 19:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:45 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 0xc541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef290>, '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 0xeefb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef0040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', '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 19:12:45 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 19:12:45 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 19:12:45 INFO - Using env: {'DISPLAY': ':0', 19:12:45 INFO - 'HOME': '/home/cltbld', 19:12:45 INFO - 'LANG': 'en_US.UTF-8', 19:12:45 INFO - 'LANGUAGE': 'en_US:en', 19:12:45 INFO - 'LOGNAME': 'cltbld', 19:12:45 INFO - 'MAIL': '/var/mail/cltbld', 19:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:45 INFO - 'MOZ_NO_REMOTE': '1', 19:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:45 INFO - 'NO_EM_RESTART': '1', 19:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:45 INFO - 'PWD': '/builds/slave/test', 19:12:45 INFO - 'SHELL': '/bin/bash', 19:12:45 INFO - 'SHLVL': '1', 19:12:45 INFO - 'TERM': 'linux', 19:12:45 INFO - 'TMOUT': '86400', 19:12:45 INFO - 'USER': 'cltbld', 19:12:45 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', 19:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:45 INFO - '_': '/tools/buildbot/bin/python'} 19:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:12:45 INFO - Running setup.py (path:/tmp/pip-n3roH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:12:45 INFO - Running setup.py (path:/tmp/pip-IZpiq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:12:45 INFO - Running setup.py (path:/tmp/pip-pmLkhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:12:45 INFO - Running setup.py (path:/tmp/pip-9pYFXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:12:45 INFO - Running setup.py (path:/tmp/pip-jxgC7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:12:46 INFO - Running setup.py (path:/tmp/pip-KyT6sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:12:46 INFO - Running setup.py (path:/tmp/pip-4KuXcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:12:46 INFO - Running setup.py (path:/tmp/pip-tBciDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:12:46 INFO - Running setup.py (path:/tmp/pip-yhxTDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:12:46 INFO - Running setup.py (path:/tmp/pip-dvbW6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:12:46 INFO - Running setup.py (path:/tmp/pip-EcyM9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:12:46 INFO - Running setup.py (path:/tmp/pip-76ZmN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:12:46 INFO - Running setup.py (path:/tmp/pip-MucMcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:12:46 INFO - Running setup.py (path:/tmp/pip-C_C77q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:46 INFO - Running setup.py (path:/tmp/pip-4uE_uT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:12:46 INFO - Running setup.py (path:/tmp/pip-71wGju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:12:46 INFO - Running setup.py (path:/tmp/pip-r2ewZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:12:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:12:46 INFO - Running setup.py install for manifestparser 19:12:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:12:46 INFO - Running setup.py install for mozcrash 19:12:47 INFO - Running setup.py install for mozdebug 19:12:47 INFO - Running setup.py install for mozdevice 19:12:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Running setup.py install for mozfile 19:12:47 INFO - Running setup.py install for mozhttpd 19:12:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Running setup.py install for mozinfo 19:12:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Running setup.py install for mozInstall 19:12:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Running setup.py install for mozleak 19:12:47 INFO - Running setup.py install for mozlog 19:12:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Running setup.py install for moznetwork 19:12:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:12:47 INFO - Running setup.py install for mozprocess 19:12:48 INFO - Running setup.py install for mozprofile 19:12:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:12:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:12:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:12:48 INFO - Running setup.py install for mozrunner 19:12:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:12:48 INFO - Running setup.py install for mozscreenshot 19:12:48 INFO - Running setup.py install for moztest 19:12:48 INFO - Running setup.py install for mozversion 19:12:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:12:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:12:48 INFO - Cleaning up... 19:12:48 INFO - Return code: 0 19:12:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:48 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')]} 19:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:48 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')]} 19:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:48 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 0xc541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef290>, '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 0xeefb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef0040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', '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 19:12:48 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 19:12:48 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 19:12:48 INFO - Using env: {'DISPLAY': ':0', 19:12:48 INFO - 'HOME': '/home/cltbld', 19:12:48 INFO - 'LANG': 'en_US.UTF-8', 19:12:48 INFO - 'LANGUAGE': 'en_US:en', 19:12:48 INFO - 'LOGNAME': 'cltbld', 19:12:48 INFO - 'MAIL': '/var/mail/cltbld', 19:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:48 INFO - 'MOZ_NO_REMOTE': '1', 19:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:48 INFO - 'NO_EM_RESTART': '1', 19:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:48 INFO - 'PWD': '/builds/slave/test', 19:12:48 INFO - 'SHELL': '/bin/bash', 19:12:48 INFO - 'SHLVL': '1', 19:12:48 INFO - 'TERM': 'linux', 19:12:48 INFO - 'TMOUT': '86400', 19:12:48 INFO - 'USER': 'cltbld', 19:12:48 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', 19:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:48 INFO - '_': '/tools/buildbot/bin/python'} 19:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:12:48 INFO - Running setup.py (path:/tmp/pip-7s7p1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:12:48 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)) 19:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:12:48 INFO - Running setup.py (path:/tmp/pip-40XzmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:12:49 INFO - Running setup.py (path:/tmp/pip-R33Tk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:12:49 INFO - Running setup.py (path:/tmp/pip-MaBIxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:12:49 INFO - Running setup.py (path:/tmp/pip-VKBInB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:12:49 INFO - Running setup.py (path:/tmp/pip-HH7AsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:12:49 INFO - Running setup.py (path:/tmp/pip-_lY3B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:12:49 INFO - Running setup.py (path:/tmp/pip-IiqAFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:12:49 INFO - Running setup.py (path:/tmp/pip-t3KbEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:12:49 INFO - Running setup.py (path:/tmp/pip-0Sljz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:12:49 INFO - Running setup.py (path:/tmp/pip-L64Siv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:12:49 INFO - Running setup.py (path:/tmp/pip-YcqFfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:12:49 INFO - Running setup.py (path:/tmp/pip-Peugbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:12:49 INFO - Running setup.py (path:/tmp/pip-wo3XHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:49 INFO - Running setup.py (path:/tmp/pip-5niO7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:49 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)) 19:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:12:50 INFO - Running setup.py (path:/tmp/pip-7o0AJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:12:50 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)) 19:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:12:50 INFO - Running setup.py (path:/tmp/pip-mzPzOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:12:50 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)) 19:12:50 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)) 19:12:50 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)) 19:12:50 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)) 19:12:50 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)) 19:12:50 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)) 19:12:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:12: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 19:12: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 19:12: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 19:12: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 19:12: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 19:12: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 19:12:52 INFO - Downloading blessings-1.6.tar.gz 19:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:12:52 INFO - Installing collected packages: blessings 19:12:52 INFO - Running setup.py install for blessings 19:12:52 INFO - Successfully installed blessings 19:12:52 INFO - Cleaning up... 19:12:52 INFO - Return code: 0 19:12:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:12:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:52 INFO - Reading from file tmpfile_stdout 19:12:52 INFO - Current package versions: 19:12:52 INFO - argparse == 1.2.1 19:12:52 INFO - blessings == 1.6 19:12:52 INFO - blobuploader == 1.2.4 19:12:52 INFO - docopt == 0.6.1 19:12:52 INFO - functools32 == 3.2.3-2 19:12:52 INFO - jsonschema == 2.5.1 19:12:52 INFO - manifestparser == 1.1 19:12:52 INFO - mozInstall == 1.12 19:12:52 INFO - mozcrash == 1.0 19:12:52 INFO - mozdebug == 0.1 19:12:52 INFO - mozdevice == 0.49 19:12:52 INFO - mozfile == 1.2 19:12:52 INFO - mozhttpd == 0.7 19:12:52 INFO - mozinfo == 0.9 19:12:52 INFO - mozleak == 0.1 19:12:52 INFO - mozlog == 3.4 19:12:52 INFO - moznetwork == 0.27 19:12:52 INFO - mozprocess == 0.25 19:12:52 INFO - mozprofile == 0.28 19:12:52 INFO - mozrunner == 6.13 19:12:52 INFO - mozscreenshot == 0.1 19:12:52 INFO - mozsystemmonitor == 0.3 19:12:52 INFO - moztest == 0.8 19:12:52 INFO - mozversion == 1.4 19:12:52 INFO - psutil == 3.1.1 19:12:52 INFO - requests == 1.2.3 19:12:52 INFO - wsgiref == 0.1.2 19:12:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12: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')]} 19:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12: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')]} 19:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:52 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 0xc541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef290>, '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 0xeefb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef0040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', '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 19:12:52 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 19:12:52 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 19:12:52 INFO - Using env: {'DISPLAY': ':0', 19:12:52 INFO - 'HOME': '/home/cltbld', 19:12:52 INFO - 'LANG': 'en_US.UTF-8', 19:12:52 INFO - 'LANGUAGE': 'en_US:en', 19:12:52 INFO - 'LOGNAME': 'cltbld', 19:12:52 INFO - 'MAIL': '/var/mail/cltbld', 19:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:52 INFO - 'MOZ_NO_REMOTE': '1', 19:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:52 INFO - 'NO_EM_RESTART': '1', 19:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:52 INFO - 'PWD': '/builds/slave/test', 19:12:52 INFO - 'SHELL': '/bin/bash', 19:12:52 INFO - 'SHLVL': '1', 19:12:52 INFO - 'TERM': 'linux', 19:12:52 INFO - 'TMOUT': '86400', 19:12:52 INFO - 'USER': 'cltbld', 19:12:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', 19:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:52 INFO - '_': '/tools/buildbot/bin/python'} 19:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 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)) 19:12:52 INFO - Cleaning up... 19:12:52 INFO - Return code: 0 19:12:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:12: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')]} 19:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12: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')]} 19:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef290>, '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 0xeefb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef0040>, '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': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', '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 19:12: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', 'jsonschema'] in /builds/slave/test/build 19:12: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 jsonschema 19:12:52 INFO - Using env: {'DISPLAY': ':0', 19:12:52 INFO - 'HOME': '/home/cltbld', 19:12:52 INFO - 'LANG': 'en_US.UTF-8', 19:12:52 INFO - 'LANGUAGE': 'en_US:en', 19:12:52 INFO - 'LOGNAME': 'cltbld', 19:12:52 INFO - 'MAIL': '/var/mail/cltbld', 19:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:52 INFO - 'MOZ_NO_REMOTE': '1', 19:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:52 INFO - 'NO_EM_RESTART': '1', 19:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:52 INFO - 'PWD': '/builds/slave/test', 19:12:52 INFO - 'SHELL': '/bin/bash', 19:12:52 INFO - 'SHLVL': '1', 19:12:52 INFO - 'TERM': 'linux', 19:12:52 INFO - 'TMOUT': '86400', 19:12:52 INFO - 'USER': 'cltbld', 19:12:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', 19:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:52 INFO - '_': '/tools/buildbot/bin/python'} 19:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:12:53 INFO - Cleaning up... 19:12:53 INFO - Return code: 0 19:12:53 INFO - Running post-action listener: _resource_record_post_action 19:12:53 INFO - Running post-action listener: _start_resource_monitoring 19:12:53 INFO - Starting resource monitoring. 19:12:53 INFO - [mozharness: 2017-03-26 02:12:53.114208Z] Finished create-virtualenv step (success) 19:12:53 INFO - [mozharness: 2017-03-26 02:12:53.114678Z] Running install step. 19:12:53 INFO - Running pre-action listener: _resource_record_pre_action 19:12:53 INFO - Running main action method: install 19:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:53 INFO - Reading from file tmpfile_stdout 19:12:53 INFO - Detecting whether we're running mozinstall >=1.0... 19:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:12:53 INFO - Reading from file tmpfile_stdout 19:12:53 INFO - Output received: 19:12:53 INFO - Usage: mozinstall [options] installer 19:12:53 INFO - Options: 19:12:53 INFO - -h, --help show this help message and exit 19:12:53 INFO - -d DEST, --destination=DEST 19:12:53 INFO - Directory to install application into. [default: 19:12:53 INFO - "/builds/slave/test"] 19:12:53 INFO - --app=APP Application being installed. [default: firefox] 19:12:53 INFO - mkdir: /builds/slave/test/build/application 19:12:53 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'] 19:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:13:09 INFO - Reading from file tmpfile_stdout 19:13:09 INFO - Output received: 19:13:09 INFO - /builds/slave/test/build/application/firefox/firefox 19:13:09 INFO - Running post-action listener: _resource_record_post_action 19:13:09 INFO - [mozharness: 2017-03-26 02:13:09.091695Z] Finished install step (success) 19:13:09 INFO - [mozharness: 2017-03-26 02:13:09.091965Z] Running run-tests step. 19:13:09 INFO - Running pre-action listener: _resource_record_pre_action 19:13:09 INFO - Running main action method: run_tests 19:13:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:13:09 INFO - Python 2.7.3 19:13:09 INFO - Return code: 0 19:13:09 INFO - grabbing minidump binary from tooltool 19:13:09 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')]} 19:13:09 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 0xeef290>, '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 0xeefb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef0040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:13:09 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 19:13:09 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 19:13:09 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 19:13:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:13:09 INFO - Return code: 0 19:13:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:13:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:13:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:13:09 INFO - ENV: RUST_BACKTRACE is now 1 19:13:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:13:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:13:09 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/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 19:13:09 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/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 19:13:09 INFO - Using env: {'DISPLAY': ':0', 19:13:09 INFO - 'HOME': '/home/cltbld', 19:13:09 INFO - 'LANG': 'en_US.UTF-8', 19:13:09 INFO - 'LANGUAGE': 'en_US:en', 19:13:09 INFO - 'LOGNAME': 'cltbld', 19:13:09 INFO - 'MAIL': '/var/mail/cltbld', 19:13:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:13:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:09 INFO - 'MOZ_NO_REMOTE': '1', 19:13:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:09 INFO - 'NO_EM_RESTART': '1', 19:13:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:09 INFO - 'PWD': '/builds/slave/test', 19:13:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:13:09 INFO - 'RUST_BACKTRACE': '1', 19:13:09 INFO - 'SHELL': '/bin/bash', 19:13:09 INFO - 'SHLVL': '1', 19:13:09 INFO - 'TERM': 'linux', 19:13:09 INFO - 'TMOUT': '86400', 19:13:09 INFO - 'USER': 'cltbld', 19:13:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438', 19:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:09 INFO - '_': '/tools/buildbot/bin/python'} 19:13:09 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/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 19:13:09 INFO - mozversion application_buildid: 20170326013901 19:13:09 INFO - mozversion application_changeset: d57834d60548d3003d8c0725e7b0f103c1346da3 19:13:09 INFO - mozversion application_display_name: Nightly 19:13:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:13:09 INFO - mozversion application_name: Firefox 19:13:09 INFO - mozversion application_remotingname: firefox 19:13:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:13:09 INFO - mozversion application_vendor: Mozilla 19:13:09 INFO - mozversion application_version: 55.0a1 19:13:09 INFO - mozversion platform_buildid: 20170326013901 19:13:09 INFO - mozversion platform_changeset: d57834d60548d3003d8c0725e7b0f103c1346da3 19:13:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:13:09 INFO - mozversion platform_version: 55.0a1 19:13:09 INFO - using testdate: 1490494389 19:13:09 INFO - actual date: 1490494389 19:13:09 INFO - starting webserver on 'localhost:45670' 19:13:09 INFO - SUITE-START | Running 2 tests 19:13:09 INFO - TEST-START | dromaeo_css 19:13:09 INFO - operating with platform_type : linux_ 19:13:09 INFO - Initialising browser for dromaeo_css test... 19:13:09 INFO - TEST-INFO | started process 30194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGPbeLI/profile http://localhost:45670/getInfo.html) 19:13:14 INFO - PID 30194 | __metrics Screen width/height:1600/1200 19:13:14 INFO - PID 30194 | colorDepth:24 19:13:14 INFO - PID 30194 | Browser inner width/height: 1024/697 19:13:14 INFO - PID 30194 | __metrics 19:13:14 ERROR - PID 30194 | 1490494394705 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6376:36 < canClose@browser.js:5227:12 < forceQuit@jar:file:///tmp/tmpGPbeLI/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpGPbeLI/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpGPbeLI/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpGPbeLI/profile/extensions/talos-powers@TalosPowersService.js:55:9 19:13:14 ERROR - PID 30194 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3392: TypeError: this.tabs is undefined 19:13:15 INFO - TEST-INFO | 30194: exit 0 19:13:15 INFO - Browser initialized. 19:13:15 INFO - Running cycle 1/1 for dromaeo_css test... 19:13:15 INFO - TEST-INFO | started process 30323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGPbeLI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:13:27 INFO - PID 30323 | RSS: Main: 156049408 19:13:27 INFO - PID 30323 | 19:16:32 INFO - PID 30323 | Cycle 1(1): loaded http://localhost:45670/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45670/tests/dromaeo/cssquery-ext.html) 19:16:34 INFO - PID 30323 | RSS: Main: 166223872 19:16:34 INFO - PID 30323 | 19:18:16 INFO - PID 30323 | ************************* 19:18:16 INFO - PID 30323 | A coding exception was thrown and uncaught in a Task. 19:18:16 INFO - PID 30323 | 19:18:16 ERROR - PID 30323 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:18:16 INFO - PID 30323 | Full stack: 19:18:16 INFO - PID 30323 | ************************* 19:18:16 INFO - PID 30323 | ************************* 19:18:16 INFO - PID 30323 | A coding exception was thrown and uncaught in a Task. 19:18:16 INFO - PID 30323 | 19:18:16 ERROR - PID 30323 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:18:16 INFO - PID 30323 | Full stack: 19:18:16 INFO - PID 30323 | ************************* 19:18:16 INFO - PID 30323 | ************************* 19:18:16 INFO - PID 30323 | A coding exception was thrown and uncaught in a Task. 19:18:16 INFO - PID 30323 | 19:18:16 ERROR - PID 30323 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:18:16 INFO - PID 30323 | Full stack: 19:18:16 INFO - PID 30323 | ************************* 19:18:16 INFO - PID 30323 | ************************* 19:18:16 INFO - PID 30323 | A coding exception was thrown and uncaught in a Task. 19:18:16 INFO - PID 30323 | 19:18:16 ERROR - PID 30323 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:18:16 INFO - PID 30323 | Full stack: 19:18:16 INFO - PID 30323 | ************************* 19:19:36 INFO - PID 30323 | Cycle 1(1): loaded http://localhost:45670/tests/dromaeo/cssquery-ext.html (next: http://localhost:45670/tests/dromaeo/cssquery-jquery.html) 19:19:37 INFO - PID 30323 | RSS: Main: 160772096 19:19:37 INFO - PID 30323 | 19:22:39 INFO - PID 30323 | Cycle 1(1): loaded http://localhost:45670/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45670/tests/dromaeo/cssquery-mootools.html) 19:22:40 INFO - PID 30323 | RSS: Main: 169508864 19:22:40 INFO - PID 30323 | 19:25:42 INFO - PID 30323 | Cycle 1(1): loaded http://localhost:45670/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45670/tests/dromaeo/cssquery-prototype.html) 19:25:42 INFO - PID 30323 | RSS: Main: 160968704 19:25:42 INFO - PID 30323 | 19:28:45 INFO - PID 30323 | Cycle 1(1): loaded http://localhost:45670/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45670/tests/dromaeo/cssquery-yui.html) 19:28:46 INFO - PID 30323 | RSS: Main: 169078784 19:28:46 INFO - PID 30323 | 19:31:49 INFO - PID 30323 | Cycle 1(1): loaded http://localhost:45670/tests/dromaeo/cssquery-yui.html (next: http://localhost:45670/tests/dromaeo/cssquery-dojo.html) 19:31:49 INFO - PID 30323 | RSS: Main: 162082816 19:31:49 INFO - PID 30323 | 19:31:49 INFO - PID 30323 | __start_tp_report 19:31:49 INFO - PID 30323 | _x_x_mozilla_page_load 19:31:49 INFO - PID 30323 | _x_x_mozilla_page_load_details 19:31:49 INFO - PID 30323 | |i|pagename|runs| 19:31:49 INFO - PID 30323 | |0;dojo.html;2610.073423934502;2625.7505536973995;2638.5118753030683;2639.77561907238;2721.578155385915;5162.896742065166;5260.342457192846;5283.233931079991;5299.629025968175;5316.3354580677415;5210.583153347732;5299.099153143965;5335.973320133394;5383.650062745928;5401.675899446036;4805.087033463648;4826.276058591205;4833.347498087766;4880.731559764212;4892.755362231892;4848.830290939818;4886.34034405356;4890.388701412324;4893.04585605807;4905.264210368456;4700.4359476862655;4767.69010014348;4784.521547845223;4818.325434439182;4829.661923665345;4854.757262136879;4855.368802055746;4868.099401610678;4870.805167793284;4905.730184839832;4780.976095119537;4787.569118779326;4811.7112973221365;4839.27410888366;4858.514148585148;5083.212102124176;5133.794648214067;5219.608529360313;5277.8416647500635;5293.550048245904;5693.202951586781;5695.231143795618;5721.914171287434;5753.539716822645;5762.9135562966585;5728.112142617901;5731.083026715747;5733.627314224562;5739.540836733051;5747.511461525775;5127.9230811537855;5180.145276029413;5290.206469029677;5307.832276899076;5318.627696061239;5844.240248767633;5845.824625261249;5898.056310990221;5900.232969713909;5902.852428689317;5403.405625381205;5462.617616766788;5520.475554822286;5536.7785288588;5596;5655.5475561954945;5719.970405326998;5723.656580605177;5725.427457254241;5763.88472230553;5467.535259502907;5532.723363831792;5667.348254950651;5677.37548869624;5689.886202275931;5593.105103183471;5646.491815736521;5660;5689.829305120853;5709.9714501427225;4747.169245382113;4757.785899634525;4761.666683332133;4783.306420569068;4798.2082956312515;4014.879553613396;4019.457373254632;4019.959800402017;4040.2929487340184;4076.6331030207425;4718.961828397747;4777.116233496814;4856.125897338513;4896.559309662076;4900.534449227318;5680.744366503517;5737.598368114275;5755.050416681201;5776.797812076557;5808.651480911159;4845.5881250093435;4863.416390033219;4882.023595280887;4886.3403440535785;4923.532264434873;4819.036192761461;4822.373091498082;4923.310736496822;4952.5542701157065;4960.429550601655;5314.760835762323;5327.893442131213;5374.758135883816;5377.300950876361;5393.352797664305;5703.543716502752;5724.998125328134;5732.283464566929;5749.367569567428;5766.826995190151;5155.200943853709;5207.2449494823795;5342.11855043929;5354.464553544614;5404.702741349263;5541.362743284412;5553;5569.387367389665;5589.5807814413265;5594.104943209067;5683.829485115453;5705.201271821865;5705.828825135252;5712.7714891403875;5715.399883012224;5373.946260537345;5435.537979271648;5493.917591236055;5541.556675466034;5563.221149039056;5510.8071217507195;5523.337199536081;5557.527610153183;5561.944380556142;5597.272354593877;5414.269073675004;5489.615726899079;5492.148716948879;5495.725213739377;5527.198556209408;5481.725913704378;5556.694381809039;5562.4993750561025;5596.664200148004;5675.971620141873;5419.160030195326;5421.9186712200135;5426.8371948841595;5468.043092458884;5474.479924407335 19:31:49 INFO - PID 30323 | |1;ext.html;646.9159009328789;716.5521549031855;736.7163641997829;978.2711879649662;987.368084425967;30071.248218794513;31060.378792424137;31080.222994425152;31084.689153108462;31141.532877006834;32885.17787055325;33304.66695333046;33321.833390833075;33331.500027499605;33351.66648333516;7326.267373262658;7354.521956072852;7513.924860751377;7525.5860927648955;7527.510711803742;7423.369013633847;7444.6277686115745;7527.247275272456;7536.510126841765;7539.736109236178;7464.066991626047;7671.462997590171;7681.116671582784;7702.268284512962;7735.4585179037485;7613.7158852344355;7647.847043059163;7693.615319234072;7698.961505192494;7714.344280736116;7396.186419493852;7560.924390756077;7585.81035474112;7587.620618969029;7594.658240379196;34962.47556286658;34992.475112873326;35061.47407788885;35175;35175.1206219844;2637.788976881845;2667.6398686177313;2680.423708902595;2683.2084535062204;2708.8239264447748;23945.16191933274;24346;24358.26925192247;24756.752432475623;24967;2762.8480433576146;2768.9307767305777;2774.8057635965492;2788.386554957906;2796.9720302796914;115138.42430787793;117397;143073;155139;155670.22164889102;40723.59276407257;40849.387259191135;40854.591454085676;40873;40918;43405.78297108557;43585.782071089445;43671.344929826075;43726.562734372885;43799.12401751947;11383.487743051583;11588.304701717923;11683.649490515298;11691.707707307216;11739.882601173878;9024.593893274687;9046.321525885585;9057.592408341641;9067.773305667279;9081.59132839024;13057.151285166623;13058.34708264602;13066;13164.802527962089;13276.53532126371;5460.6996615186545;5478.287822583039;5498.835034948958;5551.3893471718075;5610.438956104438;798.9400794940402;800.3495323019501;827.6441130313902;837.2046555772041;843.696269343036;20226.617284691278;20309.89845050795;21195.152193912378;21379.144834206458;21587.784122158893;883.0992387764444;883.8983516895511;895.4895709445684;917.1974522292994;921.7603423109906;10594.258401911793;11235.438228088562;13626.182429054288;14314.785278220836;14564.271786410636;231618;232081;232103;232348;234447;46472;46973;47017.76491117591;47074;47159.764201178776;1214.1258294028285;1244.0980289290192;1250.2935841249664;1252.2861968677767;1254.3226657604791;24552.386190345384;24792.25623231306;25443.6183457252;25791.871040644677;25897.611535827353;31450.37099258048;31606.683933160373;31645.683543164272;31709.682903171597;31730.365392691554;235497;236023;236521;236792;237121;21450.570988580454;21608.13567457347;23911.16310929109;24286.271411856967;28325.291867702646;29786.851065744533;29815.10554683363;29986.70013299839;30064.549031764105;30213.395732085675;23575.292741217792;23751.504361404717;24662.01351945974;25785;26052.34869128211;25254.242372728848;25436.236912892644;25921.481570368866;26009.349766255997;26472.205833825017;27959;28603.713962860103;28729.71270287354;28733.13800585986;28756.281092972844;25093.121740738985;25159;25668.78598848425;25782.355441114123;26210.86894565515;19615.411537653894;20859.58280834405;20951.371458856258;21028.26401075955;21029.263975761387 19:31:49 INFO - PID 30323 | |2;jquery.html;402.1795537104305;406.8189655603257;412.5606229365726;412.572986958498;430.55222568528734;12355.382230888465;17011;17879;17945.461636150936;18164.091795410244;17237.396691115813;17582.82417175828;17893.7315940261;17903.283868645238;18028.909855450704;5408.675479471224;5454.400015998247;5679.602427830054;5697.487226149646;5722.54219662426;5615.101583746601;5641.12562552805;5650.830475085733;5661.264035675377;5687.033204355249;5476.096444086721;5677.943220567803;5694.829155125332;5726.255586773714;5749.482546570808;5681.914771278434;5720.370759216483;5730.914036289438;5732.455416735404;5741.397153298885;5000.224965130411;5162.638615296931;5169.353830771153;5180.1452760294505;5184.740762961875;22267.331980040464;22814.543709125726;23006.654900176512;23380.18169364081;23486.412839679146;1576.400967632304;1593.9681206375808;1596.233807772276;1615.176260107342;1627.0481768165637;13341.132826366254;14081.295935203301;14126.576202713935;14293.785028272609;14678.339474723663;1735.0890782339247;1769.840714335716;1779.74193741908;1797.8381945624826;1806.151108978778;87308.12691873127;87923;87962.12037879667;88282;88573;11081.667549973514;11178.552857885594;11212.775744485065;11289.209755317213;11327.716807079723;12656.303903285223;14361.85638143626;14379.980204157035;14410.135391876522;14414.783778243334;6405.903911441332;6774.966125169342;6846.212685541226;6943.652817359111;6980.546264492792;6027.9095813562835;6036.879262414727;6140.416660417253;6203.7828675996125;6428.132202152649;6966.12923384577;6983.650817459208;6987.161540615159;6996.195437524648;7036.6129862857015;1878.8121187881377;1882.585831117152;1936.990315048444;1943.6209939061748;2201.086549082113;767.5586537740821;788.2984144111745;808.8018435483344;823.9835203295901;826.7891687619739;16206.351745930266;16215.675686486204;16418.6716265674;16688.415905443253;17075.40236091731;813.1421350475306;823.567626995832;829.179112678456;834.2825170353491;855.3755758296478;8730.476171429735;8824.911750882537;9152.450852948845;9212.907870921339;9281.907180928105;422633;425267;435176;441400;444940;60463.69768151131;70908;82762;88555;90607.54696226609;1036.9118624916966;1065.872095348563;1116.3469370418395;1137.4312843578211;1137.8179491281355;15923.761143583088;16213.270402831666;16754.1622918856;17305.30778768835;17373.391931282345;38913.805430972665;40017.39973900452;41176.58823411848;42476.57523424726;44669.55330446654;51738.482615173365;51861;52035.73982130065;52443.213351800514;55227.44772552384;7143.642817858982;7166.749163779451;7266.636668166465;7309.195988441161;7321.084864391951;9386.906130938603;11021.173411993972;11084.89151084885;11111.499982500645;11247.718807029562;9411.741340959568;9520.714378568655;9605.231581473605;9815;10034.448105354275;9175.128362805523;9371.203447707021;9390.577424016072;9481.383710058824;9566.952165239129;9237.168654820829;9355.204807591432;9888.357256778574;9985.251106167212;10449.84325235107;7205.243449437734;7301.744438944612;7304.707811687473;7339.082614673166;7391.40868730511;9633.32566720323;9717.12545870875;9832;10023.298369114384;10075.697729068139 19:31:49 INFO - PID 30323 | |3;mootools.html;1218.4334284557679;1271.3131917439425;1287.1054617041154;1288.66494711375;1291.1865524719426;9274.81450370993;9580.568874400651;9639.325247232688;9666.75833104172;9803.901960980387;9578.568964396602;9726.416415015105;9726.805463890736;9767.853482197756;9784.657536986208;2229.3312006398096;2254.8196144308417;2274.2040285899966;2278.2481781012225;2281.6577513372963;2141.9464513387134;2186.814120799734;2197.252934002439;2205.52581195043;2239.484918468753;2179.204590324536;2207.128184367174;2218.944526386845;2222.4443889027743;2294.7934685878267;2132.3709505695856;2187.814035806958;2198.758136604972;2200.9119635214574;2202.174184680745;1820.0808591661125;1885.632301701169;2131.6802479628027;2156.33153722345;2178.9564208715738;9587.137157655774;9591.760205994837;9652.324337296392;9672.22622190223;9694.321397502177;5329.706866122362;5523.392426833045;5564.610477266593;5566.777328906839;5573.916391254134;3160.5575219469292;3209.502527108302;3225.3871764364694;3275.5086736989642;3328.051505320996;993.4734590666958;1012.5241136665755;1019.6380284998867;1036.5439206749006;1048.4390850894736;14233.715325693533;14375.568732938029;14508.637284067983;14566.70866582673;14581.562553123424;4764.6426518011285;4945.851624451272;4961.181405068123;5036.748162591855;5135.948640513622;11866.584669536525;11874.168808183344;11907.821382679267;11946.761064778655;11997.220180688228;5599.944000559943;5602.747876345493;5609.663420194802;5614.185943038318;5618.831435056954;4868.172410690191;4877.414710234723;4943.90112197754;4999.75001249936;5001.799928002912;3633.981830090833;3656.1590834108306;3709.5548534176073;3746.5316835395574;3765.1528406108955;1087.4888802262924;1104.1884215101893;1105.690406686129;1116.084810455435;1124.7019539821954;647.5499527828208;685.95541289817;687.0621601513898;695.6730336741723;697.7418355208605;5630.887382252332;5739.512141468022;5746.339170995306;5771.336296325976;5994.730237139339;811.217175425717;813.7640084375465;825.781167990483;827.2678679368802;856.5631527920681;3626.546681664792;3644.3986742187244;3657.908552286214;3668.0829792551863;3831.3295173344554;12436.937815310866;12626.431810568547;12707.237565746085;12763.042771791967;13031.218126912416;11603.825942610867;12599;12639.810402843965;12650.304233267074;12686.873131268754;8924.732258032269;9227.907720922705;9247.722568322826;9251.306152038624;9263.490508021989;5785.537157027512;5794.855128621818;5894.351621321737;5992.221011268507;6022.337542870368;10709.518071686636;11450.599229026944;11462.083033357145;11597.88402115968;11696.239744416585;11086.390248536409;11109.889011099149;11155.609553665583;11250.83123753128;11410.828837567276;8011.919880801117;8220.301274391744;8257.669693212445;8381.95809020951;8403.70587029451;9113.36206465541;9116.08839116083;9190.678326258549;9207.76980575491;9223.58493867791;7698.615069246627;7744.651490683045;7762;7768.300852923264;7929;7806.6134367286395;7837.882431763414;7869.960650196713;7881.2118788123025;8060.516369017878;6985.44116470671;7000.264972178052;7017.719291228498;7032.753853615099;7109.82225444368;5147.871303217449;5249.6062795289745;5276.788928442973;5312.043832110257;5353.839384818461;5066.645334826527;5069.31564238823;5092.821751238689;5150.716710580804;5305.867353316198 19:31:49 INFO - PID 30323 | |4;prototype.html;370.11542413631406;381.7957392794855;387.69178503090023;390.1377954720069;391.2995737629643;5241.737913104349;5490.478404551571;5609.887802243958;5615.101583746601;5639.2105105285245;5328.866778330544;5462.781488740456;5479.04116779563;5501;5503.20203570483;4366.8908277293085;4372.2130016597;4398.295048545137;4407.427034485512;4420.668449866273;4324.6972711910175;4348.608625223729;4370.759608221547;4395.296752519597;4402.427684401024;4318.935215971763;4326.84856030039;4339.936715504706;4340.522542520336;4375.606195442409;4336.528178938007;4341.261985462464;4345.869623911288;4349.586789255016;4363.629091527224;3819.312523745725;3893.76637401754;3898.3372826619543;3922.313595120871;3922.960415489869;5362.8123015694655;5373.919391209135;5382.730863456812;5406.810761623364;5419.701916394597;5052.166392545226;5060.316857224265;5072.644914855925;5080.771365288534;5082.288479612857;5624.465675760796;5819.24349834523;5820.1560773688;5849.7660093596205;5856.590038697293;4311.568843115695;4313.82744690212;4319.740815551077;4330.891727706832;4333.631641310492;5847.210626565445;6059.45464908156;6060.8181754546995;6090.5736598438125;6131.540134489931;4413.977930110394;4417.491988421309;4429.512753597101;4433.578810013044;4434.623057040123;4421.38100665907;4451.621612163002;4462.642988560908;4470.709403888802;4483.686141970031;4861.829835955725;4965.155923493015;4996.125678006334;5000.199968005102;5028.673136246205;5824;5841.18223448709;5848.590598658053;5882.852928676732;5889.852753681193;1552.4100841680315;1579.4156162220052;1584.081232884924;1586.8016497937758;1588.4758029850123;925.5464822237055;954.4511905654276;962.4802606592501;1113.3375641493299;1132.365875109941;5068.011737711185;5068.949310506848;5077.771500282496;5085.084684756779;5092.465291144451;6035.658442278615;6042.39576042401;6044.922265297084;6059.666718330534;6069.302030266487;4925.876853078702;4925.901481970341;4994.225894986283;5034.11902916988;5078.187490001582;3153.369326134782;3187.2509960159346;3193.1218914798615;3194.728448081939;3197.4724170511604;5422.566194704415;5531.280933478622;5544.611877168641;5561.527270181999;5591.804286849941;6095.420935011167;6137.974468425409;6164.137020817089;6166.414190651881;6199.132121502993;5617.943820561742;5629.099344105005;5633.352164501053;5634.211210430543;5647.774089036392;5850.678212698343;5935.8919701370305;5939.90111829313;5966.552508561788;6033.2805150531885;5614.29821272341;5855.912161317498;5884.146798714077;5888.263967004124;5904.586678932434;5426.565874730091;5518.696471693935;5571.916421253603;5615.073512870331;5616.21373007771;4181.26827805139;4182.853600123981;4202.763871818622;4205.6635469163;4206.516250631216;5968.403159683997;5968.582199246011;6035.39646035393;6094.939050609437;6130.50955923534;5850.473457388855;5866.735996880066;5866.911996320144;5881.235439392852;5883.676397798162;5869.178315035813;5875.118732190205;5884.47039766423;5884.852878678067;5905.8188362328565;5507.779688812403;5669.489745922887;5755.827325180251;5759.769609215585;5775.33583637887;5875.118732190034;5894.086416605433;5902.822915312548;5903.819236152701;5917.556183286185;5408.918866216931;5671.744771485211;5717.142428635738;5717.799877004285;5722.370539240597 19:31:49 INFO - PID 30323 | |5;yui.html;698.8532408194279;711.118213415365;722.559238864293;738.1326940844503;751.4026349052502;12597.811032834503;13390.330483475836;13425.127366721157;13453.730925381487;13466.192028478297;13156.605301840937;13171.407286672098;13182;13275.468981240763;13856.614338566138;825.1088824070005;844.0420123160227;850.7022542110243;853.5348235211825;855.1619412975288;844.252836239929;852.1521086518923;852.6205838401913;853.2747164909839;875.5622188905547;898.9460632362046;902.1790170944441;909.417972497602;909.7634615000114;910.4810258152855;905.1717678324326;908.4503875155535;909.4270609515995;913.2146354135439;914.6432891172448;661.9404253617149;667.1427216027381;669.6718607882151;670.0150778355858;672.1497305908031;12882.742345153138;13252;13270.66823329415;13372.459232745747;14455.421783128768;13905.304734763222;14363.856361436356;14485.025421035894;14492.492762753358;14521.491747788883;10589.417582032986;10628.893711062869;10760.623378181726;10764.192685548614;10867.565297388095;2740.3405239443464;2806.3685670724126;2810.12886005339;2823.6893941666603;2871.899483518067;67719;68374.65812670955;68461.31538684599;69913;71128;10844.295120817122;10879.238453308193;10963.83554246687;11116.722081948015;11438.142139339583;17971.550711232325;18445.7233141503;22289;22390.776092239194;22564.774352256594;6580.703868325937;6749.190097188271;6845.863082738318;6859.279775623588;6896.965515172392;3382.5433566468705;3491.4762785582366;3501.3872572300256;3513.350030244413;3516.507688923553;3603.1532589841368;3623.8550457981387;3670.376036073874;3696.4270538066644;3711.3505136601525;691.3570379546969;696.7039008421401;700.0654126740858;707.6284950400977;722.2524686948983;507.14039702703565;511.3173912826344;539.1616037062406;542.3681411155959;561.9606627536115;8594.484330940164;9103.954480227689;9136.908630913606;9142.954285228532;9397.436153830655;534.0920435260074;536.9087255166631;544.1185279846674;553.3194171169484;556.2240674259385;3884.3590807517007;4023.3562629979647;4072.3687828386646;4099.467069280974;4119.7940102994735;62358;64887.35112648813;64964.350356496776;65523.672381637785;65742.34257657458;41102.794486027975;50880.236796447345;54735.45264547383;57370.713146434;57672.71163644155;51645.48354516482;52093.47906520962;52218.47781522212;52447.47552524502;52697.2095418569;8000.199980001953;8354.45696029756;8397.412181147505;8555.358348123791;8579.099194584729;27049.45901082007;27195.320116997234;27275;27288.86355568289;27396.219245748962;32864.342713145124;33150.83424582861;33161.83419082889;33449.83275083609;33928.491072634424;10210.795784084425;10318.535665895202;10448.947755261175;10501.684949451528;10576.524056417633;10963.177761667748;11050.613228536962;11056.281341712764;12494.937525312314;12807.423665934868;11035.172362072715;11395;11844.940775296069;11941.582044628396;12314.384280785745;12036.578719744766;12138.635840924786;12172.452239649414;12451.128421010442;12652;11263.380514071805;11827.52689892429;12147.696307592381;12162.75674486523;12520.499180032697;8408.369372297224;8419.579021049045;8515.787105322417;8646.351523635627;8782.077881822572;9023.323250756088;9796.706098817047;10231.7442063949;10468.738281542717;10494.737631559272 19:31:49 INFO - PID 30323 | __end_tp_report 19:31:49 INFO - PID 30323 | __start_cc_report 19:31:49 INFO - PID 30323 | _x_x_mozilla_cycle_collect,377 19:31:49 INFO - PID 30323 | __end_cc_report 19:31:49 INFO - PID 30323 | __startTimestamp1490495509381__endTimestamp 19:31:49 INFO - PID 30323 | 19:31:49 INFO - PID 30323 | ------- Summary: start ------- 19:31:49 INFO - PID 30323 | Number of tests: 6 19:31:49 INFO - PID 30323 | 19:31:49 INFO - PID 30323 | [#0] dojo.html Cycles:165 Average:5214.09 Median:5383.65 stddev:614.88 (11.4%) stddev-sans-first:581.84 19:31:49 INFO - PID 30323 | Values: 2610.1 2625.8 2638.5 2639.8 2721.6 5162.9 5260.3 5283.2 5299.6 5316.3 5210.6 5299.1 5336.0 5383.7 5401.7 4805.1 4826.3 4833.3 4880.7 4892.8 4848.8 4886.3 4890.4 4893.0 4905.3 4700.4 4767.7 4784.5 4818.3 4829.7 4854.8 4855.4 4868.1 4870.8 4905.7 4781.0 4787.6 4811.7 4839.3 4858.5 5083.2 5133.8 5219.6 5277.8 5293.6 5693.2 5695.2 5721.9 5753.5 5762.9 5728.1 5731.1 5733.6 5739.5 5747.5 5127.9 5180.1 5290.2 5307.8 5318.6 5844.2 5845.8 5898.1 5900.2 5902.9 5403.4 5462.6 5520.5 5536.8 5596.0 5655.5 5720.0 5723.7 5725.4 5763.9 5467.5 5532.7 5667.3 5677.4 5689.9 5593.1 5646.5 5660.0 5689.8 5710.0 4747.2 4757.8 4761.7 4783.3 4798.2 4014.9 4019.5 4020.0 4040.3 4076.6 4719.0 4777.1 4856.1 4896.6 4900.5 5680.7 5737.6 5755.1 5776.8 5808.7 4845.6 4863.4 4882.0 4886.3 4923.5 4819.0 4822.4 4923.3 4952.6 4960.4 5314.8 5327.9 5374.8 5377.3 5393.4 5703.5 5725.0 5732.3 5749.4 5766.8 5155.2 5207.2 5342.1 5354.5 5404.7 5541.4 5553.0 5569.4 5589.6 5594.1 5683.8 5705.2 5705.8 5712.8 5715.4 5373.9 5435.5 5493.9 5541.6 5563.2 5510.8 5523.3 5557.5 5561.9 5597.3 5414.3 5489.6 5492.1 5495.7 5527.2 5481.7 5556.7 5562.5 5596.7 5676.0 5419.2 5421.9 5426.8 5468.0 5474.5 19:31:49 INFO - PID 30323 | 19:31:49 INFO - PID 30323 | [#1] ext.html Cycles:180 Average:33824.79 Median:29800.98 stddev:54211.91 (181.9%) stddev-sans-first:54306.75 19:31:49 INFO - PID 30323 | Values: 646.9 716.6 736.7 978.3 987.4 30071.2 31060.4 31080.2 31084.7 31141.5 32885.2 33304.7 33321.8 33331.5 33351.7 7326.3 7354.5 7513.9 7525.6 7527.5 7423.4 7444.6 7527.2 7536.5 7539.7 7464.1 7671.5 7681.1 7702.3 7735.5 7613.7 7647.8 7693.6 7699.0 7714.3 7396.2 7560.9 7585.8 7587.6 7594.7 34962.5 34992.5 35061.5 35175.0 35175.1 2637.8 2667.6 2680.4 2683.2 2708.8 23945.2 24346.0 24358.3 24756.8 24967.0 2762.8 2768.9 2774.8 2788.4 2797.0 115138.4 117397.0 143073.0 155139.0 155670.2 40723.6 40849.4 40854.6 40873.0 40918.0 43405.8 43585.8 43671.3 43726.6 43799.1 11383.5 11588.3 11683.6 11691.7 11739.9 9024.6 9046.3 9057.6 9067.8 9081.6 13057.2 13058.3 13066.0 13164.8 13276.5 5460.7 5478.3 5498.8 5551.4 5610.4 798.9 800.3 827.6 837.2 843.7 20226.6 20309.9 21195.2 21379.1 21587.8 883.1 883.9 895.5 917.2 921.8 10594.3 11235.4 13626.2 14314.8 14564.3 231618.0 232081.0 232103.0 232348.0 234447.0 46472.0 46973.0 47017.8 47074.0 47159.8 1214.1 1244.1 1250.3 1252.3 1254.3 24552.4 24792.3 25443.6 25791.9 25897.6 31450.4 31606.7 31645.7 31709.7 31730.4 235497.0 236023.0 236521.0 236792.0 237121.0 21450.6 21608.1 23911.2 24286.3 28325.3 29786.9 29815.1 29986.7 30064.5 30213.4 23575.3 23751.5 24662.0 25785.0 26052.3 25254.2 25436.2 25921.5 26009.3 26472.2 27959.0 28603.7 28729.7 28733.1 28756.3 25093.1 25159.0 25668.8 25782.4 26210.9 19615.4 20859.6 20951.4 21028.3 21029.3 19:31:49 INFO - PID 30323 | 19:31:49 INFO - PID 30323 | [#2] jquery.html Cycles:180 Average:26498.53 Median:52239.48 stddev:71845.81 (137.5%) stddev-sans-first:72020.64 19:31:49 INFO - PID 30323 | Values: 402.2 406.8 412.6 412.6 430.6 12355.4 17011.0 17879.0 17945.5 18164.1 17237.4 17582.8 17893.7 17903.3 18028.9 5408.7 5454.4 5679.6 5697.5 5722.5 5615.1 5641.1 5650.8 5661.3 5687.0 5476.1 5677.9 5694.8 5726.3 5749.5 5681.9 5720.4 5730.9 5732.5 5741.4 5000.2 5162.6 5169.4 5180.1 5184.7 22267.3 22814.5 23006.7 23380.2 23486.4 1576.4 1594.0 1596.2 1615.2 1627.0 13341.1 14081.3 14126.6 14293.8 14678.3 1735.1 1769.8 1779.7 1797.8 1806.2 87308.1 87923.0 87962.1 88282.0 88573.0 11081.7 11178.6 11212.8 11289.2 11327.7 12656.3 14361.9 14380.0 14410.1 14414.8 6405.9 6775.0 6846.2 6943.7 6980.5 6027.9 6036.9 6140.4 6203.8 6428.1 6966.1 6983.7 6987.2 6996.2 7036.6 1878.8 1882.6 1937.0 1943.6 2201.1 767.6 788.3 808.8 824.0 826.8 16206.4 16215.7 16418.7 16688.4 17075.4 813.1 823.6 829.2 834.3 855.4 8730.5 8824.9 9152.5 9212.9 9281.9 422633.0 425267.0 435176.0 441400.0 444940.0 60463.7 70908.0 82762.0 88555.0 90607.5 1036.9 1065.9 1116.3 1137.4 1137.8 15923.8 16213.3 16754.2 17305.3 17373.4 38913.8 40017.4 41176.6 42476.6 44669.6 51738.5 51861.0 52035.7 52443.2 55227.4 7143.6 7166.7 7266.6 7309.2 7321.1 9386.9 11021.2 11084.9 11111.5 11247.7 9411.7 9520.7 9605.2 9815.0 10034.4 9175.1 9371.2 9390.6 9481.4 9567.0 9237.2 9355.2 9888.4 9985.3 10449.8 7205.2 7301.7 7304.7 7339.1 7391.4 9633.3 9717.1 9832.0 10023.3 10075.7 19:31:49 INFO - PID 30323 | 19:31:49 INFO - PID 30323 | [#3] mootools.html Cycles:180 Average:6164.24 Median:5000.77 stddev:3894.29 (77.9%) stddev-sans-first:3887.48 19:31:49 INFO - PID 30323 | Values: 1218.4 1271.3 1287.1 1288.7 1291.2 9274.8 9580.6 9639.3 9666.8 9803.9 9578.6 9726.4 9726.8 9767.9 9784.7 2229.3 2254.8 2274.2 2278.2 2281.7 2141.9 2186.8 2197.3 2205.5 2239.5 2179.2 2207.1 2218.9 2222.4 2294.8 2132.4 2187.8 2198.8 2200.9 2202.2 1820.1 1885.6 2131.7 2156.3 2179.0 9587.1 9591.8 9652.3 9672.2 9694.3 5329.7 5523.4 5564.6 5566.8 5573.9 3160.6 3209.5 3225.4 3275.5 3328.1 993.5 1012.5 1019.6 1036.5 1048.4 14233.7 14375.6 14508.6 14566.7 14581.6 4764.6 4945.9 4961.2 5036.7 5135.9 11866.6 11874.2 11907.8 11946.8 11997.2 5599.9 5602.7 5609.7 5614.2 5618.8 4868.2 4877.4 4943.9 4999.8 5001.8 3634.0 3656.2 3709.6 3746.5 3765.2 1087.5 1104.2 1105.7 1116.1 1124.7 647.5 686.0 687.1 695.7 697.7 5630.9 5739.5 5746.3 5771.3 5994.7 811.2 813.8 825.8 827.3 856.6 3626.5 3644.4 3657.9 3668.1 3831.3 12436.9 12626.4 12707.2 12763.0 13031.2 11603.8 12599.0 12639.8 12650.3 12686.9 8924.7 9227.9 9247.7 9251.3 9263.5 5785.5 5794.9 5894.4 5992.2 6022.3 10709.5 11450.6 11462.1 11597.9 11696.2 11086.4 11109.9 11155.6 11250.8 11410.8 8011.9 8220.3 8257.7 8382.0 8403.7 9113.4 9116.1 9190.7 9207.8 9223.6 7698.6 7744.7 7762.0 7768.3 7929.0 7806.6 7837.9 7870.0 7881.2 8060.5 6985.4 7000.3 7017.7 7032.8 7109.8 5147.9 5249.6 5276.8 5312.0 5353.8 5066.6 5069.3 5092.8 5150.7 5305.9 19:31:49 INFO - PID 30323 | 19:31:49 INFO - PID 30323 | [#4] prototype.html Cycles:180 Average:4855.38 Median:5424.57 stddev:1383.52 (25.5%) stddev-sans-first:1345.82 19:31:49 INFO - PID 30323 | Values: 370.1 381.8 387.7 390.1 391.3 5241.7 5490.5 5609.9 5615.1 5639.2 5328.9 5462.8 5479.0 5501.0 5503.2 4366.9 4372.2 4398.3 4407.4 4420.7 4324.7 4348.6 4370.8 4395.3 4402.4 4318.9 4326.8 4339.9 4340.5 4375.6 4336.5 4341.3 4345.9 4349.6 4363.6 3819.3 3893.8 3898.3 3922.3 3923.0 5362.8 5373.9 5382.7 5406.8 5419.7 5052.2 5060.3 5072.6 5080.8 5082.3 5624.5 5819.2 5820.2 5849.8 5856.6 4311.6 4313.8 4319.7 4330.9 4333.6 5847.2 6059.5 6060.8 6090.6 6131.5 4414.0 4417.5 4429.5 4433.6 4434.6 4421.4 4451.6 4462.6 4470.7 4483.7 4861.8 4965.2 4996.1 5000.2 5028.7 5824.0 5841.2 5848.6 5882.9 5889.9 1552.4 1579.4 1584.1 1586.8 1588.5 925.5 954.5 962.5 1113.3 1132.4 5068.0 5068.9 5077.8 5085.1 5092.5 6035.7 6042.4 6044.9 6059.7 6069.3 4925.9 4925.9 4994.2 5034.1 5078.2 3153.4 3187.3 3193.1 3194.7 3197.5 5422.6 5531.3 5544.6 5561.5 5591.8 6095.4 6138.0 6164.1 6166.4 6199.1 5617.9 5629.1 5633.4 5634.2 5647.8 5850.7 5935.9 5939.9 5966.6 6033.3 5614.3 5855.9 5884.1 5888.3 5904.6 5426.6 5518.7 5571.9 5615.1 5616.2 4181.3 4182.9 4202.8 4205.7 4206.5 5968.4 5968.6 6035.4 6094.9 6130.5 5850.5 5866.7 5866.9 5881.2 5883.7 5869.2 5875.1 5884.5 5884.9 5905.8 5507.8 5669.5 5755.8 5759.8 5775.3 5875.1 5894.1 5902.8 5903.8 5917.6 5408.9 5671.7 5717.1 5717.8 5722.4 19:31:49 INFO - PID 30323 | 19:31:49 INFO - PID 30323 | [#5] yui.html Cycles:180 Average:14371.78 Median:4085.92 stddev:17848.18 (436.8%) stddev-sans-first:17868.71 19:31:49 INFO - PID 30323 | Values: 698.9 711.1 722.6 738.1 751.4 12597.8 13390.3 13425.1 13453.7 13466.2 13156.6 13171.4 13182.0 13275.5 13856.6 825.1 844.0 850.7 853.5 855.2 844.3 852.2 852.6 853.3 875.6 898.9 902.2 909.4 909.8 910.5 905.2 908.5 909.4 913.2 914.6 661.9 667.1 669.7 670.0 672.1 12882.7 13252.0 13270.7 13372.5 14455.4 13905.3 14363.9 14485.0 14492.5 14521.5 10589.4 10628.9 10760.6 10764.2 10867.6 2740.3 2806.4 2810.1 2823.7 2871.9 67719.0 68374.7 68461.3 69913.0 71128.0 10844.3 10879.2 10963.8 11116.7 11438.1 17971.6 18445.7 22289.0 22390.8 22564.8 6580.7 6749.2 6845.9 6859.3 6897.0 3382.5 3491.5 3501.4 3513.4 3516.5 3603.2 3623.9 3670.4 3696.4 3711.4 691.4 696.7 700.1 707.6 722.3 507.1 511.3 539.2 542.4 562.0 8594.5 9104.0 9136.9 9143.0 9397.4 534.1 536.9 544.1 553.3 556.2 3884.4 4023.4 4072.4 4099.5 4119.8 62358.0 64887.4 64964.4 65523.7 65742.3 41102.8 50880.2 54735.5 57370.7 57672.7 51645.5 52093.5 52218.5 52447.5 52697.2 8000.2 8354.5 8397.4 8555.4 8579.1 27049.5 27195.3 27275.0 27288.9 27396.2 32864.3 33150.8 33161.8 33449.8 33928.5 10210.8 10318.5 10448.9 10501.7 10576.5 10963.2 11050.6 11056.3 12494.9 12807.4 11035.2 11395.0 11844.9 11941.6 12314.4 12036.6 12138.6 12172.5 12451.1 12652.0 11263.4 11827.5 12147.7 12162.8 12520.5 8408.4 8419.6 8515.8 8646.4 8782.1 9023.3 9796.7 10231.7 10468.7 10494.7 19:31:49 INFO - PID 30323 | -------- Summary: end -------- 19:31:49 INFO - PID 30323 | 19:31:50 INFO - TEST-INFO | 30323: exit 0 19:31:50 INFO - TEST-OK | dromaeo_css | took 1120840ms 19:31:50 INFO - TEST-START | kraken 19:31:50 INFO - operating with platform_type : linux_ 19:31:50 INFO - Initialising browser for kraken test... 19:31:50 INFO - TEST-INFO | started process 30701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1XwIsP/profile http://localhost:45670/getInfo.html) 19:31:54 INFO - PID 30701 | __metrics Screen width/height:1600/1200 19:31:54 INFO - PID 30701 | colorDepth:24 19:31:54 INFO - PID 30701 | Browser inner width/height: 1024/697 19:31:54 INFO - PID 30701 | __metrics 19:31:55 ERROR - PID 30701 | 1490495515326 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6376:36 < canClose@browser.js:5227:12 < forceQuit@jar:file:///tmp/tmp1XwIsP/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmp1XwIsP/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmp1XwIsP/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmp1XwIsP/profile/extensions/talos-powers@TalosPowersService.js:55:9 19:31:55 ERROR - PID 30701 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3392: TypeError: this.tabs is undefined 19:31:56 INFO - TEST-INFO | 30701: exit 0 19:31:56 INFO - Browser initialized. 19:31:56 INFO - Running cycle 1/1 for kraken test... 19:31:56 INFO - TEST-INFO | started process 30832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1XwIsP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:32:08 INFO - PID 30832 | RSS: Main: 156045312 19:32:08 INFO - PID 30832 | 19:32:11 INFO - PID 30832 | Cycle 1(1): loaded http://localhost:45670/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45670/tests/kraken/driver.html?testName=audio-beat-detection) 19:32:12 INFO - PID 30832 | RSS: Main: 161976320 19:32:12 INFO - PID 30832 | 19:32:14 INFO - PID 30832 | Cycle 1(1): loaded http://localhost:45670/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45670/tests/kraken/driver.html?testName=audio-dft) 19:32:15 INFO - PID 30832 | RSS: Main: 161566720 19:32:15 INFO - PID 30832 | 19:32:18 INFO - PID 30832 | Cycle 1(1): loaded http://localhost:45670/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45670/tests/kraken/driver.html?testName=audio-fft) 19:32:19 INFO - PID 30832 | RSS: Main: 158162944 19:32:19 INFO - PID 30832 | 19:32:21 INFO - PID 30832 | Cycle 1(1): loaded http://localhost:45670/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45670/tests/kraken/driver.html?testName=audio-oscillator) 19:32:21 INFO - PID 30832 | RSS: Main: 158879744 19:32:21 INFO - PID 30832 | 19:32:24 INFO - PID 30832 | Cycle 1(1): loaded http://localhost:45670/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45670/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:32:24 INFO - PID 30832 | RSS: Main: 158986240 19:32:24 INFO - PID 30832 | 19:32:27 INFO - PID 30832 | Cycle 1(1): loaded http://localhost:45670/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45670/tests/kraken/driver.html?testName=imaging-darkroom) 19:32:28 INFO - PID 30832 | RSS: Main: 164147200 19:32:28 INFO - PID 30832 | 19:32:32 INFO - PID 30832 | Cycle 1(1): loaded http://localhost:45670/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45670/tests/kraken/driver.html?testName=imaging-desaturate) 19:32:32 INFO - PID 30832 | RSS: Main: 161619968 19:32:32 INFO - PID 30832 | 19:32:35 INFO - PID 30832 | Cycle 1(1): loaded http://localhost:45670/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45670/tests/kraken/driver.html?testName=json-parse-financial) 19:32:36 INFO - PID 30832 | RSS: Main: 162603008 19:32:36 INFO - PID 30832 | 19:32:38 INFO - PID 30832 | Cycle 1(1): loaded http://localhost:45670/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45670/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:32:38 INFO - PID 30832 | RSS: Main: 163610624 19:32:38 INFO - PID 30832 | 19:32:40 INFO - PID 30832 | Cycle 1(1): loaded http://localhost:45670/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45670/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:32:41 INFO - PID 30832 | RSS: Main: 163074048 19:32:41 INFO - PID 30832 | 19:32:43 INFO - PID 30832 | Cycle 1(1): loaded http://localhost:45670/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45670/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:32:43 INFO - PID 30832 | RSS: Main: 163393536 19:32:43 INFO - PID 30832 | 19:32:46 INFO - PID 30832 | Cycle 1(1): loaded http://localhost:45670/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45670/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:32:47 INFO - PID 30832 | RSS: Main: 164052992 19:32:47 INFO - PID 30832 | 19:32:50 INFO - PID 30832 | Cycle 1(1): loaded http://localhost:45670/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45670/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:32:51 INFO - PID 30832 | RSS: Main: 163979264 19:32:51 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | Cycle 1(1): loaded http://localhost:45670/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45670/tests/kraken/driver.html?testName=ai-astar) 19:32:53 INFO - PID 30832 | RSS: Main: 165466112 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | __start_tp_report 19:32:53 INFO - PID 30832 | _x_x_mozilla_page_load 19:32:53 INFO - PID 30832 | _x_x_mozilla_page_load_details 19:32:53 INFO - PID 30832 | |i|pagename|runs| 19:32:53 INFO - PID 30832 | |0;ai-astar;105;111;111;111;111;113;112;113;111;111 19:32:53 INFO - PID 30832 | |1;audio-beat-detection;158;124;129;173;126;128;132;128;150;132 19:32:53 INFO - PID 30832 | |2;audio-dft;166;166;166;170;174;166;165;165;164;164 19:32:53 INFO - PID 30832 | |3;audio-fft;76;75;75;111;76;75;75;78;101;76 19:32:53 INFO - PID 30832 | |4;audio-oscillator;84;83;114;86;84;84;102;84;87;115 19:32:53 INFO - PID 30832 | |5;imaging-gaussian-blur;114;115;115;113;115;114;116;114;117;114 19:32:53 INFO - PID 30832 | |6;imaging-darkroom;151;150;151;150;151;150;153;150;152;150 19:32:53 INFO - PID 30832 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 19:32:53 INFO - PID 30832 | |8;json-parse-financial;70;71;69;70;72;72;72;71;72;72 19:32:53 INFO - PID 30832 | |9;json-stringify-tinderbox;55;55;56;55;55;56;55;58;56;56 19:32:53 INFO - PID 30832 | |10;stanford-crypto-aes;84;84;84;82;83;83;83;82;82;85 19:32:53 INFO - PID 30832 | |11;stanford-crypto-ccm;138;134;139;146;134;134;145;145;216;145 19:32:53 INFO - PID 30832 | |12;stanford-crypto-pbkdf2;185;196;193;193;199;197;202;193;189;194 19:32:53 INFO - PID 30832 | |13;stanford-crypto-sha256-iterative;80;72;73;70;71;72;72;73;73;73 19:32:53 INFO - PID 30832 | __end_tp_report 19:32:53 INFO - PID 30832 | __start_cc_report 19:32:53 INFO - PID 30832 | _x_x_mozilla_cycle_collect,848 19:32:53 INFO - PID 30832 | __end_cc_report 19:32:53 INFO - PID 30832 | __startTimestamp1490495573522__endTimestamp 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | ------- Summary: start ------- 19:32:53 INFO - PID 30832 | Number of tests: 14 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.23 (2.0%) stddev-sans-first:0.88 19:32:53 INFO - PID 30832 | Values: 105.0 111.0 111.0 111.0 111.0 113.0 112.0 113.0 111.0 111.0 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:132.00 stddev:16.54 (12.5%) stddev-sans-first:15.88 19:32:53 INFO - PID 30832 | Values: 158.0 124.0 129.0 173.0 126.0 128.0 132.0 128.0 150.0 132.0 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | [#2] audio-dft Cycles:10 Average:166.60 Median:166.00 stddev:3.10 (1.9%) stddev-sans-first:3.28 19:32:53 INFO - PID 30832 | Values: 166.0 166.0 166.0 170.0 174.0 166.0 165.0 165.0 164.0 164.0 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:13.00 (17.2%) stddev-sans-first:13.62 19:32:53 INFO - PID 30832 | Values: 76.0 75.0 75.0 111.0 76.0 75.0 75.0 78.0 101.0 76.0 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:84.00 stddev:12.95 (15.4%) stddev-sans-first:13.39 19:32:53 INFO - PID 30832 | Values: 84.0 83.0 114.0 86.0 84.0 84.0 102.0 84.0 87.0 115.0 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:115.00 stddev:1.16 (1.0%) stddev-sans-first:1.20 19:32:53 INFO - PID 30832 | Values: 114.0 115.0 115.0 113.0 115.0 114.0 116.0 114.0 117.0 114.0 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 19:32:53 INFO - PID 30832 | Values: 151.0 150.0 151.0 150.0 151.0 150.0 153.0 150.0 152.0 150.0 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:32:53 INFO - PID 30832 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | [#8] json-parse-financial Cycles:10 Average:71.10 Median:72.00 stddev:1.10 (1.5%) stddev-sans-first:1.09 19:32:53 INFO - PID 30832 | Values: 70.0 71.0 69.0 70.0 72.0 72.0 72.0 71.0 72.0 72.0 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:0.95 (1.7%) stddev-sans-first:0.97 19:32:53 INFO - PID 30832 | Values: 55.0 55.0 56.0 55.0 55.0 56.0 55.0 58.0 56.0 56.0 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.50 stddev:1.03 (1.2%) stddev-sans-first:1.05 19:32:53 INFO - PID 30832 | Values: 84.0 84.0 84.0 82.0 83.0 83.0 83.0 82.0 82.0 85.0 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:145.00 stddev:24.55 (16.9%) stddev-sans-first:25.79 19:32:53 INFO - PID 30832 | Values: 138.0 134.0 139.0 146.0 134.0 134.0 145.0 145.0 216.0 145.0 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.10 Median:195.00 stddev:4.84 (2.5%) stddev-sans-first:3.86 19:32:53 INFO - PID 30832 | Values: 185.0 196.0 193.0 193.0 199.0 197.0 202.0 193.0 189.0 194.0 19:32:53 INFO - PID 30832 | 19:32:53 INFO - PID 30832 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.00 stddev:2.69 (3.7%) stddev-sans-first:1.05 19:32:53 INFO - PID 30832 | Values: 80.0 72.0 73.0 70.0 71.0 72.0 72.0 73.0 73.0 73.0 19:32:53 INFO - PID 30832 | -------- Summary: end -------- 19:32:53 INFO - PID 30832 | 19:32:54 INFO - TEST-INFO | 30832: exit 0 19:32:54 INFO - TEST-OK | kraken | took 64473ms 19:32:54 INFO - SUITE-END | took 1185s 19:32:55 INFO - Completed test suite (00:19:45) 19:32:55 INFO - javascript benchmark 19:32:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6622.3620858233535, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2610.073423934502, 2625.7505536973995, 2638.5118753030683, 2639.77561907238, 2721.578155385915, 5162.896742065166, 5260.342457192846, 5283.233931079991, 5299.629025968175, 5316.3354580677415, 5210.583153347732, 5299.099153143965, 5335.973320133394, 5383.650062745928, 5401.675899446036, 4805.087033463648, 4826.276058591205, 4833.347498087766, 4880.731559764212, 4892.755362231892, 4848.830290939818, 4886.34034405356, 4890.388701412324, 4893.04585605807, 4905.264210368456, 4700.4359476862655, 4767.69010014348, 4784.521547845223, 4818.325434439182, 4829.661923665345, 4854.757262136879, 4855.368802055746, 4868.099401610678, 4870.805167793284, 4905.730184839832, 4780.976095119537, 4787.569118779326, 4811.7112973221365, 4839.27410888366, 4858.514148585148, 5083.212102124176, 5133.794648214067, 5219.608529360313, 5277.8416647500635, 5293.550048245904, 5693.202951586781, 5695.231143795618, 5721.914171287434, 5753.539716822645, 5762.9135562966585, 5728.112142617901, 5731.083026715747, 5733.627314224562, 5739.540836733051, 5747.511461525775, 5127.9230811537855, 5180.145276029413, 5290.206469029677, 5307.832276899076, 5318.627696061239, 5844.240248767633, 5845.824625261249, 5898.056310990221, 5900.232969713909, 5902.852428689317, 5403.405625381205, 5462.617616766788, 5520.475554822286, 5536.7785288588, 5596.0, 5655.5475561954945, 5719.970405326998, 5723.656580605177, 5725.427457254241, 5763.88472230553, 5467.535259502907, 5532.723363831792, 5667.348254950651, 5677.37548869624, 5689.886202275931, 5593.105103183471, 5646.491815736521, 5660.0, 5689.829305120853, 5709.9714501427225, 4747.169245382113, 4757.785899634525, 4761.666683332133, 4783.306420569068, 4798.2082956312515, 4014.879553613396, 4019.457373254632, 4019.959800402017, 4040.2929487340184, 4076.6331030207425, 4718.961828397747, 4777.116233496814, 4856.125897338513, 4896.559309662076, 4900.534449227318, 5680.744366503517, 5737.598368114275, 5755.050416681201, 5776.797812076557, 5808.651480911159, 4845.5881250093435, 4863.416390033219, 4882.023595280887, 4886.3403440535785, 4923.532264434873, 4819.036192761461, 4822.373091498082, 4923.310736496822, 4952.5542701157065, 4960.429550601655, 5314.760835762323, 5327.893442131213, 5374.758135883816, 5377.300950876361, 5393.352797664305, 5703.543716502752, 5724.998125328134, 5732.283464566929, 5749.367569567428, 5766.826995190151, 5155.200943853709, 5207.2449494823795, 5342.11855043929, 5354.464553544614, 5404.702741349263, 5541.362743284412, 5553.0, 5569.387367389665, 5589.5807814413265, 5594.104943209067, 5683.829485115453, 5705.201271821865, 5705.828825135252, 5712.7714891403875, 5715.399883012224, 5373.946260537345, 5435.537979271648, 5493.917591236055, 5541.556675466034, 5563.221149039056, 5510.8071217507195, 5523.337199536081, 5557.527610153183, 5561.944380556142, 5597.272354593877, 5414.269073675004, 5489.615726899079, 5492.148716948879, 5495.725213739377, 5527.198556209408, 5481.725913704378, 5556.694381809039, 5562.4993750561025, 5596.664200148004, 5675.971620141873, 5419.160030195326, 5421.9186712200135, 5426.8371948841595, 5468.043092458884, 5474.479924407335], "value": 5167.906917878888, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.9159009328789, 716.5521549031855, 736.7163641997829, 978.2711879649662, 987.368084425967, 30071.248218794513, 31060.378792424137, 31080.222994425152, 31084.689153108462, 31141.532877006834, 32885.17787055325, 33304.66695333046, 33321.833390833075, 33331.500027499605, 33351.66648333516, 7326.267373262658, 7354.521956072852, 7513.924860751377, 7525.5860927648955, 7527.510711803742, 7423.369013633847, 7444.6277686115745, 7527.247275272456, 7536.510126841765, 7539.736109236178, 7464.066991626047, 7671.462997590171, 7681.116671582784, 7702.268284512962, 7735.4585179037485, 7613.7158852344355, 7647.847043059163, 7693.615319234072, 7698.961505192494, 7714.344280736116, 7396.186419493852, 7560.924390756077, 7585.81035474112, 7587.620618969029, 7594.658240379196, 34962.47556286658, 34992.475112873326, 35061.47407788885, 35175.0, 35175.1206219844, 2637.788976881845, 2667.6398686177313, 2680.423708902595, 2683.2084535062204, 2708.8239264447748, 23945.16191933274, 24346.0, 24358.26925192247, 24756.752432475623, 24967.0, 2762.8480433576146, 2768.9307767305777, 2774.8057635965492, 2788.386554957906, 2796.9720302796914, 115138.42430787793, 117397.0, 143073.0, 155139.0, 155670.22164889102, 40723.59276407257, 40849.387259191135, 40854.591454085676, 40873.0, 40918.0, 43405.78297108557, 43585.782071089445, 43671.344929826075, 43726.562734372885, 43799.12401751947, 11383.487743051583, 11588.304701717923, 11683.649490515298, 11691.707707307216, 11739.882601173878, 9024.593893274687, 9046.321525885585, 9057.592408341641, 9067.773305667279, 9081.59132839024, 13057.151285166623, 13058.34708264602, 13066.0, 13164.802527962089, 13276.53532126371, 5460.6996615186545, 5478.287822583039, 5498.835034948958, 5551.3893471718075, 5610.438956104438, 798.9400794940402, 800.3495323019501, 827.6441130313902, 837.2046555772041, 843.696269343036, 20226.617284691278, 20309.89845050795, 21195.152193912378, 21379.144834206458, 21587.784122158893, 883.0992387764444, 883.8983516895511, 895.4895709445684, 917.1974522292994, 921.7603423109906, 10594.258401911793, 11235.438228088562, 13626.182429054288, 14314.785278220836, 14564.271786410636, 231618.0, 232081.0, 232103.0, 232348.0, 234447.0, 46472.0, 46973.0, 47017.76491117591, 47074.0, 47159.764201178776, 1214.1258294028285, 1244.0980289290192, 1250.2935841249664, 1252.2861968677767, 1254.3226657604791, 24552.386190345384, 24792.25623231306, 25443.6183457252, 25791.871040644677, 25897.611535827353, 31450.37099258048, 31606.683933160373, 31645.683543164272, 31709.682903171597, 31730.365392691554, 235497.0, 236023.0, 236521.0, 236792.0, 237121.0, 21450.570988580454, 21608.13567457347, 23911.16310929109, 24286.271411856967, 28325.291867702646, 29786.851065744533, 29815.10554683363, 29986.70013299839, 30064.549031764105, 30213.395732085675, 23575.292741217792, 23751.504361404717, 24662.01351945974, 25785.0, 26052.34869128211, 25254.242372728848, 25436.236912892644, 25921.481570368866, 26009.349766255997, 26472.205833825017, 27959.0, 28603.713962860103, 28729.71270287354, 28733.13800585986, 28756.281092972844, 25093.121740738985, 25159.0, 25668.78598848425, 25782.355441114123, 26210.86894565515, 19615.411537653894, 20859.58280834405, 20951.371458856258, 21028.26401075955, 21029.263975761387], "value": 14623.44698486552, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.1795537104305, 406.8189655603257, 412.5606229365726, 412.572986958498, 430.55222568528734, 12355.382230888465, 17011.0, 17879.0, 17945.461636150936, 18164.091795410244, 17237.396691115813, 17582.82417175828, 17893.7315940261, 17903.283868645238, 18028.909855450704, 5408.675479471224, 5454.400015998247, 5679.602427830054, 5697.487226149646, 5722.54219662426, 5615.101583746601, 5641.12562552805, 5650.830475085733, 5661.264035675377, 5687.033204355249, 5476.096444086721, 5677.943220567803, 5694.829155125332, 5726.255586773714, 5749.482546570808, 5681.914771278434, 5720.370759216483, 5730.914036289438, 5732.455416735404, 5741.397153298885, 5000.224965130411, 5162.638615296931, 5169.353830771153, 5180.1452760294505, 5184.740762961875, 22267.331980040464, 22814.543709125726, 23006.654900176512, 23380.18169364081, 23486.412839679146, 1576.400967632304, 1593.9681206375808, 1596.233807772276, 1615.176260107342, 1627.0481768165637, 13341.132826366254, 14081.295935203301, 14126.576202713935, 14293.785028272609, 14678.339474723663, 1735.0890782339247, 1769.840714335716, 1779.74193741908, 1797.8381945624826, 1806.151108978778, 87308.12691873127, 87923.0, 87962.12037879667, 88282.0, 88573.0, 11081.667549973514, 11178.552857885594, 11212.775744485065, 11289.209755317213, 11327.716807079723, 12656.303903285223, 14361.85638143626, 14379.980204157035, 14410.135391876522, 14414.783778243334, 6405.903911441332, 6774.966125169342, 6846.212685541226, 6943.652817359111, 6980.546264492792, 6027.9095813562835, 6036.879262414727, 6140.416660417253, 6203.7828675996125, 6428.132202152649, 6966.12923384577, 6983.650817459208, 6987.161540615159, 6996.195437524648, 7036.6129862857015, 1878.8121187881377, 1882.585831117152, 1936.990315048444, 1943.6209939061748, 2201.086549082113, 767.5586537740821, 788.2984144111745, 808.8018435483344, 823.9835203295901, 826.7891687619739, 16206.351745930266, 16215.675686486204, 16418.6716265674, 16688.415905443253, 17075.40236091731, 813.1421350475306, 823.567626995832, 829.179112678456, 834.2825170353491, 855.3755758296478, 8730.476171429735, 8824.911750882537, 9152.450852948845, 9212.907870921339, 9281.907180928105, 422633.0, 425267.0, 435176.0, 441400.0, 444940.0, 60463.69768151131, 70908.0, 82762.0, 88555.0, 90607.54696226609, 1036.9118624916966, 1065.872095348563, 1116.3469370418395, 1137.4312843578211, 1137.8179491281355, 15923.761143583088, 16213.270402831666, 16754.1622918856, 17305.30778768835, 17373.391931282345, 38913.805430972665, 40017.39973900452, 41176.58823411848, 42476.57523424726, 44669.55330446654, 51738.482615173365, 51861.0, 52035.73982130065, 52443.213351800514, 55227.44772552384, 7143.642817858982, 7166.749163779451, 7266.636668166465, 7309.195988441161, 7321.084864391951, 9386.906130938603, 11021.173411993972, 11084.89151084885, 11111.499982500645, 11247.718807029562, 9411.741340959568, 9520.714378568655, 9605.231581473605, 9815.0, 10034.448105354275, 9175.128362805523, 9371.203447707021, 9390.577424016072, 9481.383710058824, 9566.952165239129, 9237.168654820829, 9355.204807591432, 9888.357256778574, 9985.251106167212, 10449.84325235107, 7205.243449437734, 7301.744438944612, 7304.707811687473, 7339.082614673166, 7391.40868730511, 9633.32566720323, 9717.12545870875, 9832.0, 10023.298369114384, 10075.697729068139], "value": 8529.02476198946, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1218.4334284557679, 1271.3131917439425, 1287.1054617041154, 1288.66494711375, 1291.1865524719426, 9274.81450370993, 9580.568874400651, 9639.325247232688, 9666.75833104172, 9803.901960980387, 9578.568964396602, 9726.416415015105, 9726.805463890736, 9767.853482197756, 9784.657536986208, 2229.3312006398096, 2254.8196144308417, 2274.2040285899966, 2278.2481781012225, 2281.6577513372963, 2141.9464513387134, 2186.814120799734, 2197.252934002439, 2205.52581195043, 2239.484918468753, 2179.204590324536, 2207.128184367174, 2218.944526386845, 2222.4443889027743, 2294.7934685878267, 2132.3709505695856, 2187.814035806958, 2198.758136604972, 2200.9119635214574, 2202.174184680745, 1820.0808591661125, 1885.632301701169, 2131.6802479628027, 2156.33153722345, 2178.9564208715738, 9587.137157655774, 9591.760205994837, 9652.324337296392, 9672.22622190223, 9694.321397502177, 5329.706866122362, 5523.392426833045, 5564.610477266593, 5566.777328906839, 5573.916391254134, 3160.5575219469292, 3209.502527108302, 3225.3871764364694, 3275.5086736989642, 3328.051505320996, 993.4734590666958, 1012.5241136665755, 1019.6380284998867, 1036.5439206749006, 1048.4390850894736, 14233.715325693533, 14375.568732938029, 14508.637284067983, 14566.70866582673, 14581.562553123424, 4764.6426518011285, 4945.851624451272, 4961.181405068123, 5036.748162591855, 5135.948640513622, 11866.584669536525, 11874.168808183344, 11907.821382679267, 11946.761064778655, 11997.220180688228, 5599.944000559943, 5602.747876345493, 5609.663420194802, 5614.185943038318, 5618.831435056954, 4868.172410690191, 4877.414710234723, 4943.90112197754, 4999.75001249936, 5001.799928002912, 3633.981830090833, 3656.1590834108306, 3709.5548534176073, 3746.5316835395574, 3765.1528406108955, 1087.4888802262924, 1104.1884215101893, 1105.690406686129, 1116.084810455435, 1124.7019539821954, 647.5499527828208, 685.95541289817, 687.0621601513898, 695.6730336741723, 697.7418355208605, 5630.887382252332, 5739.512141468022, 5746.339170995306, 5771.336296325976, 5994.730237139339, 811.217175425717, 813.7640084375465, 825.781167990483, 827.2678679368802, 856.5631527920681, 3626.546681664792, 3644.3986742187244, 3657.908552286214, 3668.0829792551863, 3831.3295173344554, 12436.937815310866, 12626.431810568547, 12707.237565746085, 12763.042771791967, 13031.218126912416, 11603.825942610867, 12599.0, 12639.810402843965, 12650.304233267074, 12686.873131268754, 8924.732258032269, 9227.907720922705, 9247.722568322826, 9251.306152038624, 9263.490508021989, 5785.537157027512, 5794.855128621818, 5894.351621321737, 5992.221011268507, 6022.337542870368, 10709.518071686636, 11450.599229026944, 11462.083033357145, 11597.88402115968, 11696.239744416585, 11086.390248536409, 11109.889011099149, 11155.609553665583, 11250.83123753128, 11410.828837567276, 8011.919880801117, 8220.301274391744, 8257.669693212445, 8381.95809020951, 8403.70587029451, 9113.36206465541, 9116.08839116083, 9190.678326258549, 9207.76980575491, 9223.58493867791, 7698.615069246627, 7744.651490683045, 7762.0, 7768.300852923264, 7929.0, 7806.6134367286395, 7837.882431763414, 7869.960650196713, 7881.2118788123025, 8060.516369017878, 6985.44116470671, 7000.264972178052, 7017.719291228498, 7032.753853615099, 7109.82225444368, 5147.871303217449, 5249.6062795289745, 5276.788928442973, 5312.043832110257, 5353.839384818461, 5066.645334826527, 5069.31564238823, 5092.821751238689, 5150.716710580804, 5305.867353316198], "value": 4660.719444914986, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.11542413631406, 381.7957392794855, 387.69178503090023, 390.1377954720069, 391.2995737629643, 5241.737913104349, 5490.478404551571, 5609.887802243958, 5615.101583746601, 5639.2105105285245, 5328.866778330544, 5462.781488740456, 5479.04116779563, 5501.0, 5503.20203570483, 4366.8908277293085, 4372.2130016597, 4398.295048545137, 4407.427034485512, 4420.668449866273, 4324.6972711910175, 4348.608625223729, 4370.759608221547, 4395.296752519597, 4402.427684401024, 4318.935215971763, 4326.84856030039, 4339.936715504706, 4340.522542520336, 4375.606195442409, 4336.528178938007, 4341.261985462464, 4345.869623911288, 4349.586789255016, 4363.629091527224, 3819.312523745725, 3893.76637401754, 3898.3372826619543, 3922.313595120871, 3922.960415489869, 5362.8123015694655, 5373.919391209135, 5382.730863456812, 5406.810761623364, 5419.701916394597, 5052.166392545226, 5060.316857224265, 5072.644914855925, 5080.771365288534, 5082.288479612857, 5624.465675760796, 5819.24349834523, 5820.1560773688, 5849.7660093596205, 5856.590038697293, 4311.568843115695, 4313.82744690212, 4319.740815551077, 4330.891727706832, 4333.631641310492, 5847.210626565445, 6059.45464908156, 6060.8181754546995, 6090.5736598438125, 6131.540134489931, 4413.977930110394, 4417.491988421309, 4429.512753597101, 4433.578810013044, 4434.623057040123, 4421.38100665907, 4451.621612163002, 4462.642988560908, 4470.709403888802, 4483.686141970031, 4861.829835955725, 4965.155923493015, 4996.125678006334, 5000.199968005102, 5028.673136246205, 5824.0, 5841.18223448709, 5848.590598658053, 5882.852928676732, 5889.852753681193, 1552.4100841680315, 1579.4156162220052, 1584.081232884924, 1586.8016497937758, 1588.4758029850123, 925.5464822237055, 954.4511905654276, 962.4802606592501, 1113.3375641493299, 1132.365875109941, 5068.011737711185, 5068.949310506848, 5077.771500282496, 5085.084684756779, 5092.465291144451, 6035.658442278615, 6042.39576042401, 6044.922265297084, 6059.666718330534, 6069.302030266487, 4925.876853078702, 4925.901481970341, 4994.225894986283, 5034.11902916988, 5078.187490001582, 3153.369326134782, 3187.2509960159346, 3193.1218914798615, 3194.728448081939, 3197.4724170511604, 5422.566194704415, 5531.280933478622, 5544.611877168641, 5561.527270181999, 5591.804286849941, 6095.420935011167, 6137.974468425409, 6164.137020817089, 6166.414190651881, 6199.132121502993, 5617.943820561742, 5629.099344105005, 5633.352164501053, 5634.211210430543, 5647.774089036392, 5850.678212698343, 5935.8919701370305, 5939.90111829313, 5966.552508561788, 6033.2805150531885, 5614.29821272341, 5855.912161317498, 5884.146798714077, 5888.263967004124, 5904.586678932434, 5426.565874730091, 5518.696471693935, 5571.916421253603, 5615.073512870331, 5616.21373007771, 4181.26827805139, 4182.853600123981, 4202.763871818622, 4205.6635469163, 4206.516250631216, 5968.403159683997, 5968.582199246011, 6035.39646035393, 6094.939050609437, 6130.50955923534, 5850.473457388855, 5866.735996880066, 5866.911996320144, 5881.235439392852, 5883.676397798162, 5869.178315035813, 5875.118732190205, 5884.47039766423, 5884.852878678067, 5905.8188362328565, 5507.779688812403, 5669.489745922887, 5755.827325180251, 5759.769609215585, 5775.33583637887, 5875.118732190034, 5894.086416605433, 5902.822915312548, 5903.819236152701, 5917.556183286185, 5408.918866216931, 5671.744771485211, 5717.142428635738, 5717.799877004285, 5722.370539240597], "value": 4429.830888693128, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.8532408194279, 711.118213415365, 722.559238864293, 738.1326940844503, 751.4026349052502, 12597.811032834503, 13390.330483475836, 13425.127366721157, 13453.730925381487, 13466.192028478297, 13156.605301840937, 13171.407286672098, 13182.0, 13275.468981240763, 13856.614338566138, 825.1088824070005, 844.0420123160227, 850.7022542110243, 853.5348235211825, 855.1619412975288, 844.252836239929, 852.1521086518923, 852.6205838401913, 853.2747164909839, 875.5622188905547, 898.9460632362046, 902.1790170944441, 909.417972497602, 909.7634615000114, 910.4810258152855, 905.1717678324326, 908.4503875155535, 909.4270609515995, 913.2146354135439, 914.6432891172448, 661.9404253617149, 667.1427216027381, 669.6718607882151, 670.0150778355858, 672.1497305908031, 12882.742345153138, 13252.0, 13270.66823329415, 13372.459232745747, 14455.421783128768, 13905.304734763222, 14363.856361436356, 14485.025421035894, 14492.492762753358, 14521.491747788883, 10589.417582032986, 10628.893711062869, 10760.623378181726, 10764.192685548614, 10867.565297388095, 2740.3405239443464, 2806.3685670724126, 2810.12886005339, 2823.6893941666603, 2871.899483518067, 67719.0, 68374.65812670955, 68461.31538684599, 69913.0, 71128.0, 10844.295120817122, 10879.238453308193, 10963.83554246687, 11116.722081948015, 11438.142139339583, 17971.550711232325, 18445.7233141503, 22289.0, 22390.776092239194, 22564.774352256594, 6580.703868325937, 6749.190097188271, 6845.863082738318, 6859.279775623588, 6896.965515172392, 3382.5433566468705, 3491.4762785582366, 3501.3872572300256, 3513.350030244413, 3516.507688923553, 3603.1532589841368, 3623.8550457981387, 3670.376036073874, 3696.4270538066644, 3711.3505136601525, 691.3570379546969, 696.7039008421401, 700.0654126740858, 707.6284950400977, 722.2524686948983, 507.14039702703565, 511.3173912826344, 539.1616037062406, 542.3681411155959, 561.9606627536115, 8594.484330940164, 9103.954480227689, 9136.908630913606, 9142.954285228532, 9397.436153830655, 534.0920435260074, 536.9087255166631, 544.1185279846674, 553.3194171169484, 556.2240674259385, 3884.3590807517007, 4023.3562629979647, 4072.3687828386646, 4099.467069280974, 4119.7940102994735, 62358.0, 64887.35112648813, 64964.350356496776, 65523.672381637785, 65742.34257657458, 41102.794486027975, 50880.236796447345, 54735.45264547383, 57370.713146434, 57672.71163644155, 51645.48354516482, 52093.47906520962, 52218.47781522212, 52447.47552524502, 52697.2095418569, 8000.199980001953, 8354.45696029756, 8397.412181147505, 8555.358348123791, 8579.099194584729, 27049.45901082007, 27195.320116997234, 27275.0, 27288.86355568289, 27396.219245748962, 32864.342713145124, 33150.83424582861, 33161.83419082889, 33449.83275083609, 33928.491072634424, 10210.795784084425, 10318.535665895202, 10448.947755261175, 10501.684949451528, 10576.524056417633, 10963.177761667748, 11050.613228536962, 11056.281341712764, 12494.937525312314, 12807.423665934868, 11035.172362072715, 11395.0, 11844.940775296069, 11941.582044628396, 12314.384280785745, 12036.578719744766, 12138.635840924786, 12172.452239649414, 12451.128421010442, 12652.0, 11263.380514071805, 11827.52689892429, 12147.696307592381, 12162.75674486523, 12520.499180032697, 8408.369372297224, 8419.579021049045, 8515.787105322417, 8646.351523635627, 8782.077881822572, 9023.323250756088, 9796.706098817047, 10231.7442063949, 10468.738281542717, 10494.737631559272], "value": 6337.860916045468, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 111.0, 111.0, 111.0, 113.0, 112.0, 113.0, 111.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 129.0, 173.0, 126.0, 128.0, 132.0, 128.0, 150.0, 132.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 166.0, 170.0, 174.0, 166.0, 165.0, 165.0, 164.0, 164.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 111.0, 76.0, 75.0, 75.0, 78.0, 101.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 114.0, 86.0, 84.0, 84.0, 102.0, 84.0, 87.0, 115.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 113.0, 115.0, 114.0, 116.0, 114.0, 117.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 151.0, 150.0, 153.0, 150.0, 152.0, 150.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 69.0, 70.0, 72.0, 72.0, 72.0, 71.0, 72.0, 72.0], "value": 71.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 55.0, 58.0, 56.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 82.0, 83.0, 83.0, 83.0, 82.0, 82.0, 85.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 134.0, 139.0, 146.0, 134.0, 134.0, 145.0, 145.0, 216.0, 145.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 196.0, 193.0, 193.0, 199.0, 197.0, 202.0, 193.0, 189.0, 194.0], "value": 194.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 72.0, 73.0, 70.0, 71.0, 72.0, 72.0, 73.0, 73.0, 73.0], "value": 72.9, "unit": "score"}]}]} 19:32:55 INFO - Return code: 0 19:32:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:32:55 ERROR - # TBPL SUCCESS # 19:32:55 INFO - Running post-action listener: _resource_record_post_action 19:32:55 INFO - [mozharness: 2017-03-26 02:32:55.344504Z] Finished run-tests step (success) 19:32:55 INFO - Running post-run listener: _resource_record_post_run 19:32:55 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 366190592; Read time: 8; Write time: 190096 19:32:55 INFO - TinderboxPrint: CPU usage
13.3% 19:32:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:32:55 INFO - TinderboxPrint: I/O write bytes / time
366,190,592 / 190,096 19:32:55 INFO - TinderboxPrint: CPU idle
8,315.0 (86.7%) 19:32:55 INFO - TinderboxPrint: CPU user
1,221.2 (12.7%) 19:32:55 INFO - TinderboxPrint: Swap in / out
0 / 0 19:32:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105852928; Read time: 0; Write time: 66192 19:32:55 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 260337664; Read time: 8; Write time: 123904 19:32:55 INFO - Running post-run listener: _upload_blobber_files 19:32:55 INFO - Blob upload gear active. 19:32:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:32:55 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 19:32:55 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'] 19:32:55 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 19:32:56 INFO - (blobuploader) - INFO - Open directory for files ... 19:32:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:32:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:32:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:57 INFO - (blobuploader) - INFO - Done attempting. 19:32:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:32:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:58 INFO - (blobuploader) - INFO - Done attempting. 19:32:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:32:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:58 INFO - (blobuploader) - INFO - Done attempting. 19:32:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:32:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:33:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:02 INFO - (blobuploader) - INFO - Done attempting. 19:33:02 INFO - (blobuploader) - INFO - Iteration through files over. 19:33:02 INFO - Return code: 0 19:33:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:33:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:33:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48ec49e05ed4525f9f3891590b8cac5eaf063f3f1a5a038f01254263a00c4ae651c98b2e1d18334494467f0283ede957383e1b5a96bd9a0955401bf792b1ca66", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef2fb334e03eaac0f787dca614132f5364774713f58e06f8da44b07e844cc0b7c11115ddb0ed7c072300d97dda182ab1b9c4019f1b32b2ce7712e8941138f3ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b6a4599c3e6f1d98fc5726f16777ae383330a6187b4aa779fbc19f2f904288a2389a94f800821576b2e6d9f94ad792b986828c71bd16e0db57319276ab6ddda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c30f0bfe3e88fd566a28c377e308f329091a8b66667ee4c1ac04ee9c86c706c312855f56404d9b71533d294ec055d00d7b9811ef51887caa5611713f04507f21"} 19:33:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:33:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:33:02 INFO - Contents: 19:33:02 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48ec49e05ed4525f9f3891590b8cac5eaf063f3f1a5a038f01254263a00c4ae651c98b2e1d18334494467f0283ede957383e1b5a96bd9a0955401bf792b1ca66", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef2fb334e03eaac0f787dca614132f5364774713f58e06f8da44b07e844cc0b7c11115ddb0ed7c072300d97dda182ab1b9c4019f1b32b2ce7712e8941138f3ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b6a4599c3e6f1d98fc5726f16777ae383330a6187b4aa779fbc19f2f904288a2389a94f800821576b2e6d9f94ad792b986828c71bd16e0db57319276ab6ddda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c30f0bfe3e88fd566a28c377e308f329091a8b66667ee4c1ac04ee9c86c706c312855f56404d9b71533d294ec055d00d7b9811ef51887caa5611713f04507f21"} 19:33:02 INFO - Running post-run listener: copy_logs_to_upload_dir 19:33:02 INFO - Copying logs to upload dir... 19:33:02 INFO - mkdir: /builds/slave/test/build/upload/logs 19:33:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.939176 ========= master_lag: 0.53 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-25 19:33:00.875827) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-25 19:33:00.879628) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438 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/48ec49e05ed4525f9f3891590b8cac5eaf063f3f1a5a038f01254263a00c4ae651c98b2e1d18334494467f0283ede957383e1b5a96bd9a0955401bf792b1ca66", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef2fb334e03eaac0f787dca614132f5364774713f58e06f8da44b07e844cc0b7c11115ddb0ed7c072300d97dda182ab1b9c4019f1b32b2ce7712e8941138f3ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b6a4599c3e6f1d98fc5726f16777ae383330a6187b4aa779fbc19f2f904288a2389a94f800821576b2e6d9f94ad792b986828c71bd16e0db57319276ab6ddda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c30f0bfe3e88fd566a28c377e308f329091a8b66667ee4c1ac04ee9c86c706c312855f56404d9b71533d294ec055d00d7b9811ef51887caa5611713f04507f21"} build_url:https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/aUKtNe-LRZ-9XMJQTLAWjg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48ec49e05ed4525f9f3891590b8cac5eaf063f3f1a5a038f01254263a00c4ae651c98b2e1d18334494467f0283ede957383e1b5a96bd9a0955401bf792b1ca66", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef2fb334e03eaac0f787dca614132f5364774713f58e06f8da44b07e844cc0b7c11115ddb0ed7c072300d97dda182ab1b9c4019f1b32b2ce7712e8941138f3ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b6a4599c3e6f1d98fc5726f16777ae383330a6187b4aa779fbc19f2f904288a2389a94f800821576b2e6d9f94ad792b986828c71bd16e0db57319276ab6ddda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c30f0bfe3e88fd566a28c377e308f329091a8b66667ee4c1ac04ee9c86c706c312855f56404d9b71533d294ec055d00d7b9811ef51887caa5611713f04507f21"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-25 19:33:00.904646) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:33:00.904933) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1490484969.500509-1139031438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:33:00.988328) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-25 19:33:00.988646) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-25 19:33:00.988988) ========= ========= Total master_lag: 0.68 =========