builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1474973865.01 results: success (0) buildid: 20160927022250 builduid: f92cbe29358b499ab47884c3242bd418 revision: 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 03:57:45.006038) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 03:57:45.006542) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 03:57:45.006880) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 03:57:45.025528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:57:45.025994) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 03:57:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-09-27 03:57:46 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:57:45.182779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:57:45.183119) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017019 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:57:45.232436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 03:57:45.232805) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd --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=e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 03:57:46,454 truncating revision to first 12 chars 2016-09-27 03:57:46,454 Setting DEBUG logging. 2016-09-27 03:57:46,454 attempt 1/10 2016-09-27 03:57:46,454 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/66a77b9bfe5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 03:57:47,658 unpacking tar archive at: mozilla-central-66a77b9bfe5d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.596406 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 03:57:46.845780) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 03:57:46.846145) ========= script_repo_revision: 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 03:57:46.846599) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 03:57:46.846913) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 03:57:46.857440) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-27 03:57:46.857933) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:57:48 INFO - MultiFileLogger online at 20160927 03:57:48 in /builds/slave/test 03:57:48 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 03:57:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:57:48 INFO - {'append_to_log': False, 03:57:48 INFO - 'base_work_dir': '/builds/slave/test', 03:57:48 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:57:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:57:48 INFO - 'branch': 'Firefox-Non-PGO', 03:57:48 INFO - 'buildbot_json_path': 'buildprops.json', 03:57:48 INFO - 'config_files': ('talos/linux_config.py',), 03:57:48 INFO - 'default_actions': ('clobber', 03:57:48 INFO - 'read-buildbot-config', 03:57:48 INFO - 'download-and-extract', 03:57:48 INFO - 'populate-webroot', 03:57:48 INFO - 'create-virtualenv', 03:57:48 INFO - 'install', 03:57:48 INFO - 'run-tests'), 03:57:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:57:48 INFO - 'download_minidump_stackwalk': True, 03:57:48 INFO - 'download_symbols': 'ondemand', 03:57:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:57:48 INFO - 'tooltool.py': '/tools/tooltool.py', 03:57:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:57:48 INFO - '/tools/misc-python/virtualenv.py')}, 03:57:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:57:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:57:48 INFO - 'installer_path': 'installer.exe', 03:57:48 INFO - 'log_level': 'info', 03:57:48 INFO - 'log_name': 'talos', 03:57:48 INFO - 'log_to_console': True, 03:57:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:57:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:57:48 INFO - 'opt_config_files': (), 03:57:48 INFO - 'pip_index': False, 03:57:48 INFO - 'sps_profile': False, 03:57:48 INFO - 'sps_profile_interval': 0, 03:57:48 INFO - 'suite': 'dromaeojs-e10s', 03:57:48 INFO - 'system_bits': '32', 03:57:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:57:48 INFO - 'title': 'talos-linux64-ix-006', 03:57:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:57:48 INFO - 'use_talos_json': True, 03:57:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:57:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:57:48 INFO - 'work_dir': 'build'} 03:57:48 INFO - [mozharness: 2016-09-27 10:57:48.183927Z] Running clobber step. 03:57:48 INFO - Running pre-action listener: _resource_record_pre_action 03:57:48 INFO - Running main action method: clobber 03:57:48 INFO - rmtree: /builds/slave/test/build 03:57:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:57:49 INFO - Running post-action listener: _resource_record_post_action 03:57:49 INFO - [mozharness: 2016-09-27 10:57:49.151787Z] Finished clobber step (success) 03:57:49 INFO - [mozharness: 2016-09-27 10:57:49.151885Z] Running read-buildbot-config step. 03:57:49 INFO - Running pre-action listener: _resource_record_pre_action 03:57:49 INFO - Running main action method: read_buildbot_config 03:57:49 INFO - Using buildbot properties: 03:57:49 INFO - { 03:57:49 INFO - "project": "", 03:57:49 INFO - "product": "firefox", 03:57:49 INFO - "script_repo_revision": "production", 03:57:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:57:49 INFO - "repository": "", 03:57:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:57:49 INFO - "buildid": "20160927022250", 03:57:49 INFO - "pgo_build": "False", 03:57:49 INFO - "basedir": "/builds/slave/test", 03:57:49 INFO - "buildnumber": 489, 03:57:49 INFO - "slavename": "talos-linux64-ix-006", 03:57:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:57:49 INFO - "platform": "ubuntu64_hw", 03:57:49 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:57:49 INFO - "branch": "mozilla-central", 03:57:49 INFO - "repo_path": "mozilla-central", 03:57:49 INFO - "revision": "66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd", 03:57:49 INFO - "stage_platform": "linux64", 03:57:49 INFO - "builduid": "f92cbe29358b499ab47884c3242bd418", 03:57:49 INFO - "slavebuilddir": "test" 03:57:49 INFO - } 03:57:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:57:49 INFO - Running post-action listener: _resource_record_post_action 03:57:49 INFO - [mozharness: 2016-09-27 10:57:49.154313Z] Finished read-buildbot-config step (success) 03:57:49 INFO - [mozharness: 2016-09-27 10:57:49.154401Z] Running download-and-extract step. 03:57:49 INFO - Running pre-action listener: _resource_record_pre_action 03:57:49 INFO - Running main action method: download_and_extract 03:57:49 INFO - mkdir: /builds/slave/test/build/tests 03:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:49 INFO - trying https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:57:49 INFO - Downloading https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:57:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:57:49 INFO - Downloaded 1361 bytes. 03:57:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:57:49 INFO - Using the following test package requirements: 03:57:49 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:57:49 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:57:49 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:57:49 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:49 INFO - u'jsshell-linux-x86_64.zip'], 03:57:49 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:57:49 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:57:49 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:57:49 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:57:49 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:57:49 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:57:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:57:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:57:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:57:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:57:49 INFO - Fetch https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:57:50 INFO - Expected file size: 20412927 03:57:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:57:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:57:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:57:54 INFO - Fetch https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:57:55 INFO - Expected file size: 20412927 03:57:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:57:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:57:59 INFO - Fetch https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:58:00 INFO - Expected file size: 14414057 03:58:01 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')]} 03:58:01 INFO - trying https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:58:01 INFO - Downloading https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:58:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:58:02 INFO - Downloaded 55743336 bytes. 03:58:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:58:02 INFO - mkdir: /builds/slave/test/properties 03:58:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:58:02 INFO - Writing to file /builds/slave/test/properties/build_url 03:58:02 INFO - Contents: 03:58:02 INFO - build_url:https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:58:03 INFO - Running post-action listener: _resource_record_post_action 03:58:03 INFO - Running post-action listener: set_extra_try_arguments 03:58:03 INFO - [mozharness: 2016-09-27 10:58:03.445322Z] Finished download-and-extract step (success) 03:58:03 INFO - [mozharness: 2016-09-27 10:58:03.445547Z] Running populate-webroot step. 03:58:03 INFO - Running pre-action listener: _resource_record_pre_action 03:58:03 INFO - Running main action method: populate_webroot 03:58:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:58:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:58:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:58:03 INFO - '--tppagecycles', 03:58:03 INFO - '7'], 03:58:03 INFO - 'tests': ['tsvgm']}}, 03:58:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:58:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:58:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:58:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:58:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:58:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:58:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:03 INFO - 'talos_options': ['--disable-e10s'], 03:58:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:03 INFO - 'talos_options': ['--disable-e10s'], 03:58:03 INFO - 'tests': ['damp', 'tps']}, 03:58:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:03 INFO - 'tests': ['damp', 'tps']}, 03:58:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:58:03 INFO - 'tests': ['dromaeo_dom']}, 03:58:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:58:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:58:03 INFO - 'tests': ['basic_compositor_video']}, 03:58:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:58:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:58:03 INFO - 'tests': ['a11yr', 03:58:03 INFO - 'ts_paint', 03:58:03 INFO - 'tpaint', 03:58:03 INFO - 'sessionrestore', 03:58:03 INFO - 'sessionrestore_no_auto_restore', 03:58:03 INFO - 'tabpaint']}, 03:58:03 INFO - 'other-e10s': {'tests': ['a11yr', 03:58:03 INFO - 'ts_paint', 03:58:03 INFO - 'tpaint', 03:58:03 INFO - 'sessionrestore', 03:58:03 INFO - 'sessionrestore_no_auto_restore', 03:58:03 INFO - 'tabpaint']}, 03:58:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:58:03 INFO - 'ts_paint', 03:58:03 INFO - 'tpaint', 03:58:03 INFO - 'sessionrestore', 03:58:03 INFO - 'sessionrestore_no_auto_restore', 03:58:03 INFO - 'tabpaint']}, 03:58:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:58:03 INFO - 'ts_paint', 03:58:03 INFO - 'tpaint', 03:58:03 INFO - 'sessionrestore', 03:58:03 INFO - 'sessionrestore_no_auto_restore', 03:58:03 INFO - 'tabpaint']}, 03:58:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:58:03 INFO - 'tests': ['a11yr', 03:58:03 INFO - 'ts_paint', 03:58:03 INFO - 'tpaint', 03:58:03 INFO - 'sessionrestore', 03:58:03 INFO - 'sessionrestore_no_auto_restore', 03:58:03 INFO - 'tabpaint']}, 03:58:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:58:03 INFO - 'tests': ['a11yr', 03:58:03 INFO - 'ts_paint', 03:58:03 INFO - 'tpaint', 03:58:03 INFO - 'sessionrestore', 03:58:03 INFO - 'sessionrestore_no_auto_restore', 03:58:03 INFO - 'tabpaint']}, 03:58:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:58:03 INFO - 'tests': ['tsvgx', 03:58:03 INFO - 'tsvgr_opacity', 03:58:03 INFO - 'tart', 03:58:03 INFO - 'tscrollx', 03:58:03 INFO - 'cart']}, 03:58:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:58:03 INFO - 'tsvgr_opacity', 03:58:03 INFO - 'tart', 03:58:03 INFO - 'tscrollx', 03:58:03 INFO - 'cart']}, 03:58:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:03 INFO - 'talos_options': ['--disable-e10s'], 03:58:03 INFO - 'tests': ['tp5o']}, 03:58:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:03 INFO - 'tests': ['tp5o']}, 03:58:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:03 INFO - 'talos_options': ['--disable-e10s', 03:58:03 INFO - '--xperf_path', 03:58:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:03 INFO - 'tests': ['tp5n']}, 03:58:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:03 INFO - 'talos_options': ['--xperf_path', 03:58:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:03 INFO - 'tests': ['tp5n']}}, 03:58:03 INFO - 'talos.zip': {'path': '', 03:58:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:58:03 INFO - Running post-action listener: _resource_record_post_action 03:58:03 INFO - [mozharness: 2016-09-27 10:58:03.465780Z] Finished populate-webroot step (success) 03:58:03 INFO - [mozharness: 2016-09-27 10:58:03.465867Z] Running create-virtualenv step. 03:58:03 INFO - Running pre-action listener: _resource_record_pre_action 03:58:03 INFO - Running main action method: create_virtualenv 03:58:03 INFO - Creating virtualenv /builds/slave/test/build/venv 03:58:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:58:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:58:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:58:03 INFO - Using real prefix '/usr' 03:58:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:58:04 INFO - Installing distribute.............................................................................................................................................................................................done. 03:58:06 INFO - Installing pip.................done. 03:58:06 INFO - Return code: 0 03:58:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:58:06 INFO - Reading from file tmpfile_stdout 03:58:06 INFO - Output received: 03:58:06 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) 03:58:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:06 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 0x7fb302f84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf60>, '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 0x105cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', '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 03:58:06 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 03:58:06 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 03:58:06 INFO - Using env: {'DISPLAY': ':0', 03:58:06 INFO - 'HOME': '/home/cltbld', 03:58:06 INFO - 'LANG': 'en_US.UTF-8', 03:58:06 INFO - 'LANGUAGE': 'en_US:en', 03:58:06 INFO - 'LOGNAME': 'cltbld', 03:58:06 INFO - 'MAIL': '/var/mail/cltbld', 03:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:06 INFO - 'MOZ_NO_REMOTE': '1', 03:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:06 INFO - 'NO_EM_RESTART': '1', 03:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:06 INFO - 'PWD': '/builds/slave/test', 03:58:06 INFO - 'SHELL': '/bin/bash', 03:58:06 INFO - 'SHLVL': '1', 03:58:06 INFO - 'TERM': 'linux', 03:58:06 INFO - 'TMOUT': '86400', 03:58:06 INFO - 'USER': 'cltbld', 03:58:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', 03:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:06 INFO - '_': '/tools/buildbot/bin/python'} 03:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:06 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 03:58:06 INFO - Cleaning up... 03:58:06 INFO - Return code: 0 03:58:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:06 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 0x7fb302f84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf60>, '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 0x105cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', '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 03:58:06 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 03:58:06 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 03:58:06 INFO - Using env: {'DISPLAY': ':0', 03:58:06 INFO - 'HOME': '/home/cltbld', 03:58:06 INFO - 'LANG': 'en_US.UTF-8', 03:58:06 INFO - 'LANGUAGE': 'en_US:en', 03:58:06 INFO - 'LOGNAME': 'cltbld', 03:58:06 INFO - 'MAIL': '/var/mail/cltbld', 03:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:06 INFO - 'MOZ_NO_REMOTE': '1', 03:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:06 INFO - 'NO_EM_RESTART': '1', 03:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:06 INFO - 'PWD': '/builds/slave/test', 03:58:06 INFO - 'SHELL': '/bin/bash', 03:58:06 INFO - 'SHLVL': '1', 03:58:06 INFO - 'TERM': 'linux', 03:58:06 INFO - 'TMOUT': '86400', 03:58:06 INFO - 'USER': 'cltbld', 03:58:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', 03:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:06 INFO - '_': '/tools/buildbot/bin/python'} 03:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:06 INFO - Downloading/unpacking psutil>=3.1.1 03:58:06 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 03:58:06 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 03:58:06 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 03:58:06 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 03:58:06 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 03:58:06 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 03:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:58:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:08 INFO - Installing collected packages: psutil 03:58:08 INFO - Running setup.py install for psutil 03:58:08 INFO - building 'psutil._psutil_linux' extension 03:58:08 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 03:58:08 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 03:58:08 INFO - building 'psutil._psutil_posix' extension 03:58:08 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 03:58:09 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 03:58:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:09 INFO - Successfully installed psutil 03:58:09 INFO - Cleaning up... 03:58:09 INFO - Return code: 0 03:58:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:09 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 0x7fb302f84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf60>, '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 0x105cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', '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 03:58:09 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 03:58:09 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 03:58:09 INFO - Using env: {'DISPLAY': ':0', 03:58:09 INFO - 'HOME': '/home/cltbld', 03:58:09 INFO - 'LANG': 'en_US.UTF-8', 03:58:09 INFO - 'LANGUAGE': 'en_US:en', 03:58:09 INFO - 'LOGNAME': 'cltbld', 03:58:09 INFO - 'MAIL': '/var/mail/cltbld', 03:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:09 INFO - 'MOZ_NO_REMOTE': '1', 03:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:09 INFO - 'NO_EM_RESTART': '1', 03:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:09 INFO - 'PWD': '/builds/slave/test', 03:58:09 INFO - 'SHELL': '/bin/bash', 03:58:09 INFO - 'SHLVL': '1', 03:58:09 INFO - 'TERM': 'linux', 03:58:09 INFO - 'TMOUT': '86400', 03:58:09 INFO - 'USER': 'cltbld', 03:58:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', 03:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:09 INFO - '_': '/tools/buildbot/bin/python'} 03:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:58:09 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 03:58:09 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 03:58:09 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 03:58:09 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 03:58:09 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 03:58:09 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 03:58:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:58:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:58:11 INFO - Installing collected packages: mozsystemmonitor 03:58:11 INFO - Running setup.py install for mozsystemmonitor 03:58:11 INFO - Successfully installed mozsystemmonitor 03:58:11 INFO - Cleaning up... 03:58:11 INFO - Return code: 0 03:58:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb302f84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf60>, '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 0x105cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', '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 03:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:58:11 INFO - Using env: {'DISPLAY': ':0', 03:58:11 INFO - 'HOME': '/home/cltbld', 03:58:11 INFO - 'LANG': 'en_US.UTF-8', 03:58:11 INFO - 'LANGUAGE': 'en_US:en', 03:58:11 INFO - 'LOGNAME': 'cltbld', 03:58:11 INFO - 'MAIL': '/var/mail/cltbld', 03:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:11 INFO - 'MOZ_NO_REMOTE': '1', 03:58:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:11 INFO - 'NO_EM_RESTART': '1', 03:58:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:11 INFO - 'PWD': '/builds/slave/test', 03:58:11 INFO - 'SHELL': '/bin/bash', 03:58:11 INFO - 'SHLVL': '1', 03:58:11 INFO - 'TERM': 'linux', 03:58:11 INFO - 'TMOUT': '86400', 03:58:11 INFO - 'USER': 'cltbld', 03:58:11 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', 03:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:11 INFO - '_': '/tools/buildbot/bin/python'} 03:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:11 INFO - Downloading/unpacking jsonschema==2.5.1 03:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:58:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:13 INFO - Downloading functools32-3.2.3-2.tar.gz 03:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:58:13 INFO - warning: no files found matching '*.txt' 03:58:13 INFO - no previously-included directories found matching 'build' 03:58:13 INFO - no previously-included directories found matching 'dist' 03:58:13 INFO - no previously-included directories found matching '.git*' 03:58:13 INFO - Installing collected packages: jsonschema, functools32 03:58:14 INFO - Running setup.py install for functools32 03:58:14 INFO - warning: no files found matching '*.txt' 03:58:14 INFO - no previously-included directories found matching 'build' 03:58:14 INFO - no previously-included directories found matching 'dist' 03:58:14 INFO - no previously-included directories found matching '.git*' 03:58:14 INFO - Successfully installed jsonschema functools32 03:58:14 INFO - Cleaning up... 03:58:14 INFO - Return code: 0 03:58:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb302f84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf60>, '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 0x105cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', '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 03:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:58:14 INFO - Using env: {'DISPLAY': ':0', 03:58:14 INFO - 'HOME': '/home/cltbld', 03:58:14 INFO - 'LANG': 'en_US.UTF-8', 03:58:14 INFO - 'LANGUAGE': 'en_US:en', 03:58:14 INFO - 'LOGNAME': 'cltbld', 03:58:14 INFO - 'MAIL': '/var/mail/cltbld', 03:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:14 INFO - 'MOZ_NO_REMOTE': '1', 03:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:14 INFO - 'NO_EM_RESTART': '1', 03:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:14 INFO - 'PWD': '/builds/slave/test', 03:58:14 INFO - 'SHELL': '/bin/bash', 03:58:14 INFO - 'SHLVL': '1', 03:58:14 INFO - 'TERM': 'linux', 03:58:14 INFO - 'TMOUT': '86400', 03:58:14 INFO - 'USER': 'cltbld', 03:58:14 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', 03:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:14 INFO - '_': '/tools/buildbot/bin/python'} 03:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:58:14 INFO - Cleaning up... 03:58:14 INFO - Return code: 0 03:58:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb302f84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf60>, '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 0x105cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', '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 03:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:58:14 INFO - Using env: {'DISPLAY': ':0', 03:58:14 INFO - 'HOME': '/home/cltbld', 03:58:14 INFO - 'LANG': 'en_US.UTF-8', 03:58:14 INFO - 'LANGUAGE': 'en_US:en', 03:58:14 INFO - 'LOGNAME': 'cltbld', 03:58:14 INFO - 'MAIL': '/var/mail/cltbld', 03:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:14 INFO - 'MOZ_NO_REMOTE': '1', 03:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:14 INFO - 'NO_EM_RESTART': '1', 03:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:14 INFO - 'PWD': '/builds/slave/test', 03:58:14 INFO - 'SHELL': '/bin/bash', 03:58:14 INFO - 'SHLVL': '1', 03:58:14 INFO - 'TERM': 'linux', 03:58:14 INFO - 'TMOUT': '86400', 03:58:14 INFO - 'USER': 'cltbld', 03:58:14 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', 03:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:14 INFO - '_': '/tools/buildbot/bin/python'} 03:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:14 INFO - Downloading/unpacking blobuploader==1.2.4 03:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:16 INFO - Downloading blobuploader-1.2.4.tar.gz 03:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:58:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:58:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:17 INFO - Downloading docopt-0.6.1.tar.gz 03:58:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:58:17 INFO - Installing collected packages: blobuploader, requests, docopt 03:58:17 INFO - Running setup.py install for blobuploader 03:58:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:58:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:58:17 INFO - Running setup.py install for requests 03:58:17 INFO - Running setup.py install for docopt 03:58:17 INFO - Successfully installed blobuploader requests docopt 03:58:17 INFO - Cleaning up... 03:58:17 INFO - Return code: 0 03:58:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:17 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 0x7fb302f84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf60>, '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 0x105cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', '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 03:58:17 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 03:58:17 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 03:58:17 INFO - Using env: {'DISPLAY': ':0', 03:58:17 INFO - 'HOME': '/home/cltbld', 03:58:17 INFO - 'LANG': 'en_US.UTF-8', 03:58:17 INFO - 'LANGUAGE': 'en_US:en', 03:58:17 INFO - 'LOGNAME': 'cltbld', 03:58:17 INFO - 'MAIL': '/var/mail/cltbld', 03:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:17 INFO - 'MOZ_NO_REMOTE': '1', 03:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:17 INFO - 'NO_EM_RESTART': '1', 03:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:17 INFO - 'PWD': '/builds/slave/test', 03:58:17 INFO - 'SHELL': '/bin/bash', 03:58:17 INFO - 'SHLVL': '1', 03:58:17 INFO - 'TERM': 'linux', 03:58:17 INFO - 'TMOUT': '86400', 03:58:17 INFO - 'USER': 'cltbld', 03:58:17 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', 03:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:17 INFO - '_': '/tools/buildbot/bin/python'} 03:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:58:18 INFO - Running setup.py (path:/tmp/pip-fz_dfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:58:18 INFO - Running setup.py (path:/tmp/pip-nkgp5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:58:18 INFO - Running setup.py (path:/tmp/pip-7T8ys5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:58:18 INFO - Running setup.py (path:/tmp/pip-Om6Yhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:58:18 INFO - Running setup.py (path:/tmp/pip-ahRKIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:58:18 INFO - Running setup.py (path:/tmp/pip-T6dkgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:58:18 INFO - Running setup.py (path:/tmp/pip-yIgByP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:58:18 INFO - Running setup.py (path:/tmp/pip-xt1S0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:58:18 INFO - Running setup.py (path:/tmp/pip-zCxanh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:58:18 INFO - Running setup.py (path:/tmp/pip-WhLzIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:58:18 INFO - Running setup.py (path:/tmp/pip-6j68ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:58:18 INFO - Running setup.py (path:/tmp/pip-XxSM8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:58:18 INFO - Running setup.py (path:/tmp/pip-xdICjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:58:18 INFO - Running setup.py (path:/tmp/pip-1jj3bK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:19 INFO - Running setup.py (path:/tmp/pip-LGcKgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:58:19 INFO - Running setup.py (path:/tmp/pip-vhoQbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:58:19 INFO - Running setup.py (path:/tmp/pip-Fj36yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:58:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:58:19 INFO - Running setup.py install for manifestparser 03:58:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:58:19 INFO - Running setup.py install for mozcrash 03:58:19 INFO - Running setup.py install for mozdebug 03:58:19 INFO - Running setup.py install for mozdevice 03:58:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:58:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:58:19 INFO - Running setup.py install for mozfile 03:58:19 INFO - Running setup.py install for mozhttpd 03:58:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:58:19 INFO - Running setup.py install for mozinfo 03:58:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:58:19 INFO - Running setup.py install for mozInstall 03:58:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:58:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:58:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:58:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:58:20 INFO - Running setup.py install for mozleak 03:58:20 INFO - Running setup.py install for mozlog 03:58:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:58:20 INFO - Running setup.py install for moznetwork 03:58:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:58:20 INFO - Running setup.py install for mozprocess 03:58:20 INFO - Running setup.py install for mozprofile 03:58:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:58:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:58:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:58:20 INFO - Running setup.py install for mozrunner 03:58:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:58:20 INFO - Running setup.py install for mozscreenshot 03:58:20 INFO - Running setup.py install for moztest 03:58:20 INFO - Running setup.py install for mozversion 03:58:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:58:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:58:21 INFO - Cleaning up... 03:58:21 INFO - Return code: 0 03:58:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:21 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 0x7fb302f84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf60>, '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 0x105cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', '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 03:58:21 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 03:58:21 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 03:58:21 INFO - Using env: {'DISPLAY': ':0', 03:58:21 INFO - 'HOME': '/home/cltbld', 03:58:21 INFO - 'LANG': 'en_US.UTF-8', 03:58:21 INFO - 'LANGUAGE': 'en_US:en', 03:58:21 INFO - 'LOGNAME': 'cltbld', 03:58:21 INFO - 'MAIL': '/var/mail/cltbld', 03:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:21 INFO - 'MOZ_NO_REMOTE': '1', 03:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:21 INFO - 'NO_EM_RESTART': '1', 03:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:21 INFO - 'PWD': '/builds/slave/test', 03:58:21 INFO - 'SHELL': '/bin/bash', 03:58:21 INFO - 'SHLVL': '1', 03:58:21 INFO - 'TERM': 'linux', 03:58:21 INFO - 'TMOUT': '86400', 03:58:21 INFO - 'USER': 'cltbld', 03:58:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', 03:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:21 INFO - '_': '/tools/buildbot/bin/python'} 03:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:58:21 INFO - Running setup.py (path:/tmp/pip-8zv6bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:58:21 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)) 03:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:58:21 INFO - Running setup.py (path:/tmp/pip-nRXDcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:58:21 INFO - Running setup.py (path:/tmp/pip-xCMXO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:58:21 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)) 03:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:58:21 INFO - Running setup.py (path:/tmp/pip-jqXYq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:58:21 INFO - Running setup.py (path:/tmp/pip-kbtipv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:58:21 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)) 03:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:58:21 INFO - Running setup.py (path:/tmp/pip-XULjbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:58:21 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)) 03:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:58:21 INFO - Running setup.py (path:/tmp/pip-QwgJfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:58:21 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)) 03:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:58:21 INFO - Running setup.py (path:/tmp/pip-U8gLt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:58:21 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)) 03:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:58:21 INFO - Running setup.py (path:/tmp/pip-I0DrHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:58:21 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)) 03:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:58:21 INFO - Running setup.py (path:/tmp/pip-NBnLpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:58:22 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)) 03:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:58:22 INFO - Running setup.py (path:/tmp/pip-EyPyTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:58:22 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)) 03:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:58:22 INFO - Running setup.py (path:/tmp/pip-peED8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 03:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:58:22 INFO - Running setup.py (path:/tmp/pip-6nuJj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:58:22 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)) 03:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:58:22 INFO - Running setup.py (path:/tmp/pip-DCYjz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:22 INFO - Running setup.py (path:/tmp/pip-QuEngE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:22 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)) 03:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:58:22 INFO - Running setup.py (path:/tmp/pip-yT_BH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:58:22 INFO - Running setup.py (path:/tmp/pip-Rpf7KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:58:22 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)) 03:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:58:22 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)) 03:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:58:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:58:22 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 03:58:22 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 03:58:22 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 03:58:22 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 03:58:22 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 03:58:22 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 03:58:24 INFO - Downloading blessings-1.6.tar.gz 03:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:58:24 INFO - Installing collected packages: blessings 03:58:24 INFO - Running setup.py install for blessings 03:58:24 INFO - Successfully installed blessings 03:58:24 INFO - Cleaning up... 03:58:24 INFO - Return code: 0 03:58:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:58:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:58:24 INFO - Reading from file tmpfile_stdout 03:58:24 INFO - Current package versions: 03:58:24 INFO - argparse == 1.2.1 03:58:24 INFO - blessings == 1.6 03:58:24 INFO - blobuploader == 1.2.4 03:58:24 INFO - docopt == 0.6.1 03:58:24 INFO - functools32 == 3.2.3-2 03:58:24 INFO - jsonschema == 2.5.1 03:58:24 INFO - manifestparser == 1.1 03:58:24 INFO - mozInstall == 1.12 03:58:24 INFO - mozcrash == 0.17 03:58:24 INFO - mozdebug == 0.1 03:58:24 INFO - mozdevice == 0.48 03:58:24 INFO - mozfile == 1.2 03:58:24 INFO - mozhttpd == 0.7 03:58:24 INFO - mozinfo == 0.9 03:58:24 INFO - mozleak == 0.1 03:58:24 INFO - mozlog == 3.4 03:58:24 INFO - moznetwork == 0.27 03:58:24 INFO - mozprocess == 0.23 03:58:24 INFO - mozprofile == 0.28 03:58:24 INFO - mozrunner == 6.12 03:58:24 INFO - mozscreenshot == 0.1 03:58:24 INFO - mozsystemmonitor == 0.3 03:58:24 INFO - moztest == 0.7 03:58:24 INFO - mozversion == 1.4 03:58:24 INFO - psutil == 3.1.1 03:58:24 INFO - requests == 1.2.3 03:58:24 INFO - wsgiref == 0.1.2 03:58:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:24 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 0x7fb302f84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf60>, '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 0x105cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', '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 03:58:24 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 03:58:24 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 03:58:24 INFO - Using env: {'DISPLAY': ':0', 03:58:24 INFO - 'HOME': '/home/cltbld', 03:58:24 INFO - 'LANG': 'en_US.UTF-8', 03:58:24 INFO - 'LANGUAGE': 'en_US:en', 03:58:24 INFO - 'LOGNAME': 'cltbld', 03:58:24 INFO - 'MAIL': '/var/mail/cltbld', 03:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:24 INFO - 'MOZ_NO_REMOTE': '1', 03:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:24 INFO - 'NO_EM_RESTART': '1', 03:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:24 INFO - 'PWD': '/builds/slave/test', 03:58:24 INFO - 'SHELL': '/bin/bash', 03:58:24 INFO - 'SHLVL': '1', 03:58:24 INFO - 'TERM': 'linux', 03:58:24 INFO - 'TMOUT': '86400', 03:58:24 INFO - 'USER': 'cltbld', 03:58:24 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', 03:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:24 INFO - '_': '/tools/buildbot/bin/python'} 03:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:25 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)) 03:58:25 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)) 03:58:25 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)) 03:58:25 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)) 03:58:25 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)) 03:58:25 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)) 03:58:25 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)) 03:58:25 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)) 03:58:25 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)) 03:58:25 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)) 03:58:25 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)) 03:58:25 INFO - Cleaning up... 03:58:25 INFO - Return code: 0 03:58:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:58:25 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')]} 03:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:25 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')]} 03:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:25 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 0x7fb302f84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf60>, '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 0x105cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', '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 03:58:25 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 03:58:25 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 03:58:25 INFO - Using env: {'DISPLAY': ':0', 03:58:25 INFO - 'HOME': '/home/cltbld', 03:58:25 INFO - 'LANG': 'en_US.UTF-8', 03:58:25 INFO - 'LANGUAGE': 'en_US:en', 03:58:25 INFO - 'LOGNAME': 'cltbld', 03:58:25 INFO - 'MAIL': '/var/mail/cltbld', 03:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:25 INFO - 'MOZ_NO_REMOTE': '1', 03:58:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:25 INFO - 'NO_EM_RESTART': '1', 03:58:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:25 INFO - 'PWD': '/builds/slave/test', 03:58:25 INFO - 'SHELL': '/bin/bash', 03:58:25 INFO - 'SHLVL': '1', 03:58:25 INFO - 'TERM': 'linux', 03:58:25 INFO - 'TMOUT': '86400', 03:58:25 INFO - 'USER': 'cltbld', 03:58:25 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', 03:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:25 INFO - '_': '/tools/buildbot/bin/python'} 03:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:58:25 INFO - Cleaning up... 03:58:25 INFO - Return code: 0 03:58:25 INFO - Running post-action listener: _resource_record_post_action 03:58:25 INFO - Running post-action listener: _start_resource_monitoring 03:58:25 INFO - Starting resource monitoring. 03:58:25 INFO - [mozharness: 2016-09-27 10:58:25.363090Z] Finished create-virtualenv step (success) 03:58:25 INFO - [mozharness: 2016-09-27 10:58:25.363546Z] Running install step. 03:58:25 INFO - Running pre-action listener: _resource_record_pre_action 03:58:25 INFO - Running main action method: install 03:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:58:25 INFO - Reading from file tmpfile_stdout 03:58:25 INFO - Detecting whether we're running mozinstall >=1.0... 03:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:58:25 INFO - Reading from file tmpfile_stdout 03:58:25 INFO - Output received: 03:58:25 INFO - Usage: mozinstall [options] installer 03:58:25 INFO - Options: 03:58:25 INFO - -h, --help show this help message and exit 03:58:25 INFO - -d DEST, --destination=DEST 03:58:25 INFO - Directory to install application into. [default: 03:58:25 INFO - "/builds/slave/test"] 03:58:25 INFO - --app=APP Application being installed. [default: firefox] 03:58:25 INFO - mkdir: /builds/slave/test/build/application 03:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:58:41 INFO - Reading from file tmpfile_stdout 03:58:41 INFO - Output received: 03:58:41 INFO - /builds/slave/test/build/application/firefox/firefox 03:58:41 INFO - Running post-action listener: _resource_record_post_action 03:58:41 INFO - [mozharness: 2016-09-27 10:58:41.780296Z] Finished install step (success) 03:58:41 INFO - [mozharness: 2016-09-27 10:58:41.780537Z] Running run-tests step. 03:58:41 INFO - Running pre-action listener: _resource_record_pre_action 03:58:41 INFO - Running main action method: run_tests 03:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:58:41 INFO - Python 2.7.3 03:58:41 INFO - Return code: 0 03:58:41 INFO - grabbing minidump binary from tooltool 03:58: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')]} 03:58:41 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 0x105bf60>, '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 0x105cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:58:41 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 03:58:41 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 03:58:41 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 03:58:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:58:41 INFO - Return code: 0 03:58:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:58:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:58:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:58:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:58:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:58:41 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/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 03:58:41 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/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 03:58:41 INFO - Using env: {'DISPLAY': ':0', 03:58:41 INFO - 'HOME': '/home/cltbld', 03:58:41 INFO - 'LANG': 'en_US.UTF-8', 03:58:41 INFO - 'LANGUAGE': 'en_US:en', 03:58:41 INFO - 'LOGNAME': 'cltbld', 03:58:41 INFO - 'MAIL': '/var/mail/cltbld', 03:58:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:58:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:41 INFO - 'MOZ_NO_REMOTE': '1', 03:58:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:41 INFO - 'NO_EM_RESTART': '1', 03:58:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:41 INFO - 'PWD': '/builds/slave/test', 03:58:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:58:41 INFO - 'SHELL': '/bin/bash', 03:58:41 INFO - 'SHLVL': '1', 03:58:41 INFO - 'TERM': 'linux', 03:58:41 INFO - 'TMOUT': '86400', 03:58:41 INFO - 'USER': 'cltbld', 03:58:41 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399', 03:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:41 INFO - '_': '/tools/buildbot/bin/python'} 03:58:41 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/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 03:58:42 INFO - mozversion application_buildid: 20160927022250 03:58:42 INFO - mozversion application_changeset: 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd 03:58:42 INFO - mozversion application_display_name: Nightly 03:58:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:58:42 INFO - mozversion application_name: Firefox 03:58:42 INFO - mozversion application_remotingname: firefox 03:58:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:58:42 INFO - mozversion application_vendor: Mozilla 03:58:42 INFO - mozversion application_version: 52.0a1 03:58:42 INFO - mozversion platform_buildid: 20160927022250 03:58:42 INFO - mozversion platform_changeset: 66a77b9bfe5dcacd50eccf85de7c0e7e15ce0ffd 03:58:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:58:42 INFO - mozversion platform_version: 52.0a1 03:58:42 INFO - using testdate: 1474973922 03:58:42 INFO - actual date: 1474973922 03:58:42 INFO - starting webserver on 'localhost:51398' 03:58:42 INFO - SUITE-START | Running 2 tests 03:58:42 INFO - TEST-START | dromaeo_css 03:58:42 INFO - operating with platform_type : linux_ 03:58:42 INFO - Initialising browser for dromaeo_css test... 03:58:42 INFO - TEST-INFO | started process 6778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe0XrV7/profile http://localhost:51398/getInfo.html) 03:58:46 INFO - PROCESS | 6778 | __metrics Screen width/height:1600/1200 03:58:46 INFO - PROCESS | 6778 | colorDepth:24 03:58:46 INFO - PROCESS | 6778 | Browser inner width/height: 1024/697 03:58:46 INFO - PROCESS | 6778 | __metrics 03:58:47 ERROR - PROCESS | 6778 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 03:58:48 INFO - TEST-INFO | 6778: exit 0 03:58:48 INFO - Browser initialized. 03:58:48 INFO - Running cycle 1/1 for dromaeo_css test... 03:58:48 INFO - TEST-INFO | started process 6899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe0XrV7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:00 INFO - PROCESS | 6899 | RSS: Main: 186466304 03:59:00 INFO - PROCESS | 6899 | 03:59:50 INFO - PROCESS | 6899 | 1474973990405 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:02:03 INFO - PROCESS | 6899 | Cycle 1(1): loaded http://localhost:51398/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51398/tests/dromaeo/cssquery-ext.html) 04:02:04 INFO - PROCESS | 6899 | RSS: Main: 198467584 04:02:04 INFO - PROCESS | 6899 | 04:05:06 INFO - PROCESS | 6899 | Cycle 1(1): loaded http://localhost:51398/tests/dromaeo/cssquery-ext.html (next: http://localhost:51398/tests/dromaeo/cssquery-jquery.html) 04:05:07 INFO - PROCESS | 6899 | RSS: Main: 196587520 04:05:07 INFO - PROCESS | 6899 | 04:08:09 INFO - PROCESS | 6899 | Cycle 1(1): loaded http://localhost:51398/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51398/tests/dromaeo/cssquery-mootools.html) 04:08:10 INFO - PROCESS | 6899 | RSS: Main: 198647808 04:08:10 INFO - PROCESS | 6899 | 04:11:12 INFO - PROCESS | 6899 | Cycle 1(1): loaded http://localhost:51398/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51398/tests/dromaeo/cssquery-prototype.html) 04:11:12 INFO - PROCESS | 6899 | RSS: Main: 195182592 04:11:12 INFO - PROCESS | 6899 | 04:14:15 INFO - PROCESS | 6899 | Cycle 1(1): loaded http://localhost:51398/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51398/tests/dromaeo/cssquery-yui.html) 04:14:16 INFO - PROCESS | 6899 | RSS: Main: 198688768 04:14:16 INFO - PROCESS | 6899 | 04:17:19 INFO - PROCESS | 6899 | Cycle 1(1): loaded http://localhost:51398/tests/dromaeo/cssquery-yui.html (next: http://localhost:51398/tests/dromaeo/cssquery-dojo.html) 04:17:19 INFO - PROCESS | 6899 | RSS: Main: 199712768 04:17:19 INFO - PROCESS | 6899 | 04:17:19 INFO - PROCESS | 6899 | __start_tp_report 04:17:19 INFO - PROCESS | 6899 | _x_x_mozilla_page_load 04:17:19 INFO - PROCESS | 6899 | _x_x_mozilla_page_load_details 04:17:19 INFO - PROCESS | 6899 | |i|pagename|runs| 04:17:19 INFO - PROCESS | 6899 | |0;dojo.html;2647.8278911870725;2675.638788763517;2681.343070947617;2683.3157544826076;2686.9596956045675;4686.461056978448;4800.615950723943;4824.348712923755;4896.265560165977;4900.485449027849;4766.070616229837;4844.878878028051;4867.3915760529935;4874.8781280468;4901.681390709601;4318.2227199104145;4435.84474543391;4443.244648409762;4518.141553104916;4554.38515800366;4535.365048893158;4539.773011349436;4547.18150732868;4550.089982003596;4580.175568397687;4378.934315985262;4382.189294980439;4386.078923426085;4410.184115938561;4444.533324000998;4380.299152135643;4420.80106395213;4427.53510881356;4444.177827101997;4456.9331460028125;4360.193364227596;4368.082702632451;4370.475542934868;4379.189849877783;4432.689711720181;4727.692699974525;4771.475137734847;4829.154897892855;4836.250381190921;4862.659613827033;5248.947510524884;5256.526912577848;5263.0526505229045;5265.631405801595;5270.4729527047375;5275.261463395128;5276.498732620395;5291.100512912775;5294.470552944713;5360.517553420172;4740.454847692559;4750.548697873696;4803.807847686124;4893.779779909913;4896.510348965075;5183.922241166386;5256.421793602701;5266.34170728659;5330.200469929464;5334.91997620036;5017.322661440732;5022.59819214462;5027.245913113063;5027.271045698426;5082.949170508322;4987.650864439454;5050.141475949097;5102.132637451642;5110;5125.308083408767;5124.692518448905;5171.741412929338;5189.766460509286;5239.685618862881;5254.65844720092;5164.1995490699;5165.405978312467;5168.483151684802;5174.301469301671;5179.404368497596;4274.871753847389;4305.332673435622;4438.755868427267;4459.643228541709;4511.210538155875;3814.3706288462095;3851.557070936878;3869.3228684980018;3876.7480113792512;3973.5033120859894;4407.338899165151;4473.396091527602;4475.552444755564;4479.10417916418;4519.615832654195;5097.643164978416;5252.65857719247;5269.077911365573;5293.206019097166;5297.3643162819935;4356.6732495063;4369.431973843443;4384.838017925253;4404.273294906305;4446.82212711488;4671.906561868744;4673.906521869543;4686.6485013624115;4694.6713730039255;4738.620910327166;4864.051509955595;4873.926891096637;4875.366202393666;4883.902321953612;4931.0630980113665;5065.189569668835;5080.542751152414;5136.383633963948;5179.223116532399;5182.792688292426;4865.318855360323;4871.902561948812;4881.560659540658;4924.236743304794;4929.112759703288;5106.66806657566;5114.437411884615;5117.565006974449;5125.308083408692;5129.846104616868;5085.847424577269;5136.075506408883;5176.301199338041;5181.455947125498;5198.4750611016525;5112.054269960069;5112.897742045213;5114.360704911886;5142.76857541404;5172.793088276578;4957.429895561912;5094.15946368845;5099.581756622276;5110.105731496898;5124.5131712487255;4892.0705066037335;4949.109160351171;4954.479779623088;5043.672161309503;5108.974455127701;5110.8466745997675;5134.820281290137;5147.305113809737;5151.5106064923775;5158.174692049254;5010.3737032870895;5018.347614810052;5022.899542009066;5033.974830125826;5086.440491545853 04:17:19 INFO - PROCESS | 6899 | |1;ext.html;537.4061661863641;543.017138978449;547.9260299859518;549.5466240351708;552.4034043233308;38191;39900.201995960066;39969.400458993136;39988.80005599975;39995.60004399955;39421;39929.20141597174;39930.201395972064;40068;40101.398479022835;7619.923800762004;7835.412344074189;7835.608219589027;7835.647395867171;7836.216378362146;7738.883916741253;7820.491668041587;7828;7834.921650783476;7838.882416763753;7761.22387761225;7810.570418626973;7826.686932522693;7829.099653539859;7842.686292548291;7713.074431068279;7743.883841742322;7752.0697516298405;7755.340796032344;7757.49576277543;7716.537007779495;7717.729879454192;7746.573938433384;7747.070351557849;7757.5733334666575;35935.28129437396;35951;35977.28045439076;36042.45936310958;36152.457713134325;2898.4203159368;3068.0642404066753;3077.461444247248;3453.723702103826;3504.0714210734177;28008.719912801018;28197.57703634447;28575.28561785972;29156.708432915613;29877.850610746806;3479.460683594047;3553.218291975761;3553.875614353511;3574.4817001534893;3599.8560057597665;248785.7560712203;249421;249478;250217;250569;49428.752856235486;49613.75193124011;49630.50369496259;49759;49813.765829904136;32020.359592808014;32769.180770480925;32888.67111328856;34623.13442163966;53672.46327536675;14394.424223030961;14485.85514144845;14532.346044428026;14551.05418147817;14559.563213103624;10787;10867.673969780919;10897.128229741602;10959.83560246597;10964.835527467094;17615.735763963552;17625.383111591033;17642.470725878244;17747.290108395777;17753.556161096076;6617;6723.294054124344;6724.529282950244;6890.827729306808;7059.89410158848;771.2326235395817;809.663989444374;864.1747131489412;891.1712107739864;898.7213963671152;26046;28092.719072809417;28271;28391.29021774472;28506.144815655563;873.7946582553222;924.473050361301;979.3389462113046;987.116530705015;1021.4331046269243;13580.38888250031;14434.350454229585;14469.119014528254;14523.78214326786;14738.852611473962;359662;362676;363793;365010;365137;47674.76162619234;48155.27767083496;48680.513194868305;48765.512344876806;49009.509904901206;1139.4018140476317;1150.442035612727;1174.5830230268302;1188.174218917861;1191.8152686333633;25532.744672553035;25981.350466238495;26508.469830603666;26597.7340226603;26618.06836760704;40567.18865622612;40749.79625101855;40888;40912.79543602263;40965.79517102396;251571;251727;251761;251910;251991;24738;24797.25608231756;24821.87589062043;24873.378165545284;25127.120550780633;40946.59053409428;41028;41145.794271028455;41353.172936541705;42502.57497424986;35098.64901350954;35602.8219858899;35638.287234254654;35778;36022.819885900404;34808;34926.82536587301;35014.82492587623;35027.82486087553;35334.823325883204;34113.14717132092;34379.312413752086;34613.480797787546;35325.82337088298;35421;29599.704002959694;32497.675023249463;32721.181970449976;32768.672313277515;32843.671563284064;24620.630690540016;24958.12646557362;25212.49575008526;25283.367915802253;25510 04:17:19 INFO - PROCESS | 6899 | |2;jquery.html;350.28017424193274;355.4934218738298;357.1535460957531;368.7916327275091;372.5027088836403;15272.847271527282;15274.618134546641;16821.327146914107;16902.408415705453;17105.914470427662;12662.366881655904;15210.467633632825;16005.599860003505;16084.034957902533;16892.83107168928;4998.675086119409;5261.053010458116;5262.342207224097;5262.7631756571045;5266.552343050846;5011.018444025799;5124.180131179012;5170.689758614495;5191.039657663326;5204.089284375238;5150.793968241266;5156.92264616031;5160.587153027749;5161.406438259592;5170.896582068356;4952.975235123801;5068.493150684939;5150;5171.01750667372;5181.9740901295445;4574.771261436915;4580.335851301543;4582.725036497821;4588.357629931812;4600.102979918917;19372.80627193738;20035.799642003538;20120.79879201204;20130.79869201304;20158.69761953572;2145.914163433461;2208.0111045012923;2208.580369729746;2448.9755102448926;2553.170219678593;12768.233905965672;13126.212427254395;13190.472381104744;13251.13867598603;13482.52811151605;1734.332282071399;1754.1930711872553;1807.8011418743927;1922.7404300419405;1983.107601579295;60235.69882150561;67712;69143.65428172828;69404.6529767348;70229.64885175592;8658.220760131493;8785.604647790864;8820.426672266281;9950.452725100044;10148.594056237667;13586.864131358758;13603.387847546885;13606;13615.18308901469;13615.251161186032;6435.549511534241;6928.515003949675;6961.512694111364;6998.230194678581;7095.89356159658;6740.696668649923;6750.662466876636;6864.725410983605;7001.334873187039;7003.159620845531;4155.272827255279;4156.750594964312;4222.451081359403;4345.978270108692;4352.303631418958;1757.9033153176697;1763.5679258581729;1786.6873297172942;1816.0083677840473;1856.3688345962437;785.3795501553823;822.4037572759702;842.4608250719544;857.5797859049021;916.326500022483;15566.610834728996;16331;16347.918260408622;16538.334781436355;16685.49943501697;776.1346099099463;779.9571023593643;833.5290560833109;839.9496030238205;890.955452227386;8464.66141354339;9215.170634642915;9254.213391861767;9295.442273463614;9572.138507534355;363845;381463;383493;387358;387412;68931.3106868935;78472.60763696145;83982.58008710039;84435.57782211172;85118;868.7393781865416;873.6505397841041;902.4134312696799;907.5054095517959;907.8229745199623;14623.905306514192;14668.193249371387;14747.92626036863;14936.551903442914;15044.849551504783;36369.27261454703;37228.6277137236;37430.43854342242;37958;38045.80977095207;46761.298580522;46875.29687054765;52836.41490755283;54353.456465434836;55304.17043744428;4875.7074575525585;6525;7124.964375178091;7477.364424023801;7591.316781489692;10054.89945100569;10907.454627268764;11389.772204555697;11422.48598813072;11524.962753352238;9911.355761875455;9995.60017599317;10252.974702529687;10545.52545135486;10881.020708136306;10085.142762865238;10146.188304935735;10186.694399168036;10349.120324772479;10412.791744165226;9788.657396991071;10053.899461005296;10075.546600402853;10221.693349199535;10330.793384132425;7304.561726296439;7445.739399121005;7567.772966811004;7738.961305193438;7756.573388463688;9201.401908875901;10042.246831487522;10063.496825158567;10086.899131008597;10306.33008854422 04:17:19 INFO - PROCESS | 6899 | |3;mootools.html;1378.262629493221;1396.7346204221199;1494.7683109118084;1670.0397271568852;1717.5534361066118;7088.539244949075;7333.046703928482;7492.625368731562;8111.634976426068;8113;7547.207543207953;7878.4485086044;7884.250996155371;7937.841243175133;8114.14801445847;2087.780783017788;2133.658614621661;2152.870827750332;2157.1155826111217;2165.9241926532573;2084.3538503064096;2114.0381126587445;2168.1219106261988;2169.663702126173;2171.4679903423685;2151.225558798839;2162.686410470481;2174.8042676159143;2175.869447833127;2189.8576592521513;2062.412212519432;2071.7513898332145;2072.512959454527;2079.5321052763156;2083.2916808285104;2079.2306846466754;2106.6313395155785;2119.2688522459725;2120.522882351474;2125.2242931330106;7820.921790782077;7933.404994625368;7936.484128531627;7943.721969731032;7952.721654742057;4523.615492683126;4634.930476042862;4681.906361872743;4688.695234809727;4692.36653051837;2822.7741780657498;2941.544060670578;2952.630921134858;2970.762339012874;2973.628296462942;857.7169534053747;904.1004200820227;914.5701520285455;914.8947870994854;915.1443400420628;10825.512851921683;10862.78274434507;10874.565017399294;10886.61896833607;10914.23600347976;3977.3238549446664;4147.875563733093;4167.937480937789;4193.475815523059;4239.660827133822;9229.723108306762;9237;9250.629974801068;9252.259819214582;9259.398139120936;4672.532746725368;4683.906321873544;4687.601553867959;4690.7654617269;4706.529347065334;3567.0547304964207;3674.467202255658;4038.374052021941;4293.2057569349145;4299.548547402478;3534.0104770664257;3599.8200089995394;3709.5177626908867;3734.047817806442;3752.3058234226755;1163.7497937943383;1178.5639313454076;1185.0637995983077;1187.0444292344746;1191.9165658404002;813;839.7690635075281;843.5950743643085;863.9006514250816;872.7076429396096;5292.285541451932;5453.23654688344;5463.235147079412;5486.61593688438;5571.470710282517;888.2228050455851;922.6263363337858;957.818014577228;963.8216929867997;968.941863488193;3444.621091679913;3573.338932297533;3650.361186792301;3676.3015027145293;3678.3746763050344;9466.1953733932;9758.512074396253;9856.50717464124;9965;10007.649732259337;9552.856707149398;9865.309428340091;9866.457344846101;9883.654072107442;9890.653827116017;7297.635118244067;7338.889916651255;7430.7399241026305;7459.918311844752;7459.962700186573;4966.751662416937;5009.173486374707;5150;5219.791208351775;5319.4414586467865;8709.695160669346;8916.108389161032;8997.640094396413;9083.45499270046;9094.545272736204;9139.177474027369;9157.816843663222;9228.492432916253;9305.11601397866;9308.348415610842;6188.350223226496;6388.488920886411;6655.401013908771;6897.068895699016;6900.102986611709;7283.453740969342;7533.886991695239;7574.394048476219;7740.032495938008;7740.612969351622;6280.27776805655;6345.96827015862;6483.319251478527;6549.705263263069;6632.933670663231;6853;6854.9657251713425;6886.173659160932;6937.445004399737;6944.479164062816;6286.591371560834;6382.5532212744665;6386;6386.872262554816;6394.616323020447;4430.712003719748;4468.3074123510905;4499.392582001388;4504.256797628354;4524.5249248828395;4510.3234514821725;4540.931886021646;4611.33135695329;4687.882802929817;4802.375691160127 04:17:19 INFO - PROCESS | 6899 | |4;prototype.html;288.5210550486192;288.9855507224638;296.3746494895768;300.5461752753342;300.90521485731995;4917;5000.999600159933;5004.42272229802;5021.447640759514;5044.924326135111;4932.432770231425;4946.5795407390415;4950.480199579047;4951.529604687558;5017.899642007167;3892.8637497687587;3905.3556163233034;3909.4135879618143;3909.4526766252748;3913.217356528691;3773.735838491307;3774.5470543534816;3911.7261791674596;3917.1773927475265;3918.7648741075486;3838.6737127344068;3854.3062248795204;3860.7104467164936;3873.903152421198;3879.689624830007;3851.826667799942;3860.7297489175767;3869.671077958377;3878.728489005771;3948.3287841067086;3173.7778355515125;3264.5103234514777;3272.5745653065187;3428.4171690812623;3441.2601290722364;4787.180871268895;4796.529787159616;4800.3279540864305;4809.519048095198;4821.879453013667;4375.5779371704;4381.539938306464;4384.802683879201;4385.846495372647;4429.693240494062;4834.468208497063;5092.337996060525;5158.458361871987;5170.922436163461;5173.741312934339;3619.438986957026;3638.854445822164;3640.8179591020344;3642.7085833133287;3649.8540058397634;5369.7583608737705;5389.844062375042;5392.272043274147;5407.675539467645;5499.807506737245;3690.4833323334756;3693.353663108945;3700.1859590889962;3703;3714.1643130296006;3481.7562770606323;3701.8149092545264;3753.5683396409217;3774.3206222879594;3782.71629627779;4327.437433133672;4328.372386004012;4334.609885110355;4347.956520434818;4414.3157810539415;5208.609354298443;5216.66091704038;5217;5218.112920803473;5221.817236396784;1279.0598909801288;1297.4874924404996;1300.5318085489216;1302.6482849630736;1310.88202061813;782.7025730222479;807.6688557691318;812.2770734046703;814.1451475950229;827.1108558299852;3993.3810259409256;3996.620321069552;4015.3976903464713;4062.532808727034;4093.97953010239;4679.67242293043;4702.388689470347;4717.669763116617;4725.480197178307;4729;3961.3859851723028;4063.4514340564238;4074.103697186614;4078.9592104079175;4097.13960068383;2421.9031238750604;2498.3629174560733;2522.407234299938;2522.93692657685;2547.2230969554093;4781.713097214179;4871.318015477836;4963.6277279204205;5017.9247311290355;5035.874103147377;5471.972640136773;5486.451354864562;5499.312585926759;5499.312585926759;5505.174223866372;4827.155247831685;5014.445521888227;5021.271915572294;5024.2463630454995;5048;5322.973385133049;5353.625246232727;5360.758765855624;5365.973170134124;5370.516653501204;5216.791328346975;5244.842654720364;5253.789848406173;5256.6320357574605;5259.5003474671375;4821.975890120527;4934.679245849008;4976.765102683285;4990.650654454299;5015.548600625962;3667.0465678923138;3667.431548110047;3691.630836916287;3704.407294832814;3709.4806727057694;5331.840044798662;5338.1992701093595;5357.383900851296;5366.946330536644;5374.328208973879;4901.754912254301;5201.817936372209;5204.531592156724;5205.349331333583;5272.2882410874045;5214.722393013736;5216.504432078947;5276.34045744282;5278.4721527846905;5297.470252974672;5142.460041695717;5152.793888244429;5169.741512924414;5184.870378240424;5202.297689811827;4993.900121997613;5255.264263003106;5281.788728450819;5292.761825717775;5309.203619456958;5150.227465880148;5170.948290517047;5171.767270472913;5179.300794392709;5188.636795424284 04:17:19 INFO - PROCESS | 6899 | |5;yui.html;611.4985711716389;622.3394986432999;672.8116127484307;726.0575077330095;734.9206823409913;11367.090632749381;11972.102092343066;11988.460519276632;11995;12058.517659293619;12445.06662000349;12536.310502922335;13236.205827650323;13266.668333291673;13700.109492882955;750.6021808441535;769.7998520384684;776.243162916155;777;780.7696729464793;719.1262615921654;769.157772239397;779.1195948578098;780.5082797837355;782.3936449251819;820.1675299570941;821.2280456370992;822.2722890242119;824.8020475085996;826.1119296756011;819.6516480495766;819.7049062337584;820.4871955028108;821;824.6289169873521;599.3886236039259;601.636010213823;601.7412512619571;604.1451346344917;604.7157835817159;13002.089853710244;13009.804852927213;13056.608301750963;13061.673458163526;13066.869331306756;13060;13387.598372048855;13400.664983375396;13498.59504214875;13541;10517.579296828118;10519.947400263027;10541.525631346607;10630.211866097468;10735.248532602722;3138.7018233267804;3168.1604374840686;3174.1747145742274;3229.3702727968057;3259.41330560499;66740.6662966682;67335;67834.66082669554;67900.6604966972;69395.65302173507;9901.851472227921;10249.180065594883;10287.331323463952;10379.481025948673;10464;18681.15934782938;18718.251269949324;18725.157367918204;18765.155567999474;18793.060346982595;6672;6690.130283063268;6736.292689267654;6825.35159159879;6851.314868513109;3549.4498352755363;3580.104973756561;3679.889603311905;3696.907577310535;3813.599572044951;2965.4876013232974;3087.8729263818545;3116.67274936133;3220.0822765512185;3389.3899098162074;558.2993343354145;559.5495626021011;562.6314763829698;567.3050513121393;579.9942000580024;524.4414698346325;579.6637949988997;617.7405489694339;619.1486705779553;631.8894193516209;7553.848923021509;7594.658240379196;7879.606019699107;8125.9187408126345;8570.700025499078;581.5667327840786;596.785157343356;597.6503745309043;611.9663418512025;612.7732738886551;3591.5331006968927;3598.226381328027;3627.782333060025;3691.077230692327;3739.121306492972;69613.65193174002;71050;72481.27518724745;85507.14492855116;106396;75353;76042.19789010528;76257.23742762613;76360;76752;54002.45997540053;68611.65694171598;68726.65636671784;69929.30070699228;72810.2718972814;8257.669693212205;9021.548922553715;9090.909090909154;9132.680356187502;9243.39917905334;35434.64565354417;42061.15877682368;43055.569444305154;43546;43886.34170487381;53610.463895360546;63078.36921630725;63156.368436315046;63253.36746632475;63260;11005.56927599407;11044.834327485254;11049;11205.60780372683;11398.373089479826;12625.179363341353;12684.556040538537;12749.426275817796;12990;13621.25083120438;11744;11908.464119114833;12037.337946413032;12094.720210533562;12496.375181241083;11626.988688902315;12144.089193310361;12867.935660321638;12880.098393112767;12914.28971406544;8928.687495937871;10420.791584168122;11929.105317101079;11987.22083064598;12405.875941240833;9714.125728684452;9754.85367719499;9853.556589953612;9931.205503559553;10148.949255253676;10041.548130334299;10420;10424.843627345444;10433.634822781167;10468.63359782404 04:17:19 INFO - PROCESS | 6899 | __end_tp_report 04:17:19 INFO - PROCESS | 6899 | __start_cc_report 04:17:19 INFO - PROCESS | 6899 | _x_x_mozilla_cycle_collect,338 04:17:19 INFO - PROCESS | 6899 | __end_cc_report 04:17:19 INFO - PROCESS | 6899 | __startTimestamp1474975039750__endTimestamp 04:17:19 INFO - PROCESS | 6899 | 04:17:19 INFO - PROCESS | 6899 | ------- Summary: start ------- 04:17:19 INFO - PROCESS | 6899 | Number of tests: 6 04:17:19 INFO - PROCESS | 6899 | 04:17:19 INFO - PROCESS | 6899 | [#0] dojo.html Cycles:165 Average:4791.65 Median:4901.68 stddev:511.90 (10.4%) stddev-sans-first:485.06 04:17:19 INFO - PROCESS | 6899 | Values: 2647.8 2675.6 2681.3 2683.3 2687.0 4686.5 4800.6 4824.3 4896.3 4900.5 4766.1 4844.9 4867.4 4874.9 4901.7 4318.2 4435.8 4443.2 4518.1 4554.4 4535.4 4539.8 4547.2 4550.1 4580.2 4378.9 4382.2 4386.1 4410.2 4444.5 4380.3 4420.8 4427.5 4444.2 4456.9 4360.2 4368.1 4370.5 4379.2 4432.7 4727.7 4771.5 4829.2 4836.3 4862.7 5248.9 5256.5 5263.1 5265.6 5270.5 5275.3 5276.5 5291.1 5294.5 5360.5 4740.5 4750.5 4803.8 4893.8 4896.5 5183.9 5256.4 5266.3 5330.2 5334.9 5017.3 5022.6 5027.2 5027.3 5082.9 4987.7 5050.1 5102.1 5110.0 5125.3 5124.7 5171.7 5189.8 5239.7 5254.7 5164.2 5165.4 5168.5 5174.3 5179.4 4274.9 4305.3 4438.8 4459.6 4511.2 3814.4 3851.6 3869.3 3876.7 3973.5 4407.3 4473.4 4475.6 4479.1 4519.6 5097.6 5252.7 5269.1 5293.2 5297.4 4356.7 4369.4 4384.8 4404.3 4446.8 4671.9 4673.9 4686.6 4694.7 4738.6 4864.1 4873.9 4875.4 4883.9 4931.1 5065.2 5080.5 5136.4 5179.2 5182.8 4865.3 4871.9 4881.6 4924.2 4929.1 5106.7 5114.4 5117.6 5125.3 5129.8 5085.8 5136.1 5176.3 5181.5 5198.5 5112.1 5112.9 5114.4 5142.8 5172.8 4957.4 5094.2 5099.6 5110.1 5124.5 4892.1 4949.1 4954.5 5043.7 5109.0 5110.8 5134.8 5147.3 5151.5 5158.2 5010.4 5018.3 5022.9 5034.0 5086.4 04:17:19 INFO - PROCESS | 6899 | 04:17:19 INFO - PROCESS | 6899 | [#1] ext.html Cycles:180 Average:43931.52 Median:19606.38 stddev:76922.63 (392.3%) stddev-sans-first:77069.42 04:17:19 INFO - PROCESS | 6899 | Values: 537.4 543.0 547.9 549.5 552.4 38191.0 39900.2 39969.4 39988.8 39995.6 39421.0 39929.2 39930.2 40068.0 40101.4 7619.9 7835.4 7835.6 7835.6 7836.2 7738.9 7820.5 7828.0 7834.9 7838.9 7761.2 7810.6 7826.7 7829.1 7842.7 7713.1 7743.9 7752.1 7755.3 7757.5 7716.5 7717.7 7746.6 7747.1 7757.6 35935.3 35951.0 35977.3 36042.5 36152.5 2898.4 3068.1 3077.5 3453.7 3504.1 28008.7 28197.6 28575.3 29156.7 29877.9 3479.5 3553.2 3553.9 3574.5 3599.9 248785.8 249421.0 249478.0 250217.0 250569.0 49428.8 49613.8 49630.5 49759.0 49813.8 32020.4 32769.2 32888.7 34623.1 53672.5 14394.4 14485.9 14532.3 14551.1 14559.6 10787.0 10867.7 10897.1 10959.8 10964.8 17615.7 17625.4 17642.5 17747.3 17753.6 6617.0 6723.3 6724.5 6890.8 7059.9 771.2 809.7 864.2 891.2 898.7 26046.0 28092.7 28271.0 28391.3 28506.1 873.8 924.5 979.3 987.1 1021.4 13580.4 14434.4 14469.1 14523.8 14738.9 359662.0 362676.0 363793.0 365010.0 365137.0 47674.8 48155.3 48680.5 48765.5 49009.5 1139.4 1150.4 1174.6 1188.2 1191.8 25532.7 25981.4 26508.5 26597.7 26618.1 40567.2 40749.8 40888.0 40912.8 40965.8 251571.0 251727.0 251761.0 251910.0 251991.0 24738.0 24797.3 24821.9 24873.4 25127.1 40946.6 41028.0 41145.8 41353.2 42502.6 35098.6 35602.8 35638.3 35778.0 36022.8 34808.0 34926.8 35014.8 35027.8 35334.8 34113.1 34379.3 34613.5 35325.8 35421.0 29599.7 32497.7 32721.2 32768.7 32843.7 24620.6 24958.1 25212.5 25283.4 25510.0 04:17:19 INFO - PROCESS | 6899 | 04:17:19 INFO - PROCESS | 6899 | [#2] jquery.html Cycles:180 Average:23966.50 Median:4349.14 stddev:63025.17 (1449.1%) stddev-sans-first:63177.03 04:17:19 INFO - PROCESS | 6899 | Values: 350.3 355.5 357.2 368.8 372.5 15272.8 15274.6 16821.3 16902.4 17105.9 12662.4 15210.5 16005.6 16084.0 16892.8 4998.7 5261.1 5262.3 5262.8 5266.6 5011.0 5124.2 5170.7 5191.0 5204.1 5150.8 5156.9 5160.6 5161.4 5170.9 4953.0 5068.5 5150.0 5171.0 5182.0 4574.8 4580.3 4582.7 4588.4 4600.1 19372.8 20035.8 20120.8 20130.8 20158.7 2145.9 2208.0 2208.6 2449.0 2553.2 12768.2 13126.2 13190.5 13251.1 13482.5 1734.3 1754.2 1807.8 1922.7 1983.1 60235.7 67712.0 69143.7 69404.7 70229.6 8658.2 8785.6 8820.4 9950.5 10148.6 13586.9 13603.4 13606.0 13615.2 13615.3 6435.5 6928.5 6961.5 6998.2 7095.9 6740.7 6750.7 6864.7 7001.3 7003.2 4155.3 4156.8 4222.5 4346.0 4352.3 1757.9 1763.6 1786.7 1816.0 1856.4 785.4 822.4 842.5 857.6 916.3 15566.6 16331.0 16347.9 16538.3 16685.5 776.1 780.0 833.5 839.9 891.0 8464.7 9215.2 9254.2 9295.4 9572.1 363845.0 381463.0 383493.0 387358.0 387412.0 68931.3 78472.6 83982.6 84435.6 85118.0 868.7 873.7 902.4 907.5 907.8 14623.9 14668.2 14747.9 14936.6 15044.8 36369.3 37228.6 37430.4 37958.0 38045.8 46761.3 46875.3 52836.4 54353.5 55304.2 4875.7 6525.0 7125.0 7477.4 7591.3 10054.9 10907.5 11389.8 11422.5 11525.0 9911.4 9995.6 10253.0 10545.5 10881.0 10085.1 10146.2 10186.7 10349.1 10412.8 9788.7 10053.9 10075.5 10221.7 10330.8 7304.6 7445.7 7567.8 7739.0 7756.6 9201.4 10042.2 10063.5 10086.9 10306.3 04:17:19 INFO - PROCESS | 6899 | 04:17:19 INFO - PROCESS | 6899 | [#3] mootools.html Cycles:180 Average:5167.78 Median:5305.86 stddev:2929.44 (55.2%) stddev-sans-first:2923.82 04:17:19 INFO - PROCESS | 6899 | Values: 1378.3 1396.7 1494.8 1670.0 1717.6 7088.5 7333.0 7492.6 8111.6 8113.0 7547.2 7878.4 7884.3 7937.8 8114.1 2087.8 2133.7 2152.9 2157.1 2165.9 2084.4 2114.0 2168.1 2169.7 2171.5 2151.2 2162.7 2174.8 2175.9 2189.9 2062.4 2071.8 2072.5 2079.5 2083.3 2079.2 2106.6 2119.3 2120.5 2125.2 7820.9 7933.4 7936.5 7943.7 7952.7 4523.6 4634.9 4681.9 4688.7 4692.4 2822.8 2941.5 2952.6 2970.8 2973.6 857.7 904.1 914.6 914.9 915.1 10825.5 10862.8 10874.6 10886.6 10914.2 3977.3 4147.9 4167.9 4193.5 4239.7 9229.7 9237.0 9250.6 9252.3 9259.4 4672.5 4683.9 4687.6 4690.8 4706.5 3567.1 3674.5 4038.4 4293.2 4299.5 3534.0 3599.8 3709.5 3734.0 3752.3 1163.7 1178.6 1185.1 1187.0 1191.9 813.0 839.8 843.6 863.9 872.7 5292.3 5453.2 5463.2 5486.6 5571.5 888.2 922.6 957.8 963.8 968.9 3444.6 3573.3 3650.4 3676.3 3678.4 9466.2 9758.5 9856.5 9965.0 10007.6 9552.9 9865.3 9866.5 9883.7 9890.7 7297.6 7338.9 7430.7 7459.9 7460.0 4966.8 5009.2 5150.0 5219.8 5319.4 8709.7 8916.1 8997.6 9083.5 9094.5 9139.2 9157.8 9228.5 9305.1 9308.3 6188.4 6388.5 6655.4 6897.1 6900.1 7283.5 7533.9 7574.4 7740.0 7740.6 6280.3 6346.0 6483.3 6549.7 6632.9 6853.0 6855.0 6886.2 6937.4 6944.5 6286.6 6382.6 6386.0 6386.9 6394.6 4430.7 4468.3 4499.4 4504.3 4524.5 4510.3 4540.9 4611.3 4687.9 4802.4 04:17:19 INFO - PROCESS | 6899 | 04:17:19 INFO - PROCESS | 6899 | [#4] prototype.html Cycles:180 Average:4243.59 Median:4821.93 stddev:1269.86 (26.3%) stddev-sans-first:1238.23 04:17:19 INFO - PROCESS | 6899 | Values: 288.5 289.0 296.4 300.5 300.9 4917.0 5001.0 5004.4 5021.4 5044.9 4932.4 4946.6 4950.5 4951.5 5017.9 3892.9 3905.4 3909.4 3909.5 3913.2 3773.7 3774.5 3911.7 3917.2 3918.8 3838.7 3854.3 3860.7 3873.9 3879.7 3851.8 3860.7 3869.7 3878.7 3948.3 3173.8 3264.5 3272.6 3428.4 3441.3 4787.2 4796.5 4800.3 4809.5 4821.9 4375.6 4381.5 4384.8 4385.8 4429.7 4834.5 5092.3 5158.5 5170.9 5173.7 3619.4 3638.9 3640.8 3642.7 3649.9 5369.8 5389.8 5392.3 5407.7 5499.8 3690.5 3693.4 3700.2 3703.0 3714.2 3481.8 3701.8 3753.6 3774.3 3782.7 4327.4 4328.4 4334.6 4348.0 4414.3 5208.6 5216.7 5217.0 5218.1 5221.8 1279.1 1297.5 1300.5 1302.6 1310.9 782.7 807.7 812.3 814.1 827.1 3993.4 3996.6 4015.4 4062.5 4094.0 4679.7 4702.4 4717.7 4725.5 4729.0 3961.4 4063.5 4074.1 4079.0 4097.1 2421.9 2498.4 2522.4 2522.9 2547.2 4781.7 4871.3 4963.6 5017.9 5035.9 5472.0 5486.5 5499.3 5499.3 5505.2 4827.2 5014.4 5021.3 5024.2 5048.0 5323.0 5353.6 5360.8 5366.0 5370.5 5216.8 5244.8 5253.8 5256.6 5259.5 4822.0 4934.7 4976.8 4990.7 5015.5 3667.0 3667.4 3691.6 3704.4 3709.5 5331.8 5338.2 5357.4 5366.9 5374.3 4901.8 5201.8 5204.5 5205.3 5272.3 5214.7 5216.5 5276.3 5278.5 5297.5 5142.5 5152.8 5169.7 5184.9 5202.3 4993.9 5255.3 5281.8 5292.8 5309.2 5150.2 5170.9 5171.8 5179.3 5188.6 04:17:19 INFO - PROCESS | 6899 | 04:17:19 INFO - PROCESS | 6899 | [#5] yui.html Cycles:180 Average:16920.01 Median:27067.45 stddev:23195.76 (85.7%) stddev-sans-first:23228.51 04:17:19 INFO - PROCESS | 6899 | Values: 611.5 622.3 672.8 726.1 734.9 11367.1 11972.1 11988.5 11995.0 12058.5 12445.1 12536.3 13236.2 13266.7 13700.1 750.6 769.8 776.2 777.0 780.8 719.1 769.2 779.1 780.5 782.4 820.2 821.2 822.3 824.8 826.1 819.7 819.7 820.5 821.0 824.6 599.4 601.6 601.7 604.1 604.7 13002.1 13009.8 13056.6 13061.7 13066.9 13060.0 13387.6 13400.7 13498.6 13541.0 10517.6 10519.9 10541.5 10630.2 10735.2 3138.7 3168.2 3174.2 3229.4 3259.4 66740.7 67335.0 67834.7 67900.7 69395.7 9901.9 10249.2 10287.3 10379.5 10464.0 18681.2 18718.3 18725.2 18765.2 18793.1 6672.0 6690.1 6736.3 6825.4 6851.3 3549.4 3580.1 3679.9 3696.9 3813.6 2965.5 3087.9 3116.7 3220.1 3389.4 558.3 559.5 562.6 567.3 580.0 524.4 579.7 617.7 619.1 631.9 7553.8 7594.7 7879.6 8125.9 8570.7 581.6 596.8 597.7 612.0 612.8 3591.5 3598.2 3627.8 3691.1 3739.1 69613.7 71050.0 72481.3 85507.1 106396.0 75353.0 76042.2 76257.2 76360.0 76752.0 54002.5 68611.7 68726.7 69929.3 72810.3 8257.7 9021.5 9090.9 9132.7 9243.4 35434.6 42061.2 43055.6 43546.0 43886.3 53610.5 63078.4 63156.4 63253.4 63260.0 11005.6 11044.8 11049.0 11205.6 11398.4 12625.2 12684.6 12749.4 12990.0 13621.3 11744.0 11908.5 12037.3 12094.7 12496.4 11627.0 12144.1 12867.9 12880.1 12914.3 8928.7 10420.8 11929.1 11987.2 12405.9 9714.1 9754.9 9853.6 9931.2 10148.9 10041.5 10420.0 10424.8 10433.6 10468.6 04:17:19 INFO - PROCESS | 6899 | -------- Summary: end -------- 04:17:19 INFO - PROCESS | 6899 | 04:17:20 INFO - TEST-INFO | 6899: exit 0 04:17:20 INFO - TEST-OK | dromaeo_css | took 1118764ms 04:17:20 INFO - TEST-START | kraken 04:17:20 INFO - operating with platform_type : linux_ 04:17:20 INFO - Initialising browser for kraken test... 04:17:20 INFO - TEST-INFO | started process 7259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdSfm8D/profile http://localhost:51398/getInfo.html) 04:17:25 INFO - PROCESS | 7259 | __metrics Screen width/height:1600/1200 04:17:25 INFO - PROCESS | 7259 | colorDepth:24 04:17:25 INFO - PROCESS | 7259 | Browser inner width/height: 1024/697 04:17:25 INFO - PROCESS | 7259 | __metrics 04:17:26 ERROR - PROCESS | 7259 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 04:17:27 INFO - TEST-INFO | 7259: exit 0 04:17:27 INFO - Browser initialized. 04:17:27 INFO - Running cycle 1/1 for kraken test... 04:17:27 INFO - TEST-INFO | started process 7377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdSfm8D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:39 INFO - PROCESS | 7377 | RSS: Main: 186339328 04:17:39 INFO - PROCESS | 7377 | 04:17:42 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51398/tests/kraken/driver.html?testName=audio-beat-detection) 04:17:43 INFO - PROCESS | 7377 | RSS: Main: 200028160 04:17:43 INFO - PROCESS | 7377 | 04:17:46 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51398/tests/kraken/driver.html?testName=audio-dft) 04:17:46 INFO - PROCESS | 7377 | RSS: Main: 197849088 04:17:46 INFO - PROCESS | 7377 | 04:17:49 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51398/tests/kraken/driver.html?testName=audio-fft) 04:17:50 INFO - PROCESS | 7377 | RSS: Main: 193826816 04:17:50 INFO - PROCESS | 7377 | 04:17:52 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51398/tests/kraken/driver.html?testName=audio-oscillator) 04:17:53 INFO - PROCESS | 7377 | RSS: Main: 194326528 04:17:53 INFO - PROCESS | 7377 | 04:17:55 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51398/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:17:55 INFO - PROCESS | 7377 | RSS: Main: 194646016 04:17:55 INFO - PROCESS | 7377 | 04:17:59 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51398/tests/kraken/driver.html?testName=imaging-darkroom) 04:17:59 INFO - PROCESS | 7377 | RSS: Main: 195682304 04:17:59 INFO - PROCESS | 7377 | 04:18:03 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51398/tests/kraken/driver.html?testName=imaging-desaturate) 04:18:03 INFO - PROCESS | 7377 | RSS: Main: 192421888 04:18:03 INFO - PROCESS | 7377 | 04:18:06 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51398/tests/kraken/driver.html?testName=json-parse-financial) 04:18:07 INFO - PROCESS | 7377 | RSS: Main: 193810432 04:18:07 INFO - PROCESS | 7377 | 04:18:09 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51398/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:18:09 INFO - PROCESS | 7377 | RSS: Main: 194101248 04:18:09 INFO - PROCESS | 7377 | 04:18:11 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:18:12 INFO - PROCESS | 7377 | RSS: Main: 194011136 04:18:12 INFO - PROCESS | 7377 | 04:18:14 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:18:15 INFO - PROCESS | 7377 | RSS: Main: 194813952 04:18:15 INFO - PROCESS | 7377 | 04:18:18 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:18:18 INFO - PROCESS | 7377 | RSS: Main: 194781184 04:18:18 INFO - PROCESS | 7377 | 04:18:21 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:18:22 INFO - PROCESS | 7377 | RSS: Main: 195276800 04:18:22 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51398/tests/kraken/driver.html?testName=ai-astar) 04:18:24 INFO - PROCESS | 7377 | RSS: Main: 196009984 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | __start_tp_report 04:18:24 INFO - PROCESS | 7377 | _x_x_mozilla_page_load 04:18:24 INFO - PROCESS | 7377 | _x_x_mozilla_page_load_details 04:18:24 INFO - PROCESS | 7377 | |i|pagename|runs| 04:18:24 INFO - PROCESS | 7377 | |0;ai-astar;106;116;117;114;115;117;115;113;115;116 04:18:24 INFO - PROCESS | 7377 | |1;audio-beat-detection;151;128;127;179;125;126;129;126;159;132 04:18:24 INFO - PROCESS | 7377 | |2;audio-dft;166;174;165;162;165;163;165;162;164;163 04:18:24 INFO - PROCESS | 7377 | |3;audio-fft;76;76;77;109;78;78;77;78;106;77 04:18:24 INFO - PROCESS | 7377 | |4;audio-oscillator;84;83;114;85;83;83;111;84;84;112 04:18:24 INFO - PROCESS | 7377 | |5;imaging-gaussian-blur;118;118;117;117;117;117;118;119;117;118 04:18:24 INFO - PROCESS | 7377 | |6;imaging-darkroom;148;147;148;148;147;147;149;149;148;147 04:18:24 INFO - PROCESS | 7377 | |7;imaging-desaturate;95;96;96;96;96;95;95;95;95;96 04:18:24 INFO - PROCESS | 7377 | |8;json-parse-financial;63;63;63;64;65;64;64;66;65;63 04:18:24 INFO - PROCESS | 7377 | |9;json-stringify-tinderbox;66;68;68;68;68;67;67;68;66;67 04:18:24 INFO - PROCESS | 7377 | |10;stanford-crypto-aes;83;90;84;83;84;83;90;83;84;91 04:18:24 INFO - PROCESS | 7377 | |11;stanford-crypto-ccm;136;137;153;144;135;135;141;137;170;145 04:18:24 INFO - PROCESS | 7377 | |12;stanford-crypto-pbkdf2;172;174;174;173;175;174;173;174;174;173 04:18:24 INFO - PROCESS | 7377 | |13;stanford-crypto-sha256-iterative;69;70;70;69;74;70;70;70;70;68 04:18:24 INFO - PROCESS | 7377 | __end_tp_report 04:18:24 INFO - PROCESS | 7377 | __start_cc_report 04:18:24 INFO - PROCESS | 7377 | _x_x_mozilla_cycle_collect,835 04:18:24 INFO - PROCESS | 7377 | __end_cc_report 04:18:24 INFO - PROCESS | 7377 | __startTimestamp1474975104329__endTimestamp 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | ------- Summary: start ------- 04:18:24 INFO - PROCESS | 7377 | Number of tests: 14 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.50 stddev:3.20 (2.8%) stddev-sans-first:1.32 04:18:24 INFO - PROCESS | 7377 | Values: 106.0 116.0 117.0 114.0 115.0 117.0 115.0 113.0 115.0 116.0 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:130.50 stddev:18.52 (14.2%) stddev-sans-first:19.05 04:18:24 INFO - PROCESS | 7377 | Values: 151.0 128.0 127.0 179.0 125.0 126.0 129.0 126.0 159.0 132.0 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:3.48 (2.1%) stddev-sans-first:3.67 04:18:24 INFO - PROCESS | 7377 | Values: 166.0 174.0 165.0 162.0 165.0 163.0 165.0 162.0 164.0 163.0 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.00 stddev:12.85 (16.7%) stddev-sans-first:13.36 04:18:24 INFO - PROCESS | 7377 | Values: 76.0 76.0 77.0 109.0 78.0 78.0 77.0 78.0 106.0 77.0 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:83.50 stddev:13.86 (16.6%) stddev-sans-first:14.37 04:18:24 INFO - PROCESS | 7377 | Values: 84.0 83.0 114.0 85.0 83.0 83.0 111.0 84.0 84.0 112.0 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 04:18:24 INFO - PROCESS | 7377 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 118.0 119.0 117.0 118.0 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 04:18:24 INFO - PROCESS | 7377 | Values: 148.0 147.0 148.0 148.0 147.0 147.0 149.0 149.0 148.0 147.0 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:18:24 INFO - PROCESS | 7377 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:1.05 (1.6%) stddev-sans-first:1.05 04:18:24 INFO - PROCESS | 7377 | Values: 63.0 63.0 63.0 64.0 65.0 64.0 64.0 66.0 65.0 63.0 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 04:18:24 INFO - PROCESS | 7377 | Values: 66.0 68.0 68.0 68.0 68.0 67.0 67.0 68.0 66.0 67.0 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:84.00 stddev:3.37 (4.0%) stddev-sans-first:3.46 04:18:24 INFO - PROCESS | 7377 | Values: 83.0 90.0 84.0 83.0 84.0 83.0 90.0 83.0 84.0 91.0 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:142.50 stddev:10.99 (7.7%) stddev-sans-first:11.33 04:18:24 INFO - PROCESS | 7377 | Values: 136.0 137.0 153.0 144.0 135.0 135.0 141.0 137.0 170.0 145.0 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:174.00 stddev:0.84 (0.5%) stddev-sans-first:0.67 04:18:24 INFO - PROCESS | 7377 | Values: 172.0 174.0 174.0 173.0 175.0 174.0 173.0 174.0 174.0 173.0 04:18:24 INFO - PROCESS | 7377 | 04:18:24 INFO - PROCESS | 7377 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.56 (2.2%) stddev-sans-first:1.62 04:18:24 INFO - PROCESS | 7377 | Values: 69.0 70.0 70.0 69.0 74.0 70.0 70.0 70.0 70.0 68.0 04:18:24 INFO - PROCESS | 7377 | -------- Summary: end -------- 04:18:24 INFO - PROCESS | 7377 | 04:18:25 INFO - TEST-INFO | 7377: exit 0 04:18:25 INFO - TEST-OK | kraken | took 64800ms 04:18:25 INFO - SUITE-END | took 1183s 04:18:25 INFO - Completed test suite (00:19:43) 04:18:25 INFO - javascript benchmark 04:18:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6382.6245270694235, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2647.8278911870725, 2675.638788763517, 2681.343070947617, 2683.3157544826076, 2686.9596956045675, 4686.461056978448, 4800.615950723943, 4824.348712923755, 4896.265560165977, 4900.485449027849, 4766.070616229837, 4844.878878028051, 4867.3915760529935, 4874.8781280468, 4901.681390709601, 4318.2227199104145, 4435.84474543391, 4443.244648409762, 4518.141553104916, 4554.38515800366, 4535.365048893158, 4539.773011349436, 4547.18150732868, 4550.089982003596, 4580.175568397687, 4378.934315985262, 4382.189294980439, 4386.078923426085, 4410.184115938561, 4444.533324000998, 4380.299152135643, 4420.80106395213, 4427.53510881356, 4444.177827101997, 4456.9331460028125, 4360.193364227596, 4368.082702632451, 4370.475542934868, 4379.189849877783, 4432.689711720181, 4727.692699974525, 4771.475137734847, 4829.154897892855, 4836.250381190921, 4862.659613827033, 5248.947510524884, 5256.526912577848, 5263.0526505229045, 5265.631405801595, 5270.4729527047375, 5275.261463395128, 5276.498732620395, 5291.100512912775, 5294.470552944713, 5360.517553420172, 4740.454847692559, 4750.548697873696, 4803.807847686124, 4893.779779909913, 4896.510348965075, 5183.922241166386, 5256.421793602701, 5266.34170728659, 5330.200469929464, 5334.91997620036, 5017.322661440732, 5022.59819214462, 5027.245913113063, 5027.271045698426, 5082.949170508322, 4987.650864439454, 5050.141475949097, 5102.132637451642, 5110.0, 5125.308083408767, 5124.692518448905, 5171.741412929338, 5189.766460509286, 5239.685618862881, 5254.65844720092, 5164.1995490699, 5165.405978312467, 5168.483151684802, 5174.301469301671, 5179.404368497596, 4274.871753847389, 4305.332673435622, 4438.755868427267, 4459.643228541709, 4511.210538155875, 3814.3706288462095, 3851.557070936878, 3869.3228684980018, 3876.7480113792512, 3973.5033120859894, 4407.338899165151, 4473.396091527602, 4475.552444755564, 4479.10417916418, 4519.615832654195, 5097.643164978416, 5252.65857719247, 5269.077911365573, 5293.206019097166, 5297.3643162819935, 4356.6732495063, 4369.431973843443, 4384.838017925253, 4404.273294906305, 4446.82212711488, 4671.906561868744, 4673.906521869543, 4686.6485013624115, 4694.6713730039255, 4738.620910327166, 4864.051509955595, 4873.926891096637, 4875.366202393666, 4883.902321953612, 4931.0630980113665, 5065.189569668835, 5080.542751152414, 5136.383633963948, 5179.223116532399, 5182.792688292426, 4865.318855360323, 4871.902561948812, 4881.560659540658, 4924.236743304794, 4929.112759703288, 5106.66806657566, 5114.437411884615, 5117.565006974449, 5125.308083408692, 5129.846104616868, 5085.847424577269, 5136.075506408883, 5176.301199338041, 5181.455947125498, 5198.4750611016525, 5112.054269960069, 5112.897742045213, 5114.360704911886, 5142.76857541404, 5172.793088276578, 4957.429895561912, 5094.15946368845, 5099.581756622276, 5110.105731496898, 5124.5131712487255, 4892.0705066037335, 4949.109160351171, 4954.479779623088, 5043.672161309503, 5108.974455127701, 5110.8466745997675, 5134.820281290137, 5147.305113809737, 5151.5106064923775, 5158.174692049254, 5010.3737032870895, 5018.347614810052, 5022.899542009066, 5033.974830125826, 5086.440491545853], "value": 4758.262385968262, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.4061661863641, 543.017138978449, 547.9260299859518, 549.5466240351708, 552.4034043233308, 38191.0, 39900.201995960066, 39969.400458993136, 39988.80005599975, 39995.60004399955, 39421.0, 39929.20141597174, 39930.201395972064, 40068.0, 40101.398479022835, 7619.923800762004, 7835.412344074189, 7835.608219589027, 7835.647395867171, 7836.216378362146, 7738.883916741253, 7820.491668041587, 7828.0, 7834.921650783476, 7838.882416763753, 7761.22387761225, 7810.570418626973, 7826.686932522693, 7829.099653539859, 7842.686292548291, 7713.074431068279, 7743.883841742322, 7752.0697516298405, 7755.340796032344, 7757.49576277543, 7716.537007779495, 7717.729879454192, 7746.573938433384, 7747.070351557849, 7757.5733334666575, 35935.28129437396, 35951.0, 35977.28045439076, 36042.45936310958, 36152.457713134325, 2898.4203159368, 3068.0642404066753, 3077.461444247248, 3453.723702103826, 3504.0714210734177, 28008.719912801018, 28197.57703634447, 28575.28561785972, 29156.708432915613, 29877.850610746806, 3479.460683594047, 3553.218291975761, 3553.875614353511, 3574.4817001534893, 3599.8560057597665, 248785.7560712203, 249421.0, 249478.0, 250217.0, 250569.0, 49428.752856235486, 49613.75193124011, 49630.50369496259, 49759.0, 49813.765829904136, 32020.359592808014, 32769.180770480925, 32888.67111328856, 34623.13442163966, 53672.46327536675, 14394.424223030961, 14485.85514144845, 14532.346044428026, 14551.05418147817, 14559.563213103624, 10787.0, 10867.673969780919, 10897.128229741602, 10959.83560246597, 10964.835527467094, 17615.735763963552, 17625.383111591033, 17642.470725878244, 17747.290108395777, 17753.556161096076, 6617.0, 6723.294054124344, 6724.529282950244, 6890.827729306808, 7059.89410158848, 771.2326235395817, 809.663989444374, 864.1747131489412, 891.1712107739864, 898.7213963671152, 26046.0, 28092.719072809417, 28271.0, 28391.29021774472, 28506.144815655563, 873.7946582553222, 924.473050361301, 979.3389462113046, 987.116530705015, 1021.4331046269243, 13580.38888250031, 14434.350454229585, 14469.119014528254, 14523.78214326786, 14738.852611473962, 359662.0, 362676.0, 363793.0, 365010.0, 365137.0, 47674.76162619234, 48155.27767083496, 48680.513194868305, 48765.512344876806, 49009.509904901206, 1139.4018140476317, 1150.442035612727, 1174.5830230268302, 1188.174218917861, 1191.8152686333633, 25532.744672553035, 25981.350466238495, 26508.469830603666, 26597.7340226603, 26618.06836760704, 40567.18865622612, 40749.79625101855, 40888.0, 40912.79543602263, 40965.79517102396, 251571.0, 251727.0, 251761.0, 251910.0, 251991.0, 24738.0, 24797.25608231756, 24821.87589062043, 24873.378165545284, 25127.120550780633, 40946.59053409428, 41028.0, 41145.794271028455, 41353.172936541705, 42502.57497424986, 35098.64901350954, 35602.8219858899, 35638.287234254654, 35778.0, 36022.819885900404, 34808.0, 34926.82536587301, 35014.82492587623, 35027.82486087553, 35334.823325883204, 34113.14717132092, 34379.312413752086, 34613.480797787546, 35325.82337088298, 35421.0, 29599.704002959694, 32497.675023249463, 32721.181970449976, 32768.672313277515, 32843.671563284064, 24620.630690540016, 24958.12646557362, 25212.49575008526, 25283.367915802253, 25510.0], "value": 16915.132128538346, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.28017424193274, 355.4934218738298, 357.1535460957531, 368.7916327275091, 372.5027088836403, 15272.847271527282, 15274.618134546641, 16821.327146914107, 16902.408415705453, 17105.914470427662, 12662.366881655904, 15210.467633632825, 16005.599860003505, 16084.034957902533, 16892.83107168928, 4998.675086119409, 5261.053010458116, 5262.342207224097, 5262.7631756571045, 5266.552343050846, 5011.018444025799, 5124.180131179012, 5170.689758614495, 5191.039657663326, 5204.089284375238, 5150.793968241266, 5156.92264616031, 5160.587153027749, 5161.406438259592, 5170.896582068356, 4952.975235123801, 5068.493150684939, 5150.0, 5171.01750667372, 5181.9740901295445, 4574.771261436915, 4580.335851301543, 4582.725036497821, 4588.357629931812, 4600.102979918917, 19372.80627193738, 20035.799642003538, 20120.79879201204, 20130.79869201304, 20158.69761953572, 2145.914163433461, 2208.0111045012923, 2208.580369729746, 2448.9755102448926, 2553.170219678593, 12768.233905965672, 13126.212427254395, 13190.472381104744, 13251.13867598603, 13482.52811151605, 1734.332282071399, 1754.1930711872553, 1807.8011418743927, 1922.7404300419405, 1983.107601579295, 60235.69882150561, 67712.0, 69143.65428172828, 69404.6529767348, 70229.64885175592, 8658.220760131493, 8785.604647790864, 8820.426672266281, 9950.452725100044, 10148.594056237667, 13586.864131358758, 13603.387847546885, 13606.0, 13615.18308901469, 13615.251161186032, 6435.549511534241, 6928.515003949675, 6961.512694111364, 6998.230194678581, 7095.89356159658, 6740.696668649923, 6750.662466876636, 6864.725410983605, 7001.334873187039, 7003.159620845531, 4155.272827255279, 4156.750594964312, 4222.451081359403, 4345.978270108692, 4352.303631418958, 1757.9033153176697, 1763.5679258581729, 1786.6873297172942, 1816.0083677840473, 1856.3688345962437, 785.3795501553823, 822.4037572759702, 842.4608250719544, 857.5797859049021, 916.326500022483, 15566.610834728996, 16331.0, 16347.918260408622, 16538.334781436355, 16685.49943501697, 776.1346099099463, 779.9571023593643, 833.5290560833109, 839.9496030238205, 890.955452227386, 8464.66141354339, 9215.170634642915, 9254.213391861767, 9295.442273463614, 9572.138507534355, 363845.0, 381463.0, 383493.0, 387358.0, 387412.0, 68931.3106868935, 78472.60763696145, 83982.58008710039, 84435.57782211172, 85118.0, 868.7393781865416, 873.6505397841041, 902.4134312696799, 907.5054095517959, 907.8229745199623, 14623.905306514192, 14668.193249371387, 14747.92626036863, 14936.551903442914, 15044.849551504783, 36369.27261454703, 37228.6277137236, 37430.43854342242, 37958.0, 38045.80977095207, 46761.298580522, 46875.29687054765, 52836.41490755283, 54353.456465434836, 55304.17043744428, 4875.7074575525585, 6525.0, 7124.964375178091, 7477.364424023801, 7591.316781489692, 10054.89945100569, 10907.454627268764, 11389.772204555697, 11422.48598813072, 11524.962753352238, 9911.355761875455, 9995.60017599317, 10252.974702529687, 10545.52545135486, 10881.020708136306, 10085.142762865238, 10146.188304935735, 10186.694399168036, 10349.120324772479, 10412.791744165226, 9788.657396991071, 10053.899461005296, 10075.546600402853, 10221.693349199535, 10330.793384132425, 7304.561726296439, 7445.739399121005, 7567.772966811004, 7738.961305193438, 7756.573388463688, 9201.401908875901, 10042.246831487522, 10063.496825158567, 10086.899131008597, 10306.33008854422], "value": 8088.31260025158, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.262629493221, 1396.7346204221199, 1494.7683109118084, 1670.0397271568852, 1717.5534361066118, 7088.539244949075, 7333.046703928482, 7492.625368731562, 8111.634976426068, 8113.0, 7547.207543207953, 7878.4485086044, 7884.250996155371, 7937.841243175133, 8114.14801445847, 2087.780783017788, 2133.658614621661, 2152.870827750332, 2157.1155826111217, 2165.9241926532573, 2084.3538503064096, 2114.0381126587445, 2168.1219106261988, 2169.663702126173, 2171.4679903423685, 2151.225558798839, 2162.686410470481, 2174.8042676159143, 2175.869447833127, 2189.8576592521513, 2062.412212519432, 2071.7513898332145, 2072.512959454527, 2079.5321052763156, 2083.2916808285104, 2079.2306846466754, 2106.6313395155785, 2119.2688522459725, 2120.522882351474, 2125.2242931330106, 7820.921790782077, 7933.404994625368, 7936.484128531627, 7943.721969731032, 7952.721654742057, 4523.615492683126, 4634.930476042862, 4681.906361872743, 4688.695234809727, 4692.36653051837, 2822.7741780657498, 2941.544060670578, 2952.630921134858, 2970.762339012874, 2973.628296462942, 857.7169534053747, 904.1004200820227, 914.5701520285455, 914.8947870994854, 915.1443400420628, 10825.512851921683, 10862.78274434507, 10874.565017399294, 10886.61896833607, 10914.23600347976, 3977.3238549446664, 4147.875563733093, 4167.937480937789, 4193.475815523059, 4239.660827133822, 9229.723108306762, 9237.0, 9250.629974801068, 9252.259819214582, 9259.398139120936, 4672.532746725368, 4683.906321873544, 4687.601553867959, 4690.7654617269, 4706.529347065334, 3567.0547304964207, 3674.467202255658, 4038.374052021941, 4293.2057569349145, 4299.548547402478, 3534.0104770664257, 3599.8200089995394, 3709.5177626908867, 3734.047817806442, 3752.3058234226755, 1163.7497937943383, 1178.5639313454076, 1185.0637995983077, 1187.0444292344746, 1191.9165658404002, 813.0, 839.7690635075281, 843.5950743643085, 863.9006514250816, 872.7076429396096, 5292.285541451932, 5453.23654688344, 5463.235147079412, 5486.61593688438, 5571.470710282517, 888.2228050455851, 922.6263363337858, 957.818014577228, 963.8216929867997, 968.941863488193, 3444.621091679913, 3573.338932297533, 3650.361186792301, 3676.3015027145293, 3678.3746763050344, 9466.1953733932, 9758.512074396253, 9856.50717464124, 9965.0, 10007.649732259337, 9552.856707149398, 9865.309428340091, 9866.457344846101, 9883.654072107442, 9890.653827116017, 7297.635118244067, 7338.889916651255, 7430.7399241026305, 7459.918311844752, 7459.962700186573, 4966.751662416937, 5009.173486374707, 5150.0, 5219.791208351775, 5319.4414586467865, 8709.695160669346, 8916.108389161032, 8997.640094396413, 9083.45499270046, 9094.545272736204, 9139.177474027369, 9157.816843663222, 9228.492432916253, 9305.11601397866, 9308.348415610842, 6188.350223226496, 6388.488920886411, 6655.401013908771, 6897.068895699016, 6900.102986611709, 7283.453740969342, 7533.886991695239, 7574.394048476219, 7740.032495938008, 7740.612969351622, 6280.27776805655, 6345.96827015862, 6483.319251478527, 6549.705263263069, 6632.933670663231, 6853.0, 6854.9657251713425, 6886.173659160932, 6937.445004399737, 6944.479164062816, 6286.591371560834, 6382.5532212744665, 6386.0, 6386.872262554816, 6394.616323020447, 4430.712003719748, 4468.3074123510905, 4499.392582001388, 4504.256797628354, 4524.5249248828395, 4510.3234514821725, 4540.931886021646, 4611.33135695329, 4687.882802929817, 4802.375691160127], "value": 4153.2810534082955, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.5210550486192, 288.9855507224638, 296.3746494895768, 300.5461752753342, 300.90521485731995, 4917.0, 5000.999600159933, 5004.42272229802, 5021.447640759514, 5044.924326135111, 4932.432770231425, 4946.5795407390415, 4950.480199579047, 4951.529604687558, 5017.899642007167, 3892.8637497687587, 3905.3556163233034, 3909.4135879618143, 3909.4526766252748, 3913.217356528691, 3773.735838491307, 3774.5470543534816, 3911.7261791674596, 3917.1773927475265, 3918.7648741075486, 3838.6737127344068, 3854.3062248795204, 3860.7104467164936, 3873.903152421198, 3879.689624830007, 3851.826667799942, 3860.7297489175767, 3869.671077958377, 3878.728489005771, 3948.3287841067086, 3173.7778355515125, 3264.5103234514777, 3272.5745653065187, 3428.4171690812623, 3441.2601290722364, 4787.180871268895, 4796.529787159616, 4800.3279540864305, 4809.519048095198, 4821.879453013667, 4375.5779371704, 4381.539938306464, 4384.802683879201, 4385.846495372647, 4429.693240494062, 4834.468208497063, 5092.337996060525, 5158.458361871987, 5170.922436163461, 5173.741312934339, 3619.438986957026, 3638.854445822164, 3640.8179591020344, 3642.7085833133287, 3649.8540058397634, 5369.7583608737705, 5389.844062375042, 5392.272043274147, 5407.675539467645, 5499.807506737245, 3690.4833323334756, 3693.353663108945, 3700.1859590889962, 3703.0, 3714.1643130296006, 3481.7562770606323, 3701.8149092545264, 3753.5683396409217, 3774.3206222879594, 3782.71629627779, 4327.437433133672, 4328.372386004012, 4334.609885110355, 4347.956520434818, 4414.3157810539415, 5208.609354298443, 5216.66091704038, 5217.0, 5218.112920803473, 5221.817236396784, 1279.0598909801288, 1297.4874924404996, 1300.5318085489216, 1302.6482849630736, 1310.88202061813, 782.7025730222479, 807.6688557691318, 812.2770734046703, 814.1451475950229, 827.1108558299852, 3993.3810259409256, 3996.620321069552, 4015.3976903464713, 4062.532808727034, 4093.97953010239, 4679.67242293043, 4702.388689470347, 4717.669763116617, 4725.480197178307, 4729.0, 3961.3859851723028, 4063.4514340564238, 4074.103697186614, 4078.9592104079175, 4097.13960068383, 2421.9031238750604, 2498.3629174560733, 2522.407234299938, 2522.93692657685, 2547.2230969554093, 4781.713097214179, 4871.318015477836, 4963.6277279204205, 5017.9247311290355, 5035.874103147377, 5471.972640136773, 5486.451354864562, 5499.312585926759, 5499.312585926759, 5505.174223866372, 4827.155247831685, 5014.445521888227, 5021.271915572294, 5024.2463630454995, 5048.0, 5322.973385133049, 5353.625246232727, 5360.758765855624, 5365.973170134124, 5370.516653501204, 5216.791328346975, 5244.842654720364, 5253.789848406173, 5256.6320357574605, 5259.5003474671375, 4821.975890120527, 4934.679245849008, 4976.765102683285, 4990.650654454299, 5015.548600625962, 3667.0465678923138, 3667.431548110047, 3691.630836916287, 3704.407294832814, 3709.4806727057694, 5331.840044798662, 5338.1992701093595, 5357.383900851296, 5366.946330536644, 5374.328208973879, 4901.754912254301, 5201.817936372209, 5204.531592156724, 5205.349331333583, 5272.2882410874045, 5214.722393013736, 5216.504432078947, 5276.34045744282, 5278.4721527846905, 5297.470252974672, 5142.460041695717, 5152.793888244429, 5169.741512924414, 5184.870378240424, 5202.297689811827, 4993.900121997613, 5255.264263003106, 5281.788728450819, 5292.761825717775, 5309.203619456958, 5150.227465880148, 5170.948290517047, 5171.767270472913, 5179.300794392709, 5188.636795424284], "value": 3833.9566257430265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.4985711716389, 622.3394986432999, 672.8116127484307, 726.0575077330095, 734.9206823409913, 11367.090632749381, 11972.102092343066, 11988.460519276632, 11995.0, 12058.517659293619, 12445.06662000349, 12536.310502922335, 13236.205827650323, 13266.668333291673, 13700.109492882955, 750.6021808441535, 769.7998520384684, 776.243162916155, 777.0, 780.7696729464793, 719.1262615921654, 769.157772239397, 779.1195948578098, 780.5082797837355, 782.3936449251819, 820.1675299570941, 821.2280456370992, 822.2722890242119, 824.8020475085996, 826.1119296756011, 819.6516480495766, 819.7049062337584, 820.4871955028108, 821.0, 824.6289169873521, 599.3886236039259, 601.636010213823, 601.7412512619571, 604.1451346344917, 604.7157835817159, 13002.089853710244, 13009.804852927213, 13056.608301750963, 13061.673458163526, 13066.869331306756, 13060.0, 13387.598372048855, 13400.664983375396, 13498.59504214875, 13541.0, 10517.579296828118, 10519.947400263027, 10541.525631346607, 10630.211866097468, 10735.248532602722, 3138.7018233267804, 3168.1604374840686, 3174.1747145742274, 3229.3702727968057, 3259.41330560499, 66740.6662966682, 67335.0, 67834.66082669554, 67900.6604966972, 69395.65302173507, 9901.851472227921, 10249.180065594883, 10287.331323463952, 10379.481025948673, 10464.0, 18681.15934782938, 18718.251269949324, 18725.157367918204, 18765.155567999474, 18793.060346982595, 6672.0, 6690.130283063268, 6736.292689267654, 6825.35159159879, 6851.314868513109, 3549.4498352755363, 3580.104973756561, 3679.889603311905, 3696.907577310535, 3813.599572044951, 2965.4876013232974, 3087.8729263818545, 3116.67274936133, 3220.0822765512185, 3389.3899098162074, 558.2993343354145, 559.5495626021011, 562.6314763829698, 567.3050513121393, 579.9942000580024, 524.4414698346325, 579.6637949988997, 617.7405489694339, 619.1486705779553, 631.8894193516209, 7553.848923021509, 7594.658240379196, 7879.606019699107, 8125.9187408126345, 8570.700025499078, 581.5667327840786, 596.785157343356, 597.6503745309043, 611.9663418512025, 612.7732738886551, 3591.5331006968927, 3598.226381328027, 3627.782333060025, 3691.077230692327, 3739.121306492972, 69613.65193174002, 71050.0, 72481.27518724745, 85507.14492855116, 106396.0, 75353.0, 76042.19789010528, 76257.23742762613, 76360.0, 76752.0, 54002.45997540053, 68611.65694171598, 68726.65636671784, 69929.30070699228, 72810.2718972814, 8257.669693212205, 9021.548922553715, 9090.909090909154, 9132.680356187502, 9243.39917905334, 35434.64565354417, 42061.15877682368, 43055.569444305154, 43546.0, 43886.34170487381, 53610.463895360546, 63078.36921630725, 63156.368436315046, 63253.36746632475, 63260.0, 11005.56927599407, 11044.834327485254, 11049.0, 11205.60780372683, 11398.373089479826, 12625.179363341353, 12684.556040538537, 12749.426275817796, 12990.0, 13621.25083120438, 11744.0, 11908.464119114833, 12037.337946413032, 12094.720210533562, 12496.375181241083, 11626.988688902315, 12144.089193310361, 12867.935660321638, 12880.098393112767, 12914.28971406544, 8928.687495937871, 10420.791584168122, 11929.105317101079, 11987.22083064598, 12405.875941240833, 9714.125728684452, 9754.85367719499, 9853.556589953612, 9931.205503559553, 10148.949255253676, 10041.548130334299, 10420.0, 10424.843627345444, 10433.634822781167, 10468.63359782404], "value": 6521.218455395935, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 117.0, 114.0, 115.0, 117.0, 115.0, 113.0, 115.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 127.0, 179.0, 125.0, 126.0, 129.0, 126.0, 159.0, 132.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 174.0, 165.0, 162.0, 165.0, 163.0, 165.0, 162.0, 164.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 109.0, 78.0, 78.0, 77.0, 78.0, 106.0, 77.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 114.0, 85.0, 83.0, 83.0, 111.0, 84.0, 84.0, 112.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 119.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 149.0, 149.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 65.0, 64.0, 64.0, 66.0, 65.0, 63.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 68.0, 66.0, 67.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 90.0, 84.0, 83.0, 84.0, 83.0, 90.0, 83.0, 84.0, 91.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 153.0, 144.0, 135.0, 135.0, 141.0, 137.0, 170.0, 145.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 174.0, 173.0, 175.0, 174.0, 173.0, 174.0, 174.0, 173.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 69.0, 74.0, 70.0, 70.0, 70.0, 70.0, 68.0], "value": 70.0, "unit": "score"}]}]} 04:18:26 INFO - Return code: 0 04:18:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:18:26 ERROR - # TBPL SUCCESS # 04:18:26 INFO - Running post-action listener: _resource_record_post_action 04:18:26 INFO - [mozharness: 2016-09-27 11:18:26.133803Z] Finished run-tests step (success) 04:18:26 INFO - Running post-run listener: _resource_record_post_run 04:18:26 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 384430080; Read time: 12; Write time: 275088 04:18:26 INFO - TinderboxPrint: CPU usage
13.4% 04:18:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:18:26 INFO - TinderboxPrint: I/O write bytes / time
384,430,080 / 275,088 04:18:26 INFO - TinderboxPrint: CPU idle
8,287.3 (86.6%) 04:18:26 INFO - TinderboxPrint: CPU user
1,220.5 (12.8%) 04:18:26 INFO - TinderboxPrint: Swap in / out
0 / 0 04:18:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99729408; Read time: 0; Write time: 87736 04:18:26 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284700672; Read time: 0; Write time: 187352 04:18:26 INFO - Running post-run listener: _upload_blobber_files 04:18:26 INFO - Blob upload gear active. 04:18:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:18:26 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 04:18:26 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'] 04:18:26 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 04:18:27 INFO - (blobuploader) - INFO - Open directory for files ... 04:18:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:18:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:18:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:28 INFO - (blobuploader) - INFO - Done attempting. 04:18:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:18:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:18:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:32 INFO - (blobuploader) - INFO - Done attempting. 04:18:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:18:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:18:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:33 INFO - (blobuploader) - INFO - Done attempting. 04:18:33 INFO - (blobuploader) - INFO - Iteration through files over. 04:18:33 INFO - Return code: 0 04:18:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:18:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:18:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2094d52c9b4843e3606bc3e8d83734ab85754bbc783f5286569051cd71226fc3d514631e6486a20809f2abb1d867f4f31e4d2b35c7de39dec400a4e403c7a363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b724f1193531bbb545eba3515ec16b68c0975feeab79d36f0183e2fb847ca98e66554660b0b9ea6ca304ca9108bf4edd032907f3968e6e3065e38b322083c1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d964de111f97f031a82a38087210da9166fd8904e231036461de8334735b9353ca12d34abcf28440a6cdb4af94ee328bda9c1157d8707bc0e03b5c3dff5eb5bf"} 04:18:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:18:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:18:33 INFO - Contents: 04:18:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2094d52c9b4843e3606bc3e8d83734ab85754bbc783f5286569051cd71226fc3d514631e6486a20809f2abb1d867f4f31e4d2b35c7de39dec400a4e403c7a363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b724f1193531bbb545eba3515ec16b68c0975feeab79d36f0183e2fb847ca98e66554660b0b9ea6ca304ca9108bf4edd032907f3968e6e3065e38b322083c1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d964de111f97f031a82a38087210da9166fd8904e231036461de8334735b9353ca12d34abcf28440a6cdb4af94ee328bda9c1157d8707bc0e03b5c3dff5eb5bf"} 04:18:33 INFO - Running post-run listener: copy_logs_to_upload_dir 04:18:33 INFO - Copying logs to upload dir... 04:18:33 INFO - mkdir: /builds/slave/test/build/upload/logs 04:18:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.107311 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-27 04:18:31.981845) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 04:18:31.985066) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2094d52c9b4843e3606bc3e8d83734ab85754bbc783f5286569051cd71226fc3d514631e6486a20809f2abb1d867f4f31e4d2b35c7de39dec400a4e403c7a363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b724f1193531bbb545eba3515ec16b68c0975feeab79d36f0183e2fb847ca98e66554660b0b9ea6ca304ca9108bf4edd032907f3968e6e3065e38b322083c1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d964de111f97f031a82a38087210da9166fd8904e231036461de8334735b9353ca12d34abcf28440a6cdb4af94ee328bda9c1157d8707bc0e03b5c3dff5eb5bf"} build_url:https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011527 build_url: 'https://queue.taskcluster.net/v1/task/dI3lihQeQw2lS4TQTt8cIg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2094d52c9b4843e3606bc3e8d83734ab85754bbc783f5286569051cd71226fc3d514631e6486a20809f2abb1d867f4f31e4d2b35c7de39dec400a4e403c7a363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b724f1193531bbb545eba3515ec16b68c0975feeab79d36f0183e2fb847ca98e66554660b0b9ea6ca304ca9108bf4edd032907f3968e6e3065e38b322083c1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d964de111f97f031a82a38087210da9166fd8904e231036461de8334735b9353ca12d34abcf28440a6cdb4af94ee328bda9c1157d8707bc0e03b5c3dff5eb5bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 04:18:32.011819) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:18:32.012177) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1474973865.411412-1471515399 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:18:32.094587) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 04:18:32.094937) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 04:18:32.095245) ========= ========= Total master_lag: 0.17 =========