builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1476444823.56 results: success (0) buildid: 20161014030037 builduid: 3f13d4f7004144d7815e6b50ce727e92 revision: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 04:33:43.562072) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 04:33:43.562612) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 04:33:43.563158) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 04:33:43.579383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:33:43.579796) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 04:33:44-- 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% 46.5M=0s 2016-10-14 04:33:44 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131636 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:33:43.729737) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:33:43.730573) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016168 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:33:43.783315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:33:43.784137) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 --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=d6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 04:33:44,461 truncating revision to first 12 chars 2016-10-14 04:33:44,461 Setting DEBUG logging. 2016-10-14 04:33:44,461 attempt 1/10 2016-10-14 04:33:44,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1391a2889aeb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 04:33:45,024 unpacking tar archive at: mozilla-central-1391a2889aeb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.874499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:33:44.677958) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 04:33:44.678805) ========= script_repo_revision: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 04:33:44.679923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 04:33:44.680584) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 04:33:44.692125) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-14 04:33:44.692857) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:33:45 INFO - MultiFileLogger online at 20161014 04:33:45 in /builds/slave/test 04:33:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:33:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:33:45 INFO - {'append_to_log': False, 04:33:45 INFO - 'base_work_dir': '/builds/slave/test', 04:33:45 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:33:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:33:45 INFO - 'branch': 'Firefox-Non-PGO', 04:33:45 INFO - 'buildbot_json_path': 'buildprops.json', 04:33:45 INFO - 'config_files': ('talos/linux_config.py',), 04:33:45 INFO - 'default_actions': ('clobber', 04:33:45 INFO - 'read-buildbot-config', 04:33:45 INFO - 'download-and-extract', 04:33:45 INFO - 'populate-webroot', 04:33:45 INFO - 'create-virtualenv', 04:33:45 INFO - 'install', 04:33:45 INFO - 'run-tests'), 04:33:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:33:45 INFO - 'download_minidump_stackwalk': True, 04:33:45 INFO - 'download_symbols': 'ondemand', 04:33:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:33:45 INFO - 'tooltool.py': '/tools/tooltool.py', 04:33:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:33:45 INFO - '/tools/misc-python/virtualenv.py')}, 04:33:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:33:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:33:45 INFO - 'installer_path': 'installer.exe', 04:33:45 INFO - 'log_level': 'info', 04:33:45 INFO - 'log_name': 'talos', 04:33:45 INFO - 'log_to_console': True, 04:33:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:33:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:33:45 INFO - 'opt_config_files': (), 04:33:45 INFO - 'pip_index': False, 04:33:45 INFO - 'sps_profile': False, 04:33:45 INFO - 'sps_profile_interval': 0, 04:33:45 INFO - 'suite': 'dromaeojs-e10s', 04:33:45 INFO - 'system_bits': '32', 04:33:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:33:45 INFO - 'title': 'talos-linux64-ix-034', 04:33:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:33:45 INFO - 'use_talos_json': True, 04:33:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:33:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:33:45 INFO - 'work_dir': 'build'} 04:33:45 INFO - [mozharness: 2016-10-14 11:33:45.470911Z] Running clobber step. 04:33:45 INFO - Running pre-action listener: _resource_record_pre_action 04:33:45 INFO - Running main action method: clobber 04:33:45 INFO - rmtree: /builds/slave/test/build 04:33:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:33:45 INFO - Running post-action listener: _resource_record_post_action 04:33:45 INFO - [mozharness: 2016-10-14 11:33:45.933135Z] Finished clobber step (success) 04:33:45 INFO - [mozharness: 2016-10-14 11:33:45.933236Z] Running read-buildbot-config step. 04:33:45 INFO - Running pre-action listener: _resource_record_pre_action 04:33:45 INFO - Running main action method: read_buildbot_config 04:33:45 INFO - Using buildbot properties: 04:33:45 INFO - { 04:33:45 INFO - "project": "", 04:33:45 INFO - "product": "firefox", 04:33:45 INFO - "script_repo_revision": "production", 04:33:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:33:45 INFO - "repository": "", 04:33:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:33:45 INFO - "buildid": "20161014030037", 04:33:45 INFO - "pgo_build": "False", 04:33:45 INFO - "basedir": "/builds/slave/test", 04:33:45 INFO - "buildnumber": 510, 04:33:45 INFO - "slavename": "talos-linux64-ix-034", 04:33:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:33:45 INFO - "platform": "ubuntu64_hw", 04:33:45 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:33:45 INFO - "branch": "mozilla-central", 04:33:45 INFO - "repo_path": "mozilla-central", 04:33:45 INFO - "revision": "1391a2889aeb2bdd61ad6ef838e65826e35aabc2", 04:33:45 INFO - "stage_platform": "linux64", 04:33:45 INFO - "builduid": "3f13d4f7004144d7815e6b50ce727e92", 04:33:45 INFO - "slavebuilddir": "test" 04:33:45 INFO - } 04:33:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:33:45 INFO - Running post-action listener: _resource_record_post_action 04:33:45 INFO - [mozharness: 2016-10-14 11:33:45.936085Z] Finished read-buildbot-config step (success) 04:33:45 INFO - [mozharness: 2016-10-14 11:33:45.936173Z] Running download-and-extract step. 04:33:45 INFO - Running pre-action listener: _resource_record_pre_action 04:33:45 INFO - Running main action method: download_and_extract 04:33:45 INFO - mkdir: /builds/slave/test/build/tests 04:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:45 INFO - trying https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:33:45 INFO - Downloading https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:33:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:33:46 INFO - Downloaded 1361 bytes. 04:33:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:33:46 INFO - Using the following test package requirements: 04:33:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:33:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:33:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:33:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:46 INFO - u'jsshell-linux-x86_64.zip'], 04:33:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:33:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:33:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:33:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:33:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:33:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:33:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:33:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:33:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:33:46 INFO - Fetch https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:33:47 INFO - Http code: 200 04:33:47 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 04:33:47 INFO - x-amz-cf-id: W-X0WBnOrGk2cxl_aMLP30jICThksQB8WncD0cmRGCSi5uaYL7uqLA== 04:33:47 INFO - x-amz-version-id: pXc2TaNOZaIuv6OX1I2kKYsEAPpUIgPr 04:33:47 INFO - Expected file size: 20553754 04:33:47 INFO - Obtained file size: 20553754 04:33:51 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:33:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:33:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:33:51 INFO - Fetch https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:33:51 INFO - Http code: 200 04:33:51 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 04:33:51 INFO - x-amz-cf-id: lMcB6rV9gOhfHuCb2oFvmT0aH29gbqOrimLGcnGUDDujKsM7Igk1Bw== 04:33:51 INFO - x-amz-version-id: pXc2TaNOZaIuv6OX1I2kKYsEAPpUIgPr 04:33:52 INFO - Expected file size: 20553754 04:33:52 INFO - Obtained file size: 20553754 04:33:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:33:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:33:56 INFO - Fetch https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:33:57 INFO - Http code: 200 04:33:57 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 04:33:57 INFO - x-amz-cf-id: Id-t5naJxyGrLoD0p9kOWwD7V806PykYi5K7Urejf2PaX_mext92QQ== 04:33:57 INFO - x-amz-version-id: Vvdc5wEyKOp4uEOxRrcjwtARrT_EceVl 04:33:57 INFO - Expected file size: 14409006 04:33:57 INFO - Obtained file size: 14409006 04:33: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')]} 04:33:57 INFO - trying https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:33:57 INFO - Downloading https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:33:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:33:58 INFO - Downloaded 55634849 bytes. 04:33:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:33:58 INFO - mkdir: /builds/slave/test/properties 04:33:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:33:58 INFO - Writing to file /builds/slave/test/properties/build_url 04:33:58 INFO - Contents: 04:33:58 INFO - build_url:https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:33:59 INFO - Running post-action listener: _resource_record_post_action 04:33:59 INFO - Running post-action listener: set_extra_try_arguments 04:33:59 INFO - [mozharness: 2016-10-14 11:33:59.412657Z] Finished download-and-extract step (success) 04:33:59 INFO - [mozharness: 2016-10-14 11:33:59.412882Z] Running populate-webroot step. 04:33:59 INFO - Running pre-action listener: _resource_record_pre_action 04:33:59 INFO - Running main action method: populate_webroot 04:33:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:33:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:33:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:33:59 INFO - '--tppagecycles', 04:33:59 INFO - '7'], 04:33:59 INFO - 'tests': ['tsvgm']}}, 04:33:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:33:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:33:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:33:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:33:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:33:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:33:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:59 INFO - 'talos_options': ['--disable-e10s'], 04:33:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:59 INFO - 'talos_options': ['--disable-e10s'], 04:33:59 INFO - 'tests': ['damp', 'tps']}, 04:33:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:59 INFO - 'tests': ['damp', 'tps']}, 04:33:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:33:59 INFO - 'tests': ['dromaeo_dom']}, 04:33:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:33:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:33:59 INFO - 'tests': ['basic_compositor_video']}, 04:33:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:33:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:33:59 INFO - 'tests': ['a11yr', 04:33:59 INFO - 'ts_paint', 04:33:59 INFO - 'tpaint', 04:33:59 INFO - 'sessionrestore', 04:33:59 INFO - 'sessionrestore_no_auto_restore', 04:33:59 INFO - 'tabpaint']}, 04:33:59 INFO - 'other-e10s': {'tests': ['a11yr', 04:33:59 INFO - 'ts_paint', 04:33:59 INFO - 'tpaint', 04:33:59 INFO - 'sessionrestore', 04:33:59 INFO - 'sessionrestore_no_auto_restore', 04:33:59 INFO - 'tabpaint']}, 04:33:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:33:59 INFO - 'ts_paint', 04:33:59 INFO - 'tpaint', 04:33:59 INFO - 'sessionrestore', 04:33:59 INFO - 'sessionrestore_no_auto_restore', 04:33:59 INFO - 'tabpaint']}, 04:33:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:33:59 INFO - 'ts_paint', 04:33:59 INFO - 'tpaint', 04:33:59 INFO - 'sessionrestore', 04:33:59 INFO - 'sessionrestore_no_auto_restore', 04:33:59 INFO - 'tabpaint']}, 04:33:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:33:59 INFO - 'tests': ['a11yr', 04:33:59 INFO - 'ts_paint', 04:33:59 INFO - 'tpaint', 04:33:59 INFO - 'sessionrestore', 04:33:59 INFO - 'sessionrestore_no_auto_restore', 04:33:59 INFO - 'tabpaint']}, 04:33:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:33:59 INFO - 'tests': ['a11yr', 04:33:59 INFO - 'ts_paint', 04:33:59 INFO - 'tpaint', 04:33:59 INFO - 'sessionrestore', 04:33:59 INFO - 'sessionrestore_no_auto_restore', 04:33:59 INFO - 'tabpaint']}, 04:33:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:33:59 INFO - 'tests': ['tsvgx', 04:33:59 INFO - 'tsvgr_opacity', 04:33:59 INFO - 'tart', 04:33:59 INFO - 'tscrollx', 04:33:59 INFO - 'cart']}, 04:33:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:33:59 INFO - 'tsvgr_opacity', 04:33:59 INFO - 'tart', 04:33:59 INFO - 'tscrollx', 04:33:59 INFO - 'cart']}, 04:33:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:59 INFO - 'talos_options': ['--disable-e10s'], 04:33:59 INFO - 'tests': ['tp5o']}, 04:33:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:59 INFO - 'tests': ['tp5o']}, 04:33:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:59 INFO - 'talos_options': ['--disable-e10s', 04:33:59 INFO - '--xperf_path', 04:33:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:59 INFO - 'tests': ['tp5n']}, 04:33:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:59 INFO - 'talos_options': ['--xperf_path', 04:33:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:59 INFO - 'tests': ['tp5n']}}, 04:33:59 INFO - 'talos.zip': {'path': '', 04:33:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:33:59 INFO - Running post-action listener: _resource_record_post_action 04:33:59 INFO - [mozharness: 2016-10-14 11:33:59.434825Z] Finished populate-webroot step (success) 04:33:59 INFO - [mozharness: 2016-10-14 11:33:59.434913Z] Running create-virtualenv step. 04:33:59 INFO - Running pre-action listener: _resource_record_pre_action 04:33:59 INFO - Running main action method: create_virtualenv 04:33:59 INFO - Creating virtualenv /builds/slave/test/build/venv 04:33:59 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 04:33:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:33:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:33:59 INFO - Using real prefix '/usr' 04:33:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:34:00 INFO - Installing distribute.............................................................................................................................................................................................done. 04:34:02 INFO - Installing pip.................done. 04:34:02 INFO - Return code: 0 04:34:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:34:02 INFO - Reading from file tmpfile_stdout 04:34:02 INFO - Output received: 04:34:02 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) 04:34:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:02 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 0x7f591a6e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ef60>, '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 0x1b2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b301d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', '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 04:34:02 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 04:34:02 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 04:34:02 INFO - Using env: {'DISPLAY': ':0', 04:34:02 INFO - 'HOME': '/home/cltbld', 04:34:02 INFO - 'LANG': 'en_US.UTF-8', 04:34:02 INFO - 'LANGUAGE': 'en_US:en', 04:34:02 INFO - 'LOGNAME': 'cltbld', 04:34:02 INFO - 'MAIL': '/var/mail/cltbld', 04:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:02 INFO - 'MOZ_NO_REMOTE': '1', 04:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:02 INFO - 'NO_EM_RESTART': '1', 04:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:02 INFO - 'PWD': '/builds/slave/test', 04:34:02 INFO - 'SHELL': '/bin/bash', 04:34:02 INFO - 'SHLVL': '1', 04:34:02 INFO - 'TERM': 'linux', 04:34:02 INFO - 'TMOUT': '86400', 04:34:02 INFO - 'USER': 'cltbld', 04:34:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', 04:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:02 INFO - '_': '/tools/buildbot/bin/python'} 04:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:02 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 04:34:02 INFO - Cleaning up... 04:34:02 INFO - Return code: 0 04:34:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:02 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 0x7f591a6e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ef60>, '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 0x1b2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b301d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', '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 04:34:02 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 04:34:02 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 04:34:02 INFO - Using env: {'DISPLAY': ':0', 04:34:02 INFO - 'HOME': '/home/cltbld', 04:34:02 INFO - 'LANG': 'en_US.UTF-8', 04:34:02 INFO - 'LANGUAGE': 'en_US:en', 04:34:02 INFO - 'LOGNAME': 'cltbld', 04:34:02 INFO - 'MAIL': '/var/mail/cltbld', 04:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:02 INFO - 'MOZ_NO_REMOTE': '1', 04:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:02 INFO - 'NO_EM_RESTART': '1', 04:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:02 INFO - 'PWD': '/builds/slave/test', 04:34:02 INFO - 'SHELL': '/bin/bash', 04:34:02 INFO - 'SHLVL': '1', 04:34:02 INFO - 'TERM': 'linux', 04:34:02 INFO - 'TMOUT': '86400', 04:34:02 INFO - 'USER': 'cltbld', 04:34:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', 04:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:02 INFO - '_': '/tools/buildbot/bin/python'} 04:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:02 INFO - Downloading/unpacking psutil>=3.1.1 04:34: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 04:34: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 04:34: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 04:34: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 04:34: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 04:34: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 04:34:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:34:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:04 INFO - Installing collected packages: psutil 04:34:04 INFO - Running setup.py install for psutil 04:34:04 INFO - building 'psutil._psutil_linux' extension 04:34:04 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 04:34:04 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 04:34:04 INFO - building 'psutil._psutil_posix' extension 04:34:04 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 04:34:05 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 04:34:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:05 INFO - Successfully installed psutil 04:34:05 INFO - Cleaning up... 04:34:05 INFO - Return code: 0 04:34:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:34:05 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')]} 04:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:05 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')]} 04:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:05 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 0x7f591a6e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ef60>, '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 0x1b2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b301d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', '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 04:34:05 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 04:34:05 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 04:34:05 INFO - Using env: {'DISPLAY': ':0', 04:34:05 INFO - 'HOME': '/home/cltbld', 04:34:05 INFO - 'LANG': 'en_US.UTF-8', 04:34:05 INFO - 'LANGUAGE': 'en_US:en', 04:34:05 INFO - 'LOGNAME': 'cltbld', 04:34:05 INFO - 'MAIL': '/var/mail/cltbld', 04:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:05 INFO - 'MOZ_NO_REMOTE': '1', 04:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:05 INFO - 'NO_EM_RESTART': '1', 04:34:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:05 INFO - 'PWD': '/builds/slave/test', 04:34:05 INFO - 'SHELL': '/bin/bash', 04:34:05 INFO - 'SHLVL': '1', 04:34:05 INFO - 'TERM': 'linux', 04:34:05 INFO - 'TMOUT': '86400', 04:34:05 INFO - 'USER': 'cltbld', 04:34:05 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', 04:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:05 INFO - '_': '/tools/buildbot/bin/python'} 04:34:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:34:05 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 04:34:05 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 04:34:05 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 04:34:05 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 04:34:05 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 04:34:05 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 04:34:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:34:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:34:07 INFO - Installing collected packages: mozsystemmonitor 04:34:07 INFO - Running setup.py install for mozsystemmonitor 04:34:07 INFO - Successfully installed mozsystemmonitor 04:34:07 INFO - Cleaning up... 04:34:07 INFO - Return code: 0 04:34:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:34: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')]} 04:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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')]} 04:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f591a6e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ef60>, '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 0x1b2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b301d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', '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 04:34:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:34:07 INFO - Using env: {'DISPLAY': ':0', 04:34:07 INFO - 'HOME': '/home/cltbld', 04:34:07 INFO - 'LANG': 'en_US.UTF-8', 04:34:07 INFO - 'LANGUAGE': 'en_US:en', 04:34:07 INFO - 'LOGNAME': 'cltbld', 04:34:07 INFO - 'MAIL': '/var/mail/cltbld', 04:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:07 INFO - 'MOZ_NO_REMOTE': '1', 04:34:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:07 INFO - 'NO_EM_RESTART': '1', 04:34:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:07 INFO - 'PWD': '/builds/slave/test', 04:34:07 INFO - 'SHELL': '/bin/bash', 04:34:07 INFO - 'SHLVL': '1', 04:34:07 INFO - 'TERM': 'linux', 04:34:07 INFO - 'TMOUT': '86400', 04:34:07 INFO - 'USER': 'cltbld', 04:34:07 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', 04:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:07 INFO - '_': '/tools/buildbot/bin/python'} 04:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:07 INFO - Downloading/unpacking jsonschema==2.5.1 04:34:07 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 04:34:07 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 04:34:07 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 04:34:07 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 04:34:07 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 04:34:07 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 04:34:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:34:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:09 INFO - Downloading functools32-3.2.3-2.tar.gz 04:34:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:34:10 INFO - warning: no files found matching '*.txt' 04:34:10 INFO - no previously-included directories found matching 'build' 04:34:10 INFO - no previously-included directories found matching 'dist' 04:34:10 INFO - no previously-included directories found matching '.git*' 04:34:10 INFO - Installing collected packages: jsonschema, functools32 04:34:10 INFO - Running setup.py install for functools32 04:34:10 INFO - warning: no files found matching '*.txt' 04:34:10 INFO - no previously-included directories found matching 'build' 04:34:10 INFO - no previously-included directories found matching 'dist' 04:34:10 INFO - no previously-included directories found matching '.git*' 04:34:10 INFO - Successfully installed jsonschema functools32 04:34:10 INFO - Cleaning up... 04:34:10 INFO - Return code: 0 04:34:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:34:10 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')]} 04:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:10 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')]} 04:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:10 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 0x7f591a6e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ef60>, '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 0x1b2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b301d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', '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 04:34:10 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 04:34:10 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 04:34:10 INFO - Using env: {'DISPLAY': ':0', 04:34:10 INFO - 'HOME': '/home/cltbld', 04:34:10 INFO - 'LANG': 'en_US.UTF-8', 04:34:10 INFO - 'LANGUAGE': 'en_US:en', 04:34:10 INFO - 'LOGNAME': 'cltbld', 04:34:10 INFO - 'MAIL': '/var/mail/cltbld', 04:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:10 INFO - 'MOZ_NO_REMOTE': '1', 04:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:10 INFO - 'NO_EM_RESTART': '1', 04:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:10 INFO - 'PWD': '/builds/slave/test', 04:34:10 INFO - 'SHELL': '/bin/bash', 04:34:10 INFO - 'SHLVL': '1', 04:34:10 INFO - 'TERM': 'linux', 04:34:10 INFO - 'TMOUT': '86400', 04:34:10 INFO - 'USER': 'cltbld', 04:34:10 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', 04:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:10 INFO - '_': '/tools/buildbot/bin/python'} 04:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:34:10 INFO - Cleaning up... 04:34:10 INFO - Return code: 0 04:34:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:34:10 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')]} 04:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:10 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')]} 04:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:10 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 0x7f591a6e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ef60>, '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 0x1b2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b301d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', '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 04:34:10 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 04:34:10 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 04:34:10 INFO - Using env: {'DISPLAY': ':0', 04:34:10 INFO - 'HOME': '/home/cltbld', 04:34:10 INFO - 'LANG': 'en_US.UTF-8', 04:34:10 INFO - 'LANGUAGE': 'en_US:en', 04:34:10 INFO - 'LOGNAME': 'cltbld', 04:34:10 INFO - 'MAIL': '/var/mail/cltbld', 04:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:10 INFO - 'MOZ_NO_REMOTE': '1', 04:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:10 INFO - 'NO_EM_RESTART': '1', 04:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:10 INFO - 'PWD': '/builds/slave/test', 04:34:10 INFO - 'SHELL': '/bin/bash', 04:34:10 INFO - 'SHLVL': '1', 04:34:10 INFO - 'TERM': 'linux', 04:34:10 INFO - 'TMOUT': '86400', 04:34:10 INFO - 'USER': 'cltbld', 04:34:10 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', 04:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:10 INFO - '_': '/tools/buildbot/bin/python'} 04:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:10 INFO - Downloading/unpacking blobuploader==1.2.4 04:34:10 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 04:34:10 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 04:34:10 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 04:34:10 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 04:34:10 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 04:34:10 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 04:34:12 INFO - Downloading blobuploader-1.2.4.tar.gz 04:34:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:34:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:34:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:13 INFO - Downloading docopt-0.6.1.tar.gz 04:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:34:13 INFO - Installing collected packages: blobuploader, requests, docopt 04:34:13 INFO - Running setup.py install for blobuploader 04:34:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:34:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:34:13 INFO - Running setup.py install for requests 04:34:13 INFO - Running setup.py install for docopt 04:34:13 INFO - Successfully installed blobuploader requests docopt 04:34:13 INFO - Cleaning up... 04:34:13 INFO - Return code: 0 04:34:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:13 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')]} 04:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:13 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')]} 04:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:13 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 0x7f591a6e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ef60>, '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 0x1b2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b301d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', '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 04:34:13 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 04:34:13 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 04:34:13 INFO - Using env: {'DISPLAY': ':0', 04:34:13 INFO - 'HOME': '/home/cltbld', 04:34:13 INFO - 'LANG': 'en_US.UTF-8', 04:34:13 INFO - 'LANGUAGE': 'en_US:en', 04:34:13 INFO - 'LOGNAME': 'cltbld', 04:34:13 INFO - 'MAIL': '/var/mail/cltbld', 04:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:13 INFO - 'MOZ_NO_REMOTE': '1', 04:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:13 INFO - 'NO_EM_RESTART': '1', 04:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:13 INFO - 'PWD': '/builds/slave/test', 04:34:13 INFO - 'SHELL': '/bin/bash', 04:34:13 INFO - 'SHLVL': '1', 04:34:13 INFO - 'TERM': 'linux', 04:34:13 INFO - 'TMOUT': '86400', 04:34:13 INFO - 'USER': 'cltbld', 04:34:13 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', 04:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:13 INFO - '_': '/tools/buildbot/bin/python'} 04:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:14 INFO - Running setup.py (path:/tmp/pip-rqig0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:14 INFO - Running setup.py (path:/tmp/pip-fEPXP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:14 INFO - Running setup.py (path:/tmp/pip-nz1fqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:14 INFO - Running setup.py (path:/tmp/pip-qVMiiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:14 INFO - Running setup.py (path:/tmp/pip-dTbqRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:14 INFO - Running setup.py (path:/tmp/pip-pzyKWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:14 INFO - Running setup.py (path:/tmp/pip-Mc6WTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:14 INFO - Running setup.py (path:/tmp/pip-nXOJNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:14 INFO - Running setup.py (path:/tmp/pip-TS0TMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:14 INFO - Running setup.py (path:/tmp/pip-nzXvxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:14 INFO - Running setup.py (path:/tmp/pip-Hb3iS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:14 INFO - Running setup.py (path:/tmp/pip-7MJ536-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:15 INFO - Running setup.py (path:/tmp/pip-h5L2V7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:15 INFO - Running setup.py (path:/tmp/pip-eFnyAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:15 INFO - Running setup.py (path:/tmp/pip-I961OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:15 INFO - Running setup.py (path:/tmp/pip-A4N3DK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:15 INFO - Running setup.py (path:/tmp/pip-UWOO7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:34:15 INFO - Running setup.py install for manifestparser 04:34:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:34:15 INFO - Running setup.py install for mozcrash 04:34:15 INFO - Running setup.py install for mozdebug 04:34:15 INFO - Running setup.py install for mozdevice 04:34:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:34:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:34:15 INFO - Running setup.py install for mozfile 04:34:15 INFO - Running setup.py install for mozhttpd 04:34:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:34:16 INFO - Running setup.py install for mozinfo 04:34:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:34:16 INFO - Running setup.py install for mozInstall 04:34:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:34:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:34:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:34:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:34:16 INFO - Running setup.py install for mozleak 04:34:16 INFO - Running setup.py install for mozlog 04:34:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:34:16 INFO - Running setup.py install for moznetwork 04:34:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:34:16 INFO - Running setup.py install for mozprocess 04:34:16 INFO - Running setup.py install for mozprofile 04:34:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:34:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:34:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:34:16 INFO - Running setup.py install for mozrunner 04:34:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:34:16 INFO - Running setup.py install for mozscreenshot 04:34:17 INFO - Running setup.py install for moztest 04:34:17 INFO - Running setup.py install for mozversion 04:34:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:34:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:34:17 INFO - Cleaning up... 04:34:17 INFO - Return code: 0 04:34:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:17 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 0x7f591a6e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ef60>, '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 0x1b2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b301d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', '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 04:34:17 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 04:34:17 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 04:34:17 INFO - Using env: {'DISPLAY': ':0', 04:34:17 INFO - 'HOME': '/home/cltbld', 04:34:17 INFO - 'LANG': 'en_US.UTF-8', 04:34:17 INFO - 'LANGUAGE': 'en_US:en', 04:34:17 INFO - 'LOGNAME': 'cltbld', 04:34:17 INFO - 'MAIL': '/var/mail/cltbld', 04:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:17 INFO - 'MOZ_NO_REMOTE': '1', 04:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:17 INFO - 'NO_EM_RESTART': '1', 04:34:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:17 INFO - 'PWD': '/builds/slave/test', 04:34:17 INFO - 'SHELL': '/bin/bash', 04:34:17 INFO - 'SHLVL': '1', 04:34:17 INFO - 'TERM': 'linux', 04:34:17 INFO - 'TMOUT': '86400', 04:34:17 INFO - 'USER': 'cltbld', 04:34:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', 04:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:17 INFO - '_': '/tools/buildbot/bin/python'} 04:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:17 INFO - Running setup.py (path:/tmp/pip-A6Q_YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:17 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)) 04:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:17 INFO - Running setup.py (path:/tmp/pip-kRZrs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:17 INFO - Running setup.py (path:/tmp/pip-KaHANL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:17 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)) 04:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:17 INFO - Running setup.py (path:/tmp/pip-yFOeyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:17 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)) 04:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:17 INFO - Running setup.py (path:/tmp/pip-F__QKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:17 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)) 04:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:17 INFO - Running setup.py (path:/tmp/pip-9waaUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:17 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)) 04:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:17 INFO - Running setup.py (path:/tmp/pip-JZCrid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:17 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)) 04:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:17 INFO - Running setup.py (path:/tmp/pip-lrVahD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:18 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)) 04:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:18 INFO - Running setup.py (path:/tmp/pip-fwN6RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:18 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)) 04:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:18 INFO - Running setup.py (path:/tmp/pip-sAllR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:18 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)) 04:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:18 INFO - Running setup.py (path:/tmp/pip-QPgmr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:18 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)) 04:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:18 INFO - Running setup.py (path:/tmp/pip-uVxfjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:18 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)) 04:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:18 INFO - Running setup.py (path:/tmp/pip-JOO6uH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:18 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)) 04:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:18 INFO - Running setup.py (path:/tmp/pip-IrAxzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:18 INFO - Running setup.py (path:/tmp/pip-VXBwOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:18 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)) 04:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:18 INFO - Running setup.py (path:/tmp/pip-2jzgUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:18 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)) 04:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:18 INFO - Running setup.py (path:/tmp/pip-Xw4MnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:18 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)) 04:34:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:18 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)) 04:34:18 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)) 04:34:18 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)) 04:34:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:34:18 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 04:34:18 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 04:34:18 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 04:34:18 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 04:34:18 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 04:34:18 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 04:34:20 INFO - Downloading blessings-1.6.tar.gz 04:34:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:34:20 INFO - Installing collected packages: blessings 04:34:20 INFO - Running setup.py install for blessings 04:34:20 INFO - Successfully installed blessings 04:34:20 INFO - Cleaning up... 04:34:20 INFO - Return code: 0 04:34:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:34:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:21 INFO - Reading from file tmpfile_stdout 04:34:21 INFO - Current package versions: 04:34:21 INFO - argparse == 1.2.1 04:34:21 INFO - blessings == 1.6 04:34:21 INFO - blobuploader == 1.2.4 04:34:21 INFO - docopt == 0.6.1 04:34:21 INFO - functools32 == 3.2.3-2 04:34:21 INFO - jsonschema == 2.5.1 04:34:21 INFO - manifestparser == 1.1 04:34:21 INFO - mozInstall == 1.12 04:34:21 INFO - mozcrash == 0.17 04:34:21 INFO - mozdebug == 0.1 04:34:21 INFO - mozdevice == 0.48 04:34:21 INFO - mozfile == 1.2 04:34:21 INFO - mozhttpd == 0.7 04:34:21 INFO - mozinfo == 0.9 04:34:21 INFO - mozleak == 0.1 04:34:21 INFO - mozlog == 3.4 04:34:21 INFO - moznetwork == 0.27 04:34:21 INFO - mozprocess == 0.23 04:34:21 INFO - mozprofile == 0.28 04:34:21 INFO - mozrunner == 6.12 04:34:21 INFO - mozscreenshot == 0.1 04:34:21 INFO - mozsystemmonitor == 0.3 04:34:21 INFO - moztest == 0.7 04:34:21 INFO - mozversion == 1.4 04:34:21 INFO - psutil == 3.1.1 04:34:21 INFO - requests == 1.2.3 04:34:21 INFO - wsgiref == 0.1.2 04:34:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:21 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 0x7f591a6e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ef60>, '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 0x1b2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b301d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', '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 04:34:21 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 04:34:21 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 04:34:21 INFO - Using env: {'DISPLAY': ':0', 04:34:21 INFO - 'HOME': '/home/cltbld', 04:34:21 INFO - 'LANG': 'en_US.UTF-8', 04:34:21 INFO - 'LANGUAGE': 'en_US:en', 04:34:21 INFO - 'LOGNAME': 'cltbld', 04:34:21 INFO - 'MAIL': '/var/mail/cltbld', 04:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:21 INFO - 'MOZ_NO_REMOTE': '1', 04:34:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:21 INFO - 'NO_EM_RESTART': '1', 04:34:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:21 INFO - 'PWD': '/builds/slave/test', 04:34:21 INFO - 'SHELL': '/bin/bash', 04:34:21 INFO - 'SHLVL': '1', 04:34:21 INFO - 'TERM': 'linux', 04:34:21 INFO - 'TMOUT': '86400', 04:34:21 INFO - 'USER': 'cltbld', 04:34:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', 04:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:21 INFO - '_': '/tools/buildbot/bin/python'} 04:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:21 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)) 04:34:21 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)) 04:34:21 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)) 04:34:21 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)) 04:34:21 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)) 04:34:21 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)) 04:34:21 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)) 04:34:21 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)) 04:34:21 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)) 04:34:21 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)) 04:34:21 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)) 04:34:21 INFO - Cleaning up... 04:34:21 INFO - Return code: 0 04:34:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:21 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 0x7f591a6e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ef60>, '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 0x1b2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b301d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', '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 04:34:21 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 04:34:21 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 04:34:21 INFO - Using env: {'DISPLAY': ':0', 04:34:21 INFO - 'HOME': '/home/cltbld', 04:34:21 INFO - 'LANG': 'en_US.UTF-8', 04:34:21 INFO - 'LANGUAGE': 'en_US:en', 04:34:21 INFO - 'LOGNAME': 'cltbld', 04:34:21 INFO - 'MAIL': '/var/mail/cltbld', 04:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:21 INFO - 'MOZ_NO_REMOTE': '1', 04:34:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:21 INFO - 'NO_EM_RESTART': '1', 04:34:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:21 INFO - 'PWD': '/builds/slave/test', 04:34:21 INFO - 'SHELL': '/bin/bash', 04:34:21 INFO - 'SHLVL': '1', 04:34:21 INFO - 'TERM': 'linux', 04:34:21 INFO - 'TMOUT': '86400', 04:34:21 INFO - 'USER': 'cltbld', 04:34:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', 04:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:21 INFO - '_': '/tools/buildbot/bin/python'} 04:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:34:21 INFO - Cleaning up... 04:34:21 INFO - Return code: 0 04:34:21 INFO - Running post-action listener: _resource_record_post_action 04:34:21 INFO - Running post-action listener: _start_resource_monitoring 04:34:21 INFO - Starting resource monitoring. 04:34:21 INFO - [mozharness: 2016-10-14 11:34:21.594941Z] Finished create-virtualenv step (success) 04:34:21 INFO - [mozharness: 2016-10-14 11:34:21.595458Z] Running install step. 04:34:21 INFO - Running pre-action listener: _resource_record_pre_action 04:34:21 INFO - Running main action method: install 04:34:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:21 INFO - Reading from file tmpfile_stdout 04:34:21 INFO - Detecting whether we're running mozinstall >=1.0... 04:34:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:34:21 INFO - Reading from file tmpfile_stdout 04:34:21 INFO - Output received: 04:34:21 INFO - Usage: mozinstall [options] installer 04:34:21 INFO - Options: 04:34:21 INFO - -h, --help show this help message and exit 04:34:21 INFO - -d DEST, --destination=DEST 04:34:21 INFO - Directory to install application into. [default: 04:34:21 INFO - "/builds/slave/test"] 04:34:21 INFO - --app=APP Application being installed. [default: firefox] 04:34:21 INFO - mkdir: /builds/slave/test/build/application 04:34:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:34:38 INFO - Reading from file tmpfile_stdout 04:34:38 INFO - Output received: 04:34:38 INFO - /builds/slave/test/build/application/firefox/firefox 04:34:38 INFO - Running post-action listener: _resource_record_post_action 04:34:38 INFO - [mozharness: 2016-10-14 11:34:38.386767Z] Finished install step (success) 04:34:38 INFO - [mozharness: 2016-10-14 11:34:38.387018Z] Running run-tests step. 04:34:38 INFO - Running pre-action listener: _resource_record_pre_action 04:34:38 INFO - Running main action method: run_tests 04:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:34:38 INFO - Python 2.7.3 04:34:38 INFO - Return code: 0 04:34:38 INFO - grabbing minidump binary from tooltool 04:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:38 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 0x1b2ef60>, '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 0x1b2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b301d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:34:38 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 04:34:38 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 04:34:38 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 04:34:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:34:38 INFO - Return code: 0 04:34:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:34:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:34:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:34:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:34:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 04:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 04:34:38 INFO - Using env: {'DISPLAY': ':0', 04:34:38 INFO - 'HOME': '/home/cltbld', 04:34:38 INFO - 'LANG': 'en_US.UTF-8', 04:34:38 INFO - 'LANGUAGE': 'en_US:en', 04:34:38 INFO - 'LOGNAME': 'cltbld', 04:34:38 INFO - 'MAIL': '/var/mail/cltbld', 04:34:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:34:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:38 INFO - 'MOZ_NO_REMOTE': '1', 04:34:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:38 INFO - 'NO_EM_RESTART': '1', 04:34:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:38 INFO - 'PWD': '/builds/slave/test', 04:34:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:34:38 INFO - 'SHELL': '/bin/bash', 04:34:38 INFO - 'SHLVL': '1', 04:34:38 INFO - 'TERM': 'linux', 04:34:38 INFO - 'TMOUT': '86400', 04:34:38 INFO - 'USER': 'cltbld', 04:34:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245', 04:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:38 INFO - '_': '/tools/buildbot/bin/python'} 04:34:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 04:34:38 INFO - mozversion application_buildid: 20161014030037 04:34:38 INFO - mozversion application_changeset: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 04:34:38 INFO - mozversion application_display_name: Nightly 04:34:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:34:38 INFO - mozversion application_name: Firefox 04:34:38 INFO - mozversion application_remotingname: firefox 04:34:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:34:38 INFO - mozversion application_vendor: Mozilla 04:34:38 INFO - mozversion application_version: 52.0a1 04:34:38 INFO - mozversion platform_buildid: 20161014030037 04:34:38 INFO - mozversion platform_changeset: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 04:34:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:34:38 INFO - mozversion platform_version: 52.0a1 04:34:38 INFO - using testdate: 1476444878 04:34:38 INFO - actual date: 1476444878 04:34:38 INFO - starting webserver on 'localhost:46527' 04:34:38 INFO - SUITE-START | Running 2 tests 04:34:38 INFO - TEST-START | dromaeo_css 04:34:38 INFO - operating with platform_type : linux_ 04:34:38 INFO - Initialising browser for dromaeo_css test... 04:34:38 INFO - TEST-INFO | started process 9138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpefKVY_/profile http://localhost:46527/getInfo.html) 04:34:43 INFO - PROCESS | 9138 | __metrics Screen width/height:1600/1200 04:34:43 INFO - PROCESS | 9138 | colorDepth:24 04:34:43 INFO - PROCESS | 9138 | Browser inner width/height: 1024/697 04:34:43 INFO - PROCESS | 9138 | __metrics 04:34:44 ERROR - PROCESS | 9138 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 04:34:45 INFO - TEST-INFO | 9138: exit 0 04:34:45 INFO - Browser initialized. 04:34:45 INFO - Running cycle 1/1 for dromaeo_css test... 04:34:45 INFO - TEST-INFO | started process 9264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpefKVY_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:57 INFO - PROCESS | 9264 | RSS: Main: 184446976 04:34:57 INFO - PROCESS | 9264 | 04:35:47 INFO - PROCESS | 9264 | 1476444947046 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:38:01 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:46527/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46527/tests/dromaeo/cssquery-ext.html) 04:38:02 INFO - PROCESS | 9264 | RSS: Main: 194912256 04:38:02 INFO - PROCESS | 9264 | 04:41:04 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:46527/tests/dromaeo/cssquery-ext.html (next: http://localhost:46527/tests/dromaeo/cssquery-jquery.html) 04:41:05 INFO - PROCESS | 9264 | RSS: Main: 195141632 04:41:05 INFO - PROCESS | 9264 | 04:44:07 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:46527/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46527/tests/dromaeo/cssquery-mootools.html) 04:44:08 INFO - PROCESS | 9264 | RSS: Main: 198144000 04:44:08 INFO - PROCESS | 9264 | 04:47:10 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:46527/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46527/tests/dromaeo/cssquery-prototype.html) 04:47:10 INFO - PROCESS | 9264 | RSS: Main: 194760704 04:47:10 INFO - PROCESS | 9264 | 04:50:13 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:46527/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46527/tests/dromaeo/cssquery-yui.html) 04:50:14 INFO - PROCESS | 9264 | RSS: Main: 197730304 04:50:14 INFO - PROCESS | 9264 | 04:53:17 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:46527/tests/dromaeo/cssquery-yui.html (next: http://localhost:46527/tests/dromaeo/cssquery-dojo.html) 04:53:17 INFO - PROCESS | 9264 | RSS: Main: 197505024 04:53:17 INFO - PROCESS | 9264 | 04:53:17 INFO - PROCESS | 9264 | __start_tp_report 04:53:17 INFO - PROCESS | 9264 | _x_x_mozilla_page_load 04:53:17 INFO - PROCESS | 9264 | _x_x_mozilla_page_load_details 04:53:17 INFO - PROCESS | 9264 | |i|pagename|runs| 04:53:17 INFO - PROCESS | 9264 | |0;dojo.html;2575.4076562390637;2596.701379341376;2607.243899269212;2613.8693065346733;2621.069520320285;4503.1669141208895;4595.172868883599;4596.218642830719;4627.583517483426;4670.439547254326;4533.659975501834;4592.2422800238;4610.515895830939;4623.398958135438;4633.467151277604;4227.281362168424;4251.553586873365;4341.696081274312;4342.3052311630145;4380.561943805626;4243.04531480416;4322.762248076355;4331;4339.218940590692;4392.846250381237;4186.602272784081;4224.894377640553;4247.256730072225;4325.653947684178;4371.497277813029;4239.385289133058;4290.978545107286;4310.590493903074;4336.154449882274;4363.38912552243;4238.554951730086;4276.486821581399;4298.849540266107;4320.3951446797155;4349.304111342201;4516.864494065183;4547.47704014036;4641.814327426899;4660.673752837302;4695.906081878377;4905.9264111038365;4908.779104940286;4911.091448082117;4927.211646136637;4940.8764780880765;4944.703317800908;4950.356453661001;4971.651984361096;4980.651354405193;4991.201407774775;4606.539346065434;4674.719516829001;4697.812087516461;4724.12603668319;4730.219513780187;5103.489651034867;5112.795488180505;5113.64204505681;5114.846554603368;5173.818916337986;4739.454962679336;4790.640701947368;4838.322634831126;4864.246041863516;4892.315075889378;4757.452892917358;4998.300237966688;5007.073691367109;5045.5459008689395;5056.924146137811;4767.523247675204;4848.248521479177;4911.189653707098;4937.456879743226;5053.7220452875445;4947.109520286311;4955.529224723646;4961.404631444249;4985.750712464363;5009.524095210949;4160.209560183555;4194.6853985950565;4277.572242775697;4285.807138678704;4336.501302350207;3684.060564556021;3705.888823335304;3719.460678201646;3725.5343082114737;3768.1144930941205;4321.481422229353;4323.718958267703;4331.80506877185;4338.739675619473;4368.978155109204;4879.585235255043;5018.774155162953;5020.447750747415;5033.6224783141415;5046.1169295373165;4221.387898754663;4237.851675191415;4291.29193683045;4297.076128632359;4310.353446982915;4480.619147372445;4516.254817955067;4540.931886021713;4571.748553829505;4582.404287442611;4631.421072365887;4634.096351211481;4634.892436362429;4637.86086417408;4685.882852928704;4863.781129849094;4910.656254062182;5019.171836647059;5023.924641130313;5084.186530155157;4561.908761824679;4593.793279302507;4604.976975115237;4613.907721845611;4667.369905062773;4911.287863259879;4912.189488734319;4913.729744864067;4929.704217746947;4977.900441991213;4791.688540244873;4933.925991110064;4973.726445045557;4981.676191047571;5049.469805670352;4700.388949436551;4814.566688998007;4827.95172048275;4851.029794041136;4939.110960027229;4707.764611769467;4843.709377437365;4853.733044682576;4863.319135321129;4889.242167464049;4617.907641847211;4633.467151277646;4705.623550116051;4712.7643617818285;4713.104510143062;4759.190937540558;4873;4876.097921884463;4879.097366987119;4941.678790878582;4651.3720647712125;4756.120117778084;4766.642501812308;4805.3512775774825;4873.488283730299 04:53:17 INFO - PROCESS | 9264 | |1;ext.html;543.9891202175957;549.9092649712798;551.3053552523819;553.1067326268078;554.7780887644941;37417.43873841895;38687.41968870469;38944.41583376252;39078.80460597697;42259.57740422595;38893.61106388935;39646.8017659912;39686;39730.404043939365;39775.20449591007;7648.0822301323915;7710.383169346439;7784.571848548328;7785.221477852226;7785.299323060924;7499.325060744532;7577.621118944031;7626;7638.5798781067015;7639.19788422216;7696.191899850519;7729.34300584451;7731.265529774691;7745.3029227369525;7745.845083098335;7662.310392064713;7686.077670679554;7690.538567685957;7695.692172313101;7700.191479894586;7545.849083018309;7619.466637335388;7649.158592554814;7652.655630496641;7665.770026899202;36309.63690363089;36560.81719591385;36811.815940920125;36848.26303473942;36988.63011369879;2745.341118131654;2795.4828356754065;2836.1775085225468;2855.514562524376;2934.4131173765118;28531.714682853115;30213.697863021527;30984;31257.374852502824;31527.84236078828;3275.606927168755;3395.6059195277026;3412.4028295048515;3468.8785892493643;3472.4444088945647;241243;246807;247656;248961;249567;54389.45610543844;55329;55443;55713.72143139259;55791.44208557862;58845;58903;59241.703791480766;59422;59605.70197148986;12440.129190956546;12564.937175314066;12582.18215815969;12590.37048147589;12595.496180152875;9743.561539730728;9785.951070244602;9809.117179453884;9819.410835349901;9842.606295748234;17329.65340693179;18042.368517101837;18201.635967280847;18235.45293641193;18277.54306142357;7050.647467626598;7087.220405755363;7202.243764404767;7244.710211591583;7462.477626566197;735.9080114985627;736.9520981136209;747.8878168274694;802.6428239433512;857.2070834478083;25458.872705636353;27613;27781.583276250873;28178.295542611188;28179.295517612223;903.575319599787;954.737447202025;978.5351957820121;978.6036655154674;980.3480685344166;13243.252627767271;14119.505817296345;14388;14422.278886055656;14631.561053168421;362369;365634;366679;366952;367334;48058;48290;48700.26949595759;48706.756466218154;48771;1113.5991043224433;1144.730988217768;1188.0258188285695;1192.9701757456132;1203.6870413692502;24940.625890612017;27669.30826729348;28463.573046404734;28540.714592853805;28809.85595072095;39626.2074758509;40004.399934001594;40114.39828402635;40200.195996080496;40246.79876600598;282036;282243;284334;284368;284390;35962.64037359593;36055.63944360523;36669;36756.08109797276;36796;39832.60167398289;42713.8449614706;43231.8121825383;43684.34473482964;44110;34303.485447718806;34776.13059673528;34844.82577587096;35125.12187195341;35356.469652954715;33381.33237335288;34856.82571587126;34863.47704784379;34907.82546087355;35293.647063530065;34079.14802129867;34878;35021.47467788036;35213.119672008404;35418.8229058853;30808.691913080584;32175.195620109684;32368.83815580907;32790.83604581962;33003.8349808259;24992.37519062038;25007.499850003263;25067.623985639864;25344.239672809847;25395.11117110966 04:53:17 INFO - PROCESS | 9264 | |2;jquery.html;342.31536926147703;352.4026774617024;354.09881850689993;365.82988910156774;367.65624141427764;15459.922700386496;16382.18089095545;17195.968241905495;17308.740368894476;17347.653046939053;15042.323095460702;15204.315805788767;15233.31450084746;16103.83896161038;16194;4587.701799383046;4966.553010229079;4993.850184494453;4997.375328083989;5055.115354812911;4967.230079337691;5028.8239911603105;5317.521423071923;5351.839444816662;5391.460853914617;5334.626576139672;5356;5372.57019438446;5373.059714549958;5393.649412788156;5083.389993200821;5293.6294459387855;5322.547583455392;5348.491893270133;5452.727363631802;5247.842564723026;5280.735963201824;5286.101362768339;5287.180487024518;5288.709120998344;11827.290362578273;11889.108316876182;12138.939305303506;12166.087543434278;12501.812472812915;1710.5125039363722;1747.0915124135506;1762.6298477319779;1802.7025540785755;1818.3453956575622;8585.656573737044;8987.865182022275;9226;9480.715578532656;9570.665026724031;1610.1868556378954;1625.6423586810884;1646.6459711162158;1675.8826882118256;1698.176384453539;68104.31895681079;68891.96662050074;69934;70955;71219.64390178068;9470.715878523655;9539.379940303857;9608.13526782579;9883.703488895344;9955.104040636377;13128.803067953797;13152;13163.67090822737;13176.275304858325;13177.209367437985;6507.381798729113;6827.1807383113355;6887.20797108339;6891.827704307432;6949.166100068024;6342.334054924167;6359.109724638554;6375.968120159369;6529.216494020748;6559.901601475982;4052.3313653246882;4072.857449989236;4092.3861420786525;4170.207660544487;4201.642860356904;1606.7387101125794;1672.4397326895382;1702.1999660159704;1723.8103808581045;1755.6664233795539;759.9316061554487;840.2353857989323;854.3976496570027;909.5179554835947;922.4096578189964;15545.222738863238;16136.515904522883;16811.41160059392;16949.389807968222;17313.82686173147;831.1024093978489;833.5665453963904;840.4831028917295;849.6278510206097;908.0737647599543;9021;9368.250539956787;9421.38760980534;9431.811363772686;9658.179054780423;367964;372917;377914;379592;379932;44082.55917440849;60544;77489;77755.61122194353;81819.7727034095;845.6659619450282;877.8727084572702;883.0374891368439;886.2511178054533;886.9290456763443;14848.62878428048;14943.252837357872;15033;15483.071015739091;15518.9224053879;34738.478922816685;35166;36614.26771464502;36692.63307366892;37454.438183426726;48063.51936480591;51135.74432127816;51240.74379628078;51822.481775183274;51874;7192.42460603161;7236.059312289369;7256.9274307256255;7273.672684729094;7376.7786966391095;8454.704085357229;10622.415767132881;10743.838842417526;11290.830637540608;11616.303021818718;8761.430507017023;9277.16505514507;9281;9497.905020949702;9704.253234417873;9598.42409455435;9869.654562090293;9921.900780992097;9930.453825039693;10145.594176232868;8466.915330846612;9299.953500232727;9369.109934556207;9545.331826772059;9545.713628591153;7048.682809273492;7233.059702238886;7314.634268286671;7340.2292759261645;7435.62821858894;7025.789226323219;8336.333093352396;8441.95779021101;8640.524771137647;8690.435121717068 04:53:17 INFO - PROCESS | 9264 | |3;mootools.html;1364.7816349384098;1396.1762560089549;1456.1190479759746;1626.8373162683727;1669.7829282193313;6488.740450381979;6716.462682985361;7070.292970702927;7600.467967242295;7605.2394760523985;6970;7258.455615828808;7290.234525374825;7479.102507699084;7511.248875112486;2113.1547381047626;2140.079765700748;2141.764405915356;2141.9464513387134;2144.6354119799594;2117.5553133841913;2144.8927553622334;2175.401764514755;2176.1404245323088;2176.7714389988982;2124.893755312236;2128.053016407699;2130.3076500137518;2134.6264403729365;2149.0866381787755;2053.825424838883;2057.742782152231;2062.453449835795;2063.5253891605016;2064.0917996081675;2012.8590998630102;2101.0650260634025;2103.852730308879;2104.726640382562;2108.05137688041;7436.219196984347;7437.8140546486775;7490.625468726542;7559.395248380171;7561.3194812467145;4387.495438024636;4483.103379324116;4492.797824097924;4497.100579884036;4502.707324023928;2742.314421394651;2829.674587422452;2861.527847905093;2889.971100289012;2897.5219088850313;910.886139232596;931.2875650127658;931.4271722890442;948.359857096464;955.2214944819949;9873.654422095264;9913.90086099137;9926.404415735007;9929.602815887356;9940.204783617366;3828.9617103829164;3934.8229329680235;4057.6145266199665;4125.525564560114;4126.360414135814;8566.785830354167;8597.226249637437;8636.093210212963;8637.91362086371;8648.048714641385;4345.804438800262;4393.011572396249;4398.032432864765;4401.867943961686;4416.889577760518;3411.437112876348;3535.3106144301614;3971.5234171899556;3982.48227730399;3986.7009974252046;3414.283000569908;3482.512448257246;3572.3391172633146;3613.747037707335;3616.746827722034;1140.9942950285194;1162.4885050577718;1179.0685358566807;1181.216363291419;1184.5735535207318;765.9885101723479;770.6069904348823;786.7757689058706;791.0862953288961;808.9150639182918;4605.332226827159;4705.317728929286;4720.315554244684;4735.360726301974;4773.069251495995;384.57888611970407;394.45368165091554;400.3534292118208;400.9378546325266;409.86064737989227;3247.7726559140633;3256.4952432372547;3296.8516416761304;3304.2069903223055;3380.9661903381143;8563.143685631512;8963.282937364995;8964.8655270171;8976.326775491863;8996;8941.910580894108;8945.821083578423;8962.641494340154;8962.86555701665;9016.23362014223;7005.264447233069;7040.2607726189035;7048.436125109979;7063.470239732041;7091.539049961736;4722.952770472251;4772.5227477252;4837.7581120944515;4895.5593996539055;4984.8753781155765;8080.232377924088;8188.303994160325;8252.09226985019;8284.544350060563;8365.790855228668;8403.159684031792;8424.4945303282;8447.281981031681;8512.40413171072;8520.275776559061;5622.353429355677;5825.271841019872;6252.687365631791;6312.210973628296;6322.936770632235;6777.356151165632;6982.895256571257;7011.929880701127;7114.928850711427;7142.714291428492;6239.06414037898;6349.07938348946;6420.550561460653;6427.292997770335;6521.141474679694;6458.709358078804;6508.707108180238;6516.6415847128865;6520.576162549419;6534.771283005072;5492.862678433071;5637.689927053887;5647.1529270609735;5648.15277708347;5648.943510565006;4166.291730405777;4176.519700234512;4182.707210495358;4275.102228532043;4324.156789426158;4153.792310384529;4226.640735537514;4279.079997800488;4289.163613095417;4368.885934086915 04:53:17 INFO - PROCESS | 9264 | |4;prototype.html;279.96220510231115;291.37500062366223;293.6784221277701;298.69831470215104;303.3190487355886;4837.016823102529;4919.237518184678;4972.453030166684;5040.470750571192;5060.493950604938;4725.362076119732;4840.152973229679;4864.276005436949;4867.345102665102;4892.217245240762;3818.1027458547287;3825.7321987460887;3825.751326163804;3826.9234615307814;3851.9422208666892;3628.256207477461;3832.3868181090893;3863.6715879150306;3873;3876.612338766129;3754.192848537564;3764.341240282953;3773.9811300943456;3774.9811250943844;3792.829322680472;3747.793871337089;3773.0378753417704;3780.697544196458;3781.7541859779026;3786.2427514497213;3325.6341802401716;3335.5663763710804;3339.0316808125613;3341.164708822794;3354.3962086824604;4788.904221915577;4851.660383773137;4854.805807767685;4906.190478571031;4909.435414927293;4327.437433133704;4355.3031514957775;4364.388985542027;4367.126574685076;4375.8249670013165;5187.662801917863;5202.115640341151;5206.479352064801;5217.530422262014;5248.763805628756;3549.7515173937836;3595.2449985503076;3628.858973205795;3647.598764135943;3662.6520480554304;5386.569074474032;5417.8622489277295;5431.456854314616;5443.265159203496;5475.7262136893;3694.4458331250526;3705.7220708446976;3716.8699095532065;3739.6260373962386;3741.607131251234;3788.4885540451687;3793.637317085319;3797.2974999625158;3800.657940785343;3808.5429748430365;4121.649659778893;4264.232438161099;4309.685545908465;4336.869893903188;4363.716358436692;5149.562287205555;5166.948330516722;5177.559907407913;5178.6116041297055;5179.741012949337;1208.6221707253737;1245.2466257914014;1268.657462485124;1275.808628705683;1284.4797856867983;823.9011318641801;844.2486187293314;853.9658413663384;857.4212406625503;866.6490071521044;4485.237509623372;4500.797464114123;4508.436445444319;4514.480834703985;4538.773061346919;5300.9734951325;5316.494932981361;5324.148136298174;5326.201069839555;5335.626506144533;4452.5547445255215;4476.798544065525;4487.461504619467;4532.206863798822;4537.455505339314;2395.6406539019285;2483.5653760592186;2503.5493611149805;2521;2540.22523130447;4301.247281725686;4344.740734817877;4362.367456718822;4369.6722745794195;4418.779061046999;4689.6717229793585;4726.763661816895;4733.01213490328;4745.857624271208;4748.762561871893;4313.137372525507;4560.703554268962;4937.629677774181;4984.950150498448;5000.924616284201;5368.7047212403695;5403.892761661981;5420.457954204548;5426.430224826337;5438.537724293479;5158.329417175743;5293.179557168645;5335.599830012687;5336.3863155736035;5337.733113344395;4907.60739140875;4914.483979182134;4927.827526036572;4938.604911607134;4938.999705119432;3636.3454578176184;3671.687906527975;3680.7975561344383;3687.1150923778637;3690.520232369775;5388.218708287355;5410.810621628224;5413.83758487246;5444.537214336826;5453.400125986059;4770.284457331428;5070.771815268396;5141.994622097311;5156.607715916756;5171.63798534099;5166.2508936204795;5169.327987361769;5207.401148867929;5234.345706786652;5243.082460569309;4896.310772783384;5111.309973153725;5126.666766660155;5138.4604616514725;5155.355580552431;5185.248139019896;5230.34620672416;5233.6074794389815;5240.68555886648;5240.947590524046;5112.74436278192;5119.48805119485;5124.74376281177;5128.384593848613;5134.897302053863 04:53:17 INFO - PROCESS | 9264 | |5;yui.html;587.1427715535318;597.6802410710269;616.6608365399032;626.6616027345234;674.4469534981316;12204.694882627928;12922;13233;13241.668958276035;13888.583342499716;12428.067894907872;12630.431630576622;12641.683957901034;12646.430910609022;12825.935870320636;747.8279995601015;764.4304992780386;774.2915232562199;775.7595145504883;776.2392855002101;781.6677911887454;783.7374479549358;789.3487872505177;791.1060501633146;791.1929831571794;827.1397746343795;827.4414770030236;829.8755186721979;832.097174565597;832.379876991642;811.9188081191893;821.1419067074921;822.1613953767154;822.5558198572763;823.217942954193;603.8248907816728;604.0998911621696;604.2145211225389;604.2778879239311;604.5314880967242;13223.272720000396;13242.73514529704;13269.867301327056;13364.264965426897;13367.264800435973;13239.20564766117;13297.401616927165;13385.19688818674;13566.118202316818;13632.727345453135;10400.271980961335;10482.266241363108;10553.546288050997;10597.099246564052;10646.78706425875;3182.872685092617;3230.2408933900515;3264.7877887937207;3279.950800737991;3290.835458227103;60660.69669651668;62127.37872621261;62728.37271627271;63692.36307636957;64014.359856401774;10083.49582520871;10131;10263.281570290008;10310.793784124426;10355.482225888676;18892.433227003214;18906.960117193412;18932.337368192046;18974.905125474284;19013.524661883563;6277.748890044347;6282.748690052346;6338.904916426257;6616.900746488806;6638.17022872141;3537.0803591066506;3588.4258518636893;3621.8578477710907;3628.219932714479;3688.114852435396;2584.1730646193037;2661.148432501581;2677.1700772760505;2681.4234939488106;2682.235562864574;434.6392494229782;444.30022714225225;451.7876597998935;457.3391449355649;458.0335492111642;590.2592246730326;593.1636392686291;610.2006371653149;614.8585825260216;626.6083697688945;7695.4997925134685;7834.490758100819;8150.510969341858;8322.70870519529;8335.768520215435;461.3932678527725;478.6577597018149;532.475511621053;554.4510934175138;557.289455943667;3739.1773809761808;3757.0982964088967;3789.4694742736037;3801.8099095045136;4031.879043628696;93169.53415232881;95267.52366238124;99379.50930736045;102137.48931255296;102774;22519.662205066936;22764.544709105725;22787.202447914577;22821.657675134888;84380.57809711035;72749;73694;74632.62683686655;75096;76002.01978792257;7067.893981590383;7432.293932076444;7432.405407567489;7433.182349941394;7514.407529402348;42893.356599650404;43295.783521082194;44060;45218.54781452144;45936.31095533637;47476.7626161867;49584.55400798017;51257.743711281204;51937.98837156936;58320.70839645775;10703.464826758787;10808.783824323627;11127.276727012719;11333.603323883624;11487.253328533952;11795.233309834834;12196.695082623006;12324.568640097554;12505.56230531927;12751.681207969876;11430.828537571777;11604.30374177552;11624.709382265512;11848.229865058744;12025.879741202476;11964.58123965657;11989;12170.14808963364;12384.75230495367;12541.93729031349;11061.446927653424;11569.768604628029;11686.24039437468;11807.704807379885;12146.635600931986;9707.563159657973;9708.75728106803;10002.649907253211;10107;11057;9399.953000234955;10116.393016419039;10240.897591024292;10289.228307876789;10316.329438586468 04:53:17 INFO - PROCESS | 9264 | __end_tp_report 04:53:17 INFO - PROCESS | 9264 | __start_cc_report 04:53:17 INFO - PROCESS | 9264 | _x_x_mozilla_cycle_collect,336 04:53:17 INFO - PROCESS | 9264 | __end_cc_report 04:53:17 INFO - PROCESS | 9264 | __startTimestamp1476445997563__endTimestamp 04:53:17 INFO - PROCESS | 9264 | 04:53:17 INFO - PROCESS | 9264 | ------- Summary: start ------- 04:53:17 INFO - PROCESS | 9264 | Number of tests: 6 04:53:17 INFO - PROCESS | 9264 | 04:53:17 INFO - PROCESS | 9264 | [#0] dojo.html Cycles:165 Average:4590.65 Median:4674.72 stddev:471.43 (10.1%) stddev-sans-first:445.59 04:53:17 INFO - PROCESS | 9264 | Values: 2575.4 2596.7 2607.2 2613.9 2621.1 4503.2 4595.2 4596.2 4627.6 4670.4 4533.7 4592.2 4610.5 4623.4 4633.5 4227.3 4251.6 4341.7 4342.3 4380.6 4243.0 4322.8 4331.0 4339.2 4392.8 4186.6 4224.9 4247.3 4325.7 4371.5 4239.4 4291.0 4310.6 4336.2 4363.4 4238.6 4276.5 4298.8 4320.4 4349.3 4516.9 4547.5 4641.8 4660.7 4695.9 4905.9 4908.8 4911.1 4927.2 4940.9 4944.7 4950.4 4971.7 4980.7 4991.2 4606.5 4674.7 4697.8 4724.1 4730.2 5103.5 5112.8 5113.6 5114.8 5173.8 4739.5 4790.6 4838.3 4864.2 4892.3 4757.5 4998.3 5007.1 5045.5 5056.9 4767.5 4848.2 4911.2 4937.5 5053.7 4947.1 4955.5 4961.4 4985.8 5009.5 4160.2 4194.7 4277.6 4285.8 4336.5 3684.1 3705.9 3719.5 3725.5 3768.1 4321.5 4323.7 4331.8 4338.7 4369.0 4879.6 5018.8 5020.4 5033.6 5046.1 4221.4 4237.9 4291.3 4297.1 4310.4 4480.6 4516.3 4540.9 4571.7 4582.4 4631.4 4634.1 4634.9 4637.9 4685.9 4863.8 4910.7 5019.2 5023.9 5084.2 4561.9 4593.8 4605.0 4613.9 4667.4 4911.3 4912.2 4913.7 4929.7 4977.9 4791.7 4933.9 4973.7 4981.7 5049.5 4700.4 4814.6 4828.0 4851.0 4939.1 4707.8 4843.7 4853.7 4863.3 4889.2 4617.9 4633.5 4705.6 4712.8 4713.1 4759.2 4873.0 4876.1 4879.1 4941.7 4651.4 4756.1 4766.6 4805.4 4873.5 04:53:17 INFO - PROCESS | 9264 | 04:53:17 INFO - PROCESS | 9264 | [#1] ext.html Cycles:180 Average:45866.31 Median:36776.04 stddev:79527.94 (216.2%) stddev-sans-first:79678.24 04:53:17 INFO - PROCESS | 9264 | Values: 544.0 549.9 551.3 553.1 554.8 37417.4 38687.4 38944.4 39078.8 42259.6 38893.6 39646.8 39686.0 39730.4 39775.2 7648.1 7710.4 7784.6 7785.2 7785.3 7499.3 7577.6 7626.0 7638.6 7639.2 7696.2 7729.3 7731.3 7745.3 7745.8 7662.3 7686.1 7690.5 7695.7 7700.2 7545.8 7619.5 7649.2 7652.7 7665.8 36309.6 36560.8 36811.8 36848.3 36988.6 2745.3 2795.5 2836.2 2855.5 2934.4 28531.7 30213.7 30984.0 31257.4 31527.8 3275.6 3395.6 3412.4 3468.9 3472.4 241243.0 246807.0 247656.0 248961.0 249567.0 54389.5 55329.0 55443.0 55713.7 55791.4 58845.0 58903.0 59241.7 59422.0 59605.7 12440.1 12564.9 12582.2 12590.4 12595.5 9743.6 9786.0 9809.1 9819.4 9842.6 17329.7 18042.4 18201.6 18235.5 18277.5 7050.6 7087.2 7202.2 7244.7 7462.5 735.9 737.0 747.9 802.6 857.2 25458.9 27613.0 27781.6 28178.3 28179.3 903.6 954.7 978.5 978.6 980.3 13243.3 14119.5 14388.0 14422.3 14631.6 362369.0 365634.0 366679.0 366952.0 367334.0 48058.0 48290.0 48700.3 48706.8 48771.0 1113.6 1144.7 1188.0 1193.0 1203.7 24940.6 27669.3 28463.6 28540.7 28809.9 39626.2 40004.4 40114.4 40200.2 40246.8 282036.0 282243.0 284334.0 284368.0 284390.0 35962.6 36055.6 36669.0 36756.1 36796.0 39832.6 42713.8 43231.8 43684.3 44110.0 34303.5 34776.1 34844.8 35125.1 35356.5 33381.3 34856.8 34863.5 34907.8 35293.6 34079.1 34878.0 35021.5 35213.1 35418.8 30808.7 32175.2 32368.8 32790.8 33003.8 24992.4 25007.5 25067.6 25344.2 25395.1 04:53:17 INFO - PROCESS | 9264 | 04:53:17 INFO - PROCESS | 9264 | [#2] jquery.html Cycles:180 Average:23098.64 Median:5320.03 stddev:62086.11 (1167.0%) stddev-sans-first:62236.77 04:53:17 INFO - PROCESS | 9264 | Values: 342.3 352.4 354.1 365.8 367.7 15459.9 16382.2 17196.0 17308.7 17347.7 15042.3 15204.3 15233.3 16103.8 16194.0 4587.7 4966.6 4993.9 4997.4 5055.1 4967.2 5028.8 5317.5 5351.8 5391.5 5334.6 5356.0 5372.6 5373.1 5393.6 5083.4 5293.6 5322.5 5348.5 5452.7 5247.8 5280.7 5286.1 5287.2 5288.7 11827.3 11889.1 12138.9 12166.1 12501.8 1710.5 1747.1 1762.6 1802.7 1818.3 8585.7 8987.9 9226.0 9480.7 9570.7 1610.2 1625.6 1646.6 1675.9 1698.2 68104.3 68892.0 69934.0 70955.0 71219.6 9470.7 9539.4 9608.1 9883.7 9955.1 13128.8 13152.0 13163.7 13176.3 13177.2 6507.4 6827.2 6887.2 6891.8 6949.2 6342.3 6359.1 6376.0 6529.2 6559.9 4052.3 4072.9 4092.4 4170.2 4201.6 1606.7 1672.4 1702.2 1723.8 1755.7 759.9 840.2 854.4 909.5 922.4 15545.2 16136.5 16811.4 16949.4 17313.8 831.1 833.6 840.5 849.6 908.1 9021.0 9368.3 9421.4 9431.8 9658.2 367964.0 372917.0 377914.0 379592.0 379932.0 44082.6 60544.0 77489.0 77755.6 81819.8 845.7 877.9 883.0 886.3 886.9 14848.6 14943.3 15033.0 15483.1 15518.9 34738.5 35166.0 36614.3 36692.6 37454.4 48063.5 51135.7 51240.7 51822.5 51874.0 7192.4 7236.1 7256.9 7273.7 7376.8 8454.7 10622.4 10743.8 11290.8 11616.3 8761.4 9277.2 9281.0 9497.9 9704.3 9598.4 9869.7 9921.9 9930.5 10145.6 8466.9 9300.0 9369.1 9545.3 9545.7 7048.7 7233.1 7314.6 7340.2 7435.6 7025.8 8336.3 8442.0 8640.5 8690.4 04:53:17 INFO - PROCESS | 9264 | 04:53:17 INFO - PROCESS | 9264 | [#3] mootools.html Cycles:180 Average:4815.60 Median:4772.80 stddev:2683.55 (56.2%) stddev-sans-first:2678.55 04:53:17 INFO - PROCESS | 9264 | Values: 1364.8 1396.2 1456.1 1626.8 1669.8 6488.7 6716.5 7070.3 7600.5 7605.2 6970.0 7258.5 7290.2 7479.1 7511.2 2113.2 2140.1 2141.8 2141.9 2144.6 2117.6 2144.9 2175.4 2176.1 2176.8 2124.9 2128.1 2130.3 2134.6 2149.1 2053.8 2057.7 2062.5 2063.5 2064.1 2012.9 2101.1 2103.9 2104.7 2108.1 7436.2 7437.8 7490.6 7559.4 7561.3 4387.5 4483.1 4492.8 4497.1 4502.7 2742.3 2829.7 2861.5 2890.0 2897.5 910.9 931.3 931.4 948.4 955.2 9873.7 9913.9 9926.4 9929.6 9940.2 3829.0 3934.8 4057.6 4125.5 4126.4 8566.8 8597.2 8636.1 8637.9 8648.0 4345.8 4393.0 4398.0 4401.9 4416.9 3411.4 3535.3 3971.5 3982.5 3986.7 3414.3 3482.5 3572.3 3613.7 3616.7 1141.0 1162.5 1179.1 1181.2 1184.6 766.0 770.6 786.8 791.1 808.9 4605.3 4705.3 4720.3 4735.4 4773.1 384.6 394.5 400.4 400.9 409.9 3247.8 3256.5 3296.9 3304.2 3381.0 8563.1 8963.3 8964.9 8976.3 8996.0 8941.9 8945.8 8962.6 8962.9 9016.2 7005.3 7040.3 7048.4 7063.5 7091.5 4723.0 4772.5 4837.8 4895.6 4984.9 8080.2 8188.3 8252.1 8284.5 8365.8 8403.2 8424.5 8447.3 8512.4 8520.3 5622.4 5825.3 6252.7 6312.2 6322.9 6777.4 6982.9 7011.9 7114.9 7142.7 6239.1 6349.1 6420.6 6427.3 6521.1 6458.7 6508.7 6516.6 6520.6 6534.8 5492.9 5637.7 5647.2 5648.2 5648.9 4166.3 4176.5 4182.7 4275.1 4324.2 4153.8 4226.6 4279.1 4289.2 4368.9 04:53:17 INFO - PROCESS | 9264 | 04:53:17 INFO - PROCESS | 9264 | [#4] prototype.html Cycles:180 Average:4229.76 Median:4739.43 stddev:1258.86 (26.6%) stddev-sans-first:1226.99 04:53:17 INFO - PROCESS | 9264 | Values: 280.0 291.4 293.7 298.7 303.3 4837.0 4919.2 4972.5 5040.5 5060.5 4725.4 4840.2 4864.3 4867.3 4892.2 3818.1 3825.7 3825.8 3826.9 3851.9 3628.3 3832.4 3863.7 3873.0 3876.6 3754.2 3764.3 3774.0 3775.0 3792.8 3747.8 3773.0 3780.7 3781.8 3786.2 3325.6 3335.6 3339.0 3341.2 3354.4 4788.9 4851.7 4854.8 4906.2 4909.4 4327.4 4355.3 4364.4 4367.1 4375.8 5187.7 5202.1 5206.5 5217.5 5248.8 3549.8 3595.2 3628.9 3647.6 3662.7 5386.6 5417.9 5431.5 5443.3 5475.7 3694.4 3705.7 3716.9 3739.6 3741.6 3788.5 3793.6 3797.3 3800.7 3808.5 4121.6 4264.2 4309.7 4336.9 4363.7 5149.6 5166.9 5177.6 5178.6 5179.7 1208.6 1245.2 1268.7 1275.8 1284.5 823.9 844.2 854.0 857.4 866.6 4485.2 4500.8 4508.4 4514.5 4538.8 5301.0 5316.5 5324.1 5326.2 5335.6 4452.6 4476.8 4487.5 4532.2 4537.5 2395.6 2483.6 2503.5 2521.0 2540.2 4301.2 4344.7 4362.4 4369.7 4418.8 4689.7 4726.8 4733.0 4745.9 4748.8 4313.1 4560.7 4937.6 4985.0 5000.9 5368.7 5403.9 5420.5 5426.4 5438.5 5158.3 5293.2 5335.6 5336.4 5337.7 4907.6 4914.5 4927.8 4938.6 4939.0 3636.3 3671.7 3680.8 3687.1 3690.5 5388.2 5410.8 5413.8 5444.5 5453.4 4770.3 5070.8 5142.0 5156.6 5171.6 5166.3 5169.3 5207.4 5234.3 5243.1 4896.3 5111.3 5126.7 5138.5 5155.4 5185.2 5230.3 5233.6 5240.7 5240.9 5112.7 5119.5 5124.7 5128.4 5134.9 04:53:17 INFO - PROCESS | 9264 | 04:53:17 INFO - PROCESS | 9264 | [#5] yui.html Cycles:180 Average:16089.54 Median:3795.64 stddev:22876.42 (602.7%) stddev-sans-first:22910.98 04:53:17 INFO - PROCESS | 9264 | Values: 587.1 597.7 616.7 626.7 674.4 12204.7 12922.0 13233.0 13241.7 13888.6 12428.1 12630.4 12641.7 12646.4 12825.9 747.8 764.4 774.3 775.8 776.2 781.7 783.7 789.3 791.1 791.2 827.1 827.4 829.9 832.1 832.4 811.9 821.1 822.2 822.6 823.2 603.8 604.1 604.2 604.3 604.5 13223.3 13242.7 13269.9 13364.3 13367.3 13239.2 13297.4 13385.2 13566.1 13632.7 10400.3 10482.3 10553.5 10597.1 10646.8 3182.9 3230.2 3264.8 3280.0 3290.8 60660.7 62127.4 62728.4 63692.4 64014.4 10083.5 10131.0 10263.3 10310.8 10355.5 18892.4 18907.0 18932.3 18974.9 19013.5 6277.7 6282.7 6338.9 6616.9 6638.2 3537.1 3588.4 3621.9 3628.2 3688.1 2584.2 2661.1 2677.2 2681.4 2682.2 434.6 444.3 451.8 457.3 458.0 590.3 593.2 610.2 614.9 626.6 7695.5 7834.5 8150.5 8322.7 8335.8 461.4 478.7 532.5 554.5 557.3 3739.2 3757.1 3789.5 3801.8 4031.9 93169.5 95267.5 99379.5 102137.5 102774.0 22519.7 22764.5 22787.2 22821.7 84380.6 72749.0 73694.0 74632.6 75096.0 76002.0 7067.9 7432.3 7432.4 7433.2 7514.4 42893.4 43295.8 44060.0 45218.5 45936.3 47476.8 49584.6 51257.7 51938.0 58320.7 10703.5 10808.8 11127.3 11333.6 11487.3 11795.2 12196.7 12324.6 12505.6 12751.7 11430.8 11604.3 11624.7 11848.2 12025.9 11964.6 11989.0 12170.1 12384.8 12541.9 11061.4 11569.8 11686.2 11807.7 12146.6 9707.6 9708.8 10002.6 10107.0 11057.0 9400.0 10116.4 10240.9 10289.2 10316.3 04:53:17 INFO - PROCESS | 9264 | -------- Summary: end -------- 04:53:17 INFO - PROCESS | 9264 | 04:53:18 INFO - TEST-INFO | 9264: exit 0 04:53:18 INFO - TEST-OK | dromaeo_css | took 1120082ms 04:53:18 INFO - TEST-START | kraken 04:53:18 INFO - operating with platform_type : linux_ 04:53:18 INFO - Initialising browser for kraken test... 04:53:18 INFO - TEST-INFO | started process 9637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTfo3GG/profile http://localhost:46527/getInfo.html) 04:53:23 INFO - PROCESS | 9637 | __metrics Screen width/height:1600/1200 04:53:23 INFO - PROCESS | 9637 | colorDepth:24 04:53:23 INFO - PROCESS | 9637 | Browser inner width/height: 1024/697 04:53:23 INFO - PROCESS | 9637 | __metrics 04:53:24 ERROR - PROCESS | 9637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 04:53:25 INFO - TEST-INFO | 9637: exit 0 04:53:25 INFO - Browser initialized. 04:53:25 INFO - Running cycle 1/1 for kraken test... 04:53:25 INFO - TEST-INFO | started process 9758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTfo3GG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:37 INFO - PROCESS | 9758 | RSS: Main: 184127488 04:53:37 INFO - PROCESS | 9758 | 04:53:40 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46527/tests/kraken/driver.html?testName=audio-beat-detection) 04:53:41 INFO - PROCESS | 9758 | RSS: Main: 197533696 04:53:41 INFO - PROCESS | 9758 | 04:53:44 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46527/tests/kraken/driver.html?testName=audio-dft) 04:53:44 INFO - PROCESS | 9758 | RSS: Main: 195887104 04:53:44 INFO - PROCESS | 9758 | 04:53:47 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46527/tests/kraken/driver.html?testName=audio-fft) 04:53:48 INFO - PROCESS | 9758 | RSS: Main: 192614400 04:53:48 INFO - PROCESS | 9758 | 04:53:50 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46527/tests/kraken/driver.html?testName=audio-oscillator) 04:53:51 INFO - PROCESS | 9758 | RSS: Main: 192794624 04:53:51 INFO - PROCESS | 9758 | 04:53:53 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46527/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:53:54 INFO - PROCESS | 9758 | RSS: Main: 193187840 04:53:54 INFO - PROCESS | 9758 | 04:53:57 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46527/tests/kraken/driver.html?testName=imaging-darkroom) 04:53:58 INFO - PROCESS | 9758 | RSS: Main: 193912832 04:53:58 INFO - PROCESS | 9758 | 04:54:01 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46527/tests/kraken/driver.html?testName=imaging-desaturate) 04:54:02 INFO - PROCESS | 9758 | RSS: Main: 191500288 04:54:02 INFO - PROCESS | 9758 | 04:54:05 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46527/tests/kraken/driver.html?testName=json-parse-financial) 04:54:05 INFO - PROCESS | 9758 | RSS: Main: 192565248 04:54:05 INFO - PROCESS | 9758 | 04:54:07 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46527/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:54:08 INFO - PROCESS | 9758 | RSS: Main: 192692224 04:54:08 INFO - PROCESS | 9758 | 04:54:10 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:54:10 INFO - PROCESS | 9758 | RSS: Main: 192475136 04:54:10 INFO - PROCESS | 9758 | 04:54:13 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:54:13 INFO - PROCESS | 9758 | RSS: Main: 193773568 04:54:13 INFO - PROCESS | 9758 | 04:54:16 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:54:17 INFO - PROCESS | 9758 | RSS: Main: 193470464 04:54:17 INFO - PROCESS | 9758 | 04:54:20 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:54:21 INFO - PROCESS | 9758 | RSS: Main: 193269760 04:54:21 INFO - PROCESS | 9758 | 04:54:22 INFO - PROCESS | 9758 | Cycle 1(1): loaded http://localhost:46527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46527/tests/kraken/driver.html?testName=ai-astar) 04:54:23 INFO - PROCESS | 9758 | RSS: Main: 196173824 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | __start_tp_report 04:54:23 INFO - PROCESS | 9758 | _x_x_mozilla_page_load 04:54:23 INFO - PROCESS | 9758 | _x_x_mozilla_page_load_details 04:54:23 INFO - PROCESS | 9758 | |i|pagename|runs| 04:54:23 INFO - PROCESS | 9758 | |0;ai-astar;111;116;115;115;115;116;117;116;116;116 04:54:23 INFO - PROCESS | 9758 | |1;audio-beat-detection;158;129;129;185;134;129;130;130;158;131 04:54:23 INFO - PROCESS | 9758 | |2;audio-dft;171;166;165;166;165;166;164;166;165;163 04:54:23 INFO - PROCESS | 9758 | |3;audio-fft;80;78;78;107;77;77;76;85;104;78 04:54:23 INFO - PROCESS | 9758 | |4;audio-oscillator;85;85;112;85;85;85;110;85;84;117 04:54:23 INFO - PROCESS | 9758 | |5;imaging-gaussian-blur;117;118;119;118;119;119;119;119;118;118 04:54:23 INFO - PROCESS | 9758 | |6;imaging-darkroom;147;147;148;149;149;148;150;148;148;148 04:54:23 INFO - PROCESS | 9758 | |7;imaging-desaturate;85;86;86;84;86;86;85;85;85;86 04:54:23 INFO - PROCESS | 9758 | |8;json-parse-financial;66;67;65;66;65;69;66;65;67;71 04:54:23 INFO - PROCESS | 9758 | |9;json-stringify-tinderbox;68;68;67;68;69;70;68;68;69;68 04:54:23 INFO - PROCESS | 9758 | |10;stanford-crypto-aes;90;86;84;84;86;88;83;83;86;83 04:54:23 INFO - PROCESS | 9758 | |11;stanford-crypto-ccm;144;143;142;151;148;145;151;148;185;146 04:54:23 INFO - PROCESS | 9758 | |12;stanford-crypto-pbkdf2;181;182;183;181;175;177;183;179;175;188 04:54:23 INFO - PROCESS | 9758 | |13;stanford-crypto-sha256-iterative;73;72;72;72;75;72;73;73;74;71 04:54:23 INFO - PROCESS | 9758 | __end_tp_report 04:54:23 INFO - PROCESS | 9758 | __start_cc_report 04:54:23 INFO - PROCESS | 9758 | _x_x_mozilla_cycle_collect,882 04:54:23 INFO - PROCESS | 9758 | __end_cc_report 04:54:23 INFO - PROCESS | 9758 | __startTimestamp1476446063131__endTimestamp 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | ------- Summary: start ------- 04:54:23 INFO - PROCESS | 9758 | Number of tests: 14 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | [#0] ai-astar Cycles:10 Average:115.30 Median:116.00 stddev:1.64 (1.4%) stddev-sans-first:0.67 04:54:23 INFO - PROCESS | 9758 | Values: 111.0 116.0 115.0 115.0 115.0 116.0 117.0 116.0 116.0 116.0 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:132.50 stddev:19.25 (14.5%) stddev-sans-first:19.45 04:54:23 INFO - PROCESS | 9758 | Values: 158.0 129.0 129.0 185.0 134.0 129.0 130.0 130.0 158.0 131.0 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | [#2] audio-dft Cycles:10 Average:165.70 Median:166.00 stddev:2.11 (1.3%) stddev-sans-first:1.05 04:54:23 INFO - PROCESS | 9758 | Values: 171.0 166.0 165.0 166.0 165.0 166.0 164.0 166.0 165.0 163.0 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | [#3] audio-fft Cycles:10 Average:84.00 Median:78.00 stddev:11.62 (14.9%) stddev-sans-first:12.24 04:54:23 INFO - PROCESS | 9758 | Values: 80.0 78.0 78.0 107.0 77.0 77.0 76.0 85.0 104.0 78.0 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:85.00 stddev:13.70 (16.1%) stddev-sans-first:14.20 04:54:23 INFO - PROCESS | 9758 | Values: 85.0 85.0 112.0 85.0 85.0 85.0 110.0 85.0 84.0 117.0 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:119.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 04:54:23 INFO - PROCESS | 9758 | Values: 117.0 118.0 119.0 118.0 119.0 119.0 119.0 119.0 118.0 118.0 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 04:54:23 INFO - PROCESS | 9758 | Values: 147.0 147.0 148.0 149.0 149.0 148.0 150.0 148.0 148.0 148.0 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 04:54:23 INFO - PROCESS | 9758 | Values: 85.0 86.0 86.0 84.0 86.0 86.0 85.0 85.0 85.0 86.0 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:66.50 stddev:1.95 (2.9%) stddev-sans-first:2.05 04:54:23 INFO - PROCESS | 9758 | Values: 66.0 67.0 65.0 66.0 65.0 69.0 66.0 65.0 67.0 71.0 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 04:54:23 INFO - PROCESS | 9758 | Values: 68.0 68.0 67.0 68.0 69.0 70.0 68.0 68.0 69.0 68.0 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:86.00 stddev:2.36 (2.7%) stddev-sans-first:1.79 04:54:23 INFO - PROCESS | 9758 | Values: 90.0 86.0 84.0 84.0 86.0 88.0 83.0 83.0 86.0 83.0 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | [#11] stanford-crypto-ccm Cycles:10 Average:150.30 Median:148.00 stddev:12.58 (8.5%) stddev-sans-first:13.13 04:54:23 INFO - PROCESS | 9758 | Values: 144.0 143.0 142.0 151.0 148.0 145.0 151.0 148.0 185.0 146.0 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:181.50 stddev:4.03 (2.2%) stddev-sans-first:4.27 04:54:23 INFO - PROCESS | 9758 | Values: 181.0 182.0 183.0 181.0 175.0 177.0 183.0 179.0 175.0 188.0 04:54:23 INFO - PROCESS | 9758 | 04:54:23 INFO - PROCESS | 9758 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.00 stddev:1.16 (1.6%) stddev-sans-first:1.22 04:54:23 INFO - PROCESS | 9758 | Values: 73.0 72.0 72.0 72.0 75.0 72.0 73.0 73.0 74.0 71.0 04:54:23 INFO - PROCESS | 9758 | -------- Summary: end -------- 04:54:23 INFO - PROCESS | 9758 | 04:54:24 INFO - TEST-INFO | 9758: exit 0 04:54:24 INFO - TEST-OK | kraken | took 65637ms 04:54:24 INFO - SUITE-END | took 1185s 04:54:24 INFO - Completed test suite (00:19:46) 04:54:24 INFO - javascript benchmark 04:54:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6184.816194917176, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2575.4076562390637, 2596.701379341376, 2607.243899269212, 2613.8693065346733, 2621.069520320285, 4503.1669141208895, 4595.172868883599, 4596.218642830719, 4627.583517483426, 4670.439547254326, 4533.659975501834, 4592.2422800238, 4610.515895830939, 4623.398958135438, 4633.467151277604, 4227.281362168424, 4251.553586873365, 4341.696081274312, 4342.3052311630145, 4380.561943805626, 4243.04531480416, 4322.762248076355, 4331.0, 4339.218940590692, 4392.846250381237, 4186.602272784081, 4224.894377640553, 4247.256730072225, 4325.653947684178, 4371.497277813029, 4239.385289133058, 4290.978545107286, 4310.590493903074, 4336.154449882274, 4363.38912552243, 4238.554951730086, 4276.486821581399, 4298.849540266107, 4320.3951446797155, 4349.304111342201, 4516.864494065183, 4547.47704014036, 4641.814327426899, 4660.673752837302, 4695.906081878377, 4905.9264111038365, 4908.779104940286, 4911.091448082117, 4927.211646136637, 4940.8764780880765, 4944.703317800908, 4950.356453661001, 4971.651984361096, 4980.651354405193, 4991.201407774775, 4606.539346065434, 4674.719516829001, 4697.812087516461, 4724.12603668319, 4730.219513780187, 5103.489651034867, 5112.795488180505, 5113.64204505681, 5114.846554603368, 5173.818916337986, 4739.454962679336, 4790.640701947368, 4838.322634831126, 4864.246041863516, 4892.315075889378, 4757.452892917358, 4998.300237966688, 5007.073691367109, 5045.5459008689395, 5056.924146137811, 4767.523247675204, 4848.248521479177, 4911.189653707098, 4937.456879743226, 5053.7220452875445, 4947.109520286311, 4955.529224723646, 4961.404631444249, 4985.750712464363, 5009.524095210949, 4160.209560183555, 4194.6853985950565, 4277.572242775697, 4285.807138678704, 4336.501302350207, 3684.060564556021, 3705.888823335304, 3719.460678201646, 3725.5343082114737, 3768.1144930941205, 4321.481422229353, 4323.718958267703, 4331.80506877185, 4338.739675619473, 4368.978155109204, 4879.585235255043, 5018.774155162953, 5020.447750747415, 5033.6224783141415, 5046.1169295373165, 4221.387898754663, 4237.851675191415, 4291.29193683045, 4297.076128632359, 4310.353446982915, 4480.619147372445, 4516.254817955067, 4540.931886021713, 4571.748553829505, 4582.404287442611, 4631.421072365887, 4634.096351211481, 4634.892436362429, 4637.86086417408, 4685.882852928704, 4863.781129849094, 4910.656254062182, 5019.171836647059, 5023.924641130313, 5084.186530155157, 4561.908761824679, 4593.793279302507, 4604.976975115237, 4613.907721845611, 4667.369905062773, 4911.287863259879, 4912.189488734319, 4913.729744864067, 4929.704217746947, 4977.900441991213, 4791.688540244873, 4933.925991110064, 4973.726445045557, 4981.676191047571, 5049.469805670352, 4700.388949436551, 4814.566688998007, 4827.95172048275, 4851.029794041136, 4939.110960027229, 4707.764611769467, 4843.709377437365, 4853.733044682576, 4863.319135321129, 4889.242167464049, 4617.907641847211, 4633.467151277646, 4705.623550116051, 4712.7643617818285, 4713.104510143062, 4759.190937540558, 4873.0, 4876.097921884463, 4879.097366987119, 4941.678790878582, 4651.3720647712125, 4756.120117778084, 4766.642501812308, 4805.3512775774825, 4873.488283730299], "value": 4561.186801064754, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.9891202175957, 549.9092649712798, 551.3053552523819, 553.1067326268078, 554.7780887644941, 37417.43873841895, 38687.41968870469, 38944.41583376252, 39078.80460597697, 42259.57740422595, 38893.61106388935, 39646.8017659912, 39686.0, 39730.404043939365, 39775.20449591007, 7648.0822301323915, 7710.383169346439, 7784.571848548328, 7785.221477852226, 7785.299323060924, 7499.325060744532, 7577.621118944031, 7626.0, 7638.5798781067015, 7639.19788422216, 7696.191899850519, 7729.34300584451, 7731.265529774691, 7745.3029227369525, 7745.845083098335, 7662.310392064713, 7686.077670679554, 7690.538567685957, 7695.692172313101, 7700.191479894586, 7545.849083018309, 7619.466637335388, 7649.158592554814, 7652.655630496641, 7665.770026899202, 36309.63690363089, 36560.81719591385, 36811.815940920125, 36848.26303473942, 36988.63011369879, 2745.341118131654, 2795.4828356754065, 2836.1775085225468, 2855.514562524376, 2934.4131173765118, 28531.714682853115, 30213.697863021527, 30984.0, 31257.374852502824, 31527.84236078828, 3275.606927168755, 3395.6059195277026, 3412.4028295048515, 3468.8785892493643, 3472.4444088945647, 241243.0, 246807.0, 247656.0, 248961.0, 249567.0, 54389.45610543844, 55329.0, 55443.0, 55713.72143139259, 55791.44208557862, 58845.0, 58903.0, 59241.703791480766, 59422.0, 59605.70197148986, 12440.129190956546, 12564.937175314066, 12582.18215815969, 12590.37048147589, 12595.496180152875, 9743.561539730728, 9785.951070244602, 9809.117179453884, 9819.410835349901, 9842.606295748234, 17329.65340693179, 18042.368517101837, 18201.635967280847, 18235.45293641193, 18277.54306142357, 7050.647467626598, 7087.220405755363, 7202.243764404767, 7244.710211591583, 7462.477626566197, 735.9080114985627, 736.9520981136209, 747.8878168274694, 802.6428239433512, 857.2070834478083, 25458.872705636353, 27613.0, 27781.583276250873, 28178.295542611188, 28179.295517612223, 903.575319599787, 954.737447202025, 978.5351957820121, 978.6036655154674, 980.3480685344166, 13243.252627767271, 14119.505817296345, 14388.0, 14422.278886055656, 14631.561053168421, 362369.0, 365634.0, 366679.0, 366952.0, 367334.0, 48058.0, 48290.0, 48700.26949595759, 48706.756466218154, 48771.0, 1113.5991043224433, 1144.730988217768, 1188.0258188285695, 1192.9701757456132, 1203.6870413692502, 24940.625890612017, 27669.30826729348, 28463.573046404734, 28540.714592853805, 28809.85595072095, 39626.2074758509, 40004.399934001594, 40114.39828402635, 40200.195996080496, 40246.79876600598, 282036.0, 282243.0, 284334.0, 284368.0, 284390.0, 35962.64037359593, 36055.63944360523, 36669.0, 36756.08109797276, 36796.0, 39832.60167398289, 42713.8449614706, 43231.8121825383, 43684.34473482964, 44110.0, 34303.485447718806, 34776.13059673528, 34844.82577587096, 35125.12187195341, 35356.469652954715, 33381.33237335288, 34856.82571587126, 34863.47704784379, 34907.82546087355, 35293.647063530065, 34079.14802129867, 34878.0, 35021.47467788036, 35213.119672008404, 35418.8229058853, 30808.691913080584, 32175.195620109684, 32368.83815580907, 32790.83604581962, 33003.8349808259, 24992.37519062038, 25007.499850003263, 25067.623985639864, 25344.239672809847, 25395.11117110966], "value": 17230.73938216524, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.31536926147703, 352.4026774617024, 354.09881850689993, 365.82988910156774, 367.65624141427764, 15459.922700386496, 16382.18089095545, 17195.968241905495, 17308.740368894476, 17347.653046939053, 15042.323095460702, 15204.315805788767, 15233.31450084746, 16103.83896161038, 16194.0, 4587.701799383046, 4966.553010229079, 4993.850184494453, 4997.375328083989, 5055.115354812911, 4967.230079337691, 5028.8239911603105, 5317.521423071923, 5351.839444816662, 5391.460853914617, 5334.626576139672, 5356.0, 5372.57019438446, 5373.059714549958, 5393.649412788156, 5083.389993200821, 5293.6294459387855, 5322.547583455392, 5348.491893270133, 5452.727363631802, 5247.842564723026, 5280.735963201824, 5286.101362768339, 5287.180487024518, 5288.709120998344, 11827.290362578273, 11889.108316876182, 12138.939305303506, 12166.087543434278, 12501.812472812915, 1710.5125039363722, 1747.0915124135506, 1762.6298477319779, 1802.7025540785755, 1818.3453956575622, 8585.656573737044, 8987.865182022275, 9226.0, 9480.715578532656, 9570.665026724031, 1610.1868556378954, 1625.6423586810884, 1646.6459711162158, 1675.8826882118256, 1698.176384453539, 68104.31895681079, 68891.96662050074, 69934.0, 70955.0, 71219.64390178068, 9470.715878523655, 9539.379940303857, 9608.13526782579, 9883.703488895344, 9955.104040636377, 13128.803067953797, 13152.0, 13163.67090822737, 13176.275304858325, 13177.209367437985, 6507.381798729113, 6827.1807383113355, 6887.20797108339, 6891.827704307432, 6949.166100068024, 6342.334054924167, 6359.109724638554, 6375.968120159369, 6529.216494020748, 6559.901601475982, 4052.3313653246882, 4072.857449989236, 4092.3861420786525, 4170.207660544487, 4201.642860356904, 1606.7387101125794, 1672.4397326895382, 1702.1999660159704, 1723.8103808581045, 1755.6664233795539, 759.9316061554487, 840.2353857989323, 854.3976496570027, 909.5179554835947, 922.4096578189964, 15545.222738863238, 16136.515904522883, 16811.41160059392, 16949.389807968222, 17313.82686173147, 831.1024093978489, 833.5665453963904, 840.4831028917295, 849.6278510206097, 908.0737647599543, 9021.0, 9368.250539956787, 9421.38760980534, 9431.811363772686, 9658.179054780423, 367964.0, 372917.0, 377914.0, 379592.0, 379932.0, 44082.55917440849, 60544.0, 77489.0, 77755.61122194353, 81819.7727034095, 845.6659619450282, 877.8727084572702, 883.0374891368439, 886.2511178054533, 886.9290456763443, 14848.62878428048, 14943.252837357872, 15033.0, 15483.071015739091, 15518.9224053879, 34738.478922816685, 35166.0, 36614.26771464502, 36692.63307366892, 37454.438183426726, 48063.51936480591, 51135.74432127816, 51240.74379628078, 51822.481775183274, 51874.0, 7192.42460603161, 7236.059312289369, 7256.9274307256255, 7273.672684729094, 7376.7786966391095, 8454.704085357229, 10622.415767132881, 10743.838842417526, 11290.830637540608, 11616.303021818718, 8761.430507017023, 9277.16505514507, 9281.0, 9497.905020949702, 9704.253234417873, 9598.42409455435, 9869.654562090293, 9921.900780992097, 9930.453825039693, 10145.594176232868, 8466.915330846612, 9299.953500232727, 9369.109934556207, 9545.331826772059, 9545.713628591153, 7048.682809273492, 7233.059702238886, 7314.634268286671, 7340.2292759261645, 7435.62821858894, 7025.789226323219, 8336.333093352396, 8441.95779021101, 8640.524771137647, 8690.435121717068], "value": 7715.00332097103, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.7816349384098, 1396.1762560089549, 1456.1190479759746, 1626.8373162683727, 1669.7829282193313, 6488.740450381979, 6716.462682985361, 7070.292970702927, 7600.467967242295, 7605.2394760523985, 6970.0, 7258.455615828808, 7290.234525374825, 7479.102507699084, 7511.248875112486, 2113.1547381047626, 2140.079765700748, 2141.764405915356, 2141.9464513387134, 2144.6354119799594, 2117.5553133841913, 2144.8927553622334, 2175.401764514755, 2176.1404245323088, 2176.7714389988982, 2124.893755312236, 2128.053016407699, 2130.3076500137518, 2134.6264403729365, 2149.0866381787755, 2053.825424838883, 2057.742782152231, 2062.453449835795, 2063.5253891605016, 2064.0917996081675, 2012.8590998630102, 2101.0650260634025, 2103.852730308879, 2104.726640382562, 2108.05137688041, 7436.219196984347, 7437.8140546486775, 7490.625468726542, 7559.395248380171, 7561.3194812467145, 4387.495438024636, 4483.103379324116, 4492.797824097924, 4497.100579884036, 4502.707324023928, 2742.314421394651, 2829.674587422452, 2861.527847905093, 2889.971100289012, 2897.5219088850313, 910.886139232596, 931.2875650127658, 931.4271722890442, 948.359857096464, 955.2214944819949, 9873.654422095264, 9913.90086099137, 9926.404415735007, 9929.602815887356, 9940.204783617366, 3828.9617103829164, 3934.8229329680235, 4057.6145266199665, 4125.525564560114, 4126.360414135814, 8566.785830354167, 8597.226249637437, 8636.093210212963, 8637.91362086371, 8648.048714641385, 4345.804438800262, 4393.011572396249, 4398.032432864765, 4401.867943961686, 4416.889577760518, 3411.437112876348, 3535.3106144301614, 3971.5234171899556, 3982.48227730399, 3986.7009974252046, 3414.283000569908, 3482.512448257246, 3572.3391172633146, 3613.747037707335, 3616.746827722034, 1140.9942950285194, 1162.4885050577718, 1179.0685358566807, 1181.216363291419, 1184.5735535207318, 765.9885101723479, 770.6069904348823, 786.7757689058706, 791.0862953288961, 808.9150639182918, 4605.332226827159, 4705.317728929286, 4720.315554244684, 4735.360726301974, 4773.069251495995, 384.57888611970407, 394.45368165091554, 400.3534292118208, 400.9378546325266, 409.86064737989227, 3247.7726559140633, 3256.4952432372547, 3296.8516416761304, 3304.2069903223055, 3380.9661903381143, 8563.143685631512, 8963.282937364995, 8964.8655270171, 8976.326775491863, 8996.0, 8941.910580894108, 8945.821083578423, 8962.641494340154, 8962.86555701665, 9016.23362014223, 7005.264447233069, 7040.2607726189035, 7048.436125109979, 7063.470239732041, 7091.539049961736, 4722.952770472251, 4772.5227477252, 4837.7581120944515, 4895.5593996539055, 4984.8753781155765, 8080.232377924088, 8188.303994160325, 8252.09226985019, 8284.544350060563, 8365.790855228668, 8403.159684031792, 8424.4945303282, 8447.281981031681, 8512.40413171072, 8520.275776559061, 5622.353429355677, 5825.271841019872, 6252.687365631791, 6312.210973628296, 6322.936770632235, 6777.356151165632, 6982.895256571257, 7011.929880701127, 7114.928850711427, 7142.714291428492, 6239.06414037898, 6349.07938348946, 6420.550561460653, 6427.292997770335, 6521.141474679694, 6458.709358078804, 6508.707108180238, 6516.6415847128865, 6520.576162549419, 6534.771283005072, 5492.862678433071, 5637.689927053887, 5647.1529270609735, 5648.15277708347, 5648.943510565006, 4166.291730405777, 4176.519700234512, 4182.707210495358, 4275.102228532043, 4324.156789426158, 4153.792310384529, 4226.640735537514, 4279.079997800488, 4289.163613095417, 4368.885934086915], "value": 3845.398030806769, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.96220510231115, 291.37500062366223, 293.6784221277701, 298.69831470215104, 303.3190487355886, 4837.016823102529, 4919.237518184678, 4972.453030166684, 5040.470750571192, 5060.493950604938, 4725.362076119732, 4840.152973229679, 4864.276005436949, 4867.345102665102, 4892.217245240762, 3818.1027458547287, 3825.7321987460887, 3825.751326163804, 3826.9234615307814, 3851.9422208666892, 3628.256207477461, 3832.3868181090893, 3863.6715879150306, 3873.0, 3876.612338766129, 3754.192848537564, 3764.341240282953, 3773.9811300943456, 3774.9811250943844, 3792.829322680472, 3747.793871337089, 3773.0378753417704, 3780.697544196458, 3781.7541859779026, 3786.2427514497213, 3325.6341802401716, 3335.5663763710804, 3339.0316808125613, 3341.164708822794, 3354.3962086824604, 4788.904221915577, 4851.660383773137, 4854.805807767685, 4906.190478571031, 4909.435414927293, 4327.437433133704, 4355.3031514957775, 4364.388985542027, 4367.126574685076, 4375.8249670013165, 5187.662801917863, 5202.115640341151, 5206.479352064801, 5217.530422262014, 5248.763805628756, 3549.7515173937836, 3595.2449985503076, 3628.858973205795, 3647.598764135943, 3662.6520480554304, 5386.569074474032, 5417.8622489277295, 5431.456854314616, 5443.265159203496, 5475.7262136893, 3694.4458331250526, 3705.7220708446976, 3716.8699095532065, 3739.6260373962386, 3741.607131251234, 3788.4885540451687, 3793.637317085319, 3797.2974999625158, 3800.657940785343, 3808.5429748430365, 4121.649659778893, 4264.232438161099, 4309.685545908465, 4336.869893903188, 4363.716358436692, 5149.562287205555, 5166.948330516722, 5177.559907407913, 5178.6116041297055, 5179.741012949337, 1208.6221707253737, 1245.2466257914014, 1268.657462485124, 1275.808628705683, 1284.4797856867983, 823.9011318641801, 844.2486187293314, 853.9658413663384, 857.4212406625503, 866.6490071521044, 4485.237509623372, 4500.797464114123, 4508.436445444319, 4514.480834703985, 4538.773061346919, 5300.9734951325, 5316.494932981361, 5324.148136298174, 5326.201069839555, 5335.626506144533, 4452.5547445255215, 4476.798544065525, 4487.461504619467, 4532.206863798822, 4537.455505339314, 2395.6406539019285, 2483.5653760592186, 2503.5493611149805, 2521.0, 2540.22523130447, 4301.247281725686, 4344.740734817877, 4362.367456718822, 4369.6722745794195, 4418.779061046999, 4689.6717229793585, 4726.763661816895, 4733.01213490328, 4745.857624271208, 4748.762561871893, 4313.137372525507, 4560.703554268962, 4937.629677774181, 4984.950150498448, 5000.924616284201, 5368.7047212403695, 5403.892761661981, 5420.457954204548, 5426.430224826337, 5438.537724293479, 5158.329417175743, 5293.179557168645, 5335.599830012687, 5336.3863155736035, 5337.733113344395, 4907.60739140875, 4914.483979182134, 4927.827526036572, 4938.604911607134, 4938.999705119432, 3636.3454578176184, 3671.687906527975, 3680.7975561344383, 3687.1150923778637, 3690.520232369775, 5388.218708287355, 5410.810621628224, 5413.83758487246, 5444.537214336826, 5453.400125986059, 4770.284457331428, 5070.771815268396, 5141.994622097311, 5156.607715916756, 5171.63798534099, 5166.2508936204795, 5169.327987361769, 5207.401148867929, 5234.345706786652, 5243.082460569309, 4896.310772783384, 5111.309973153725, 5126.666766660155, 5138.4604616514725, 5155.355580552431, 5185.248139019896, 5230.34620672416, 5233.6074794389815, 5240.68555886648, 5240.947590524046, 5112.74436278192, 5119.48805119485, 5124.74376281177, 5128.384593848613, 5134.897302053863], "value": 3825.07256930059, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.1427715535318, 597.6802410710269, 616.6608365399032, 626.6616027345234, 674.4469534981316, 12204.694882627928, 12922.0, 13233.0, 13241.668958276035, 13888.583342499716, 12428.067894907872, 12630.431630576622, 12641.683957901034, 12646.430910609022, 12825.935870320636, 747.8279995601015, 764.4304992780386, 774.2915232562199, 775.7595145504883, 776.2392855002101, 781.6677911887454, 783.7374479549358, 789.3487872505177, 791.1060501633146, 791.1929831571794, 827.1397746343795, 827.4414770030236, 829.8755186721979, 832.097174565597, 832.379876991642, 811.9188081191893, 821.1419067074921, 822.1613953767154, 822.5558198572763, 823.217942954193, 603.8248907816728, 604.0998911621696, 604.2145211225389, 604.2778879239311, 604.5314880967242, 13223.272720000396, 13242.73514529704, 13269.867301327056, 13364.264965426897, 13367.264800435973, 13239.20564766117, 13297.401616927165, 13385.19688818674, 13566.118202316818, 13632.727345453135, 10400.271980961335, 10482.266241363108, 10553.546288050997, 10597.099246564052, 10646.78706425875, 3182.872685092617, 3230.2408933900515, 3264.7877887937207, 3279.950800737991, 3290.835458227103, 60660.69669651668, 62127.37872621261, 62728.37271627271, 63692.36307636957, 64014.359856401774, 10083.49582520871, 10131.0, 10263.281570290008, 10310.793784124426, 10355.482225888676, 18892.433227003214, 18906.960117193412, 18932.337368192046, 18974.905125474284, 19013.524661883563, 6277.748890044347, 6282.748690052346, 6338.904916426257, 6616.900746488806, 6638.17022872141, 3537.0803591066506, 3588.4258518636893, 3621.8578477710907, 3628.219932714479, 3688.114852435396, 2584.1730646193037, 2661.148432501581, 2677.1700772760505, 2681.4234939488106, 2682.235562864574, 434.6392494229782, 444.30022714225225, 451.7876597998935, 457.3391449355649, 458.0335492111642, 590.2592246730326, 593.1636392686291, 610.2006371653149, 614.8585825260216, 626.6083697688945, 7695.4997925134685, 7834.490758100819, 8150.510969341858, 8322.70870519529, 8335.768520215435, 461.3932678527725, 478.6577597018149, 532.475511621053, 554.4510934175138, 557.289455943667, 3739.1773809761808, 3757.0982964088967, 3789.4694742736037, 3801.8099095045136, 4031.879043628696, 93169.53415232881, 95267.52366238124, 99379.50930736045, 102137.48931255296, 102774.0, 22519.662205066936, 22764.544709105725, 22787.202447914577, 22821.657675134888, 84380.57809711035, 72749.0, 73694.0, 74632.62683686655, 75096.0, 76002.01978792257, 7067.893981590383, 7432.293932076444, 7432.405407567489, 7433.182349941394, 7514.407529402348, 42893.356599650404, 43295.783521082194, 44060.0, 45218.54781452144, 45936.31095533637, 47476.7626161867, 49584.55400798017, 51257.743711281204, 51937.98837156936, 58320.70839645775, 10703.464826758787, 10808.783824323627, 11127.276727012719, 11333.603323883624, 11487.253328533952, 11795.233309834834, 12196.695082623006, 12324.568640097554, 12505.56230531927, 12751.681207969876, 11430.828537571777, 11604.30374177552, 11624.709382265512, 11848.229865058744, 12025.879741202476, 11964.58123965657, 11989.0, 12170.14808963364, 12384.75230495367, 12541.93729031349, 11061.446927653424, 11569.768604628029, 11686.24039437468, 11807.704807379885, 12146.635600931986, 9707.563159657973, 9708.75728106803, 10002.649907253211, 10107.0, 11057.0, 9399.953000234955, 10116.393016419039, 10240.897591024292, 10289.228307876789, 10316.329438586468], "value": 6274.958362067723, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 115.0, 115.0, 115.0, 116.0, 117.0, 116.0, 116.0, 116.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 129.0, 185.0, 134.0, 129.0, 130.0, 130.0, 158.0, 131.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 166.0, 165.0, 166.0, 165.0, 166.0, 164.0, 166.0, 165.0, 163.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 107.0, 77.0, 77.0, 76.0, 85.0, 104.0, 78.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 112.0, 85.0, 85.0, 85.0, 110.0, 85.0, 84.0, 117.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 119.0, 118.0, 119.0, 119.0, 119.0, 119.0, 118.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 149.0, 149.0, 148.0, 150.0, 148.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 84.0, 86.0, 86.0, 85.0, 85.0, 85.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 65.0, 69.0, 66.0, 65.0, 67.0, 71.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 69.0, 70.0, 68.0, 68.0, 69.0, 68.0], "value": 68.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 84.0, 84.0, 86.0, 88.0, 83.0, 83.0, 86.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 143.0, 142.0, 151.0, 148.0, 145.0, 151.0, 148.0, 185.0, 146.0], "value": 150.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 183.0, 181.0, 175.0, 177.0, 183.0, 179.0, 175.0, 188.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 72.0, 75.0, 72.0, 73.0, 73.0, 74.0, 71.0], "value": 72.7, "unit": "score"}]}]} 04:54:24 INFO - Return code: 0 04:54:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:54:24 ERROR - # TBPL SUCCESS # 04:54:24 INFO - Running post-action listener: _resource_record_post_action 04:54:24 INFO - [mozharness: 2016-10-14 11:54:24.943880Z] Finished run-tests step (success) 04:54:24 INFO - Running post-run listener: _resource_record_post_run 04:54:25 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 12288; Write bytes: 390590464; Read time: 392; Write time: 356228 04:54:25 INFO - TinderboxPrint: CPU usage
13.4% 04:54:25 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 392 04:54:25 INFO - TinderboxPrint: I/O write bytes / time
390,590,464 / 356,228 04:54:25 INFO - TinderboxPrint: CPU idle
8,306.3 (86.6%) 04:54:25 INFO - TinderboxPrint: CPU user
1,223.9 (12.8%) 04:54:25 INFO - TinderboxPrint: Swap in / out
0 / 0 04:54:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 98963456; Read time: 276; Write time: 110456 04:54:25 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289136640; Read time: 116; Write time: 245444 04:54:25 INFO - Running post-run listener: _upload_blobber_files 04:54:25 INFO - Blob upload gear active. 04:54:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:54:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:54:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:54:25 INFO - (blobuploader) - INFO - Open directory for files ... 04:54:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:54:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:54:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:26 INFO - (blobuploader) - INFO - Done attempting. 04:54:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:54:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:54:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:27 INFO - (blobuploader) - INFO - Done attempting. 04:54:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:54:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:54:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:30 INFO - (blobuploader) - INFO - Done attempting. 04:54:30 INFO - (blobuploader) - INFO - Iteration through files over. 04:54:30 INFO - Return code: 0 04:54:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:54:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:54:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af1b89ab8e49a77415ddae400f35f0b67fb7db8c9efa1ebe4b8315ad2d86a11847e44145702093549d55dd679767d831ae9828b9080e9d1c0a4edb85071973c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1af6a01df85c6388d3633d91e62419a1b6f4871d92516c4ddca37fd7d222fe3e1e3386a1fc833be491f4a7a96a28318c72e30bafbc79340fb136bdd8aaf46b8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5568cb66008ce558888d233e1b5b1498ed7e1a7f167faf2a0f6d1f8eb2d25692560520c9c7b610e2edc7b58d147499c3002d3a806f9e26ef4bd41f38264179c"} 04:54:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:54:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:54:30 INFO - Contents: 04:54:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af1b89ab8e49a77415ddae400f35f0b67fb7db8c9efa1ebe4b8315ad2d86a11847e44145702093549d55dd679767d831ae9828b9080e9d1c0a4edb85071973c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1af6a01df85c6388d3633d91e62419a1b6f4871d92516c4ddca37fd7d222fe3e1e3386a1fc833be491f4a7a96a28318c72e30bafbc79340fb136bdd8aaf46b8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5568cb66008ce558888d233e1b5b1498ed7e1a7f167faf2a0f6d1f8eb2d25692560520c9c7b610e2edc7b58d147499c3002d3a806f9e26ef4bd41f38264179c"} 04:54:30 INFO - Running post-run listener: copy_logs_to_upload_dir 04:54:30 INFO - Copying logs to upload dir... 04:54:30 INFO - mkdir: /builds/slave/test/build/upload/logs 04:54:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.409610 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-14 04:54:30.133782) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 04:54:30.138091) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af1b89ab8e49a77415ddae400f35f0b67fb7db8c9efa1ebe4b8315ad2d86a11847e44145702093549d55dd679767d831ae9828b9080e9d1c0a4edb85071973c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1af6a01df85c6388d3633d91e62419a1b6f4871d92516c4ddca37fd7d222fe3e1e3386a1fc833be491f4a7a96a28318c72e30bafbc79340fb136bdd8aaf46b8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5568cb66008ce558888d233e1b5b1498ed7e1a7f167faf2a0f6d1f8eb2d25692560520c9c7b610e2edc7b58d147499c3002d3a806f9e26ef4bd41f38264179c"} build_url:https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011461 build_url: 'https://queue.taskcluster.net/v1/task/PPQaK-JBTDysAf0UYI6d4w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af1b89ab8e49a77415ddae400f35f0b67fb7db8c9efa1ebe4b8315ad2d86a11847e44145702093549d55dd679767d831ae9828b9080e9d1c0a4edb85071973c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1af6a01df85c6388d3633d91e62419a1b6f4871d92516c4ddca37fd7d222fe3e1e3386a1fc833be491f4a7a96a28318c72e30bafbc79340fb136bdd8aaf46b8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5568cb66008ce558888d233e1b5b1498ed7e1a7f167faf2a0f6d1f8eb2d25692560520c9c7b610e2edc7b58d147499c3002d3a806f9e26ef4bd41f38264179c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 04:54:30.171325) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:54:30.171710) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1476444823.202302-1948416245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004798 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 04:54:30.255319) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 04:54:30.256129) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 04:54:30.256913) ========= ========= Total master_lag: 0.21 =========