builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1479747813.81 results: success (0) buildid: 20161121061609 builduid: 0d832ffe026f486d9c7038b146bfd613 revision: bb1124d7df770a08acb6255289276cf5575db0b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:33.808168) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:33.808682) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:33.808991) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:33.824093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:33.824447) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-21 09:03:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-11-21 09:03:34 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126821 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:33.966154) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:33.966648) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021840 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:34.022057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:34.022453) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bb1124d7df770a08acb6255289276cf5575db0b1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bb1124d7df770a08acb6255289276cf5575db0b1 --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=edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-21 09:03:34,408 truncating revision to first 12 chars 2016-11-21 09:03:34,408 Setting DEBUG logging. 2016-11-21 09:03:34,408 attempt 1/10 2016-11-21 09:03:34,408 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bb1124d7df77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 09:03:34,730 unpacking tar archive at: mozilla-aurora-bb1124d7df77/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655835 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:34.794003) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:34.794362) ========= script_repo_revision: bb1124d7df770a08acb6255289276cf5575db0b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:34.794793) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:34.795246) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:34.814152) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-21 09:03:34.814572) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:03:35 INFO - MultiFileLogger online at 20161121 09:03:35 in /builds/slave/test 09:03:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:03:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:03:35 INFO - {'append_to_log': False, 09:03:35 INFO - 'base_work_dir': '/builds/slave/test', 09:03:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:03:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:03:35 INFO - 'branch': 'Mozilla-Aurora', 09:03:35 INFO - 'buildbot_json_path': 'buildprops.json', 09:03:35 INFO - 'config_files': ('talos/linux_config.py',), 09:03:35 INFO - 'default_actions': ('clobber', 09:03:35 INFO - 'read-buildbot-config', 09:03:35 INFO - 'download-and-extract', 09:03:35 INFO - 'populate-webroot', 09:03:35 INFO - 'create-virtualenv', 09:03:35 INFO - 'install', 09:03:35 INFO - 'run-tests'), 09:03:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:03:35 INFO - 'download_minidump_stackwalk': True, 09:03:35 INFO - 'download_symbols': 'ondemand', 09:03:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:03:35 INFO - 'tooltool.py': '/tools/tooltool.py', 09:03:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:03:35 INFO - '/tools/misc-python/virtualenv.py')}, 09:03:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:03:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:03:35 INFO - 'installer_path': 'installer.exe', 09:03:35 INFO - 'log_level': 'info', 09:03:35 INFO - 'log_name': 'talos', 09:03:35 INFO - 'log_to_console': True, 09:03:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:03:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:03:35 INFO - 'opt_config_files': (), 09:03:35 INFO - 'pip_index': False, 09:03:35 INFO - 'sps_profile': False, 09:03:35 INFO - 'sps_profile_interval': 0, 09:03:35 INFO - 'suite': 'dromaeojs-e10s', 09:03:35 INFO - 'system_bits': '32', 09:03:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:03:35 INFO - 'title': 'talos-linux64-ix-033', 09:03:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:03:35 INFO - 'use_talos_json': True, 09:03:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:03:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:03:35 INFO - 'work_dir': 'build'} 09:03:35 INFO - [mozharness: 2016-11-21 17:03:35.303211Z] Running clobber step. 09:03:35 INFO - Running pre-action listener: _resource_record_pre_action 09:03:35 INFO - Running main action method: clobber 09:03:35 INFO - rmtree: /builds/slave/test/build 09:03:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:03:35 INFO - Running post-action listener: _resource_record_post_action 09:03:35 INFO - [mozharness: 2016-11-21 17:03:35.766579Z] Finished clobber step (success) 09:03:35 INFO - [mozharness: 2016-11-21 17:03:35.766680Z] Running read-buildbot-config step. 09:03:35 INFO - Running pre-action listener: _resource_record_pre_action 09:03:35 INFO - Running main action method: read_buildbot_config 09:03:35 INFO - Using buildbot properties: 09:03:35 INFO - { 09:03:35 INFO - "project": "", 09:03:35 INFO - "product": "firefox", 09:03:35 INFO - "script_repo_revision": "production", 09:03:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:03:35 INFO - "repository": "", 09:03:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:03:35 INFO - "buildid": "20161121061609", 09:03:35 INFO - "pgo_build": "True", 09:03:35 INFO - "basedir": "/builds/slave/test", 09:03:35 INFO - "buildnumber": 658, 09:03:35 INFO - "slavename": "talos-linux64-ix-033", 09:03:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:03:35 INFO - "platform": "ubuntu64_hw", 09:03:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:03:35 INFO - "branch": "mozilla-aurora", 09:03:35 INFO - "repo_path": "releases/mozilla-aurora", 09:03:35 INFO - "revision": "bb1124d7df770a08acb6255289276cf5575db0b1", 09:03:35 INFO - "stage_platform": "linux64-pgo", 09:03:35 INFO - "builduid": "0d832ffe026f486d9c7038b146bfd613", 09:03:35 INFO - "slavebuilddir": "test" 09:03:35 INFO - } 09:03:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:03:35 INFO - Running post-action listener: _resource_record_post_action 09:03:35 INFO - [mozharness: 2016-11-21 17:03:35.769129Z] Finished read-buildbot-config step (success) 09:03:35 INFO - [mozharness: 2016-11-21 17:03:35.769218Z] Running download-and-extract step. 09:03:35 INFO - Running pre-action listener: _resource_record_pre_action 09:03:35 INFO - Running main action method: download_and_extract 09:03:35 INFO - mkdir: /builds/slave/test/build/tests 09:03:35 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')]} 09:03:35 INFO - trying https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:03:35 INFO - Downloading https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:03:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:03:36 INFO - Downloaded 1361 bytes. 09:03:36 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:03:36 INFO - Using the following test package requirements: 09:03:36 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:03:36 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:03:36 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:03:36 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:36 INFO - u'jsshell-linux-x86_64.zip'], 09:03:36 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:03:36 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:03:36 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:03:36 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:03:36 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:03:36 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:03:36 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:03:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:03:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:03:36 INFO - Fetch https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:03:36 INFO - Http code: 200 09:03:36 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 09:03:36 INFO - x-amz-cf-id: j1B_rWJhzsk5W_-pIIIlWCFMxR-frqAIh9X_uFSLhc7BXUJIPJSoIg== 09:03:36 INFO - x-amz-version-id: xJWbmiKvKgqyC0kmgqNjF72eofkGuLM_ 09:03:37 INFO - Expected file size: 21947271 09:03:37 INFO - Obtained file size: 21947271 09:03:41 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:03:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:03:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:03:41 INFO - Fetch https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:03:41 INFO - Http code: 200 09:03:41 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 09:03:41 INFO - x-amz-cf-id: ohp9jq2KDrx2wkLaxbhl5z7JTlsXF2mJloPh1v6ELAJFDbx_Up8FNg== 09:03:41 INFO - x-amz-version-id: xJWbmiKvKgqyC0kmgqNjF72eofkGuLM_ 09:03:42 INFO - Expected file size: 21947271 09:03:42 INFO - Obtained file size: 21947271 09:03:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:03:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:03:46 INFO - Fetch https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:03:47 INFO - Http code: 200 09:03:47 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 09:03:47 INFO - x-amz-cf-id: q8qek6ouJs-yqcetuO2fgPoz1E21d8SvWhtFqmQ4t5vg79Jx0hwtMg== 09:03:47 INFO - x-amz-version-id: 6ENkfoccwkudeZej0PRzg5gtmkj3Z6Wg 09:03:47 INFO - Expected file size: 14409038 09:03:47 INFO - Obtained file size: 14409038 09:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:47 INFO - trying https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:03:47 INFO - Downloading https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:03:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:03:48 INFO - Downloaded 63942042 bytes. 09:03:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:03:48 INFO - mkdir: /builds/slave/test/properties 09:03:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:03:48 INFO - Writing to file /builds/slave/test/properties/build_url 09:03:48 INFO - Contents: 09:03:48 INFO - build_url:https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:03:49 INFO - Running post-action listener: _resource_record_post_action 09:03:49 INFO - Running post-action listener: set_extra_try_arguments 09:03:49 INFO - [mozharness: 2016-11-21 17:03:49.352169Z] Finished download-and-extract step (success) 09:03:49 INFO - [mozharness: 2016-11-21 17:03:49.352468Z] Running populate-webroot step. 09:03:49 INFO - Running pre-action listener: _resource_record_pre_action 09:03:49 INFO - Running main action method: populate_webroot 09:03:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:03:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:03:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:03:49 INFO - '--tppagecycles', 09:03:49 INFO - '7'], 09:03:49 INFO - 'tests': ['tsvgm']}}, 09:03:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:03:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:03:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:03:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:03:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:03:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:03:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'talos_options': ['--disable-e10s'], 09:03:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'talos_options': ['--disable-e10s'], 09:03:49 INFO - 'tests': ['damp', 'tps']}, 09:03:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'tests': ['damp', 'tps']}, 09:03:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:03:49 INFO - 'tests': ['dromaeo_dom']}, 09:03:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:03:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:03:49 INFO - 'tests': ['basic_compositor_video']}, 09:03:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:03:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:03:49 INFO - 'tests': ['a11yr', 09:03:49 INFO - 'ts_paint', 09:03:49 INFO - 'tpaint', 09:03:49 INFO - 'sessionrestore', 09:03:49 INFO - 'sessionrestore_no_auto_restore', 09:03:49 INFO - 'tabpaint']}, 09:03:49 INFO - 'other-e10s': {'tests': ['a11yr', 09:03:49 INFO - 'ts_paint', 09:03:49 INFO - 'tpaint', 09:03:49 INFO - 'sessionrestore', 09:03:49 INFO - 'sessionrestore_no_auto_restore', 09:03:49 INFO - 'tabpaint']}, 09:03:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:03:49 INFO - 'ts_paint', 09:03:49 INFO - 'tpaint', 09:03:49 INFO - 'sessionrestore', 09:03:49 INFO - 'sessionrestore_no_auto_restore', 09:03:49 INFO - 'tabpaint']}, 09:03:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:03:49 INFO - 'ts_paint', 09:03:49 INFO - 'tpaint', 09:03:49 INFO - 'sessionrestore', 09:03:49 INFO - 'sessionrestore_no_auto_restore', 09:03:49 INFO - 'tabpaint']}, 09:03:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:03:49 INFO - 'tests': ['a11yr', 09:03:49 INFO - 'ts_paint', 09:03:49 INFO - 'tpaint', 09:03:49 INFO - 'sessionrestore', 09:03:49 INFO - 'sessionrestore_no_auto_restore', 09:03:49 INFO - 'tabpaint']}, 09:03:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:03:49 INFO - 'tests': ['a11yr', 09:03:49 INFO - 'ts_paint', 09:03:49 INFO - 'tpaint', 09:03:49 INFO - 'sessionrestore', 09:03:49 INFO - 'sessionrestore_no_auto_restore', 09:03:49 INFO - 'tabpaint']}, 09:03:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:03:49 INFO - 'tests': ['tsvgx', 09:03:49 INFO - 'tsvgr_opacity', 09:03:49 INFO - 'tart', 09:03:49 INFO - 'tscrollx', 09:03:49 INFO - 'cart']}, 09:03:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:03:49 INFO - 'tsvgr_opacity', 09:03:49 INFO - 'tart', 09:03:49 INFO - 'tscrollx', 09:03:49 INFO - 'cart']}, 09:03:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'talos_options': ['--disable-e10s'], 09:03:49 INFO - 'tests': ['tp5o']}, 09:03:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'tests': ['tp5o']}, 09:03:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'talos_options': ['--disable-e10s', 09:03:49 INFO - '--xperf_path', 09:03:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:49 INFO - 'tests': ['tp5n']}, 09:03:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:49 INFO - 'talos_options': ['--xperf_path', 09:03:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:49 INFO - 'tests': ['tp5n']}}, 09:03:49 INFO - 'talos.zip': {'path': '', 09:03:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:03:49 INFO - Running post-action listener: _resource_record_post_action 09:03:49 INFO - [mozharness: 2016-11-21 17:03:49.373166Z] Finished populate-webroot step (success) 09:03:49 INFO - [mozharness: 2016-11-21 17:03:49.373285Z] Running create-virtualenv step. 09:03:49 INFO - Running pre-action listener: _resource_record_pre_action 09:03:49 INFO - Running main action method: create_virtualenv 09:03:49 INFO - Creating virtualenv /builds/slave/test/build/venv 09:03:49 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 09:03:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:03:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:03:49 INFO - Using real prefix '/usr' 09:03:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:03:49 INFO - Installing distribute.............................................................................................................................................................................................done. 09:03:51 INFO - Installing pip.................done. 09:03:51 INFO - Return code: 0 09:03:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:03:52 INFO - Reading from file tmpfile_stdout 09:03:52 INFO - Output received: 09:03:52 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) 09:03:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe566295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e8f60>, '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 0x13e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', '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 09:03:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:03:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:03:52 INFO - Using env: {'DISPLAY': ':0', 09:03:52 INFO - 'HOME': '/home/cltbld', 09:03:52 INFO - 'LANG': 'en_US.UTF-8', 09:03:52 INFO - 'LANGUAGE': 'en_US:en', 09:03:52 INFO - 'LOGNAME': 'cltbld', 09:03:52 INFO - 'MAIL': '/var/mail/cltbld', 09:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:52 INFO - 'MOZ_NO_REMOTE': '1', 09:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:52 INFO - 'NO_EM_RESTART': '1', 09:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:52 INFO - 'PWD': '/builds/slave/test', 09:03:52 INFO - 'SHELL': '/bin/bash', 09:03:52 INFO - 'SHLVL': '1', 09:03:52 INFO - 'TERM': 'linux', 09:03:52 INFO - 'TMOUT': '86400', 09:03:52 INFO - 'USER': 'cltbld', 09:03:52 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', 09:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:52 INFO - '_': '/tools/buildbot/bin/python'} 09:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:52 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 09:03:52 INFO - Cleaning up... 09:03:52 INFO - Return code: 0 09:03:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe566295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e8f60>, '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 0x13e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', '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 09:03:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:03:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:03:52 INFO - Using env: {'DISPLAY': ':0', 09:03:52 INFO - 'HOME': '/home/cltbld', 09:03:52 INFO - 'LANG': 'en_US.UTF-8', 09:03:52 INFO - 'LANGUAGE': 'en_US:en', 09:03:52 INFO - 'LOGNAME': 'cltbld', 09:03:52 INFO - 'MAIL': '/var/mail/cltbld', 09:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:52 INFO - 'MOZ_NO_REMOTE': '1', 09:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:52 INFO - 'NO_EM_RESTART': '1', 09:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:52 INFO - 'PWD': '/builds/slave/test', 09:03:52 INFO - 'SHELL': '/bin/bash', 09:03:52 INFO - 'SHLVL': '1', 09:03:52 INFO - 'TERM': 'linux', 09:03:52 INFO - 'TMOUT': '86400', 09:03:52 INFO - 'USER': 'cltbld', 09:03:52 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', 09:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:52 INFO - '_': '/tools/buildbot/bin/python'} 09:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:52 INFO - Downloading/unpacking psutil>=3.1.1 09:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:03:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:54 INFO - Installing collected packages: psutil 09:03:54 INFO - Running setup.py install for psutil 09:03:54 INFO - building 'psutil._psutil_linux' extension 09:03:54 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 09:03:54 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 09:03:54 INFO - building 'psutil._psutil_posix' extension 09:03:54 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 09:03:55 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 09:03:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:55 INFO - Successfully installed psutil 09:03:55 INFO - Cleaning up... 09:03:55 INFO - Return code: 0 09:03:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe566295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e8f60>, '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 0x13e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', '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 09:03:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:03:55 INFO - Using env: {'DISPLAY': ':0', 09:03:55 INFO - 'HOME': '/home/cltbld', 09:03:55 INFO - 'LANG': 'en_US.UTF-8', 09:03:55 INFO - 'LANGUAGE': 'en_US:en', 09:03:55 INFO - 'LOGNAME': 'cltbld', 09:03:55 INFO - 'MAIL': '/var/mail/cltbld', 09:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:55 INFO - 'MOZ_NO_REMOTE': '1', 09:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:55 INFO - 'NO_EM_RESTART': '1', 09:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:55 INFO - 'PWD': '/builds/slave/test', 09:03:55 INFO - 'SHELL': '/bin/bash', 09:03:55 INFO - 'SHLVL': '1', 09:03:55 INFO - 'TERM': 'linux', 09:03:55 INFO - 'TMOUT': '86400', 09:03:55 INFO - 'USER': 'cltbld', 09:03:55 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', 09:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:55 INFO - '_': '/tools/buildbot/bin/python'} 09:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:03:57 INFO - Installing collected packages: mozsystemmonitor 09:03:57 INFO - Running setup.py install for mozsystemmonitor 09:03:57 INFO - Successfully installed mozsystemmonitor 09:03:57 INFO - Cleaning up... 09:03:57 INFO - Return code: 0 09:03:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:03:57 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')]} 09:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:57 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')]} 09:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:57 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 0x7fe566295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e8f60>, '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 0x13e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', '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 09:03:57 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 09:03:57 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 09:03:57 INFO - Using env: {'DISPLAY': ':0', 09:03:57 INFO - 'HOME': '/home/cltbld', 09:03:57 INFO - 'LANG': 'en_US.UTF-8', 09:03:57 INFO - 'LANGUAGE': 'en_US:en', 09:03:57 INFO - 'LOGNAME': 'cltbld', 09:03:57 INFO - 'MAIL': '/var/mail/cltbld', 09:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:57 INFO - 'MOZ_NO_REMOTE': '1', 09:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:57 INFO - 'NO_EM_RESTART': '1', 09:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:57 INFO - 'PWD': '/builds/slave/test', 09:03:57 INFO - 'SHELL': '/bin/bash', 09:03:57 INFO - 'SHLVL': '1', 09:03:57 INFO - 'TERM': 'linux', 09:03:57 INFO - 'TMOUT': '86400', 09:03:57 INFO - 'USER': 'cltbld', 09:03:57 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', 09:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:57 INFO - '_': '/tools/buildbot/bin/python'} 09:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:57 INFO - Downloading/unpacking jsonschema==2.5.1 09:03:57 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 09:03:57 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 09:03:57 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 09:03:57 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 09:03:57 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 09:03:57 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 09:03:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:03:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:03:59 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 09:03:59 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 09:03:59 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 09:03:59 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 09:03:59 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 09:03:59 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 09:03:59 INFO - Downloading functools32-3.2.3-2.tar.gz 09:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:03:59 INFO - warning: no files found matching '*.txt' 09:03:59 INFO - no previously-included directories found matching 'build' 09:03:59 INFO - no previously-included directories found matching 'dist' 09:03:59 INFO - no previously-included directories found matching '.git*' 09:04:00 INFO - Installing collected packages: jsonschema, functools32 09:04:00 INFO - Running setup.py install for functools32 09:04:00 INFO - warning: no files found matching '*.txt' 09:04:00 INFO - no previously-included directories found matching 'build' 09:04:00 INFO - no previously-included directories found matching 'dist' 09:04:00 INFO - no previously-included directories found matching '.git*' 09:04:00 INFO - Successfully installed jsonschema functools32 09:04:00 INFO - Cleaning up... 09:04:00 INFO - Return code: 0 09:04:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:04:00 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')]} 09:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:00 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')]} 09:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:00 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 0x7fe566295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e8f60>, '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 0x13e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', '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 09:04:00 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 09:04:00 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 09:04:00 INFO - Using env: {'DISPLAY': ':0', 09:04:00 INFO - 'HOME': '/home/cltbld', 09:04:00 INFO - 'LANG': 'en_US.UTF-8', 09:04:00 INFO - 'LANGUAGE': 'en_US:en', 09:04:00 INFO - 'LOGNAME': 'cltbld', 09:04:00 INFO - 'MAIL': '/var/mail/cltbld', 09:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:00 INFO - 'MOZ_NO_REMOTE': '1', 09:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:00 INFO - 'NO_EM_RESTART': '1', 09:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:00 INFO - 'PWD': '/builds/slave/test', 09:04:00 INFO - 'SHELL': '/bin/bash', 09:04:00 INFO - 'SHLVL': '1', 09:04:00 INFO - 'TERM': 'linux', 09:04:00 INFO - 'TMOUT': '86400', 09:04:00 INFO - 'USER': 'cltbld', 09:04:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', 09:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:00 INFO - '_': '/tools/buildbot/bin/python'} 09:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:04:00 INFO - Cleaning up... 09:04:00 INFO - Return code: 0 09:04:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:04:00 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')]} 09:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:00 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')]} 09:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:00 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 0x7fe566295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e8f60>, '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 0x13e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', '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 09:04:00 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 09:04:00 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 09:04:00 INFO - Using env: {'DISPLAY': ':0', 09:04:00 INFO - 'HOME': '/home/cltbld', 09:04:00 INFO - 'LANG': 'en_US.UTF-8', 09:04:00 INFO - 'LANGUAGE': 'en_US:en', 09:04:00 INFO - 'LOGNAME': 'cltbld', 09:04:00 INFO - 'MAIL': '/var/mail/cltbld', 09:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:00 INFO - 'MOZ_NO_REMOTE': '1', 09:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:00 INFO - 'NO_EM_RESTART': '1', 09:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:00 INFO - 'PWD': '/builds/slave/test', 09:04:00 INFO - 'SHELL': '/bin/bash', 09:04:00 INFO - 'SHLVL': '1', 09:04:00 INFO - 'TERM': 'linux', 09:04:00 INFO - 'TMOUT': '86400', 09:04:00 INFO - 'USER': 'cltbld', 09:04:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', 09:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:00 INFO - '_': '/tools/buildbot/bin/python'} 09:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:04:00 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 09:04:00 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 09:04:00 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 09:04:00 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 09:04:00 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 09:04:00 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 09:04:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:04:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:04:02 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 09:04:02 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 09:04:02 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 09:04:02 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 09:04:02 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 09:04:02 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 09:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:04:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:04:03 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 09:04:03 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 09:04:03 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 09:04:03 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 09:04:03 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 09:04:03 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 09:04:03 INFO - Downloading docopt-0.6.1.tar.gz 09:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:04:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:04:03 INFO - Running setup.py install for blobuploader 09:04:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:04:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:04:03 INFO - Running setup.py install for requests 09:04:03 INFO - Running setup.py install for docopt 09:04:03 INFO - Successfully installed blobuploader requests docopt 09:04:03 INFO - Cleaning up... 09:04:03 INFO - Return code: 0 09:04:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:03 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 0x7fe566295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e8f60>, '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 0x13e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', '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 09:04:03 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 09:04:03 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 09:04:03 INFO - Using env: {'DISPLAY': ':0', 09:04:03 INFO - 'HOME': '/home/cltbld', 09:04:03 INFO - 'LANG': 'en_US.UTF-8', 09:04:03 INFO - 'LANGUAGE': 'en_US:en', 09:04:03 INFO - 'LOGNAME': 'cltbld', 09:04:03 INFO - 'MAIL': '/var/mail/cltbld', 09:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:03 INFO - 'MOZ_NO_REMOTE': '1', 09:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:03 INFO - 'NO_EM_RESTART': '1', 09:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:03 INFO - 'PWD': '/builds/slave/test', 09:04:03 INFO - 'SHELL': '/bin/bash', 09:04:03 INFO - 'SHLVL': '1', 09:04:03 INFO - 'TERM': 'linux', 09:04:03 INFO - 'TMOUT': '86400', 09:04:03 INFO - 'USER': 'cltbld', 09:04:03 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', 09:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:03 INFO - '_': '/tools/buildbot/bin/python'} 09:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:04 INFO - Running setup.py (path:/tmp/pip-GCt773-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:04 INFO - Running setup.py (path:/tmp/pip-lYeA1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:04 INFO - Running setup.py (path:/tmp/pip-AwcnZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:04 INFO - Running setup.py (path:/tmp/pip-RR8Pq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:04 INFO - Running setup.py (path:/tmp/pip-hP9UHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:04 INFO - Running setup.py (path:/tmp/pip-_QnWSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:04 INFO - Running setup.py (path:/tmp/pip-3dQXNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:04 INFO - Running setup.py (path:/tmp/pip-lOXFJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:04 INFO - Running setup.py (path:/tmp/pip-VqUaTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:04 INFO - Running setup.py (path:/tmp/pip-4Rjjkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:04 INFO - Running setup.py (path:/tmp/pip-i7wkqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:04 INFO - Running setup.py (path:/tmp/pip-W59jcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:05 INFO - Running setup.py (path:/tmp/pip-Vre2jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:05 INFO - Running setup.py (path:/tmp/pip-oi1R3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:05 INFO - Running setup.py (path:/tmp/pip-DqSCsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:05 INFO - Running setup.py (path:/tmp/pip-NuqPEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:05 INFO - Running setup.py (path:/tmp/pip-HenyN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:04:05 INFO - Running setup.py install for manifestparser 09:04:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Running setup.py install for mozcrash 09:04:05 INFO - Running setup.py install for mozdebug 09:04:05 INFO - Running setup.py install for mozdevice 09:04:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:04:05 INFO - Running setup.py install for mozfile 09:04:05 INFO - Running setup.py install for mozhttpd 09:04:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:04:06 INFO - Running setup.py install for mozinfo 09:04:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:04:06 INFO - Running setup.py install for mozInstall 09:04:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:04:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:04:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:04:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:04:06 INFO - Running setup.py install for mozleak 09:04:06 INFO - Running setup.py install for mozlog 09:04:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:04:06 INFO - Running setup.py install for moznetwork 09:04:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:04:06 INFO - Running setup.py install for mozprocess 09:04:06 INFO - Running setup.py install for mozprofile 09:04:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:04:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:04:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:04:06 INFO - Running setup.py install for mozrunner 09:04:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:04:06 INFO - Running setup.py install for mozscreenshot 09:04:06 INFO - Running setup.py install for moztest 09:04:07 INFO - Running setup.py install for mozversion 09:04:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:04:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:04:07 INFO - Cleaning up... 09:04:07 INFO - Return code: 0 09:04:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:07 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 0x7fe566295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e8f60>, '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 0x13e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', '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 09:04:07 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 09:04:07 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 09:04:07 INFO - Using env: {'DISPLAY': ':0', 09:04:07 INFO - 'HOME': '/home/cltbld', 09:04:07 INFO - 'LANG': 'en_US.UTF-8', 09:04:07 INFO - 'LANGUAGE': 'en_US:en', 09:04:07 INFO - 'LOGNAME': 'cltbld', 09:04:07 INFO - 'MAIL': '/var/mail/cltbld', 09:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:07 INFO - 'MOZ_NO_REMOTE': '1', 09:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:07 INFO - 'NO_EM_RESTART': '1', 09:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:07 INFO - 'PWD': '/builds/slave/test', 09:04:07 INFO - 'SHELL': '/bin/bash', 09:04:07 INFO - 'SHLVL': '1', 09:04:07 INFO - 'TERM': 'linux', 09:04:07 INFO - 'TMOUT': '86400', 09:04:07 INFO - 'USER': 'cltbld', 09:04:07 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', 09:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:07 INFO - '_': '/tools/buildbot/bin/python'} 09:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:07 INFO - Running setup.py (path:/tmp/pip-j5ogh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:07 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)) 09:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:07 INFO - Running setup.py (path:/tmp/pip-3jfvB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:07 INFO - Running setup.py (path:/tmp/pip-MxC_VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:07 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)) 09:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:07 INFO - Running setup.py (path:/tmp/pip-bOhThs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:07 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)) 09:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:07 INFO - Running setup.py (path:/tmp/pip-ux6qb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:07 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)) 09:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:07 INFO - Running setup.py (path:/tmp/pip-OK7sDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:07 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)) 09:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:07 INFO - Running setup.py (path:/tmp/pip-ohFlsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:07 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)) 09:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:07 INFO - Running setup.py (path:/tmp/pip-z9DyfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:08 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)) 09:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:08 INFO - Running setup.py (path:/tmp/pip-IQ5i7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:08 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)) 09:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:08 INFO - Running setup.py (path:/tmp/pip-7sd6jH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:08 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)) 09:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:08 INFO - Running setup.py (path:/tmp/pip-ZSU5d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:08 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)) 09:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:08 INFO - Running setup.py (path:/tmp/pip-XBpmnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:08 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)) 09:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:08 INFO - Running setup.py (path:/tmp/pip-FiGDlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:08 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)) 09:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:08 INFO - Running setup.py (path:/tmp/pip-8MdU4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:08 INFO - Running setup.py (path:/tmp/pip-2NpypD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:08 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)) 09:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:08 INFO - Running setup.py (path:/tmp/pip-YyX0bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:08 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)) 09:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:08 INFO - Running setup.py (path:/tmp/pip-2tfREs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:08 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)) 09:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:04:08 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)) 09:04:08 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)) 09:04:08 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)) 09:04:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:10 INFO - Downloading blessings-1.6.tar.gz 09:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:04:10 INFO - Installing collected packages: blessings 09:04:10 INFO - Running setup.py install for blessings 09:04:10 INFO - Successfully installed blessings 09:04:10 INFO - Cleaning up... 09:04:10 INFO - Return code: 0 09:04:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:04:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:04:11 INFO - Reading from file tmpfile_stdout 09:04:11 INFO - Current package versions: 09:04:11 INFO - argparse == 1.2.1 09:04:11 INFO - blessings == 1.6 09:04:11 INFO - blobuploader == 1.2.4 09:04:11 INFO - docopt == 0.6.1 09:04:11 INFO - functools32 == 3.2.3-2 09:04:11 INFO - jsonschema == 2.5.1 09:04:11 INFO - manifestparser == 1.1 09:04:11 INFO - mozInstall == 1.12 09:04:11 INFO - mozcrash == 1.0 09:04:11 INFO - mozdebug == 0.1 09:04:11 INFO - mozdevice == 0.48 09:04:11 INFO - mozfile == 1.2 09:04:11 INFO - mozhttpd == 0.7 09:04:11 INFO - mozinfo == 0.9 09:04:11 INFO - mozleak == 0.1 09:04:11 INFO - mozlog == 3.4 09:04:11 INFO - moznetwork == 0.27 09:04:11 INFO - mozprocess == 0.23 09:04:11 INFO - mozprofile == 0.28 09:04:11 INFO - mozrunner == 6.13 09:04:11 INFO - mozscreenshot == 0.1 09:04:11 INFO - mozsystemmonitor == 0.3 09:04:11 INFO - moztest == 0.7 09:04:11 INFO - mozversion == 1.4 09:04:11 INFO - psutil == 3.1.1 09:04:11 INFO - requests == 1.2.3 09:04:11 INFO - wsgiref == 0.1.2 09:04:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:11 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 0x7fe566295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e8f60>, '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 0x13e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', '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 09:04:11 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 09:04:11 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 09:04:11 INFO - Using env: {'DISPLAY': ':0', 09:04:11 INFO - 'HOME': '/home/cltbld', 09:04:11 INFO - 'LANG': 'en_US.UTF-8', 09:04:11 INFO - 'LANGUAGE': 'en_US:en', 09:04:11 INFO - 'LOGNAME': 'cltbld', 09:04:11 INFO - 'MAIL': '/var/mail/cltbld', 09:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:11 INFO - 'MOZ_NO_REMOTE': '1', 09:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:11 INFO - 'NO_EM_RESTART': '1', 09:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:11 INFO - 'PWD': '/builds/slave/test', 09:04:11 INFO - 'SHELL': '/bin/bash', 09:04:11 INFO - 'SHLVL': '1', 09:04:11 INFO - 'TERM': 'linux', 09:04:11 INFO - 'TMOUT': '86400', 09:04:11 INFO - 'USER': 'cltbld', 09:04:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', 09:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:11 INFO - '_': '/tools/buildbot/bin/python'} 09:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:11 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)) 09:04:11 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)) 09:04:11 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)) 09:04:11 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)) 09:04:11 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)) 09:04:11 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)) 09:04:11 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)) 09:04:11 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)) 09:04:11 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)) 09:04:11 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)) 09:04:11 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)) 09:04:11 INFO - Cleaning up... 09:04:11 INFO - Return code: 0 09:04:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe566295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e8f60>, '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 0x13e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', '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 09:04: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'] in /builds/slave/test/build 09:04: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 09:04:11 INFO - Using env: {'DISPLAY': ':0', 09:04:11 INFO - 'HOME': '/home/cltbld', 09:04:11 INFO - 'LANG': 'en_US.UTF-8', 09:04:11 INFO - 'LANGUAGE': 'en_US:en', 09:04:11 INFO - 'LOGNAME': 'cltbld', 09:04:11 INFO - 'MAIL': '/var/mail/cltbld', 09:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:11 INFO - 'MOZ_NO_REMOTE': '1', 09:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:11 INFO - 'NO_EM_RESTART': '1', 09:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:11 INFO - 'PWD': '/builds/slave/test', 09:04:11 INFO - 'SHELL': '/bin/bash', 09:04:11 INFO - 'SHLVL': '1', 09:04:11 INFO - 'TERM': 'linux', 09:04:11 INFO - 'TMOUT': '86400', 09:04:11 INFO - 'USER': 'cltbld', 09:04:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', 09:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:11 INFO - '_': '/tools/buildbot/bin/python'} 09:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:04:11 INFO - Cleaning up... 09:04:11 INFO - Return code: 0 09:04:11 INFO - Running post-action listener: _resource_record_post_action 09:04:11 INFO - Running post-action listener: _start_resource_monitoring 09:04:11 INFO - Starting resource monitoring. 09:04:11 INFO - [mozharness: 2016-11-21 17:04:11.601741Z] Finished create-virtualenv step (success) 09:04:11 INFO - [mozharness: 2016-11-21 17:04:11.602248Z] Running install step. 09:04:11 INFO - Running pre-action listener: _resource_record_pre_action 09:04:11 INFO - Running main action method: install 09:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:04:11 INFO - Reading from file tmpfile_stdout 09:04:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:04:11 INFO - Reading from file tmpfile_stdout 09:04:11 INFO - Output received: 09:04:11 INFO - Usage: mozinstall [options] installer 09:04:11 INFO - Options: 09:04:11 INFO - -h, --help show this help message and exit 09:04:11 INFO - -d DEST, --destination=DEST 09:04:11 INFO - Directory to install application into. [default: 09:04:11 INFO - "/builds/slave/test"] 09:04:11 INFO - --app=APP Application being installed. [default: firefox] 09:04:11 INFO - mkdir: /builds/slave/test/build/application 09:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:04:27 INFO - Reading from file tmpfile_stdout 09:04:27 INFO - Output received: 09:04:27 INFO - /builds/slave/test/build/application/firefox/firefox 09:04:27 INFO - Running post-action listener: _resource_record_post_action 09:04:27 INFO - [mozharness: 2016-11-21 17:04:27.823349Z] Finished install step (success) 09:04:27 INFO - [mozharness: 2016-11-21 17:04:27.823594Z] Running run-tests step. 09:04:27 INFO - Running pre-action listener: _resource_record_pre_action 09:04:27 INFO - Running main action method: run_tests 09:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:04:27 INFO - Python 2.7.3 09:04:27 INFO - Return code: 0 09:04:27 INFO - grabbing minidump binary from tooltool 09:04:27 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')]} 09:04:27 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 0x13e8f60>, '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 0x13e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ea1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:04:27 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 09:04:27 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 09:04:27 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 09:04:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:04:27 INFO - Return code: 0 09:04:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:04:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:04:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:04:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:04:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 09:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 09:04:27 INFO - Using env: {'DISPLAY': ':0', 09:04:27 INFO - 'HOME': '/home/cltbld', 09:04:27 INFO - 'LANG': 'en_US.UTF-8', 09:04:27 INFO - 'LANGUAGE': 'en_US:en', 09:04:27 INFO - 'LOGNAME': 'cltbld', 09:04:27 INFO - 'MAIL': '/var/mail/cltbld', 09:04:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:04:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:27 INFO - 'MOZ_NO_REMOTE': '1', 09:04:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:27 INFO - 'NO_EM_RESTART': '1', 09:04:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:27 INFO - 'PWD': '/builds/slave/test', 09:04:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:04:27 INFO - 'SHELL': '/bin/bash', 09:04:27 INFO - 'SHLVL': '1', 09:04:27 INFO - 'TERM': 'linux', 09:04:27 INFO - 'TMOUT': '86400', 09:04:27 INFO - 'USER': 'cltbld', 09:04:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225', 09:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:27 INFO - '_': '/tools/buildbot/bin/python'} 09:04:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 09:04:28 INFO - mozversion application_buildid: 20161121061609 09:04:28 INFO - mozversion application_changeset: bb1124d7df770a08acb6255289276cf5575db0b1 09:04:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:04:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:04:28 INFO - mozversion application_name: Firefox 09:04:28 INFO - mozversion application_remotingname: firefox-dev 09:04:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:04:28 INFO - mozversion application_vendor: Mozilla 09:04:28 INFO - mozversion application_version: 52.0a2 09:04:28 INFO - mozversion platform_buildid: 20161121061609 09:04:28 INFO - mozversion platform_changeset: bb1124d7df770a08acb6255289276cf5575db0b1 09:04:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:04:28 INFO - mozversion platform_version: 52.0a2 09:04:28 INFO - using testdate: 1479747868 09:04:28 INFO - actual date: 1479747868 09:04:28 INFO - starting webserver on 'localhost:59629' 09:04:28 INFO - SUITE-START | Running 2 tests 09:04:28 INFO - TEST-START | dromaeo_css 09:04:28 INFO - operating with platform_type : linux_ 09:04:28 INFO - Initialising browser for dromaeo_css test... 09:04:28 INFO - TEST-INFO | started process 3259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0JmHjE/profile http://localhost:59629/getInfo.html) 09:04:31 ERROR - PROCESS | 3259 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 09:04:33 INFO - PROCESS | 3259 | __metrics Screen width/height:1600/1200 09:04:33 INFO - PROCESS | 3259 | colorDepth:24 09:04:33 INFO - PROCESS | 3259 | Browser inner width/height: 1024/697 09:04:33 INFO - PROCESS | 3259 | __metrics 09:04:33 ERROR - PROCESS | 3259 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 09:04:34 INFO - TEST-INFO | 3259: exit 0 09:04:34 INFO - Browser initialized. 09:04:34 INFO - Running cycle 1/1 for dromaeo_css test... 09:04:34 INFO - TEST-INFO | started process 3391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0JmHjE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:46 INFO - PROCESS | 3391 | RSS: Main: 151900160 09:04:46 INFO - PROCESS | 3391 | 09:05:36 INFO - PROCESS | 3391 | 1479747936367 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] 09:07:47 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:59629/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59629/tests/dromaeo/cssquery-ext.html) 09:07:48 INFO - PROCESS | 3391 | RSS: Main: 156147712 09:07:48 INFO - PROCESS | 3391 | 09:10:50 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:59629/tests/dromaeo/cssquery-ext.html (next: http://localhost:59629/tests/dromaeo/cssquery-jquery.html) 09:10:50 INFO - PROCESS | 3391 | RSS: Main: 154132480 09:10:50 INFO - PROCESS | 3391 | 09:13:52 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:59629/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59629/tests/dromaeo/cssquery-mootools.html) 09:13:53 INFO - PROCESS | 3391 | RSS: Main: 153190400 09:13:53 INFO - PROCESS | 3391 | 09:16:55 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:59629/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59629/tests/dromaeo/cssquery-prototype.html) 09:16:55 INFO - PROCESS | 3391 | RSS: Main: 151552000 09:16:55 INFO - PROCESS | 3391 | 09:19:58 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:59629/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59629/tests/dromaeo/cssquery-yui.html) 09:19:58 INFO - PROCESS | 3391 | RSS: Main: 154583040 09:19:58 INFO - PROCESS | 3391 | 09:23:01 INFO - PROCESS | 3391 | Cycle 1(1): loaded http://localhost:59629/tests/dromaeo/cssquery-yui.html (next: http://localhost:59629/tests/dromaeo/cssquery-dojo.html) 09:23:01 INFO - PROCESS | 3391 | RSS: Main: 155385856 09:23:01 INFO - PROCESS | 3391 | 09:23:01 INFO - PROCESS | 3391 | __start_tp_report 09:23:01 INFO - PROCESS | 3391 | _x_x_mozilla_page_load 09:23:01 INFO - PROCESS | 3391 | _x_x_mozilla_page_load_details 09:23:01 INFO - PROCESS | 3391 | |i|pagename|runs| 09:23:01 INFO - PROCESS | 3391 | |0;dojo.html;3273.98363008185;3280.7211387032103;3303.388873058486;3307.908390231224;3311.983440082799;5638.492535671789;5685.374608793035;5715.885682286352;5718.199452076713;5740.626859254156;5688.914666280009;5696.458836410545;5720.084786434171;5739.827805165852;5742.626729262595;5188.688678679272;5232.947670523284;5249.921251181236;5278.3138192034985;5284.154535274357;5276.472352764712;5283.181106928432;5283.947160528384;5288.814891478799;5323.9467605324035;5198;5226.320578324831;5302;5304.761285742132;5306.389765176996;5178.8705282368055;5215.348081489814;5216.400113986902;5235.528802407764;5322.840314790563;5228.058949389108;5249.212618107276;5316.016536940679;5334.5732341412595;5339.252504649352;5738.885222295572;5795.82612521625;5801.796937107181;5854.882902341929;5858.41415858415;6070.908936365914;6086.391360863879;6092;6166.84582885427;6179.969100154471;6142.812908896602;6177.227846519185;6194.969025154845;6203.906941395882;6232.127502149703;5617.297837770278;5750.511206547407;5765.106408506688;5785.681787501686;5786.247787787561;6129.816105516842;6140.381550880983;6158.599691020159;6163.476104531075;6231;6015.30823955242;6032.728527216286;6046.153538504613;6048.751278660659;6072.574919755575;6085.208922840003;6112.144299798032;6143.477804386677;6162.26052873649;6162.383761623802;5938.524918006549;5961.910571341434;5981.431763982415;6008.969955150284;6029.3669164737075;6104.97815029019;6111.682900513672;6144.569880108439;6145.907811382833;6158.538109641795;4692.436907571113;4716.3632909557455;4731.597814185764;4738.218193997952;4751.881202969954;4129.607687269705;4168.228877657643;4246.554111818276;4248.511421186541;4280.636145927631;5731.398203188689;5754.827355179351;5757.539396848242;5802.941970580325;5910.7931222407005;5997.760089596454;6033.42682445167;6067.150598916155;6067.908981365194;6119.724612392453;5725.198472213893;5791.507721843606;5832.358440571534;5840.3575606683235;5861.17943487912;5240.737963101829;5241.213817927342;5262.500062494057;5296.073187192226;5324.520793128637;6470.288268290485;6485.805425837232;6488.318726533646;6506.284308726036;6508.902366464602;6098.237720284965;6169.136320915165;6174.722137503733;6189.319174890848;6201.875962480815;6217.4715149212825;6246.593971391845;6346.07981842621;6370.331115232834;6475.935240647534;6084.695765211633;6088.908666370096;6095.969520152371;6100.511959043355;6133.110698948717;6159.81520554384;6177.62934223948;6182.412670796267;6191.25704915413;6204.069389591416;5829.7959571416495;5851;5883.441073098049;6028.969855150696;6047.516198704006;5882.882342353043;5932.555058370725;5978.252718410199;6003.189569408074;6016.4585187331595;5836.678982655994;5869.236999190078;5891.263592050994;5921.940780592311;5923.555733319932;5840.620359676607;5947.851303717269;5952.404759524013;6023.3073196582955;6026.90959635597;5852.18069470283;5887.852803679943;5918.053111502139;5941.197938278277;5995.46040856325 09:23:01 INFO - PROCESS | 3391 | |1;ext.html;570.7060863655219;628.949684025278;657.6941722099223;666.9199696036476;676.976305829296;42715.14569708604;43254.351184732215;43761.781191094036;47725.52274477254;48012.75993620027;45796.77101614487;46088;46147;46207.537924620825;46282.76858615702;8802.779930501742;8978.326625503114;9043.050479699636;9050.502222377767;9060.954695226515;8786.516741579211;8879.644814207424;8883.95558022209;8900.287976961827;8960.10398960102;8960.23837973773;9006.729798106067;9019.368644194908;9026.864597031017;9028.548572571379;8954.104589541059;8962.238209752179;8963.955180224057;8989.505577193251;9001.324900632446;8888.377813553054;8890.688825891128;8923.643054277822;8938.68714594986;8959.41763785352;42516;42628.147437051084;42729.863506824535;42830.1433971322;43102.353464698055;3463.7748546344405;3766.6610005099674;4017.959820401788;4020.396940458925;4356.215881141393;32421.351572968644;32614;32927.176820579436;33042.66957330444;33115.337693246;4375.562443755631;4414.514403415622;4435.68950173488;4505.842295519674;4560.361549383089;330262;332288.3385583081;333297;334652;336288;60608.696956514934;60632;61138;61363.079553806725;61367.238474268765;64478.677606611665;64482;64701.352986470476;64705;64709.67645161744;17581.912090439466;17774.644507109784;17937.820621793617;17948;17972.281108755764;13649;13676.452941882413;13696.589102326947;13848.515301964382;13899.930500347433;16979.15104244783;17763.822361776216;17781.46655600334;17894.91052544729;17945.910270448563;6065.211522502046;6134.294556126102;6376.681165941684;6382.648954307558;6394.5843520171975;985.3201291109111;1111.7609713911547;1151.6775302915198;1216.7748966441236;1231.9630411087683;32229.51655725166;32275.193120171713;32608.510872336934;32627.51058734121;33150;1093.2456604942565;1170.5493385046818;1171.2094336322948;1213.3205404973066;1238.9814152787715;17281.740773888403;17515.82484175142;17566.736498952527;17573.12134393275;17678.381256655954;519745;524269;524718;525354;526893;61384.38615613876;61451.385486144565;61586.69206653938;61602.69198653978;61637.38362616406;1370.6367812529688;1388.4168649167173;1417.4755340523866;1419.9645008874654;1430.356339647142;30716.692833072277;31662.208444789063;32114.357712845143;32540.349193016482;33180;54127.72936135294;54342.45657543374;54462.7276863629;54630;54714.452855472526;440757;442531;443548;444127;448563;43149.78425107854;43696.781516093484;44161.33757993569;44615;44731.776341118086;50083;50119.49880501294;50216.74891625519;51083;51562.22656660078;42821.571784283005;42907.570924290354;43198.78400608103;43284.78357608318;44134.77932610316;41826.58173418227;42491.7875410621;42625.36061959135;43233.13533729245;43433.56566434421;37471.43792843164;38850;40815.795921021396;42868;45934.540654593024;37313.25373492569;37663.05842353963;38108.618913810504;38730;38853.611463885;28802.135935921957;29381.265468362606;29625.25936851596;29752.70247297586;29770.553441698827 09:23:01 INFO - PROCESS | 3391 | |2;jquery.html;415.4412315435738;419.6055707634825;422.8604560495036;438.145616048705;438.66442171738623;18535.351262705808;19807.40577782667;20313.695294570574;20795.688064679005;21040;19601.803981960176;20099.095540700666;20128.39614811558;20207.59584808303;20310.390688279338;5525.336959564847;5851.180834683148;5858.73635686393;5862.237909071815;5877.588568800185;4253.532111467736;5748.856278593027;5837.182794408786;6220.346863579327;6334;6407.391297826723;6422.614643121405;6437.130987316699;6438.259600145973;6438.356164383571;6223.688815559227;6434.806955791334;6455.677216139221;6471.644059576722;6480.092787009822;5550.333959924795;5577.247071645316;5745.540356771448;5754.482096611325;5779.682117483537;24230.636540451906;24233.515329693484;24256.1510347137;24408;24506;2241.663750437431;2260.660900864867;2475.7029156501153;2869.03887197789;3011.728944394993;14702.411903523845;15125.697486050327;15126.470573529874;15456.922715386463;15593.766093508606;1915.82757551821;1933.9323123690604;1964.911578978935;2005.5487515309085;2008.2268326694182;84487;84793;85222;85744;86516;11075.72310692239;11414.94292528532;11472.77054458906;11473.311601303949;11824.822627660593;15988.600284992735;16094.839051609568;16155.515334539983;16182.75725864113;16247.918760406123;8201.26188643025;8608.870866937;8677.6528938843;8771.692990745421;8834.249088827393;8324.750257492286;8459.280961118375;8546.760719695734;8669.739907802776;8727.432716873383;6742.190937087483;6890.345417185359;6916.6541672916155;6960.582365058112;6988.091548098715;1746.1531157388656;1845.6895604121225;1848.196034724899;2014.21445636202;2025.2506572568243;909.8407778638712;970.7184916374173;978.2076518020426;1051.2168434516334;1057.5875408590655;17974.2810287587;19410.320638777575;19466.70799938002;19570.70643940342;19881.30415435453;955.527014128011;968.6900191938653;975.3708857786688;997.5336255704103;1073.0557109743377;10761.623343182951;11039.83440248397;11079.72300692489;11103.333799972028;11174.441277936234;498190;504270;506592;512343;512584;91756;91871.5406422977;91898.54050729703;92228;94131;1010.9646162384429;1033.7415646088477;1050.99474502627;1055.672741450153;1062.2988827374052;17265.654686905942;17447.651046978735;17626.11334827714;17718.291268349636;17879.910600446914;42380;43872.34191487194;44334;44477.33284000678;44778.55221447744;56766;59781;60120.699396502736;61486;62034.37965620286;7966.760997170094;7984.8802267967185;8061.186233097506;8077.959610201911;8108.2297181767635;11037.282576632815;12552.43514041852;13743;13873.791893121814;14088.506902258372;11092.835252298393;11928;11944.522219111139;12595.433205505591;12690.555830545887;11543.307401555598;11830.46762895689;11870.347130907883;12174.39128043612;12436.440360183995;11728.824067638821;11862.288262704265;11908.106891983309;12039.819402709141;12041.75916481648;8899.377043607145;9052.728418147466;9057;9082.682106126254;9217.493037882712;11940.16418850707;12110.697232568904;12231;12277.69305767363;12390.442430090849 09:23:01 INFO - PROCESS | 3391 | |3;mootools.html;1464.165425707347;1532.9386824527019;1664.8751343649221;1783.8572914166868;1804.0348413598736;7931.325837303822;8178.79553011175;8480.279176270016;9043.547822608867;9056.547172641367;8425.241728244457;8672.30621550276;8697.47815131091;8876.068012858654;8923.776905577348;2456.6192240202754;2483.255023492954;2484.7391023942496;2493.588557887955;2496.8002559795264;2415.1184817541557;2528.456381877896;2556.2842404126873;2561.487702459506;2563.7179910209957;2431.2463136427677;2454.864982425966;2476.182859656309;2510.585753350704;2511.7613826686434;2343.94140146496;2347.2019513365367;2371.027878569787;2378.3102900158933;2384.7615238476187;2417.347316224627;2454.7177074636465;2460.987695061531;2471.2586224132688;2476.8018558515278;8665.17680820321;8680;8769.473831570127;8773.824523509558;8781.429207101519;5404.135338345845;5512.035393806068;5526.972365138189;5530.087535556629;5534.75093620788;3469.930601387958;3529.347070791912;3576.660217279354;3579.2483578448555;3626.4197728363597;1149.6321177223292;1160.7446361800392;1172.7009612548745;1207.2816674078908;1217.3852204636603;12332.753344933051;12410.81383779244;12419.689507762288;12448.502059917593;12560.309182995023;4710.939993616353;4838.346823178897;4930.8767280818265;4947.233178857283;5058.924116138261;10345;10392.220583456272;10427.11369533583;10466.267361284788;10477.37135771856;5647.040003199466;5689.857753556194;5692.658440493584;5696.743646535916;5700.173474846124;4619.284010978304;4854.417469903634;5132.563732082815;5151.6908985461;5246.055709972242;4115.855161331683;4147.336426171798;4192.308269135619;4200.5169405518145;4202.096549241927;1374.9587512374644;1386.757317469459;1403.985960140406;1414.7382734194207;1427.0866645346987;986.6497393425374;987.012987012987;998.0867506231862;1001.4742260313394;1008.1178968402647;5900.232969713996;5945.791897283574;5997.430244126801;6053.909191362133;6122.418370254819;457.757388584051;467.7497538816785;472.86759707282016;485.980560777572;490.75952783136006;4048.8987775305263;4120.361343991686;4148.2947898857265;4182.079942412664;4255.446791917031;10581.206409519316;10738.838917416246;10804.459777011118;10818.783624327627;10964.451777411257;10733.08768754649;10806.459677016117;10811.78376432467;10842.457877106272;10849.349039057683;8197.50814951093;8388.11924747905;8423.831523369498;8438.957805211057;8469.788255293544;5945.044298171064;6017.729202185825;6030.336662967158;6058.0610005449225;6061.848453788691;9790.363626364264;9795.33479308505;9806.950965245129;9869.259805514472;9939.503024848873;10100.44447555362;10124.088832005154;10124.949375253076;10156.746081348025;10257.17942564608;7108.111486064242;7231.63841807918;7302;7731.652075656497;7856.332211761835;8482.236598706146;8487.811706360992;8534.23191912706;8544.786380340292;8565.871511927202;7522.022137122358;7535.886961695689;7571;7579.734709285149;7767.417443691858;7284.708611655475;7350.448716346403;7412.518186317872;7440.702371905063;7467.92532074694;6965.303469652994;7056.047433596399;7061.752838650623;7075.469339799639;7079.964600176966;4900.92648610264;4989.126902791924;4999.800007999639;5025.924611130763;5068.670536415121;5146.099432599355;5172.586193104617;5233.241180028798;5247.580193584427;5328.440513746001 09:23:01 INFO - PROCESS | 3391 | |4;prototype.html;352.3288136100728;358.2887967384741;359.68347853888577;362.6862763709392;367.7756568493217;5533.418991005947;5571.498565129137;5577.330720313563;5613.915791263134;5621.718914054301;5512.944870551293;5513.669179849212;5518.724063796804;5527.806526771564;5555.2778138841995;4248.87253382399;4296.377025331325;4353.412289340946;4363.258246098171;4383.452068491439;4343.717658352213;4345.956540434587;4354.1944740223;4356;4366.476022877259;4301.720388174775;4336.978315108436;4340.717853339539;4351.543087975749;4355;4114.732542384751;4272.060146767706;4325.762083085429;4342.261815491374;4346.456692913386;3808.7905165215902;3825.48355971943;3829.215010922754;3840.615938406165;3855.2289542091694;5381.569474442074;5386.569074474072;5387.973060134675;5397.4062853086125;5422.2951016368015;4862.294967229732;4917.901641967141;4924.630652701062;4973.726445045521;5000.799968001275;5709.9714501427225;5724.771009159628;5750.511206547449;5769.336526299488;5780.595358324919;4191.497020357546;4200.558941311149;4201.642860356873;4233.25917964355;4239.194553034913;5806.854828629276;5829.271341082364;5931.881362372728;6023.578349515536;6041;4265.971160476097;4282.5075116361395;4306.784660766949;4310.6335961443;4316.525182229952;4344.782760861945;4346.130773845181;4352.347147927836;4355.934660980088;4361.171377438277;4896.755162241873;4933.186024306021;4936.67911585753;4949.950500495021;4979;5801.375614827855;5812.273465816773;5831.708414579339;5847.210626565445;5847.356790753014;1432.957011289663;1435.4904009076836;1440.6038339456525;1444.7543917534044;1453.2878889344356;974.9714051675409;992.2558081438921;995.4375777685584;1013.7060252526832;1030.7474668706066;5480.835574932758;5491.791805802717;5503.183949296723;5512.200730893998;5570.220169176318;5760.798372056958;5796.797112101056;5798.82603521895;5799.738102140169;5813.59304848665;5319.494648008433;5427.810026649048;5485.232067510552;5516.724163791794;5580.972095139579;3056.1748327951327;3061.4131059254896;3074.9231269218003;3095.1797773590015;3108.559780572285;5907.7046147692445;5997.880042399128;6067.635941843503;6108.51131909455;6131.417515336036;5869.7673488567025;5877.52979761618;5877.647341159544;5880.4416829540205;5888.735006924699;6027.156198132265;6037.9396206038255;6052.788152414732;6082.847928801815;6097.17688112108;5456.7544460498575;5542.900531510939;5646.153077038312;5672.914906276326;5755.7409916553015;5657.397597105378;5667.631603945731;5673.574481913791;5675.134057301037;5728.255326807488;6063.6664983426335;6134.202553667995;6258.780942666985;6311.179546658905;6332.366763323631;4286.978565107154;4295.935560966525;4317.935230971475;4318.78406079701;4326.978365108154;5820.359760426265;6059.09113632941;6088.695565221809;6099.329073801967;6102.603330783485;5850.6782126981725;5868.09044598088;5870.26621672291;5873.618214816023;5884.911726324194;5860.619059761102;5907.527397808251;5910.024845900551;5917.556183286357;5955.40445955401;5614.06314821386;5815.82552523425;5833;5868.530517558671;5904.940950590611;5815.82552523425;5909.527237820878;5941.366124315848;5945.256842894638;5998.8500287491415;5625.437456254342;5734.913976290442;5820.330661973927;5825.737841797214;5827.650340979555 09:23:01 INFO - PROCESS | 3391 | |5;yui.html;789.1516619633893;793.6626933553242;795.9721409750659;850.9702160424387;902.8329758994587;14166.787498187536;14727.748141407967;14971.850281497182;15099.849001509981;16067.437639682614;13662.521811736591;13812.79280810786;13821.101628394148;13952.093113947587;13977.860221397783;827.5986146718836;856.3919617071871;875.2472873328932;875.3916028360292;876.5222953490331;853.799357151069;862.7498025572577;864.2955990867455;864.8789169516241;865.8917635295588;900.4372267332917;904.1139683110556;906.4063038709655;907.8774365460645;908.3686837647838;902.4449963272606;903.0292435631657;903.6024149374255;904.1004200820161;905.0813424374265;656.4944992355908;657.9605223686594;659.7163219815477;660.8711301296249;660.8909529927556;14578.343974521173;14754.409823607042;14966;15095.924520377328;15112.319945602365;14799.112053276838;14885.181315027668;15203.315850786741;15288.541343759594;15360.846391536053;11623.709407264801;11804.763904721944;11807.468663910146;11947.820782688266;12038.4582693779;3868.7678739275734;3887.7472964257518;3896.4544963705102;3897.8635747748694;3907.4529565860803;70864.29135708629;72033;72958.63520682415;75163.24836751618;75220.62389688072;11177.44112794357;11182.608608698656;11189.216754827246;11231.326120432801;11270.154738394653;20498.795012049988;20777.688334674993;20818.27136050231;20908.16367345289;21041.263555775473;8104.270615644502;8362.665493380196;8489;8496.66013359471;8598.441101328393;4543.25036369002;4574.4510658721165;4615.469221039623;4721.709970664225;4797.232442809203;3448.5516882805073;3498.0555250082334;3507.7719948203285;3539;3542.2384187399316;584.3980699879131;590.3388205210192;595.1434703123696;595.657496939253;615.5291202230297;687.8933765266391;695.6660802814678;767.7658314214218;774.3650206830345;794.3843521271061;9574;9612;9775.853362199572;9868.654597089067;10051.497425128715;719.0939416335455;732.8131326511811;773.818152734107;788.7633709887126;800.7557694903111;4594.977025114853;4917.65576409655;4949.826756063592;4989.276554899519;5017.422996355393;59185.40814591885;59883;92243;94347.58478622827;95534.5223273893;51381;52307.95384092297;63404.68297658482;72363;72759.27240727525;44542.55457445449;46226.30660540095;59281.40718592759;67443.3255667437;68136.318636813;9325.487098209664;9595;9768.26737994639;9968.900310997087;9972.60109595608;35021.64978350184;46020.30969535527;46514.76742616265;47285.763571181924;48165.75917120392;61260;65253;65257.67371163114;65310;65676;11978.700532486757;12777;12804.743905121659;12878.742425151631;13354.599362019155;12709.491620335453;14737.631559211106;14903.254837257877;14986.325615347554;15105.622359441102;11820.40897955116;11861.762764744484;11968.581099661471;12004.09969252327;12047.337396442928;13867.930660346634;14026.65631856262;14691.706165876836;15044.849551504345;15269.312880920163;12802.551910683082;13034.217946923214;13497.257650829299;13851.445942162201;13949.093308934887;11192.664220073411;11451.770964580495;11549.826752598885;11582.768344633228;11583.826242606536;12087.39563021863;12155.392230388268;12358.382080896099;12392.75214495723;12448.25310481374 09:23:01 INFO - PROCESS | 3391 | __end_tp_report 09:23:01 INFO - PROCESS | 3391 | __start_cc_report 09:23:01 INFO - PROCESS | 3391 | _x_x_mozilla_cycle_collect,308 09:23:01 INFO - PROCESS | 3391 | __end_cc_report 09:23:01 INFO - PROCESS | 3391 | __startTimestamp1479748981471__endTimestamp 09:23:01 INFO - PROCESS | 3391 | 09:23:01 INFO - PROCESS | 3391 | ------- Summary: start ------- 09:23:01 INFO - PROCESS | 3391 | Number of tests: 6 09:23:01 INFO - PROCESS | 3391 | 09:23:01 INFO - PROCESS | 3391 | [#0] dojo.html Cycles:165 Average:5702.02 Median:5887.85 stddev:639.20 (10.9%) stddev-sans-first:612.12 09:23:01 INFO - PROCESS | 3391 | Values: 3274.0 3280.7 3303.4 3307.9 3312.0 5638.5 5685.4 5715.9 5718.2 5740.6 5688.9 5696.5 5720.1 5739.8 5742.6 5188.7 5232.9 5249.9 5278.3 5284.2 5276.5 5283.2 5283.9 5288.8 5323.9 5198.0 5226.3 5302.0 5304.8 5306.4 5178.9 5215.3 5216.4 5235.5 5322.8 5228.1 5249.2 5316.0 5334.6 5339.3 5738.9 5795.8 5801.8 5854.9 5858.4 6070.9 6086.4 6092.0 6166.8 6180.0 6142.8 6177.2 6195.0 6203.9 6232.1 5617.3 5750.5 5765.1 5785.7 5786.2 6129.8 6140.4 6158.6 6163.5 6231.0 6015.3 6032.7 6046.2 6048.8 6072.6 6085.2 6112.1 6143.5 6162.3 6162.4 5938.5 5961.9 5981.4 6009.0 6029.4 6105.0 6111.7 6144.6 6145.9 6158.5 4692.4 4716.4 4731.6 4738.2 4751.9 4129.6 4168.2 4246.6 4248.5 4280.6 5731.4 5754.8 5757.5 5802.9 5910.8 5997.8 6033.4 6067.2 6067.9 6119.7 5725.2 5791.5 5832.4 5840.4 5861.2 5240.7 5241.2 5262.5 5296.1 5324.5 6470.3 6485.8 6488.3 6506.3 6508.9 6098.2 6169.1 6174.7 6189.3 6201.9 6217.5 6246.6 6346.1 6370.3 6475.9 6084.7 6088.9 6096.0 6100.5 6133.1 6159.8 6177.6 6182.4 6191.3 6204.1 5829.8 5851.0 5883.4 6029.0 6047.5 5882.9 5932.6 5978.3 6003.2 6016.5 5836.7 5869.2 5891.3 5921.9 5923.6 5840.6 5947.9 5952.4 6023.3 6026.9 5852.2 5887.9 5918.1 5941.2 5995.5 09:23:01 INFO - PROCESS | 3391 | 09:23:01 INFO - PROCESS | 3391 | [#1] ext.html Cycles:180 Average:60959.26 Median:24036.17 stddev:116615.26 (485.2%) stddev-sans-first:116854.26 09:23:01 INFO - PROCESS | 3391 | Values: 570.7 628.9 657.7 666.9 677.0 42715.1 43254.4 43761.8 47725.5 48012.8 45796.8 46088.0 46147.0 46207.5 46282.8 8802.8 8978.3 9043.1 9050.5 9061.0 8786.5 8879.6 8884.0 8900.3 8960.1 8960.2 9006.7 9019.4 9026.9 9028.5 8954.1 8962.2 8964.0 8989.5 9001.3 8888.4 8890.7 8923.6 8938.7 8959.4 42516.0 42628.1 42729.9 42830.1 43102.4 3463.8 3766.7 4018.0 4020.4 4356.2 32421.4 32614.0 32927.2 33042.7 33115.3 4375.6 4414.5 4435.7 4505.8 4560.4 330262.0 332288.3 333297.0 334652.0 336288.0 60608.7 60632.0 61138.0 61363.1 61367.2 64478.7 64482.0 64701.4 64705.0 64709.7 17581.9 17774.6 17937.8 17948.0 17972.3 13649.0 13676.5 13696.6 13848.5 13899.9 16979.2 17763.8 17781.5 17894.9 17945.9 6065.2 6134.3 6376.7 6382.6 6394.6 985.3 1111.8 1151.7 1216.8 1232.0 32229.5 32275.2 32608.5 32627.5 33150.0 1093.2 1170.5 1171.2 1213.3 1239.0 17281.7 17515.8 17566.7 17573.1 17678.4 519745.0 524269.0 524718.0 525354.0 526893.0 61384.4 61451.4 61586.7 61602.7 61637.4 1370.6 1388.4 1417.5 1420.0 1430.4 30716.7 31662.2 32114.4 32540.3 33180.0 54127.7 54342.5 54462.7 54630.0 54714.5 440757.0 442531.0 443548.0 444127.0 448563.0 43149.8 43696.8 44161.3 44615.0 44731.8 50083.0 50119.5 50216.7 51083.0 51562.2 42821.6 42907.6 43198.8 43284.8 44134.8 41826.6 42491.8 42625.4 43233.1 43433.6 37471.4 38850.0 40815.8 42868.0 45934.5 37313.3 37663.1 38108.6 38730.0 38853.6 28802.1 29381.3 29625.3 29752.7 29770.6 09:23:01 INFO - PROCESS | 3391 | 09:23:01 INFO - PROCESS | 3391 | [#2] jquery.html Cycles:180 Average:30164.81 Median:2672.37 stddev:83497.57 (3124.5%) stddev-sans-first:83701.92 09:23:01 INFO - PROCESS | 3391 | Values: 415.4 419.6 422.9 438.1 438.7 18535.4 19807.4 20313.7 20795.7 21040.0 19601.8 20099.1 20128.4 20207.6 20310.4 5525.3 5851.2 5858.7 5862.2 5877.6 4253.5 5748.9 5837.2 6220.3 6334.0 6407.4 6422.6 6437.1 6438.3 6438.4 6223.7 6434.8 6455.7 6471.6 6480.1 5550.3 5577.2 5745.5 5754.5 5779.7 24230.6 24233.5 24256.2 24408.0 24506.0 2241.7 2260.7 2475.7 2869.0 3011.7 14702.4 15125.7 15126.5 15456.9 15593.8 1915.8 1933.9 1964.9 2005.5 2008.2 84487.0 84793.0 85222.0 85744.0 86516.0 11075.7 11414.9 11472.8 11473.3 11824.8 15988.6 16094.8 16155.5 16182.8 16247.9 8201.3 8608.9 8677.7 8771.7 8834.2 8324.8 8459.3 8546.8 8669.7 8727.4 6742.2 6890.3 6916.7 6960.6 6988.1 1746.2 1845.7 1848.2 2014.2 2025.3 909.8 970.7 978.2 1051.2 1057.6 17974.3 19410.3 19466.7 19570.7 19881.3 955.5 968.7 975.4 997.5 1073.1 10761.6 11039.8 11079.7 11103.3 11174.4 498190.0 504270.0 506592.0 512343.0 512584.0 91756.0 91871.5 91898.5 92228.0 94131.0 1011.0 1033.7 1051.0 1055.7 1062.3 17265.7 17447.7 17626.1 17718.3 17879.9 42380.0 43872.3 44334.0 44477.3 44778.6 56766.0 59781.0 60120.7 61486.0 62034.4 7966.8 7984.9 8061.2 8078.0 8108.2 11037.3 12552.4 13743.0 13873.8 14088.5 11092.8 11928.0 11944.5 12595.4 12690.6 11543.3 11830.5 11870.3 12174.4 12436.4 11728.8 11862.3 11908.1 12039.8 12041.8 8899.4 9052.7 9057.0 9082.7 9217.5 11940.2 12110.7 12231.0 12277.7 12390.4 09:23:01 INFO - PROCESS | 3391 | 09:23:01 INFO - PROCESS | 3391 | [#3] mootools.html Cycles:180 Average:5834.46 Median:2695.84 stddev:3248.75 (120.5%) stddev-sans-first:3241.26 09:23:01 INFO - PROCESS | 3391 | Values: 1464.2 1532.9 1664.9 1783.9 1804.0 7931.3 8178.8 8480.3 9043.5 9056.5 8425.2 8672.3 8697.5 8876.1 8923.8 2456.6 2483.3 2484.7 2493.6 2496.8 2415.1 2528.5 2556.3 2561.5 2563.7 2431.2 2454.9 2476.2 2510.6 2511.8 2343.9 2347.2 2371.0 2378.3 2384.8 2417.3 2454.7 2461.0 2471.3 2476.8 8665.2 8680.0 8769.5 8773.8 8781.4 5404.1 5512.0 5527.0 5530.1 5534.8 3469.9 3529.3 3576.7 3579.2 3626.4 1149.6 1160.7 1172.7 1207.3 1217.4 12332.8 12410.8 12419.7 12448.5 12560.3 4710.9 4838.3 4930.9 4947.2 5058.9 10345.0 10392.2 10427.1 10466.3 10477.4 5647.0 5689.9 5692.7 5696.7 5700.2 4619.3 4854.4 5132.6 5151.7 5246.1 4115.9 4147.3 4192.3 4200.5 4202.1 1375.0 1386.8 1404.0 1414.7 1427.1 986.6 987.0 998.1 1001.5 1008.1 5900.2 5945.8 5997.4 6053.9 6122.4 457.8 467.7 472.9 486.0 490.8 4048.9 4120.4 4148.3 4182.1 4255.4 10581.2 10738.8 10804.5 10818.8 10964.5 10733.1 10806.5 10811.8 10842.5 10849.3 8197.5 8388.1 8423.8 8439.0 8469.8 5945.0 6017.7 6030.3 6058.1 6061.8 9790.4 9795.3 9807.0 9869.3 9939.5 10100.4 10124.1 10124.9 10156.7 10257.2 7108.1 7231.6 7302.0 7731.7 7856.3 8482.2 8487.8 8534.2 8544.8 8565.9 7522.0 7535.9 7571.0 7579.7 7767.4 7284.7 7350.4 7412.5 7440.7 7467.9 6965.3 7056.0 7061.8 7075.5 7080.0 4900.9 4989.1 4999.8 5025.9 5068.7 5146.1 5172.6 5233.2 5247.6 5328.4 09:23:01 INFO - PROCESS | 3391 | 09:23:01 INFO - PROCESS | 3391 | [#4] prototype.html Cycles:180 Average:4879.00 Median:5538.16 stddev:1424.94 (25.7%) stddev-sans-first:1387.84 09:23:01 INFO - PROCESS | 3391 | Values: 352.3 358.3 359.7 362.7 367.8 5533.4 5571.5 5577.3 5613.9 5621.7 5512.9 5513.7 5518.7 5527.8 5555.3 4248.9 4296.4 4353.4 4363.3 4383.5 4343.7 4346.0 4354.2 4356.0 4366.5 4301.7 4337.0 4340.7 4351.5 4355.0 4114.7 4272.1 4325.8 4342.3 4346.5 3808.8 3825.5 3829.2 3840.6 3855.2 5381.6 5386.6 5388.0 5397.4 5422.3 4862.3 4917.9 4924.6 4973.7 5000.8 5710.0 5724.8 5750.5 5769.3 5780.6 4191.5 4200.6 4201.6 4233.3 4239.2 5806.9 5829.3 5931.9 6023.6 6041.0 4266.0 4282.5 4306.8 4310.6 4316.5 4344.8 4346.1 4352.3 4355.9 4361.2 4896.8 4933.2 4936.7 4950.0 4979.0 5801.4 5812.3 5831.7 5847.2 5847.4 1433.0 1435.5 1440.6 1444.8 1453.3 975.0 992.3 995.4 1013.7 1030.7 5480.8 5491.8 5503.2 5512.2 5570.2 5760.8 5796.8 5798.8 5799.7 5813.6 5319.5 5427.8 5485.2 5516.7 5581.0 3056.2 3061.4 3074.9 3095.2 3108.6 5907.7 5997.9 6067.6 6108.5 6131.4 5869.8 5877.5 5877.6 5880.4 5888.7 6027.2 6037.9 6052.8 6082.8 6097.2 5456.8 5542.9 5646.2 5672.9 5755.7 5657.4 5667.6 5673.6 5675.1 5728.3 6063.7 6134.2 6258.8 6311.2 6332.4 4287.0 4295.9 4317.9 4318.8 4327.0 5820.4 6059.1 6088.7 6099.3 6102.6 5850.7 5868.1 5870.3 5873.6 5884.9 5860.6 5907.5 5910.0 5917.6 5955.4 5614.1 5815.8 5833.0 5868.5 5904.9 5815.8 5909.5 5941.4 5945.3 5998.9 5625.4 5734.9 5820.3 5825.7 5827.7 09:23:01 INFO - PROCESS | 3391 | 09:23:01 INFO - PROCESS | 3391 | [#5] yui.html Cycles:180 Average:17440.74 Median:26003.74 stddev:22282.31 (85.7%) stddev-sans-first:22309.73 09:23:01 INFO - PROCESS | 3391 | Values: 789.2 793.7 796.0 851.0 902.8 14166.8 14727.7 14971.9 15099.8 16067.4 13662.5 13812.8 13821.1 13952.1 13977.9 827.6 856.4 875.2 875.4 876.5 853.8 862.7 864.3 864.9 865.9 900.4 904.1 906.4 907.9 908.4 902.4 903.0 903.6 904.1 905.1 656.5 658.0 659.7 660.9 660.9 14578.3 14754.4 14966.0 15095.9 15112.3 14799.1 14885.2 15203.3 15288.5 15360.8 11623.7 11804.8 11807.5 11947.8 12038.5 3868.8 3887.7 3896.5 3897.9 3907.5 70864.3 72033.0 72958.6 75163.2 75220.6 11177.4 11182.6 11189.2 11231.3 11270.2 20498.8 20777.7 20818.3 20908.2 21041.3 8104.3 8362.7 8489.0 8496.7 8598.4 4543.3 4574.5 4615.5 4721.7 4797.2 3448.6 3498.1 3507.8 3539.0 3542.2 584.4 590.3 595.1 595.7 615.5 687.9 695.7 767.8 774.4 794.4 9574.0 9612.0 9775.9 9868.7 10051.5 719.1 732.8 773.8 788.8 800.8 4595.0 4917.7 4949.8 4989.3 5017.4 59185.4 59883.0 92243.0 94347.6 95534.5 51381.0 52308.0 63404.7 72363.0 72759.3 44542.6 46226.3 59281.4 67443.3 68136.3 9325.5 9595.0 9768.3 9968.9 9972.6 35021.6 46020.3 46514.8 47285.8 48165.8 61260.0 65253.0 65257.7 65310.0 65676.0 11978.7 12777.0 12804.7 12878.7 13354.6 12709.5 14737.6 14903.3 14986.3 15105.6 11820.4 11861.8 11968.6 12004.1 12047.3 13867.9 14026.7 14691.7 15044.8 15269.3 12802.6 13034.2 13497.3 13851.4 13949.1 11192.7 11451.8 11549.8 11582.8 11583.8 12087.4 12155.4 12358.4 12392.8 12448.3 09:23:01 INFO - PROCESS | 3391 | -------- Summary: end -------- 09:23:01 INFO - PROCESS | 3391 | 09:23:02 INFO - TEST-INFO | 3391: exit 0 09:23:02 INFO - TEST-OK | dromaeo_css | took 1114219ms 09:23:02 INFO - TEST-START | kraken 09:23:02 INFO - operating with platform_type : linux_ 09:23:02 INFO - Initialising browser for kraken test... 09:23:02 INFO - TEST-INFO | started process 3767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2p2N_D/profile http://localhost:59629/getInfo.html) 09:23:05 ERROR - PROCESS | 3767 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 09:23:07 INFO - PROCESS | 3767 | __metrics Screen width/height:1600/1200 09:23:07 INFO - PROCESS | 3767 | colorDepth:24 09:23:07 INFO - PROCESS | 3767 | Browser inner width/height: 1024/697 09:23:07 INFO - PROCESS | 3767 | __metrics 09:23:07 ERROR - PROCESS | 3767 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 09:23:08 INFO - TEST-INFO | 3767: exit 0 09:23:08 INFO - Browser initialized. 09:23:08 INFO - Running cycle 1/1 for kraken test... 09:23:08 INFO - TEST-INFO | started process 3904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2p2N_D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:20 INFO - PROCESS | 3904 | RSS: Main: 152031232 09:23:20 INFO - PROCESS | 3904 | 09:23:23 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59629/tests/kraken/driver.html?testName=audio-beat-detection) 09:23:24 INFO - PROCESS | 3904 | RSS: Main: 157478912 09:23:24 INFO - PROCESS | 3904 | 09:23:26 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59629/tests/kraken/driver.html?testName=audio-dft) 09:23:27 INFO - PROCESS | 3904 | RSS: Main: 155537408 09:23:27 INFO - PROCESS | 3904 | 09:23:30 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59629/tests/kraken/driver.html?testName=audio-fft) 09:23:30 INFO - PROCESS | 3904 | RSS: Main: 156049408 09:23:30 INFO - PROCESS | 3904 | 09:23:32 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59629/tests/kraken/driver.html?testName=audio-oscillator) 09:23:33 INFO - PROCESS | 3904 | RSS: Main: 155693056 09:23:33 INFO - PROCESS | 3904 | 09:23:35 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59629/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:23:36 INFO - PROCESS | 3904 | RSS: Main: 155455488 09:23:36 INFO - PROCESS | 3904 | 09:23:39 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59629/tests/kraken/driver.html?testName=imaging-darkroom) 09:23:39 INFO - PROCESS | 3904 | RSS: Main: 158380032 09:23:39 INFO - PROCESS | 3904 | 09:23:43 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59629/tests/kraken/driver.html?testName=imaging-desaturate) 09:23:43 INFO - PROCESS | 3904 | RSS: Main: 158490624 09:23:43 INFO - PROCESS | 3904 | 09:23:46 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59629/tests/kraken/driver.html?testName=json-parse-financial) 09:23:47 INFO - PROCESS | 3904 | RSS: Main: 158990336 09:23:47 INFO - PROCESS | 3904 | 09:23:48 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59629/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:23:49 INFO - PROCESS | 3904 | RSS: Main: 157556736 09:23:49 INFO - PROCESS | 3904 | 09:23:51 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:23:51 INFO - PROCESS | 3904 | RSS: Main: 158167040 09:23:51 INFO - PROCESS | 3904 | 09:23:53 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:23:54 INFO - PROCESS | 3904 | RSS: Main: 158441472 09:23:54 INFO - PROCESS | 3904 | 09:23:56 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:23:57 INFO - PROCESS | 3904 | RSS: Main: 158478336 09:23:57 INFO - PROCESS | 3904 | 09:24:00 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:24:01 INFO - PROCESS | 3904 | RSS: Main: 158543872 09:24:01 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | Cycle 1(1): loaded http://localhost:59629/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59629/tests/kraken/driver.html?testName=ai-astar) 09:24:02 INFO - PROCESS | 3904 | RSS: Main: 160301056 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | __start_tp_report 09:24:02 INFO - PROCESS | 3904 | _x_x_mozilla_page_load 09:24:02 INFO - PROCESS | 3904 | _x_x_mozilla_page_load_details 09:24:02 INFO - PROCESS | 3904 | |i|pagename|runs| 09:24:02 INFO - PROCESS | 3904 | |0;ai-astar;102;111;112;111;112;113;113;111;111;112 09:24:02 INFO - PROCESS | 3904 | |1;audio-beat-detection;150;123;122;166;121;123;123;122;154;124 09:24:02 INFO - PROCESS | 3904 | |2;audio-dft;162;166;164;162;162;162;163;162;162;164 09:24:02 INFO - PROCESS | 3904 | |3;audio-fft;75;77;78;110;77;76;76;76;107;75 09:24:02 INFO - PROCESS | 3904 | |4;audio-oscillator;83;82;116;82;82;82;99;84;83;116 09:24:02 INFO - PROCESS | 3904 | |5;imaging-gaussian-blur;117;117;118;118;118;118;118;120;117;121 09:24:02 INFO - PROCESS | 3904 | |6;imaging-darkroom;151;148;147;146;146;147;147;148;147;148 09:24:02 INFO - PROCESS | 3904 | |7;imaging-desaturate;85;85;85;87;86;85;86;85;86;85 09:24:02 INFO - PROCESS | 3904 | |8;json-parse-financial;53;57;54;57;54;55;60;56;53;55 09:24:02 INFO - PROCESS | 3904 | |9;json-stringify-tinderbox;60;61;60;59;60;60;60;60;59;63 09:24:02 INFO - PROCESS | 3904 | |10;stanford-crypto-aes;76;82;75;75;74;80;81;76;74;73 09:24:02 INFO - PROCESS | 3904 | |11;stanford-crypto-ccm;143;128;128;125;135;139;126;137;177;130 09:24:02 INFO - PROCESS | 3904 | |12;stanford-crypto-pbkdf2;158;164;157;155;158;159;159;157;161;164 09:24:02 INFO - PROCESS | 3904 | |13;stanford-crypto-sha256-iterative;62;63;65;62;71;65;61;61;62;63 09:24:02 INFO - PROCESS | 3904 | __end_tp_report 09:24:02 INFO - PROCESS | 3904 | __start_cc_report 09:24:02 INFO - PROCESS | 3904 | _x_x_mozilla_cycle_collect,808 09:24:02 INFO - PROCESS | 3904 | __end_cc_report 09:24:02 INFO - PROCESS | 3904 | __startTimestamp1479749042946__endTimestamp 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | ------- Summary: start ------- 09:24:02 INFO - PROCESS | 3904 | Number of tests: 14 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.19 (2.8%) stddev-sans-first:0.83 09:24:02 INFO - PROCESS | 3904 | Values: 102.0 111.0 112.0 111.0 112.0 113.0 113.0 111.0 111.0 112.0 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:123.50 stddev:16.95 (13.7%) stddev-sans-first:16.80 09:24:02 INFO - PROCESS | 3904 | Values: 150.0 123.0 122.0 166.0 121.0 123.0 123.0 122.0 154.0 124.0 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.50 stddev:1.37 (0.8%) stddev-sans-first:1.41 09:24:02 INFO - PROCESS | 3904 | Values: 162.0 166.0 164.0 162.0 162.0 162.0 163.0 162.0 162.0 164.0 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:13.65 (18.0%) stddev-sans-first:14.19 09:24:02 INFO - PROCESS | 3904 | Values: 75.0 77.0 78.0 110.0 77.0 76.0 76.0 76.0 107.0 75.0 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:82.50 stddev:14.20 (17.2%) stddev-sans-first:14.77 09:24:02 INFO - PROCESS | 3904 | Values: 83.0 82.0 116.0 82.0 82.0 82.0 99.0 84.0 83.0 116.0 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.32 (1.1%) stddev-sans-first:1.32 09:24:02 INFO - PROCESS | 3904 | Values: 117.0 117.0 118.0 118.0 118.0 118.0 118.0 120.0 117.0 121.0 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:1.43 (1.0%) stddev-sans-first:0.78 09:24:02 INFO - PROCESS | 3904 | Values: 151.0 148.0 147.0 146.0 146.0 147.0 147.0 148.0 147.0 148.0 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 09:24:02 INFO - PROCESS | 3904 | Values: 85.0 85.0 85.0 87.0 86.0 85.0 86.0 85.0 86.0 85.0 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:2.17 (3.9%) stddev-sans-first:2.12 09:24:02 INFO - PROCESS | 3904 | Values: 53.0 57.0 54.0 57.0 54.0 55.0 60.0 56.0 53.0 55.0 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:1.14 (1.9%) stddev-sans-first:1.20 09:24:02 INFO - PROCESS | 3904 | Values: 60.0 61.0 60.0 59.0 60.0 60.0 60.0 60.0 59.0 63.0 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.00 stddev:3.20 (4.2%) stddev-sans-first:3.39 09:24:02 INFO - PROCESS | 3904 | Values: 76.0 82.0 75.0 75.0 74.0 80.0 81.0 76.0 74.0 73.0 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:136.00 stddev:15.35 (11.3%) stddev-sans-first:16.11 09:24:02 INFO - PROCESS | 3904 | Values: 143.0 128.0 128.0 125.0 135.0 139.0 126.0 137.0 177.0 130.0 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:159.00 stddev:2.97 (1.9%) stddev-sans-first:3.12 09:24:02 INFO - PROCESS | 3904 | Values: 158.0 164.0 157.0 155.0 158.0 159.0 159.0 157.0 161.0 164.0 09:24:02 INFO - PROCESS | 3904 | 09:24:02 INFO - PROCESS | 3904 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:2.99 (4.7%) stddev-sans-first:3.12 09:24:02 INFO - PROCESS | 3904 | Values: 62.0 63.0 65.0 62.0 71.0 65.0 61.0 61.0 62.0 63.0 09:24:02 INFO - PROCESS | 3904 | -------- Summary: end -------- 09:24:02 INFO - PROCESS | 3904 | 09:24:03 INFO - TEST-INFO | 3904: exit 0 09:24:03 INFO - TEST-OK | kraken | took 61644ms 09:24:03 INFO - SUITE-END | took 1175s 09:24:04 INFO - Completed test suite (00:19:36) 09:24:04 INFO - javascript benchmark 09:24:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7468.173186357568, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3273.98363008185, 3280.7211387032103, 3303.388873058486, 3307.908390231224, 3311.983440082799, 5638.492535671789, 5685.374608793035, 5715.885682286352, 5718.199452076713, 5740.626859254156, 5688.914666280009, 5696.458836410545, 5720.084786434171, 5739.827805165852, 5742.626729262595, 5188.688678679272, 5232.947670523284, 5249.921251181236, 5278.3138192034985, 5284.154535274357, 5276.472352764712, 5283.181106928432, 5283.947160528384, 5288.814891478799, 5323.9467605324035, 5198.0, 5226.320578324831, 5302.0, 5304.761285742132, 5306.389765176996, 5178.8705282368055, 5215.348081489814, 5216.400113986902, 5235.528802407764, 5322.840314790563, 5228.058949389108, 5249.212618107276, 5316.016536940679, 5334.5732341412595, 5339.252504649352, 5738.885222295572, 5795.82612521625, 5801.796937107181, 5854.882902341929, 5858.41415858415, 6070.908936365914, 6086.391360863879, 6092.0, 6166.84582885427, 6179.969100154471, 6142.812908896602, 6177.227846519185, 6194.969025154845, 6203.906941395882, 6232.127502149703, 5617.297837770278, 5750.511206547407, 5765.106408506688, 5785.681787501686, 5786.247787787561, 6129.816105516842, 6140.381550880983, 6158.599691020159, 6163.476104531075, 6231.0, 6015.30823955242, 6032.728527216286, 6046.153538504613, 6048.751278660659, 6072.574919755575, 6085.208922840003, 6112.144299798032, 6143.477804386677, 6162.26052873649, 6162.383761623802, 5938.524918006549, 5961.910571341434, 5981.431763982415, 6008.969955150284, 6029.3669164737075, 6104.97815029019, 6111.682900513672, 6144.569880108439, 6145.907811382833, 6158.538109641795, 4692.436907571113, 4716.3632909557455, 4731.597814185764, 4738.218193997952, 4751.881202969954, 4129.607687269705, 4168.228877657643, 4246.554111818276, 4248.511421186541, 4280.636145927631, 5731.398203188689, 5754.827355179351, 5757.539396848242, 5802.941970580325, 5910.7931222407005, 5997.760089596454, 6033.42682445167, 6067.150598916155, 6067.908981365194, 6119.724612392453, 5725.198472213893, 5791.507721843606, 5832.358440571534, 5840.3575606683235, 5861.17943487912, 5240.737963101829, 5241.213817927342, 5262.500062494057, 5296.073187192226, 5324.520793128637, 6470.288268290485, 6485.805425837232, 6488.318726533646, 6506.284308726036, 6508.902366464602, 6098.237720284965, 6169.136320915165, 6174.722137503733, 6189.319174890848, 6201.875962480815, 6217.4715149212825, 6246.593971391845, 6346.07981842621, 6370.331115232834, 6475.935240647534, 6084.695765211633, 6088.908666370096, 6095.969520152371, 6100.511959043355, 6133.110698948717, 6159.81520554384, 6177.62934223948, 6182.412670796267, 6191.25704915413, 6204.069389591416, 5829.7959571416495, 5851.0, 5883.441073098049, 6028.969855150696, 6047.516198704006, 5882.882342353043, 5932.555058370725, 5978.252718410199, 6003.189569408074, 6016.4585187331595, 5836.678982655994, 5869.236999190078, 5891.263592050994, 5921.940780592311, 5923.555733319932, 5840.620359676607, 5947.851303717269, 5952.404759524013, 6023.3073196582955, 6026.90959635597, 5852.18069470283, 5887.852803679943, 5918.053111502139, 5941.197938278277, 5995.46040856325], "value": 5659.0427009777395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.7060863655219, 628.949684025278, 657.6941722099223, 666.9199696036476, 676.976305829296, 42715.14569708604, 43254.351184732215, 43761.781191094036, 47725.52274477254, 48012.75993620027, 45796.77101614487, 46088.0, 46147.0, 46207.537924620825, 46282.76858615702, 8802.779930501742, 8978.326625503114, 9043.050479699636, 9050.502222377767, 9060.954695226515, 8786.516741579211, 8879.644814207424, 8883.95558022209, 8900.287976961827, 8960.10398960102, 8960.23837973773, 9006.729798106067, 9019.368644194908, 9026.864597031017, 9028.548572571379, 8954.104589541059, 8962.238209752179, 8963.955180224057, 8989.505577193251, 9001.324900632446, 8888.377813553054, 8890.688825891128, 8923.643054277822, 8938.68714594986, 8959.41763785352, 42516.0, 42628.147437051084, 42729.863506824535, 42830.1433971322, 43102.353464698055, 3463.7748546344405, 3766.6610005099674, 4017.959820401788, 4020.396940458925, 4356.215881141393, 32421.351572968644, 32614.0, 32927.176820579436, 33042.66957330444, 33115.337693246, 4375.562443755631, 4414.514403415622, 4435.68950173488, 4505.842295519674, 4560.361549383089, 330262.0, 332288.3385583081, 333297.0, 334652.0, 336288.0, 60608.696956514934, 60632.0, 61138.0, 61363.079553806725, 61367.238474268765, 64478.677606611665, 64482.0, 64701.352986470476, 64705.0, 64709.67645161744, 17581.912090439466, 17774.644507109784, 17937.820621793617, 17948.0, 17972.281108755764, 13649.0, 13676.452941882413, 13696.589102326947, 13848.515301964382, 13899.930500347433, 16979.15104244783, 17763.822361776216, 17781.46655600334, 17894.91052544729, 17945.910270448563, 6065.211522502046, 6134.294556126102, 6376.681165941684, 6382.648954307558, 6394.5843520171975, 985.3201291109111, 1111.7609713911547, 1151.6775302915198, 1216.7748966441236, 1231.9630411087683, 32229.51655725166, 32275.193120171713, 32608.510872336934, 32627.51058734121, 33150.0, 1093.2456604942565, 1170.5493385046818, 1171.2094336322948, 1213.3205404973066, 1238.9814152787715, 17281.740773888403, 17515.82484175142, 17566.736498952527, 17573.12134393275, 17678.381256655954, 519745.0, 524269.0, 524718.0, 525354.0, 526893.0, 61384.38615613876, 61451.385486144565, 61586.69206653938, 61602.69198653978, 61637.38362616406, 1370.6367812529688, 1388.4168649167173, 1417.4755340523866, 1419.9645008874654, 1430.356339647142, 30716.692833072277, 31662.208444789063, 32114.357712845143, 32540.349193016482, 33180.0, 54127.72936135294, 54342.45657543374, 54462.7276863629, 54630.0, 54714.452855472526, 440757.0, 442531.0, 443548.0, 444127.0, 448563.0, 43149.78425107854, 43696.781516093484, 44161.33757993569, 44615.0, 44731.776341118086, 50083.0, 50119.49880501294, 50216.74891625519, 51083.0, 51562.22656660078, 42821.571784283005, 42907.570924290354, 43198.78400608103, 43284.78357608318, 44134.77932610316, 41826.58173418227, 42491.7875410621, 42625.36061959135, 43233.13533729245, 43433.56566434421, 37471.43792843164, 38850.0, 40815.795921021396, 42868.0, 45934.540654593024, 37313.25373492569, 37663.05842353963, 38108.618913810504, 38730.0, 38853.611463885, 28802.135935921957, 29381.265468362606, 29625.25936851596, 29752.70247297586, 29770.553441698827], "value": 20919.668591161822, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.4412315435738, 419.6055707634825, 422.8604560495036, 438.145616048705, 438.66442171738623, 18535.351262705808, 19807.40577782667, 20313.695294570574, 20795.688064679005, 21040.0, 19601.803981960176, 20099.095540700666, 20128.39614811558, 20207.59584808303, 20310.390688279338, 5525.336959564847, 5851.180834683148, 5858.73635686393, 5862.237909071815, 5877.588568800185, 4253.532111467736, 5748.856278593027, 5837.182794408786, 6220.346863579327, 6334.0, 6407.391297826723, 6422.614643121405, 6437.130987316699, 6438.259600145973, 6438.356164383571, 6223.688815559227, 6434.806955791334, 6455.677216139221, 6471.644059576722, 6480.092787009822, 5550.333959924795, 5577.247071645316, 5745.540356771448, 5754.482096611325, 5779.682117483537, 24230.636540451906, 24233.515329693484, 24256.1510347137, 24408.0, 24506.0, 2241.663750437431, 2260.660900864867, 2475.7029156501153, 2869.03887197789, 3011.728944394993, 14702.411903523845, 15125.697486050327, 15126.470573529874, 15456.922715386463, 15593.766093508606, 1915.82757551821, 1933.9323123690604, 1964.911578978935, 2005.5487515309085, 2008.2268326694182, 84487.0, 84793.0, 85222.0, 85744.0, 86516.0, 11075.72310692239, 11414.94292528532, 11472.77054458906, 11473.311601303949, 11824.822627660593, 15988.600284992735, 16094.839051609568, 16155.515334539983, 16182.75725864113, 16247.918760406123, 8201.26188643025, 8608.870866937, 8677.6528938843, 8771.692990745421, 8834.249088827393, 8324.750257492286, 8459.280961118375, 8546.760719695734, 8669.739907802776, 8727.432716873383, 6742.190937087483, 6890.345417185359, 6916.6541672916155, 6960.582365058112, 6988.091548098715, 1746.1531157388656, 1845.6895604121225, 1848.196034724899, 2014.21445636202, 2025.2506572568243, 909.8407778638712, 970.7184916374173, 978.2076518020426, 1051.2168434516334, 1057.5875408590655, 17974.2810287587, 19410.320638777575, 19466.70799938002, 19570.70643940342, 19881.30415435453, 955.527014128011, 968.6900191938653, 975.3708857786688, 997.5336255704103, 1073.0557109743377, 10761.623343182951, 11039.83440248397, 11079.72300692489, 11103.333799972028, 11174.441277936234, 498190.0, 504270.0, 506592.0, 512343.0, 512584.0, 91756.0, 91871.5406422977, 91898.54050729703, 92228.0, 94131.0, 1010.9646162384429, 1033.7415646088477, 1050.99474502627, 1055.672741450153, 1062.2988827374052, 17265.654686905942, 17447.651046978735, 17626.11334827714, 17718.291268349636, 17879.910600446914, 42380.0, 43872.34191487194, 44334.0, 44477.33284000678, 44778.55221447744, 56766.0, 59781.0, 60120.699396502736, 61486.0, 62034.37965620286, 7966.760997170094, 7984.8802267967185, 8061.186233097506, 8077.959610201911, 8108.2297181767635, 11037.282576632815, 12552.43514041852, 13743.0, 13873.791893121814, 14088.506902258372, 11092.835252298393, 11928.0, 11944.522219111139, 12595.433205505591, 12690.555830545887, 11543.307401555598, 11830.46762895689, 11870.347130907883, 12174.39128043612, 12436.440360183995, 11728.824067638821, 11862.288262704265, 11908.106891983309, 12039.819402709141, 12041.75916481648, 8899.377043607145, 9052.728418147466, 9057.0, 9082.682106126254, 9217.493037882712, 11940.16418850707, 12110.697232568904, 12231.0, 12277.69305767363, 12390.442430090849], "value": 9719.810380933819, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.165425707347, 1532.9386824527019, 1664.8751343649221, 1783.8572914166868, 1804.0348413598736, 7931.325837303822, 8178.79553011175, 8480.279176270016, 9043.547822608867, 9056.547172641367, 8425.241728244457, 8672.30621550276, 8697.47815131091, 8876.068012858654, 8923.776905577348, 2456.6192240202754, 2483.255023492954, 2484.7391023942496, 2493.588557887955, 2496.8002559795264, 2415.1184817541557, 2528.456381877896, 2556.2842404126873, 2561.487702459506, 2563.7179910209957, 2431.2463136427677, 2454.864982425966, 2476.182859656309, 2510.585753350704, 2511.7613826686434, 2343.94140146496, 2347.2019513365367, 2371.027878569787, 2378.3102900158933, 2384.7615238476187, 2417.347316224627, 2454.7177074636465, 2460.987695061531, 2471.2586224132688, 2476.8018558515278, 8665.17680820321, 8680.0, 8769.473831570127, 8773.824523509558, 8781.429207101519, 5404.135338345845, 5512.035393806068, 5526.972365138189, 5530.087535556629, 5534.75093620788, 3469.930601387958, 3529.347070791912, 3576.660217279354, 3579.2483578448555, 3626.4197728363597, 1149.6321177223292, 1160.7446361800392, 1172.7009612548745, 1207.2816674078908, 1217.3852204636603, 12332.753344933051, 12410.81383779244, 12419.689507762288, 12448.502059917593, 12560.309182995023, 4710.939993616353, 4838.346823178897, 4930.8767280818265, 4947.233178857283, 5058.924116138261, 10345.0, 10392.220583456272, 10427.11369533583, 10466.267361284788, 10477.37135771856, 5647.040003199466, 5689.857753556194, 5692.658440493584, 5696.743646535916, 5700.173474846124, 4619.284010978304, 4854.417469903634, 5132.563732082815, 5151.6908985461, 5246.055709972242, 4115.855161331683, 4147.336426171798, 4192.308269135619, 4200.5169405518145, 4202.096549241927, 1374.9587512374644, 1386.757317469459, 1403.985960140406, 1414.7382734194207, 1427.0866645346987, 986.6497393425374, 987.012987012987, 998.0867506231862, 1001.4742260313394, 1008.1178968402647, 5900.232969713996, 5945.791897283574, 5997.430244126801, 6053.909191362133, 6122.418370254819, 457.757388584051, 467.7497538816785, 472.86759707282016, 485.980560777572, 490.75952783136006, 4048.8987775305263, 4120.361343991686, 4148.2947898857265, 4182.079942412664, 4255.446791917031, 10581.206409519316, 10738.838917416246, 10804.459777011118, 10818.783624327627, 10964.451777411257, 10733.08768754649, 10806.459677016117, 10811.78376432467, 10842.457877106272, 10849.349039057683, 8197.50814951093, 8388.11924747905, 8423.831523369498, 8438.957805211057, 8469.788255293544, 5945.044298171064, 6017.729202185825, 6030.336662967158, 6058.0610005449225, 6061.848453788691, 9790.363626364264, 9795.33479308505, 9806.950965245129, 9869.259805514472, 9939.503024848873, 10100.44447555362, 10124.088832005154, 10124.949375253076, 10156.746081348025, 10257.17942564608, 7108.111486064242, 7231.63841807918, 7302.0, 7731.652075656497, 7856.332211761835, 8482.236598706146, 8487.811706360992, 8534.23191912706, 8544.786380340292, 8565.871511927202, 7522.022137122358, 7535.886961695689, 7571.0, 7579.734709285149, 7767.417443691858, 7284.708611655475, 7350.448716346403, 7412.518186317872, 7440.702371905063, 7467.92532074694, 6965.303469652994, 7056.047433596399, 7061.752838650623, 7075.469339799639, 7079.964600176966, 4900.92648610264, 4989.126902791924, 4999.800007999639, 5025.924611130763, 5068.670536415121, 5146.099432599355, 5172.586193104617, 5233.241180028798, 5247.580193584427, 5328.440513746001], "value": 4651.109795069886, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.3288136100728, 358.2887967384741, 359.68347853888577, 362.6862763709392, 367.7756568493217, 5533.418991005947, 5571.498565129137, 5577.330720313563, 5613.915791263134, 5621.718914054301, 5512.944870551293, 5513.669179849212, 5518.724063796804, 5527.806526771564, 5555.2778138841995, 4248.87253382399, 4296.377025331325, 4353.412289340946, 4363.258246098171, 4383.452068491439, 4343.717658352213, 4345.956540434587, 4354.1944740223, 4356.0, 4366.476022877259, 4301.720388174775, 4336.978315108436, 4340.717853339539, 4351.543087975749, 4355.0, 4114.732542384751, 4272.060146767706, 4325.762083085429, 4342.261815491374, 4346.456692913386, 3808.7905165215902, 3825.48355971943, 3829.215010922754, 3840.615938406165, 3855.2289542091694, 5381.569474442074, 5386.569074474072, 5387.973060134675, 5397.4062853086125, 5422.2951016368015, 4862.294967229732, 4917.901641967141, 4924.630652701062, 4973.726445045521, 5000.799968001275, 5709.9714501427225, 5724.771009159628, 5750.511206547449, 5769.336526299488, 5780.595358324919, 4191.497020357546, 4200.558941311149, 4201.642860356873, 4233.25917964355, 4239.194553034913, 5806.854828629276, 5829.271341082364, 5931.881362372728, 6023.578349515536, 6041.0, 4265.971160476097, 4282.5075116361395, 4306.784660766949, 4310.6335961443, 4316.525182229952, 4344.782760861945, 4346.130773845181, 4352.347147927836, 4355.934660980088, 4361.171377438277, 4896.755162241873, 4933.186024306021, 4936.67911585753, 4949.950500495021, 4979.0, 5801.375614827855, 5812.273465816773, 5831.708414579339, 5847.210626565445, 5847.356790753014, 1432.957011289663, 1435.4904009076836, 1440.6038339456525, 1444.7543917534044, 1453.2878889344356, 974.9714051675409, 992.2558081438921, 995.4375777685584, 1013.7060252526832, 1030.7474668706066, 5480.835574932758, 5491.791805802717, 5503.183949296723, 5512.200730893998, 5570.220169176318, 5760.798372056958, 5796.797112101056, 5798.82603521895, 5799.738102140169, 5813.59304848665, 5319.494648008433, 5427.810026649048, 5485.232067510552, 5516.724163791794, 5580.972095139579, 3056.1748327951327, 3061.4131059254896, 3074.9231269218003, 3095.1797773590015, 3108.559780572285, 5907.7046147692445, 5997.880042399128, 6067.635941843503, 6108.51131909455, 6131.417515336036, 5869.7673488567025, 5877.52979761618, 5877.647341159544, 5880.4416829540205, 5888.735006924699, 6027.156198132265, 6037.9396206038255, 6052.788152414732, 6082.847928801815, 6097.17688112108, 5456.7544460498575, 5542.900531510939, 5646.153077038312, 5672.914906276326, 5755.7409916553015, 5657.397597105378, 5667.631603945731, 5673.574481913791, 5675.134057301037, 5728.255326807488, 6063.6664983426335, 6134.202553667995, 6258.780942666985, 6311.179546658905, 6332.366763323631, 4286.978565107154, 4295.935560966525, 4317.935230971475, 4318.78406079701, 4326.978365108154, 5820.359760426265, 6059.09113632941, 6088.695565221809, 6099.329073801967, 6102.603330783485, 5850.6782126981725, 5868.09044598088, 5870.26621672291, 5873.618214816023, 5884.911726324194, 5860.619059761102, 5907.527397808251, 5910.024845900551, 5917.556183286357, 5955.40445955401, 5614.06314821386, 5815.82552523425, 5833.0, 5868.530517558671, 5904.940950590611, 5815.82552523425, 5909.527237820878, 5941.366124315848, 5945.256842894638, 5998.8500287491415, 5625.437456254342, 5734.913976290442, 5820.330661973927, 5825.737841797214, 5827.650340979555], "value": 4427.122388595044, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.1516619633893, 793.6626933553242, 795.9721409750659, 850.9702160424387, 902.8329758994587, 14166.787498187536, 14727.748141407967, 14971.850281497182, 15099.849001509981, 16067.437639682614, 13662.521811736591, 13812.79280810786, 13821.101628394148, 13952.093113947587, 13977.860221397783, 827.5986146718836, 856.3919617071871, 875.2472873328932, 875.3916028360292, 876.5222953490331, 853.799357151069, 862.7498025572577, 864.2955990867455, 864.8789169516241, 865.8917635295588, 900.4372267332917, 904.1139683110556, 906.4063038709655, 907.8774365460645, 908.3686837647838, 902.4449963272606, 903.0292435631657, 903.6024149374255, 904.1004200820161, 905.0813424374265, 656.4944992355908, 657.9605223686594, 659.7163219815477, 660.8711301296249, 660.8909529927556, 14578.343974521173, 14754.409823607042, 14966.0, 15095.924520377328, 15112.319945602365, 14799.112053276838, 14885.181315027668, 15203.315850786741, 15288.541343759594, 15360.846391536053, 11623.709407264801, 11804.763904721944, 11807.468663910146, 11947.820782688266, 12038.4582693779, 3868.7678739275734, 3887.7472964257518, 3896.4544963705102, 3897.8635747748694, 3907.4529565860803, 70864.29135708629, 72033.0, 72958.63520682415, 75163.24836751618, 75220.62389688072, 11177.44112794357, 11182.608608698656, 11189.216754827246, 11231.326120432801, 11270.154738394653, 20498.795012049988, 20777.688334674993, 20818.27136050231, 20908.16367345289, 21041.263555775473, 8104.270615644502, 8362.665493380196, 8489.0, 8496.66013359471, 8598.441101328393, 4543.25036369002, 4574.4510658721165, 4615.469221039623, 4721.709970664225, 4797.232442809203, 3448.5516882805073, 3498.0555250082334, 3507.7719948203285, 3539.0, 3542.2384187399316, 584.3980699879131, 590.3388205210192, 595.1434703123696, 595.657496939253, 615.5291202230297, 687.8933765266391, 695.6660802814678, 767.7658314214218, 774.3650206830345, 794.3843521271061, 9574.0, 9612.0, 9775.853362199572, 9868.654597089067, 10051.497425128715, 719.0939416335455, 732.8131326511811, 773.818152734107, 788.7633709887126, 800.7557694903111, 4594.977025114853, 4917.65576409655, 4949.826756063592, 4989.276554899519, 5017.422996355393, 59185.40814591885, 59883.0, 92243.0, 94347.58478622827, 95534.5223273893, 51381.0, 52307.95384092297, 63404.68297658482, 72363.0, 72759.27240727525, 44542.55457445449, 46226.30660540095, 59281.40718592759, 67443.3255667437, 68136.318636813, 9325.487098209664, 9595.0, 9768.26737994639, 9968.900310997087, 9972.60109595608, 35021.64978350184, 46020.30969535527, 46514.76742616265, 47285.763571181924, 48165.75917120392, 61260.0, 65253.0, 65257.67371163114, 65310.0, 65676.0, 11978.700532486757, 12777.0, 12804.743905121659, 12878.742425151631, 13354.599362019155, 12709.491620335453, 14737.631559211106, 14903.254837257877, 14986.325615347554, 15105.622359441102, 11820.40897955116, 11861.762764744484, 11968.581099661471, 12004.09969252327, 12047.337396442928, 13867.930660346634, 14026.65631856262, 14691.706165876836, 15044.849551504345, 15269.312880920163, 12802.551910683082, 13034.217946923214, 13497.257650829299, 13851.445942162201, 13949.093308934887, 11192.664220073411, 11451.770964580495, 11549.826752598885, 11582.768344633228, 11583.826242606536, 12087.39563021863, 12155.392230388268, 12358.382080896099, 12392.75214495723, 12448.25310481374], "value": 7321.643073190511, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1483.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 112.0, 111.0, 112.0, 113.0, 113.0, 111.0, 111.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 122.0, 166.0, 121.0, 123.0, 123.0, 122.0, 154.0, 124.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 164.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 164.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 110.0, 77.0, 76.0, 76.0, 76.0, 107.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 116.0, 82.0, 82.0, 82.0, 99.0, 84.0, 83.0, 116.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 120.0, 117.0, 121.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 147.0, 146.0, 146.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 87.0, 86.0, 85.0, 86.0, 85.0, 86.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 54.0, 57.0, 54.0, 55.0, 60.0, 56.0, 53.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 63.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 75.0, 75.0, 74.0, 80.0, 81.0, 76.0, 74.0, 73.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 128.0, 128.0, 125.0, 135.0, 139.0, 126.0, 137.0, 177.0, 130.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 164.0, 157.0, 155.0, 158.0, 159.0, 159.0, 157.0, 161.0, 164.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 65.0, 62.0, 71.0, 65.0, 61.0, 61.0, 62.0, 63.0], "value": 63.5, "unit": "score"}]}]} 09:24:04 INFO - Return code: 0 09:24:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:24:04 ERROR - # TBPL SUCCESS # 09:24:04 INFO - Running post-action listener: _resource_record_post_action 09:24:04 INFO - [mozharness: 2016-11-21 17:24:04.267825Z] Finished run-tests step (success) 09:24:04 INFO - Running post-run listener: _resource_record_post_run 09:24:04 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 351629312; Read time: 0; Write time: 618256 09:24:04 INFO - TinderboxPrint: CPU usage
13.3% 09:24:04 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:24:04 INFO - TinderboxPrint: I/O write bytes / time
351,629,312 / 618,256 09:24:04 INFO - TinderboxPrint: CPU idle
8,239.9 (86.6%) 09:24:04 INFO - TinderboxPrint: CPU user
1,207.0 (12.7%) 09:24:04 INFO - TinderboxPrint: Swap in / out
0 / 0 09:24:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107372544; Read time: 0; Write time: 229752 09:24:04 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 243699712; Read time: 0; Write time: 388496 09:24:04 INFO - Running post-run listener: _upload_blobber_files 09:24:04 INFO - Blob upload gear active. 09:24:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:24:04 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 09:24:04 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:24:04 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:24:05 INFO - (blobuploader) - INFO - Open directory for files ... 09:24:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:24:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:24:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:06 INFO - (blobuploader) - INFO - Done attempting. 09:24:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:24:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:24:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:09 INFO - (blobuploader) - INFO - Done attempting. 09:24:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:24:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:24:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:10 INFO - (blobuploader) - INFO - Done attempting. 09:24:10 INFO - (blobuploader) - INFO - Iteration through files over. 09:24:10 INFO - Return code: 0 09:24:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:24:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:24:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27f794cc3cc8e4e4864a9031ee0347a074a63518981fc1fe436a23f649727baefd0338a135ab3f6d3b9672c2604175ffbede8a9f760ba2f3773bbeaf20ad8a8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3c04ea662faee124023385489bd405916334be75717e9ced57870ea21a9978345c699063cc8c626c93ea731a70641e14b7a1df47aec33c5fb8542f3deb640315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea0a1693296196d1419b00886edd74a373c302829dadf2ef6ffcf21e9367d3dae8c89988f27117ab7da389bba265c86e824e287c547003eb3a935ea9a348f251"} 09:24:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:24:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:24:10 INFO - Contents: 09:24:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27f794cc3cc8e4e4864a9031ee0347a074a63518981fc1fe436a23f649727baefd0338a135ab3f6d3b9672c2604175ffbede8a9f760ba2f3773bbeaf20ad8a8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3c04ea662faee124023385489bd405916334be75717e9ced57870ea21a9978345c699063cc8c626c93ea731a70641e14b7a1df47aec33c5fb8542f3deb640315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea0a1693296196d1419b00886edd74a373c302829dadf2ef6ffcf21e9367d3dae8c89988f27117ab7da389bba265c86e824e287c547003eb3a935ea9a348f251"} 09:24:10 INFO - Running post-run listener: copy_logs_to_upload_dir 09:24:10 INFO - Copying logs to upload dir... 09:24:10 INFO - mkdir: /builds/slave/test/build/upload/logs 09:24:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.265421 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-21 09:24:10.118278) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 09:24:10.122486) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225 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/Mozilla-Aurora/sha512/27f794cc3cc8e4e4864a9031ee0347a074a63518981fc1fe436a23f649727baefd0338a135ab3f6d3b9672c2604175ffbede8a9f760ba2f3773bbeaf20ad8a8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3c04ea662faee124023385489bd405916334be75717e9ced57870ea21a9978345c699063cc8c626c93ea731a70641e14b7a1df47aec33c5fb8542f3deb640315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea0a1693296196d1419b00886edd74a373c302829dadf2ef6ffcf21e9367d3dae8c89988f27117ab7da389bba265c86e824e287c547003eb3a935ea9a348f251"} build_url:https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011682 build_url: 'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27f794cc3cc8e4e4864a9031ee0347a074a63518981fc1fe436a23f649727baefd0338a135ab3f6d3b9672c2604175ffbede8a9f760ba2f3773bbeaf20ad8a8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3c04ea662faee124023385489bd405916334be75717e9ced57870ea21a9978345c699063cc8c626c93ea731a70641e14b7a1df47aec33c5fb8542f3deb640315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea0a1693296196d1419b00886edd74a373c302829dadf2ef6ffcf21e9367d3dae8c89988f27117ab7da389bba265c86e824e287c547003eb3a935ea9a348f251"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 09:24:10.150732) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:24:10.151110) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1479746303.979644-2075444225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:24:10.234481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 09:24:10.235032) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 09:24:10.235566) ========= ========= Total master_lag: 0.30 =========