builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1482427900.64 results: success (0) buildid: 20161222075153 builduid: d1811395cf6d4ac19a01e019e50ba300 revision: af6633c41d46a6183d9173cd6aa13532ed6a733b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 09:31:40.644247) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 09:31:40.645288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 09:31:40.646022) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 09:31:40.663491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:31:40.664211) ========= 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=3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-22 09:31:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-12-22 09:31:41 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146548 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:31:40.826597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:31:40.826948) ========= 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=3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017346 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:31:40.877660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 09:31:40.878125) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev af6633c41d46a6183d9173cd6aa13532ed6a733b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev af6633c41d46a6183d9173cd6aa13532ed6a733b --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=3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-22 09:31:41,304 truncating revision to first 12 chars 2016-12-22 09:31:41,304 Setting DEBUG logging. 2016-12-22 09:31:41,304 attempt 1/10 2016-12-22 09:31:41,304 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/af6633c41d46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 09:31:42,188 unpacking tar archive at: mozilla-aurora-af6633c41d46/testing/mozharness/ program finished with exit code 0 elapsedTime=1.189062 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 09:31:42.081285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 09:31:42.081665) ========= script_repo_revision: af6633c41d46a6183d9173cd6aa13532ed6a733b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 09:31:42.082487) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 09:31:42.082980) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 09:31:42.095240) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-22 09:31:42.095895) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:31:42 INFO - MultiFileLogger online at 20161222 09:31:42 in /builds/slave/test 09:31:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:31:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:31:42 INFO - {'append_to_log': False, 09:31:42 INFO - 'base_work_dir': '/builds/slave/test', 09:31:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:31:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:31:42 INFO - 'branch': 'Mozilla-Aurora', 09:31:42 INFO - 'buildbot_json_path': 'buildprops.json', 09:31:42 INFO - 'config_files': ('talos/linux_config.py',), 09:31:42 INFO - 'default_actions': ('clobber', 09:31:42 INFO - 'read-buildbot-config', 09:31:42 INFO - 'download-and-extract', 09:31:42 INFO - 'populate-webroot', 09:31:42 INFO - 'create-virtualenv', 09:31:42 INFO - 'install', 09:31:42 INFO - 'run-tests'), 09:31:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:31:42 INFO - 'download_minidump_stackwalk': True, 09:31:42 INFO - 'download_symbols': 'ondemand', 09:31:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:31:42 INFO - 'tooltool.py': '/tools/tooltool.py', 09:31:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:31:42 INFO - '/tools/misc-python/virtualenv.py')}, 09:31:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:31:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:31:42 INFO - 'installer_path': 'installer.exe', 09:31:42 INFO - 'log_level': 'info', 09:31:42 INFO - 'log_name': 'talos', 09:31:42 INFO - 'log_to_console': True, 09:31:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:31:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:31:42 INFO - 'opt_config_files': (), 09:31:42 INFO - 'pip_index': False, 09:31:42 INFO - 'sps_profile': False, 09:31:42 INFO - 'sps_profile_interval': 0, 09:31:42 INFO - 'suite': 'dromaeojs', 09:31:42 INFO - 'system_bits': '32', 09:31:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:31:42 INFO - 'title': 'talos-linux64-ix-030', 09:31:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:31:42 INFO - 'use_talos_json': True, 09:31:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:31:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:31:42 INFO - 'work_dir': 'build'} 09:31:42 INFO - [mozharness: 2016-12-22 17:31:42.628057Z] Running clobber step. 09:31:42 INFO - Running pre-action listener: _resource_record_pre_action 09:31:42 INFO - Running main action method: clobber 09:31:42 INFO - rmtree: /builds/slave/test/build 09:31:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:31:43 INFO - Running post-action listener: _resource_record_post_action 09:31:43 INFO - [mozharness: 2016-12-22 17:31:43.088741Z] Finished clobber step (success) 09:31:43 INFO - [mozharness: 2016-12-22 17:31:43.088842Z] Running read-buildbot-config step. 09:31:43 INFO - Running pre-action listener: _resource_record_pre_action 09:31:43 INFO - Running main action method: read_buildbot_config 09:31:43 INFO - Using buildbot properties: 09:31:43 INFO - { 09:31:43 INFO - "project": "", 09:31:43 INFO - "product": "firefox", 09:31:43 INFO - "script_repo_revision": "production", 09:31:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:31:43 INFO - "repository": "", 09:31:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:31:43 INFO - "buildid": "20161222075153", 09:31:43 INFO - "pgo_build": "True", 09:31:43 INFO - "basedir": "/builds/slave/test", 09:31:43 INFO - "buildnumber": 985, 09:31:43 INFO - "slavename": "talos-linux64-ix-030", 09:31:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:31:43 INFO - "platform": "ubuntu64_hw", 09:31:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:31:43 INFO - "branch": "mozilla-aurora", 09:31:43 INFO - "repo_path": "releases/mozilla-aurora", 09:31:43 INFO - "revision": "af6633c41d46a6183d9173cd6aa13532ed6a733b", 09:31:43 INFO - "stage_platform": "linux64-pgo", 09:31:43 INFO - "builduid": "d1811395cf6d4ac19a01e019e50ba300", 09:31:43 INFO - "slavebuilddir": "test" 09:31:43 INFO - } 09:31:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:31:43 INFO - Running post-action listener: _resource_record_post_action 09:31:43 INFO - [mozharness: 2016-12-22 17:31:43.091433Z] Finished read-buildbot-config step (success) 09:31:43 INFO - [mozharness: 2016-12-22 17:31:43.091533Z] Running download-and-extract step. 09:31:43 INFO - Running pre-action listener: _resource_record_pre_action 09:31:43 INFO - Running main action method: download_and_extract 09:31:43 INFO - mkdir: /builds/slave/test/build/tests 09:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:43 INFO - trying https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:31:43 INFO - Downloading https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:31:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:31:43 INFO - Downloaded 1361 bytes. 09:31:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:31:43 INFO - Using the following test package requirements: 09:31:43 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:31:43 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:31:43 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:31:43 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:31:43 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:31:43 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:31:43 INFO - u'jsshell-linux-x86_64.zip'], 09:31:43 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:31:43 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:31:43 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:31:43 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:31:43 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:31:43 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:31:43 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:31:43 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:31:43 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:31:43 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:31:43 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:31:43 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:31:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:31:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:31:43 INFO - Fetch https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:31:44 INFO - Http code: 200 09:31:44 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 09:31:44 INFO - x-amz-cf-id: 2basqTxe-sXtHk5PXDDXaCPgE8L8SICc4ID1hCc8p_V4ZuHhYuj-yQ== 09:31:44 INFO - x-amz-version-id: _xxFmFZ.sC8ThB99ms6XLhj46oyxDeJb 09:31:44 INFO - Expected file size: 21944407 09:31:44 INFO - Obtained file size: 21944407 09:31:48 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:31:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:31:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:31:48 INFO - Fetch https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:31:49 INFO - Http code: 200 09:31:49 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 09:31:49 INFO - x-amz-cf-id: qrawTqo8JVMU7grde_RaPM7Lwmnh6idpdIsPqi60Q02RYEO6BdFFZQ== 09:31:49 INFO - x-amz-version-id: _xxFmFZ.sC8ThB99ms6XLhj46oyxDeJb 09:31:49 INFO - Expected file size: 21944407 09:31:49 INFO - Obtained file size: 21944407 09:31:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:31:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:31:53 INFO - Fetch https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:31:54 INFO - Http code: 200 09:31:54 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 09:31:54 INFO - x-amz-cf-id: MSdLphcVUlG8HINyzkeTXxbbYGCM4U5DtOeAk2MbPaxvYtiNCclQyw== 09:31:54 INFO - x-amz-version-id: e4NbZ3KJm9O1trF3M7Qre9LajPf_rzYy 09:31:55 INFO - Expected file size: 14409038 09:31:55 INFO - Obtained file size: 14409038 09:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:55 INFO - trying https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:31:55 INFO - Downloading https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:31:57 INFO - Downloaded 63979839 bytes. 09:31:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:31:57 INFO - mkdir: /builds/slave/test/properties 09:31:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:31:57 INFO - Writing to file /builds/slave/test/properties/build_url 09:31:57 INFO - Contents: 09:31:57 INFO - build_url:https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:31:57 INFO - Running post-action listener: _resource_record_post_action 09:31:57 INFO - Running post-action listener: set_extra_try_arguments 09:31:57 INFO - [mozharness: 2016-12-22 17:31:57.717233Z] Finished download-and-extract step (success) 09:31:57 INFO - [mozharness: 2016-12-22 17:31:57.717459Z] Running populate-webroot step. 09:31:57 INFO - Running pre-action listener: _resource_record_pre_action 09:31:57 INFO - Running main action method: populate_webroot 09:31:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:31:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:31:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:31:57 INFO - '--tppagecycles', 09:31:57 INFO - '7'], 09:31:57 INFO - 'tests': ['tsvgm']}}, 09:31:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:31:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:31:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:31:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:31:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:31:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:31:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:57 INFO - 'talos_options': ['--disable-e10s'], 09:31:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:57 INFO - 'talos_options': ['--disable-e10s'], 09:31:57 INFO - 'tests': ['damp', 'tps']}, 09:31:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:57 INFO - 'tests': ['damp', 'tps']}, 09:31:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:31:57 INFO - 'tests': ['dromaeo_dom']}, 09:31:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:31:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:31:57 INFO - 'tests': ['basic_compositor_video']}, 09:31:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:31:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:31:57 INFO - 'tests': ['a11yr', 09:31:57 INFO - 'ts_paint', 09:31:57 INFO - 'tpaint', 09:31:57 INFO - 'sessionrestore', 09:31:57 INFO - 'sessionrestore_no_auto_restore', 09:31:57 INFO - 'tabpaint']}, 09:31:57 INFO - 'other-e10s': {'tests': ['a11yr', 09:31:57 INFO - 'ts_paint', 09:31:57 INFO - 'tpaint', 09:31:57 INFO - 'sessionrestore', 09:31:57 INFO - 'sessionrestore_no_auto_restore', 09:31:57 INFO - 'tabpaint']}, 09:31:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:31:57 INFO - 'ts_paint', 09:31:57 INFO - 'tpaint', 09:31:57 INFO - 'sessionrestore', 09:31:57 INFO - 'sessionrestore_no_auto_restore', 09:31:57 INFO - 'tabpaint']}, 09:31:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:31:57 INFO - 'ts_paint', 09:31:57 INFO - 'tpaint', 09:31:57 INFO - 'sessionrestore', 09:31:57 INFO - 'sessionrestore_no_auto_restore', 09:31:57 INFO - 'tabpaint']}, 09:31:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:31:57 INFO - 'tests': ['a11yr', 09:31:57 INFO - 'ts_paint', 09:31:57 INFO - 'tpaint', 09:31:57 INFO - 'sessionrestore', 09:31:57 INFO - 'sessionrestore_no_auto_restore', 09:31:57 INFO - 'tabpaint']}, 09:31:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:31:57 INFO - 'tests': ['a11yr', 09:31:57 INFO - 'ts_paint', 09:31:57 INFO - 'tpaint', 09:31:57 INFO - 'sessionrestore', 09:31:57 INFO - 'sessionrestore_no_auto_restore', 09:31:57 INFO - 'tabpaint']}, 09:31:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:31:57 INFO - 'tests': ['tsvgx', 09:31:57 INFO - 'tsvgr_opacity', 09:31:57 INFO - 'tart', 09:31:57 INFO - 'tscrollx', 09:31:57 INFO - 'cart']}, 09:31:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:31:57 INFO - 'tsvgr_opacity', 09:31:57 INFO - 'tart', 09:31:57 INFO - 'tscrollx', 09:31:57 INFO - 'cart']}, 09:31:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:57 INFO - 'talos_options': ['--disable-e10s'], 09:31:57 INFO - 'tests': ['tp5o']}, 09:31:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:57 INFO - 'tests': ['tp5o']}, 09:31:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:57 INFO - 'talos_options': ['--disable-e10s', 09:31:57 INFO - '--xperf_path', 09:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:57 INFO - 'tests': ['tp5n']}, 09:31:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:57 INFO - 'talos_options': ['--xperf_path', 09:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:57 INFO - 'tests': ['tp5n']}}, 09:31:57 INFO - 'talos.zip': {'path': '', 09:31:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:31:57 INFO - Running post-action listener: _resource_record_post_action 09:31:57 INFO - [mozharness: 2016-12-22 17:31:57.738936Z] Finished populate-webroot step (success) 09:31:57 INFO - [mozharness: 2016-12-22 17:31:57.739025Z] Running create-virtualenv step. 09:31:57 INFO - Running pre-action listener: _resource_record_pre_action 09:31:57 INFO - Running main action method: create_virtualenv 09:31:57 INFO - Creating virtualenv /builds/slave/test/build/venv 09:31:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:31:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:31:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:31:57 INFO - Using real prefix '/usr' 09:31:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:31:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:32:00 INFO - Installing pip.................done. 09:32:00 INFO - Return code: 0 09:32:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:32:00 INFO - Reading from file tmpfile_stdout 09:32:00 INFO - Output received: 09:32:00 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:32:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ae42fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccf60>, '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 0x19cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ce1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:32:00 INFO - Using env: {'DISPLAY': ':0', 09:32:00 INFO - 'HOME': '/home/cltbld', 09:32:00 INFO - 'LANG': 'en_US.UTF-8', 09:32:00 INFO - 'LANGUAGE': 'en_US:en', 09:32:00 INFO - 'LOGNAME': 'cltbld', 09:32:00 INFO - 'MAIL': '/var/mail/cltbld', 09:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:00 INFO - 'MOZ_NO_REMOTE': '1', 09:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:00 INFO - 'NO_EM_RESTART': '1', 09:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:00 INFO - 'PWD': '/builds/slave/test', 09:32:00 INFO - 'SHELL': '/bin/bash', 09:32:00 INFO - 'SHLVL': '1', 09:32:00 INFO - 'TERM': 'linux', 09:32:00 INFO - 'TMOUT': '86400', 09:32:00 INFO - 'USER': 'cltbld', 09:32:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 09:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:00 INFO - '_': '/tools/buildbot/bin/python'} 09:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:32:00 INFO - Cleaning up... 09:32:00 INFO - Return code: 0 09:32:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7ae42fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccf60>, '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 0x19cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ce1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:32:00 INFO - Using env: {'DISPLAY': ':0', 09:32:00 INFO - 'HOME': '/home/cltbld', 09:32:00 INFO - 'LANG': 'en_US.UTF-8', 09:32:00 INFO - 'LANGUAGE': 'en_US:en', 09:32:00 INFO - 'LOGNAME': 'cltbld', 09:32:00 INFO - 'MAIL': '/var/mail/cltbld', 09:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:00 INFO - 'MOZ_NO_REMOTE': '1', 09:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:00 INFO - 'NO_EM_RESTART': '1', 09:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:00 INFO - 'PWD': '/builds/slave/test', 09:32:00 INFO - 'SHELL': '/bin/bash', 09:32:00 INFO - 'SHLVL': '1', 09:32:00 INFO - 'TERM': 'linux', 09:32:00 INFO - 'TMOUT': '86400', 09:32:00 INFO - 'USER': 'cltbld', 09:32:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 09:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:00 INFO - '_': '/tools/buildbot/bin/python'} 09:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:00 INFO - Downloading/unpacking psutil>=3.1.1 09:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:32:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:03 INFO - Installing collected packages: psutil 09:32:03 INFO - Running setup.py install for psutil 09:32:03 INFO - building 'psutil._psutil_linux' extension 09:32:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:32:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:32:03 INFO - building 'psutil._psutil_posix' extension 09:32:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:32:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:32:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:03 INFO - Successfully installed psutil 09:32:03 INFO - Cleaning up... 09:32:03 INFO - Return code: 0 09:32:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ae42fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccf60>, '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 0x19cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ce1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:32:03 INFO - Using env: {'DISPLAY': ':0', 09:32:03 INFO - 'HOME': '/home/cltbld', 09:32:03 INFO - 'LANG': 'en_US.UTF-8', 09:32:03 INFO - 'LANGUAGE': 'en_US:en', 09:32:03 INFO - 'LOGNAME': 'cltbld', 09:32:03 INFO - 'MAIL': '/var/mail/cltbld', 09:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:03 INFO - 'MOZ_NO_REMOTE': '1', 09:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:03 INFO - 'NO_EM_RESTART': '1', 09:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:03 INFO - 'PWD': '/builds/slave/test', 09:32:03 INFO - 'SHELL': '/bin/bash', 09:32:03 INFO - 'SHLVL': '1', 09:32:03 INFO - 'TERM': 'linux', 09:32:03 INFO - 'TMOUT': '86400', 09:32:03 INFO - 'USER': 'cltbld', 09:32:03 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 09:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:03 INFO - '_': '/tools/buildbot/bin/python'} 09:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:32:05 INFO - Installing collected packages: mozsystemmonitor 09:32:05 INFO - Running setup.py install for mozsystemmonitor 09:32:05 INFO - Successfully installed mozsystemmonitor 09:32:05 INFO - Cleaning up... 09:32:06 INFO - Return code: 0 09:32:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7ae42fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccf60>, '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 0x19cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ce1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:32:06 INFO - Using env: {'DISPLAY': ':0', 09:32:06 INFO - 'HOME': '/home/cltbld', 09:32:06 INFO - 'LANG': 'en_US.UTF-8', 09:32:06 INFO - 'LANGUAGE': 'en_US:en', 09:32:06 INFO - 'LOGNAME': 'cltbld', 09:32:06 INFO - 'MAIL': '/var/mail/cltbld', 09:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:06 INFO - 'MOZ_NO_REMOTE': '1', 09:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:06 INFO - 'NO_EM_RESTART': '1', 09:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:06 INFO - 'PWD': '/builds/slave/test', 09:32:06 INFO - 'SHELL': '/bin/bash', 09:32:06 INFO - 'SHLVL': '1', 09:32:06 INFO - 'TERM': 'linux', 09:32:06 INFO - 'TMOUT': '86400', 09:32:06 INFO - 'USER': 'cltbld', 09:32:06 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 09:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:06 INFO - '_': '/tools/buildbot/bin/python'} 09:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:06 INFO - Downloading/unpacking jsonschema==2.5.1 09:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:32:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:08 INFO - Downloading functools32-3.2.3-2.tar.gz 09:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:32:08 INFO - warning: no files found matching '*.txt' 09:32:08 INFO - no previously-included directories found matching 'build' 09:32:08 INFO - no previously-included directories found matching 'dist' 09:32:08 INFO - no previously-included directories found matching '.git*' 09:32:08 INFO - Installing collected packages: jsonschema, functools32 09:32:08 INFO - Running setup.py install for functools32 09:32:08 INFO - warning: no files found matching '*.txt' 09:32:08 INFO - no previously-included directories found matching 'build' 09:32:08 INFO - no previously-included directories found matching 'dist' 09:32:08 INFO - no previously-included directories found matching '.git*' 09:32:08 INFO - Successfully installed jsonschema functools32 09:32:08 INFO - Cleaning up... 09:32:08 INFO - Return code: 0 09:32:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:08 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 0x7f7ae42fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccf60>, '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 0x19cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ce1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:32:08 INFO - Using env: {'DISPLAY': ':0', 09:32:08 INFO - 'HOME': '/home/cltbld', 09:32:08 INFO - 'LANG': 'en_US.UTF-8', 09:32:08 INFO - 'LANGUAGE': 'en_US:en', 09:32:08 INFO - 'LOGNAME': 'cltbld', 09:32:08 INFO - 'MAIL': '/var/mail/cltbld', 09:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:08 INFO - 'MOZ_NO_REMOTE': '1', 09:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:08 INFO - 'NO_EM_RESTART': '1', 09:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:08 INFO - 'PWD': '/builds/slave/test', 09:32:08 INFO - 'SHELL': '/bin/bash', 09:32:08 INFO - 'SHLVL': '1', 09:32:08 INFO - 'TERM': 'linux', 09:32:08 INFO - 'TMOUT': '86400', 09:32:08 INFO - 'USER': 'cltbld', 09:32:08 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 09:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:08 INFO - '_': '/tools/buildbot/bin/python'} 09:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:32:09 INFO - Cleaning up... 09:32:09 INFO - Return code: 0 09:32:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7ae42fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccf60>, '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 0x19cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ce1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:32:09 INFO - Using env: {'DISPLAY': ':0', 09:32:09 INFO - 'HOME': '/home/cltbld', 09:32:09 INFO - 'LANG': 'en_US.UTF-8', 09:32:09 INFO - 'LANGUAGE': 'en_US:en', 09:32:09 INFO - 'LOGNAME': 'cltbld', 09:32:09 INFO - 'MAIL': '/var/mail/cltbld', 09:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:09 INFO - 'MOZ_NO_REMOTE': '1', 09:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:09 INFO - 'NO_EM_RESTART': '1', 09:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:09 INFO - 'PWD': '/builds/slave/test', 09:32:09 INFO - 'SHELL': '/bin/bash', 09:32:09 INFO - 'SHLVL': '1', 09:32:09 INFO - 'TERM': 'linux', 09:32:09 INFO - 'TMOUT': '86400', 09:32:09 INFO - 'USER': 'cltbld', 09:32:09 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 09:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:09 INFO - '_': '/tools/buildbot/bin/python'} 09:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:09 INFO - Downloading/unpacking blobuploader==1.2.4 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32:11 INFO - Downloading blobuploader-1.2.4.tar.gz 09:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:32:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:32:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:12 INFO - Downloading docopt-0.6.1.tar.gz 09:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:32:12 INFO - Installing collected packages: blobuploader, requests, docopt 09:32:12 INFO - Running setup.py install for blobuploader 09:32:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:32:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:32:12 INFO - Running setup.py install for requests 09:32:12 INFO - Running setup.py install for docopt 09:32:12 INFO - Successfully installed blobuploader requests docopt 09:32:12 INFO - Cleaning up... 09:32:12 INFO - Return code: 0 09:32:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:12 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 0x7f7ae42fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccf60>, '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 0x19cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ce1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:32:12 INFO - Using env: {'DISPLAY': ':0', 09:32:12 INFO - 'HOME': '/home/cltbld', 09:32:12 INFO - 'LANG': 'en_US.UTF-8', 09:32:12 INFO - 'LANGUAGE': 'en_US:en', 09:32:12 INFO - 'LOGNAME': 'cltbld', 09:32:12 INFO - 'MAIL': '/var/mail/cltbld', 09:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:12 INFO - 'MOZ_NO_REMOTE': '1', 09:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:12 INFO - 'NO_EM_RESTART': '1', 09:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:12 INFO - 'PWD': '/builds/slave/test', 09:32:12 INFO - 'SHELL': '/bin/bash', 09:32:12 INFO - 'SHLVL': '1', 09:32:12 INFO - 'TERM': 'linux', 09:32:12 INFO - 'TMOUT': '86400', 09:32:12 INFO - 'USER': 'cltbld', 09:32:12 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 09:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:12 INFO - '_': '/tools/buildbot/bin/python'} 09:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:13 INFO - Running setup.py (path:/tmp/pip-EDybIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:13 INFO - Running setup.py (path:/tmp/pip-G51CBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:13 INFO - Running setup.py (path:/tmp/pip-yITLuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:13 INFO - Running setup.py (path:/tmp/pip-r0NnvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:13 INFO - Running setup.py (path:/tmp/pip-ldft9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:13 INFO - Running setup.py (path:/tmp/pip-eB_Fmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:13 INFO - Running setup.py (path:/tmp/pip-AWmAjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:13 INFO - Running setup.py (path:/tmp/pip-fOaMPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:13 INFO - Running setup.py (path:/tmp/pip-qRNeSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:13 INFO - Running setup.py (path:/tmp/pip-Xh_cpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:13 INFO - Running setup.py (path:/tmp/pip-GIBu6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:13 INFO - Running setup.py (path:/tmp/pip-_nE0EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:13 INFO - Running setup.py (path:/tmp/pip-Oc9Ejl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:13 INFO - Running setup.py (path:/tmp/pip-GInhAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:14 INFO - Running setup.py (path:/tmp/pip-JEjtp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:14 INFO - Running setup.py (path:/tmp/pip-JuifEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:14 INFO - Running setup.py (path:/tmp/pip-2gzbD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:32:14 INFO - Running setup.py install for manifestparser 09:32:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:32:14 INFO - Running setup.py install for mozcrash 09:32:14 INFO - Running setup.py install for mozdebug 09:32:14 INFO - Running setup.py install for mozdevice 09:32:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:32:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:32:14 INFO - Running setup.py install for mozfile 09:32:14 INFO - Running setup.py install for mozhttpd 09:32:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:32:14 INFO - Running setup.py install for mozinfo 09:32:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:32:15 INFO - Running setup.py install for mozInstall 09:32:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:32:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:32:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:32:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:32:15 INFO - Running setup.py install for mozleak 09:32:15 INFO - Running setup.py install for mozlog 09:32:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:32:15 INFO - Running setup.py install for moznetwork 09:32:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:32:15 INFO - Running setup.py install for mozprocess 09:32:15 INFO - Running setup.py install for mozprofile 09:32:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:32:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:32:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:32:15 INFO - Running setup.py install for mozrunner 09:32:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:32:15 INFO - Running setup.py install for mozscreenshot 09:32:15 INFO - Running setup.py install for moztest 09:32:16 INFO - Running setup.py install for mozversion 09:32:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:32:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:32:16 INFO - Cleaning up... 09:32:16 INFO - Return code: 0 09:32:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:16 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 0x7f7ae42fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccf60>, '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 0x19cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ce1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:32:16 INFO - Using env: {'DISPLAY': ':0', 09:32:16 INFO - 'HOME': '/home/cltbld', 09:32:16 INFO - 'LANG': 'en_US.UTF-8', 09:32:16 INFO - 'LANGUAGE': 'en_US:en', 09:32:16 INFO - 'LOGNAME': 'cltbld', 09:32:16 INFO - 'MAIL': '/var/mail/cltbld', 09:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:16 INFO - 'MOZ_NO_REMOTE': '1', 09:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:16 INFO - 'NO_EM_RESTART': '1', 09:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:16 INFO - 'PWD': '/builds/slave/test', 09:32:16 INFO - 'SHELL': '/bin/bash', 09:32:16 INFO - 'SHLVL': '1', 09:32:16 INFO - 'TERM': 'linux', 09:32:16 INFO - 'TMOUT': '86400', 09:32:16 INFO - 'USER': 'cltbld', 09:32:16 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 09:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:16 INFO - '_': '/tools/buildbot/bin/python'} 09:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:16 INFO - Running setup.py (path:/tmp/pip-garTqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:16 INFO - Running setup.py (path:/tmp/pip-ddvrEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:16 INFO - Running setup.py (path:/tmp/pip-veUNZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:16 INFO - Running setup.py (path:/tmp/pip-Go3xsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:16 INFO - Running setup.py (path:/tmp/pip-O5_d7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:16 INFO - Running setup.py (path:/tmp/pip-liBYO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:16 INFO - Running setup.py (path:/tmp/pip-4CToSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:16 INFO - Running setup.py (path:/tmp/pip-W6crwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:16 INFO - Running setup.py (path:/tmp/pip-Q_tBY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:17 INFO - Running setup.py (path:/tmp/pip-PWVmwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:17 INFO - Running setup.py (path:/tmp/pip-eW3vwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:17 INFO - Running setup.py (path:/tmp/pip-tsISms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:17 INFO - Running setup.py (path:/tmp/pip-FmdgTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:17 INFO - Running setup.py (path:/tmp/pip-VyUPfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:17 INFO - Running setup.py (path:/tmp/pip-HuuWfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:17 INFO - Running setup.py (path:/tmp/pip-C9u5WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:17 INFO - Running setup.py (path:/tmp/pip-MMsgD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:32:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:19 INFO - Downloading blessings-1.6.tar.gz 09:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:32:19 INFO - Installing collected packages: blessings 09:32:19 INFO - Running setup.py install for blessings 09:32:19 INFO - Successfully installed blessings 09:32:19 INFO - Cleaning up... 09:32:19 INFO - Return code: 0 09:32:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:20 INFO - Reading from file tmpfile_stdout 09:32:20 INFO - Current package versions: 09:32:20 INFO - argparse == 1.2.1 09:32:20 INFO - blessings == 1.6 09:32:20 INFO - blobuploader == 1.2.4 09:32:20 INFO - docopt == 0.6.1 09:32:20 INFO - functools32 == 3.2.3-2 09:32:20 INFO - jsonschema == 2.5.1 09:32:20 INFO - manifestparser == 1.1 09:32:20 INFO - mozInstall == 1.12 09:32:20 INFO - mozcrash == 1.0 09:32:20 INFO - mozdebug == 0.1 09:32:20 INFO - mozdevice == 0.48 09:32:20 INFO - mozfile == 1.2 09:32:20 INFO - mozhttpd == 0.7 09:32:20 INFO - mozinfo == 0.9 09:32:20 INFO - mozleak == 0.1 09:32:20 INFO - mozlog == 3.4 09:32:20 INFO - moznetwork == 0.27 09:32:20 INFO - mozprocess == 0.23 09:32:20 INFO - mozprofile == 0.28 09:32:20 INFO - mozrunner == 6.13 09:32:20 INFO - mozscreenshot == 0.1 09:32:20 INFO - mozsystemmonitor == 0.3 09:32:20 INFO - moztest == 0.7 09:32:20 INFO - mozversion == 1.4 09:32:20 INFO - psutil == 3.1.1 09:32:20 INFO - requests == 1.2.3 09:32:20 INFO - wsgiref == 0.1.2 09:32:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:20 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 0x7f7ae42fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccf60>, '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 0x19cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ce1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:32:20 INFO - Using env: {'DISPLAY': ':0', 09:32:20 INFO - 'HOME': '/home/cltbld', 09:32:20 INFO - 'LANG': 'en_US.UTF-8', 09:32:20 INFO - 'LANGUAGE': 'en_US:en', 09:32:20 INFO - 'LOGNAME': 'cltbld', 09:32:20 INFO - 'MAIL': '/var/mail/cltbld', 09:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:20 INFO - 'MOZ_NO_REMOTE': '1', 09:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:20 INFO - 'NO_EM_RESTART': '1', 09:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:20 INFO - 'PWD': '/builds/slave/test', 09:32:20 INFO - 'SHELL': '/bin/bash', 09:32:20 INFO - 'SHLVL': '1', 09:32:20 INFO - 'TERM': 'linux', 09:32:20 INFO - 'TMOUT': '86400', 09:32:20 INFO - 'USER': 'cltbld', 09:32:20 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 09:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:20 INFO - '_': '/tools/buildbot/bin/python'} 09:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:32:20 INFO - Cleaning up... 09:32:20 INFO - Return code: 0 09:32:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:20 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 0x7f7ae42fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccf60>, '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 0x19cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ce1d0>, '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': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:32:20 INFO - Using env: {'DISPLAY': ':0', 09:32:20 INFO - 'HOME': '/home/cltbld', 09:32:20 INFO - 'LANG': 'en_US.UTF-8', 09:32:20 INFO - 'LANGUAGE': 'en_US:en', 09:32:20 INFO - 'LOGNAME': 'cltbld', 09:32:20 INFO - 'MAIL': '/var/mail/cltbld', 09:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:20 INFO - 'MOZ_NO_REMOTE': '1', 09:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:20 INFO - 'NO_EM_RESTART': '1', 09:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:20 INFO - 'PWD': '/builds/slave/test', 09:32:20 INFO - 'SHELL': '/bin/bash', 09:32:20 INFO - 'SHLVL': '1', 09:32:20 INFO - 'TERM': 'linux', 09:32:20 INFO - 'TMOUT': '86400', 09:32:20 INFO - 'USER': 'cltbld', 09:32:20 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 09:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:20 INFO - '_': '/tools/buildbot/bin/python'} 09:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:32:20 INFO - Cleaning up... 09:32:20 INFO - Return code: 0 09:32:20 INFO - Running post-action listener: _resource_record_post_action 09:32:20 INFO - Running post-action listener: _start_resource_monitoring 09:32:20 INFO - Starting resource monitoring. 09:32:20 INFO - [mozharness: 2016-12-22 17:32:20.595443Z] Finished create-virtualenv step (success) 09:32:20 INFO - [mozharness: 2016-12-22 17:32:20.595898Z] Running install step. 09:32:20 INFO - Running pre-action listener: _resource_record_pre_action 09:32:20 INFO - Running main action method: install 09:32:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:20 INFO - Reading from file tmpfile_stdout 09:32:20 INFO - Detecting whether we're running mozinstall >=1.0... 09:32:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:32:20 INFO - Reading from file tmpfile_stdout 09:32:20 INFO - Output received: 09:32:20 INFO - Usage: mozinstall [options] installer 09:32:20 INFO - Options: 09:32:20 INFO - -h, --help show this help message and exit 09:32:20 INFO - -d DEST, --destination=DEST 09:32:20 INFO - Directory to install application into. [default: 09:32:20 INFO - "/builds/slave/test"] 09:32:20 INFO - --app=APP Application being installed. [default: firefox] 09:32:20 INFO - mkdir: /builds/slave/test/build/application 09:32:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:32:36 INFO - Reading from file tmpfile_stdout 09:32:36 INFO - Output received: 09:32:36 INFO - /builds/slave/test/build/application/firefox/firefox 09:32:36 INFO - Running post-action listener: _resource_record_post_action 09:32:36 INFO - [mozharness: 2016-12-22 17:32:36.817951Z] Finished install step (success) 09:32:36 INFO - [mozharness: 2016-12-22 17:32:36.818193Z] Running run-tests step. 09:32:36 INFO - Running pre-action listener: _resource_record_pre_action 09:32:36 INFO - Running main action method: run_tests 09:32:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:32:36 INFO - Python 2.7.3 09:32:36 INFO - Return code: 0 09:32:36 INFO - grabbing minidump binary from tooltool 09:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:36 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 0x19ccf60>, '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 0x19cdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ce1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:32:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:32:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:32:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:32:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:32:36 INFO - Return code: 0 09:32:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:32:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:32:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:32:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:32:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:32:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:32:36 INFO - Using env: {'DISPLAY': ':0', 09:32:36 INFO - 'HOME': '/home/cltbld', 09:32:36 INFO - 'LANG': 'en_US.UTF-8', 09:32:36 INFO - 'LANGUAGE': 'en_US:en', 09:32:36 INFO - 'LOGNAME': 'cltbld', 09:32:36 INFO - 'MAIL': '/var/mail/cltbld', 09:32:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:32:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:36 INFO - 'MOZ_NO_REMOTE': '1', 09:32:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:32:36 INFO - 'NO_EM_RESTART': '1', 09:32:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:36 INFO - 'PWD': '/builds/slave/test', 09:32:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:32:36 INFO - 'SHELL': '/bin/bash', 09:32:36 INFO - 'SHLVL': '1', 09:32:36 INFO - 'TERM': 'linux', 09:32:36 INFO - 'TMOUT': '86400', 09:32:36 INFO - 'USER': 'cltbld', 09:32:36 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105', 09:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:36 INFO - '_': '/tools/buildbot/bin/python'} 09:32:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:32:37 INFO - mozversion application_buildid: 20161222075153 09:32:37 INFO - mozversion application_changeset: af6633c41d46a6183d9173cd6aa13532ed6a733b 09:32:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:32:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:32:37 INFO - mozversion application_name: Firefox 09:32:37 INFO - mozversion application_remotingname: firefox-dev 09:32:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:32:37 INFO - mozversion application_vendor: Mozilla 09:32:37 INFO - mozversion application_version: 52.0a2 09:32:37 INFO - mozversion platform_buildid: 20161222075153 09:32:37 INFO - mozversion platform_changeset: af6633c41d46a6183d9173cd6aa13532ed6a733b 09:32:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:32:37 INFO - mozversion platform_version: 52.0a2 09:32:37 INFO - using testdate: 1482427957 09:32:37 INFO - actual date: 1482427957 09:32:37 INFO - starting webserver on 'localhost:33767' 09:32:37 INFO - SUITE-START | Running 2 tests 09:32:37 INFO - TEST-START | dromaeo_css 09:32:37 INFO - operating with platform_type : linux_ 09:32:37 INFO - Initialising browser for dromaeo_css test... 09:32:37 INFO - TEST-INFO | started process 11666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIJ5bxO/profile http://localhost:33767/getInfo.html) 09:32:41 INFO - PROCESS | 11666 | __metrics Screen width/height:1600/1200 09:32:41 INFO - PROCESS | 11666 | colorDepth:24 09:32:41 INFO - PROCESS | 11666 | Browser inner width/height: 1024/697 09:32:41 INFO - PROCESS | 11666 | __metrics 09:32:41 INFO - PROCESS | 11666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:32:41 INFO - PROCESS | 11666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:32:42 INFO - PROCESS | 11666 | console.error: PushService: 09:32:42 INFO - PROCESS | 11666 | stateChangeProcessEnqueue: Error transitioning state 09:32:42 INFO - PROCESS | 11666 | UnknownError 09:32:42 INFO - TEST-INFO | 11666: exit 0 09:32:42 INFO - Browser initialized. 09:32:42 INFO - Running cycle 1/1 for dromaeo_css test... 09:32:42 INFO - TEST-INFO | started process 11758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIJ5bxO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:54 INFO - PROCESS | 11758 | RSS: Main: 144535552 09:32:54 INFO - PROCESS | 11758 | 09:33:46 INFO - PROCESS | 11758 | 1482428026197 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:35:56 INFO - PROCESS | 11758 | Cycle 1(1): loaded http://localhost:33767/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33767/tests/dromaeo/cssquery-ext.html) 09:35:57 INFO - PROCESS | 11758 | RSS: Main: 232914944 09:35:57 INFO - PROCESS | 11758 | 09:39:00 INFO - PROCESS | 11758 | Cycle 1(1): loaded http://localhost:33767/tests/dromaeo/cssquery-ext.html (next: http://localhost:33767/tests/dromaeo/cssquery-jquery.html) 09:39:00 INFO - PROCESS | 11758 | RSS: Main: 230600704 09:39:00 INFO - PROCESS | 11758 | 09:42:02 INFO - PROCESS | 11758 | Cycle 1(1): loaded http://localhost:33767/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33767/tests/dromaeo/cssquery-mootools.html) 09:42:03 INFO - PROCESS | 11758 | RSS: Main: 176906240 09:42:03 INFO - PROCESS | 11758 | 09:45:05 INFO - PROCESS | 11758 | Cycle 1(1): loaded http://localhost:33767/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33767/tests/dromaeo/cssquery-prototype.html) 09:45:06 INFO - PROCESS | 11758 | RSS: Main: 223571968 09:45:06 INFO - PROCESS | 11758 | 09:48:08 INFO - PROCESS | 11758 | Cycle 1(1): loaded http://localhost:33767/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33767/tests/dromaeo/cssquery-yui.html) 09:48:09 INFO - PROCESS | 11758 | RSS: Main: 173813760 09:48:09 INFO - PROCESS | 11758 | 09:51:12 INFO - PROCESS | 11758 | Cycle 1(1): loaded http://localhost:33767/tests/dromaeo/cssquery-yui.html (next: http://localhost:33767/tests/dromaeo/cssquery-dojo.html) 09:51:12 INFO - PROCESS | 11758 | RSS: Main: 263127040 09:51:12 INFO - PROCESS | 11758 | 09:51:12 INFO - PROCESS | 11758 | __start_tp_report 09:51:12 INFO - PROCESS | 11758 | _x_x_mozilla_page_load 09:51:12 INFO - PROCESS | 11758 | _x_x_mozilla_page_load_details 09:51:12 INFO - PROCESS | 11758 | |i|pagename|runs| 09:51:12 INFO - PROCESS | 11758 | |0;dojo.html;3247.155739507728;3289.013296011196;3295.505674148878;3319.5186697928784;3335.616404113526;5665.971670141648;5715.628484148533;5722.885542289152;5726.3414707308675;5727.055035919078;5628.240187574676;5650.378458369586;5654.293213348332;5656.066748986423;5688.829335119943;5142.537171654551;5157.871053223662;5158.226266060084;5183.585313174937;5220.321358223426;5040.319556859832;5043.092243396187;5052.242163675442;5209.062368773619;5223.921641175385;5136.58907287418;5216.765245563959;5231.163013917774;5234.42421333653;5245.082110630643;5217.843464696046;5227.059129356695;5229.712365819878;5231.712255825928;5267.3679158500845;4966.404031516205;5077.441481437039;5134.871628209325;5157.767900444489;5208.218767184915;5519.668819870821;5541.556675465993;5570.303712035996;5617.831465056055;5619.662820230758;6006.669633170174;6015.578909476339;6019;6052.515798736091;6088.995315772892;6123.295820980599;6134;6134.754609815602;6137.9386206137815;6146.35463276354;5516.172574113875;5562.833115006556;5601.7759289628775;5653.689047102366;5657.4908258256955;6179.938200618026;6180.103884936749;6185.072239164161;6185.350538193425;6207.472364848948;5940.435658612425;5952.7321270542925;5953.642781433128;5954.85112872173;5956.1065840123465;5811.389804070512;5821.27234095738;5988.9101663475085;5990.490808281258;6049.1833602463985;6072.392760723892;6078.1186727924205;6098.1157732128595;6109.480694141048;6109.572329936862;5999.610025348338;6056.182415373956;6062.181605483292;6072.51419886408;6072.787452439232;4530.70550414222;4533.274676051816;4634.0500197460115;4698.107359601665;4706.835260765857;4175.832966681299;4185.769782661982;4186.497620285585;4218.0720241546815;4227.3447615619625;5815.970920145457;5817.0711688363135;5822.737976791054;5829.5044921181325;5850.736716847752;5818.8254352369495;5871.148683440877;5972.940270597325;6144.631322120687;6150.3849615039035;5558.110702287696;5674.404187560329;5700.401457846866;5721.256236689287;5790.623609465371;5131.435542090367;5165.845024649267;5173.818916337986;5176.689398636018;5200.401953775288;6267.341929097379;6276;6285.088662144055;6287;6294.213223347082;5891.351951285441;5939.316978547349;6000.819975400745;6054.54590905675;6067.635941843503;6299.181106456314;6314.842128946813;6315.810525684236;6325.367463253822;6327.810165694852;5928.851778705567;5980.372060933713;5989.2812862456785;5990.4908082813445;5997.880042399215;5876.030454974882;5920.79277225295;5938;5955.464008239279;6104.256155771938;5877.764889404376;5878.2064421302575;5884.117382392676;5895.29256489224;5900.262467191601;5885;5890.4698577128265;5892.7642894283745;5893.557983151195;5899.616524925866;5622.6064175508955;5742.540596752333;5770.6249093808765;5827.504662103599;5830.941690583039;5537.501624853782;6002.639841609517;6005.699715014319;6030.849228769141;6035.969820150871;5830.708464576839;5852.7658893645485;5872.618279811799;5873;5877.529797616095 09:51:12 INFO - PROCESS | 11758 | |1;ext.html;575.4561938967674;604.1210039392683;611.6391329115818;620.0977577624556;629.9023651334045;33991;35906.281874362496;36054.63945360549;36157.819210903945;44909.32636010463;45463.77268113655;45887.541124588744;45918;45932.54067459324;46013.53986460134;8689.087645797212;8819.95590022049;8824.735257942271;8825.602847871829;8827.470351778882;8389.916100838975;8545.914540854605;8557.529335886524;8685.913140868573;8713.041565427799;10454.4772761362;10707.250492465531;10719.249652524326;10918.945405272963;10996.450177491133;10509.106725928266;10592.947035264851;10594.41730704807;10597.576096956112;10606.098481629071;10440.37357758537;10473.47632618366;10494.317869338469;10505.107065899409;10508.527116279785;42346.15307693829;42803.785981069894;42880.571194288284;42905.35641965373;42919.35620965688;3123.141136187544;3186.8406579671155;3508.964910350915;3837.2517359114986;3845.807709614508;32035.679643203504;32509.51235731466;32509.6749032509;32548.837255813807;33423.83288083544;4419.4254746883025;4450.933236001462;4460.643148548108;4517.5256598057385;4523.592876641085;247414;252812;253276;253497;253541;59469.70265148733;59737.40262597406;59871;59896;59906.101408478906;40291.798541007105;41069.794651026554;41246.112772106266;43308.78345608315;56104.43895560992;18545.629087418176;18762.249510019446;18770.155343009596;18773.530661733294;18788.342408015655;14046.508372207129;14158.929205354114;14159.221242831743;14169.574912752634;14179.85820141806;17990.640187196183;18464.538386540444;19673.819570825795;20106.69839952402;20364.18543258253;7284.526505777108;7330.816729581697;7438.6280685965485;7479.177290498041;7614.543127412373;1007.8840933292619;1047.9580816767395;1131.1449223273837;1144.1533265383723;1228.993855030737;32957.17607059843;33253;33425.49861752076;33486.114855756015;33608.1597960053;1000.8048430556117;1146.7075895646556;1150.2523359816187;1150.4592841364545;1175.7766024455327;16064.67870642604;17713.645727085386;17741.822581774017;18522.259109635732;18600.720989185174;529085;531574;532497;533400;533492;53580;54867.45132548623;57999.130013049835;58880.705596471744;59107.70446147828;1412.7033323002079;1416.7449859025473;1424.7934049562755;1425.5794540610545;1448.4206317472883;31783.364332712754;34178;34601;34714;34756.30487390289;47087.17476951394;47250.76374618243;47257;47278.29082563833;47382.76308618435;435619;436390;436499;436596;437326;29873.402531949672;29942.550861736654;30506.694933050385;30594.847025764728;30635.693643063285;48554.514454855;50173;50206;50382;50634.240486391995;41126.79436602798;41342.793286033375;41480.58519414767;41768;42548.149037019706;41727.79136104421;41820.58179418167;42831;43153.35269971016;43174.568254318314;41751.373729393476;42888.78555607202;43278;43348.783256083516;43405.78297108494;35340;36721.44917826288;37645;38216.61783382131;38380.42429363506;28727.425451490435;28887.277818054717;29079;29192.124236272946;29227.85386073056 09:51:12 INFO - PROCESS | 11758 | |2;jquery.html;397.36818458650737;433.6920786241768;436.23876335794046;437.78548511229496;438.5570573720543;16107.919460402696;19128.234870605178;21372.89313553434;21439.464013399673;21548.245811396606;19732.605347893033;19808.90095549524;20183.29358472454;20333;20387.28644497443;5742.28221472316;5949.375315591866;5950.37521060289;5950.732217050221;5956.076808094752;5688.687122208277;5943.732532036047;5975.462208401243;6045.607035542697;6051.939480605181;6029.758809647631;6043.395660433944;6049.001914684072;6056.515478761688;6394.71223794928;6476.352364763533;6551.836204094888;6577.440917522016;6582.5063120265695;6583.769568065095;5746.827595172152;5906.704664766788;5944.286685597756;5947.732352044169;5958.255218097738;14777.70444591113;14816.925915370353;14846.925765371105;14963;15035.849641503664;2298.230092918874;2419.27421773469;2537.9873100634377;2548.9745102548923;2751.435955629091;10686.358818470917;10762.3542587445;10857.131429485622;11337.603183888525;11512.19414640967;1952.2678995376734;1992.6911328744068;2029.7158397824169;2035.2469586253033;2056.270024141423;84693;85940.57029714811;87144;88580;92354;9465.621375145054;9942.204623630092;10366.844497332546;10431.321964072311;11919.284842909454;15477.690446191013;15584.298706558233;16406.917965410095;16408.917955410147;16966.15169241533;8589.484630922165;8613.741587752378;8739.388242823068;8775.648974041094;8833.116688331243;7563.886541701879;7645.273698998586;7733.651985660659;8315.708950186714;8467.534285614227;4904.337914381513;5072.163093089599;5110.540051395392;5147.716875571805;5193.506616871391;1935.7193206984907;2006.9498262543552;2016.7176595276674;2041;2050.384884534634;960.558143254097;983.685220729374;1007.778288776468;1035.994820025895;1043.843423486483;19963.101660425316;20299.594008119755;20428.182872684927;20798;21032.263870764757;1012.86832711747;1018.7554986803262;1024.5850430575629;1026.0867827633413;1044.0864243786687;10634.41510716918;11283.60507382254;11385.430728463709;11411.942940285246;11480.540778368939;508432;524558;530033;533657;535217;91489;94252;94481;94884.52557737305;95531.52234238785;1008.606643409071;1010.4745532323298;1027.8715160604925;1031.9226058045676;1034.4930983817876;17764.91117544456;17875.46373608742;18182.363617273862;18361.816381836546;18696.906515467337;43767.343489847044;43908.341374878764;44234;45925.54074459346;46126.53873461222;59384;60504.39495604987;62018;62569.68715156395;63373.36626633674;6179.474744646755;8440.746777596682;8984.55077246122;9069.727908162766;9373.1564159226;9829.754256143653;13016.674583135497;13809.930950345184;13813.309334533033;14135.717285654435;11296.096312294832;11497.770044598894;11624.767504650028;11642.6507204784;11790.823137653113;11161.107111431229;11348.489317980875;11402.94298528502;11441.256318339281;11447.599334023269;11470.311781293149;11746.17776755619;11811.468483918072;11877.168598198388;12171.81742273849;8792.912070879465;8882.111788821325;8927;8934.28525717928;8992.190702836515;10806.621768238074;11495.137864660017;11834.940825295818;11893.345865977455;12208.816867746813 09:51:12 INFO - PROCESS | 11758 | |3;mootools.html;1409.9647508812284;1517.5599076267883;1518.4761257366206;1720.6816738903303;1855.8979256140906;7445.143808462021;8559.358048146383;8808.955955220215;8815.559222038888;9033.277337812975;8866.77833054174;8956.641734330618;8962.596683149257;8962.820743585124;8967.372283940127;2490.464550121728;2498.775110240078;2502.336880726609;2521.369657585604;2525.078346403568;2222.4666080140732;2318.1654604342425;2322.198841399714;2325.186184835311;2327.650852372141;2301.367124040894;2325.9651105233434;2422.697162854643;2507.962380564293;2510.347309699473;2212.7787221277904;2233.1737257214854;2236.7875051870046;2253.5718213539376;2258.0741895822716;2245.5396643688005;2257.8983945722316;2265.76209498002;2266.7393249776324;2268.3081660093667;8760.912390876138;8779.604917778715;8882.289416846701;8908.8663670045;9019.864702029476;5592.6085174037835;5708.7145642718115;5720.084786434192;5731.799387021476;5745.683987380692;3546.2730140321432;3567.161716996504;3614.331348700499;3623.0942264433893;3715.2755212733528;1152.4986630815538;1164.4177911044478;1183.9881601183963;1184.1414974143763;1199.9980016686077;12687.619371418872;12748.553800616934;12773.29746863922;12784.872151278461;12809.487620495169;4587.08258348325;4700.95299047012;4730.113494823448;4833.081714474239;4910.140725373046;10029.498525073717;10036.146927511243;10045.54339620751;10047.296689231829;10055;5449.809256675997;5453.072977593819;5461.044317244467;5471.261379713687;5481.205225242317;4318.417013703172;4455.242608756519;4567.9086418271445;5114.105031619451;5164.586833053347;4111.753294802322;4114.934723021853;4167.884115389377;4190.790460477025;4225.809838557211;1235.932023738703;1245.6823510005072;1259.420666493405;1267.765463389276;1269.7079671675567;997.7306127345576;1004.4726518577659;1007.7531004903699;1013.1489548779061;1018.0888105145852;5797.710114494343;5929.37741537141;5986.97531877634;6085.17850090241;6313.273973493016;470.78579246442786;475.8881662809237;477.6489280378919;479.0658216477882;487.14992338369063;4203.516595591546;4244.87265382039;4256.1487702459635;4282.978585107055;4318.352247162888;11057.336559806437;11411.48648310828;11415.771684566262;11422.828657570142;11518.94240528792;11323.263987840764;11343.773124537629;11350.09199264057;11353.772924541629;11360.659180224606;7984.441089123706;8249.175082491824;8250.54621995796;8435.409521333448;8463.984321881291;5801;5840.795572154954;6036.275646922398;6090.269167699905;6311.053341998553;10218.54016569271;10332.793344133226;10419.42693151884;10497.895021049691;10499.790004200026;8704.390692651454;10222.846657299997;10501.054905058581;10603.098736607475;10692.411917344309;7741.148473667779;8086.474379165335;8283.37874659391;8284.130166332448;8288.254057134887;8580.828383432421;8810.25112865388;8853.51305678194;8855.203031727175;8881.73354799357;7871.409644276588;7877.84244315099;7923.920760792318;8024.759257222293;8162.591870406337;7728.381729461742;7909.209079092045;7936.56348900816;7945.761627151194;7978.760637180894;7197;7222.133343998754;7293.197748247795;7304.269573042653;7378.852422951618;5329.626926115135;5376.6773993558945;5430.945690543202;5434.347878254634;5531.695756733418;5161.019406312788;5269.499397557226;5305.045091883498;5319.281896944018;5386.919196211981 09:51:12 INFO - PROCESS | 11758 | |4;prototype.html;358.7201982453687;369.83727160049574;370.712697659314;371.7342100398218;374.47386422076977;5186.781106439984;5286.762095705692;5293.57651387889;5374.274472946156;5395.946040539593;5138.845834624958;5240.973795131029;5272.839975205448;5284.44513326101;5311.964166987439;4287.892802679942;4292.14157168566;4293.570642935712;4311.82752689892;4331.133773245348;4165.146145040259;4218.725782824106;4226;4268.850590229343;4312.266914624522;4206.149294310509;4221.662267018631;4224.408582798395;4228.851990180345;4237.343211802176;4234.386014027964;4234.513031001444;4246.065865509599;4256.702030857841;4288.721233119868;3643.1074386775144;3741.8316175772156;3764.360058789985;3773.509443772292;3838.5201849768778;5147.4080480744815;5155;5166.173412254059;5176.990486855065;5178.482151784791;4759.904801903977;4777.140114779373;4786.569208771228;4792.305115758196;4803.447603525569;5345.572354211693;5455.618106732531;5516.365617953947;5519.806806761744;5521.199426083195;4070.9389359159636;4074.8573799916862;4092.7953602319767;4101.37995491782;4107.767669699078;5713.714314284269;5725.826205627878;5732.5127364174095;5746.25298711169;5774.076147816371;4039.7374170678813;4181.954511372157;4191.203671302443;4195.601417865298;4217.367394890791;4245.363195520635;4246.193223287565;4251.553586873396;4257.361395790656;4276.679249056333;4799.208130658402;4804.95195048052;4823.662343635911;4840.410380446444;4851.587615052689;5293.285406470154;5554.472325129106;5565.970295495346;5602.0029284333505;5605.299337582802;1395.107131435882;1419.884372285308;1432.842387337392;1469.926503674812;1476.5496523560203;1030.896910308978;1050.5974524010378;1059.2849826367171;1074.8387741838787;1075.9623413180502;5135.922961155586;5160.148575485003;5185.248139019821;5186.662866913639;5199.66202196856;5407.242985981966;5467.917981230285;5477.342718873681;5517.200005999108;5531.6957567333375;5014.197728363444;5127.948720512747;5139.58883289336;5245.186996015624;5260.894782104337;2886.7546258567836;2898.3333833218476;2901.7812518741757;2902.490704833475;2916.1397387770235;5639.746211420496;5644.774209031675;5645.379008309083;5668.149777533403;5673.886522269531;5551.306086739158;5563.972180139154;5834.212381328466;5873.676947767828;5883.911476376884;5951.137085122633;5952.821415357546;5955.791547295824;5971.402859713994;5973.820785376446;5583.776648934159;5731.254936858182;5772.797952071657;5778.393268706725;5786.450287222707;5665.206871037975;5667.858303542444;5670.858228544319;5671.893980673729;5698.065496269507;5915.166298447495;5924.733386997509;5946.43508866657;5968.910466342922;5980.531291850629;4060;4166.270902591974;4190.51809041964;4216.936745948875;4223.704340696245;5512.669239845462;5659.547236221175;5787.977355737722;5811.27359080115;5825.70871456434;5469.288992430958;5589.860253493695;5602.523785478117;5605.495505404533;5606.831795046155;5544.750486228048;5572.582056345871;5583.804566840141;5607.130894711327;5621.831345059655;5336.95929293784;5484.149956756709;5544.667319960815;5569.66582005081;5583.385827559046;5622;5627.268455100811;5633.577481688808;5643.689597072201;5653.830385088454;5310.973445132904;5508.944910550843;5530.364008138955;5533.501984821385;5539.476643922953 09:51:12 INFO - PROCESS | 11758 | |5;yui.html;786.1391776005272;800.1958032177664;809.5587904592004;818.5661599352343;821.5686764448664;14949.103053816765;15062;15068.849311506881;15117.773233401495;15453.922730386346;13912.373943172557;14212.928935355334;14241.501547445841;14246.430142794301;14276.143431394124;709.7373971630504;727.2037119354299;829.1625458287143;845.8181490979438;855.6406309350087;815.8980127484065;816.4488969945263;816.5549775372407;816.6039470856659;818.0633175014605;718.9460790440738;890.0698769785589;890.8619164029586;891.6789955615973;891.7592250092471;747.1445195251434;869.7390782765177;880.6477409036405;889.4796544021755;899.9325050621229;654.4339146638172;656.5207398599001;658.1937127019411;658.8945768677037;659.8416380068749;12463.875361246362;12485.375731213493;12505;12562;12604.558840440632;13083.476660933551;13302.201867887958;13386;13885.514007009706;13986;13151.86848131516;13164.341782910817;13248.47006119754;13349.733005339936;13613.319334033258;4370.737755734666;4426.867193984153;4465.37484752135;4523.547645235483;4617.930731039037;60806.391936080516;60822.69588652073;63032.68483657552;63677.68161159211;67790.66104669495;11453.484593193327;11506.367149806674;11573.363465009505;11646.184767066394;11821.940890295493;20529.79470205309;20648;20742.58514829695;20837.583248334948;21311.893440532698;8280.337572994145;8403.621837017226;8520.829583408296;8610.741677749553;8671;4126.793660316972;4209.494860616745;4224.936625950613;4289.849855255114;4350.71720338177;3439.6216416194197;3474.7046501047694;3498.352804731133;3524.2951409718157;3556.1820781220463;642.3159335307882;648.7437462202404;657.7599176300616;660.6531570925303;668.6222284409293;617.7745123030062;696.585531608692;702.7294491620661;709.2694524639629;723.8660847743184;9131.452112873249;9308.394954327947;9548.952255238679;9649.179819715262;9661.227101831837;690.4234963805279;711.4024219655514;736.9557826530425;763.5151678684076;766.6166916541729;4145.481814773153;4453.576910193527;4468.932966005513;4582.243929751554;4606.585407313358;87530;90988;91266.54366728124;92530.53734731283;94239.52880235692;81828;82781.58609206915;83134.58432707797;83796.58101709574;87205;69990;71878.28121718716;72270;73580.99999999892;74108.62945685345;8277.296429803535;8364.205400486944;8459.534725590152;8605.612747426507;8821.647134114564;49647.50352496429;49946.500534994186;49980.75009625074;50312;50380.74809625928;62716;63428.36571634225;64879;65769;66930;11293.943530282624;11682.357470339213;11770.646880593597;11784.410779461165;11818.587360594796;12533.87466125327;12704.74590508203;12922.935385323013;12967.546135885199;13131.737365252833;11793.351365674971;12243.20419172751;12322.260664360167;12419.19275247106;13142.34288285601;12173.573924912585;12381.257124572554;12607.43266552989;12732.299723515296;12806.167599106027;12282.14025018276;12852.807207892076;13027.283499407624;13344.399502022237;13372.997025222952;10321.225908057077;10698.946505267424;10729.9463502682;10908.781824363627;11311.717207069889;10164.390136591828;10552.5380406566;10876.12990960737;10928.890711092787;11016.834747478633 09:51:12 INFO - PROCESS | 11758 | __end_tp_report 09:51:12 INFO - PROCESS | 11758 | __start_cc_report 09:51:12 INFO - PROCESS | 11758 | _x_x_mozilla_cycle_collect,967 09:51:12 INFO - PROCESS | 11758 | __end_cc_report 09:51:12 INFO - PROCESS | 11758 | __startTimestamp1482429072326__endTimestamp 09:51:12 INFO - PROCESS | 11758 | 09:51:12 INFO - PROCESS | 11758 | ------- Summary: start ------- 09:51:12 INFO - PROCESS | 11758 | Number of tests: 6 09:51:12 INFO - PROCESS | 11758 | 09:51:12 INFO - PROCESS | 11758 | [#0] dojo.html Cycles:165 Average:5618.58 Median:5830.71 stddev:628.70 (10.8%) stddev-sans-first:602.48 09:51:12 INFO - PROCESS | 11758 | Values: 3247.2 3289.0 3295.5 3319.5 3335.6 5666.0 5715.6 5722.9 5726.3 5727.1 5628.2 5650.4 5654.3 5656.1 5688.8 5142.5 5157.9 5158.2 5183.6 5220.3 5040.3 5043.1 5052.2 5209.1 5223.9 5136.6 5216.8 5231.2 5234.4 5245.1 5217.8 5227.1 5229.7 5231.7 5267.4 4966.4 5077.4 5134.9 5157.8 5208.2 5519.7 5541.6 5570.3 5617.8 5619.7 6006.7 6015.6 6019.0 6052.5 6089.0 6123.3 6134.0 6134.8 6137.9 6146.4 5516.2 5562.8 5601.8 5653.7 5657.5 6179.9 6180.1 6185.1 6185.4 6207.5 5940.4 5952.7 5953.6 5954.9 5956.1 5811.4 5821.3 5988.9 5990.5 6049.2 6072.4 6078.1 6098.1 6109.5 6109.6 5999.6 6056.2 6062.2 6072.5 6072.8 4530.7 4533.3 4634.1 4698.1 4706.8 4175.8 4185.8 4186.5 4218.1 4227.3 5816.0 5817.1 5822.7 5829.5 5850.7 5818.8 5871.1 5972.9 6144.6 6150.4 5558.1 5674.4 5700.4 5721.3 5790.6 5131.4 5165.8 5173.8 5176.7 5200.4 6267.3 6276.0 6285.1 6287.0 6294.2 5891.4 5939.3 6000.8 6054.5 6067.6 6299.2 6314.8 6315.8 6325.4 6327.8 5928.9 5980.4 5989.3 5990.5 5997.9 5876.0 5920.8 5938.0 5955.5 6104.3 5877.8 5878.2 5884.1 5895.3 5900.3 5885.0 5890.5 5892.8 5893.6 5899.6 5622.6 5742.5 5770.6 5827.5 5830.9 5537.5 6002.6 6005.7 6030.8 6036.0 5830.7 5852.8 5872.6 5873.0 5877.5 09:51:12 INFO - PROCESS | 11758 | 09:51:12 INFO - PROCESS | 11758 | [#1] ext.html Cycles:180 Average:57427.92 Median:21026.93 stddev:112238.14 (533.8%) stddev-sans-first:112471.83 09:51:12 INFO - PROCESS | 11758 | Values: 575.5 604.1 611.6 620.1 629.9 33991.0 35906.3 36054.6 36157.8 44909.3 45463.8 45887.5 45918.0 45932.5 46013.5 8689.1 8820.0 8824.7 8825.6 8827.5 8389.9 8545.9 8557.5 8685.9 8713.0 10454.5 10707.3 10719.2 10918.9 10996.5 10509.1 10592.9 10594.4 10597.6 10606.1 10440.4 10473.5 10494.3 10505.1 10508.5 42346.2 42803.8 42880.6 42905.4 42919.4 3123.1 3186.8 3509.0 3837.3 3845.8 32035.7 32509.5 32509.7 32548.8 33423.8 4419.4 4450.9 4460.6 4517.5 4523.6 247414.0 252812.0 253276.0 253497.0 253541.0 59469.7 59737.4 59871.0 59896.0 59906.1 40291.8 41069.8 41246.1 43308.8 56104.4 18545.6 18762.2 18770.2 18773.5 18788.3 14046.5 14158.9 14159.2 14169.6 14179.9 17990.6 18464.5 19673.8 20106.7 20364.2 7284.5 7330.8 7438.6 7479.2 7614.5 1007.9 1048.0 1131.1 1144.2 1229.0 32957.2 33253.0 33425.5 33486.1 33608.2 1000.8 1146.7 1150.3 1150.5 1175.8 16064.7 17713.6 17741.8 18522.3 18600.7 529085.0 531574.0 532497.0 533400.0 533492.0 53580.0 54867.5 57999.1 58880.7 59107.7 1412.7 1416.7 1424.8 1425.6 1448.4 31783.4 34178.0 34601.0 34714.0 34756.3 47087.2 47250.8 47257.0 47278.3 47382.8 435619.0 436390.0 436499.0 436596.0 437326.0 29873.4 29942.6 30506.7 30594.8 30635.7 48554.5 50173.0 50206.0 50382.0 50634.2 41126.8 41342.8 41480.6 41768.0 42548.1 41727.8 41820.6 42831.0 43153.4 43174.6 41751.4 42888.8 43278.0 43348.8 43405.8 35340.0 36721.4 37645.0 38216.6 38380.4 28727.4 28887.3 29079.0 29192.1 29227.9 09:51:12 INFO - PROCESS | 11758 | 09:51:12 INFO - PROCESS | 11758 | [#2] jquery.html Cycles:180 Average:30440.62 Median:2358.75 stddev:86812.41 (3680.4%) stddev-sans-first:87026.63 09:51:12 INFO - PROCESS | 11758 | Values: 397.4 433.7 436.2 437.8 438.6 16107.9 19128.2 21372.9 21439.5 21548.2 19732.6 19808.9 20183.3 20333.0 20387.3 5742.3 5949.4 5950.4 5950.7 5956.1 5688.7 5943.7 5975.5 6045.6 6051.9 6029.8 6043.4 6049.0 6056.5 6394.7 6476.4 6551.8 6577.4 6582.5 6583.8 5746.8 5906.7 5944.3 5947.7 5958.3 14777.7 14816.9 14846.9 14963.0 15035.8 2298.2 2419.3 2538.0 2549.0 2751.4 10686.4 10762.4 10857.1 11337.6 11512.2 1952.3 1992.7 2029.7 2035.2 2056.3 84693.0 85940.6 87144.0 88580.0 92354.0 9465.6 9942.2 10366.8 10431.3 11919.3 15477.7 15584.3 16406.9 16408.9 16966.2 8589.5 8613.7 8739.4 8775.6 8833.1 7563.9 7645.3 7733.7 8315.7 8467.5 4904.3 5072.2 5110.5 5147.7 5193.5 1935.7 2006.9 2016.7 2041.0 2050.4 960.6 983.7 1007.8 1036.0 1043.8 19963.1 20299.6 20428.2 20798.0 21032.3 1012.9 1018.8 1024.6 1026.1 1044.1 10634.4 11283.6 11385.4 11411.9 11480.5 508432.0 524558.0 530033.0 533657.0 535217.0 91489.0 94252.0 94481.0 94884.5 95531.5 1008.6 1010.5 1027.9 1031.9 1034.5 17764.9 17875.5 18182.4 18361.8 18696.9 43767.3 43908.3 44234.0 45925.5 46126.5 59384.0 60504.4 62018.0 62569.7 63373.4 6179.5 8440.7 8984.6 9069.7 9373.2 9829.8 13016.7 13809.9 13813.3 14135.7 11296.1 11497.8 11624.8 11642.7 11790.8 11161.1 11348.5 11402.9 11441.3 11447.6 11470.3 11746.2 11811.5 11877.2 12171.8 8792.9 8882.1 8927.0 8934.3 8992.2 10806.6 11495.1 11834.9 11893.3 12208.8 09:51:12 INFO - PROCESS | 11758 | 09:51:12 INFO - PROCESS | 11758 | [#3] mootools.html Cycles:180 Average:5928.65 Median:4577.50 stddev:3387.74 (74.0%) stddev-sans-first:3380.22 09:51:12 INFO - PROCESS | 11758 | Values: 1410.0 1517.6 1518.5 1720.7 1855.9 7445.1 8559.4 8809.0 8815.6 9033.3 8866.8 8956.6 8962.6 8962.8 8967.4 2490.5 2498.8 2502.3 2521.4 2525.1 2222.5 2318.2 2322.2 2325.2 2327.7 2301.4 2326.0 2422.7 2508.0 2510.3 2212.8 2233.2 2236.8 2253.6 2258.1 2245.5 2257.9 2265.8 2266.7 2268.3 8760.9 8779.6 8882.3 8908.9 9019.9 5592.6 5708.7 5720.1 5731.8 5745.7 3546.3 3567.2 3614.3 3623.1 3715.3 1152.5 1164.4 1184.0 1184.1 1200.0 12687.6 12748.6 12773.3 12784.9 12809.5 4587.1 4701.0 4730.1 4833.1 4910.1 10029.5 10036.1 10045.5 10047.3 10055.0 5449.8 5453.1 5461.0 5471.3 5481.2 4318.4 4455.2 4567.9 5114.1 5164.6 4111.8 4114.9 4167.9 4190.8 4225.8 1235.9 1245.7 1259.4 1267.8 1269.7 997.7 1004.5 1007.8 1013.1 1018.1 5797.7 5929.4 5987.0 6085.2 6313.3 470.8 475.9 477.6 479.1 487.1 4203.5 4244.9 4256.1 4283.0 4318.4 11057.3 11411.5 11415.8 11422.8 11518.9 11323.3 11343.8 11350.1 11353.8 11360.7 7984.4 8249.2 8250.5 8435.4 8464.0 5801.0 5840.8 6036.3 6090.3 6311.1 10218.5 10332.8 10419.4 10497.9 10499.8 8704.4 10222.8 10501.1 10603.1 10692.4 7741.1 8086.5 8283.4 8284.1 8288.3 8580.8 8810.3 8853.5 8855.2 8881.7 7871.4 7877.8 7923.9 8024.8 8162.6 7728.4 7909.2 7936.6 7945.8 7978.8 7197.0 7222.1 7293.2 7304.3 7378.9 5329.6 5376.7 5430.9 5434.3 5531.7 5161.0 5269.5 5305.0 5319.3 5386.9 09:51:12 INFO - PROCESS | 11758 | 09:51:12 INFO - PROCESS | 11758 | [#4] prototype.html Cycles:180 Average:4703.01 Median:5243.08 stddev:1347.73 (25.7%) stddev-sans-first:1311.47 09:51:12 INFO - PROCESS | 11758 | Values: 358.7 369.8 370.7 371.7 374.5 5186.8 5286.8 5293.6 5374.3 5395.9 5138.8 5241.0 5272.8 5284.4 5312.0 4287.9 4292.1 4293.6 4311.8 4331.1 4165.1 4218.7 4226.0 4268.9 4312.3 4206.1 4221.7 4224.4 4228.9 4237.3 4234.4 4234.5 4246.1 4256.7 4288.7 3643.1 3741.8 3764.4 3773.5 3838.5 5147.4 5155.0 5166.2 5177.0 5178.5 4759.9 4777.1 4786.6 4792.3 4803.4 5345.6 5455.6 5516.4 5519.8 5521.2 4070.9 4074.9 4092.8 4101.4 4107.8 5713.7 5725.8 5732.5 5746.3 5774.1 4039.7 4182.0 4191.2 4195.6 4217.4 4245.4 4246.2 4251.6 4257.4 4276.7 4799.2 4805.0 4823.7 4840.4 4851.6 5293.3 5554.5 5566.0 5602.0 5605.3 1395.1 1419.9 1432.8 1469.9 1476.5 1030.9 1050.6 1059.3 1074.8 1076.0 5135.9 5160.1 5185.2 5186.7 5199.7 5407.2 5467.9 5477.3 5517.2 5531.7 5014.2 5127.9 5139.6 5245.2 5260.9 2886.8 2898.3 2901.8 2902.5 2916.1 5639.7 5644.8 5645.4 5668.1 5673.9 5551.3 5564.0 5834.2 5873.7 5883.9 5951.1 5952.8 5955.8 5971.4 5973.8 5583.8 5731.3 5772.8 5778.4 5786.5 5665.2 5667.9 5670.9 5671.9 5698.1 5915.2 5924.7 5946.4 5968.9 5980.5 4060.0 4166.3 4190.5 4216.9 4223.7 5512.7 5659.5 5788.0 5811.3 5825.7 5469.3 5589.9 5602.5 5605.5 5606.8 5544.8 5572.6 5583.8 5607.1 5621.8 5337.0 5484.1 5544.7 5569.7 5583.4 5622.0 5627.3 5633.6 5643.7 5653.8 5311.0 5508.9 5530.4 5533.5 5539.5 09:51:12 INFO - PROCESS | 11758 | 09:51:12 INFO - PROCESS | 11758 | [#5] yui.html Cycles:180 Average:18346.03 Median:49797.00 stddev:24802.24 (49.8%) stddev-sans-first:24836.77 09:51:12 INFO - PROCESS | 11758 | Values: 786.1 800.2 809.6 818.6 821.6 14949.1 15062.0 15068.8 15117.8 15453.9 13912.4 14212.9 14241.5 14246.4 14276.1 709.7 727.2 829.2 845.8 855.6 815.9 816.4 816.6 816.6 818.1 718.9 890.1 890.9 891.7 891.8 747.1 869.7 880.6 889.5 899.9 654.4 656.5 658.2 658.9 659.8 12463.9 12485.4 12505.0 12562.0 12604.6 13083.5 13302.2 13386.0 13885.5 13986.0 13151.9 13164.3 13248.5 13349.7 13613.3 4370.7 4426.9 4465.4 4523.5 4617.9 60806.4 60822.7 63032.7 63677.7 67790.7 11453.5 11506.4 11573.4 11646.2 11821.9 20529.8 20648.0 20742.6 20837.6 21311.9 8280.3 8403.6 8520.8 8610.7 8671.0 4126.8 4209.5 4224.9 4289.8 4350.7 3439.6 3474.7 3498.4 3524.3 3556.2 642.3 648.7 657.8 660.7 668.6 617.8 696.6 702.7 709.3 723.9 9131.5 9308.4 9549.0 9649.2 9661.2 690.4 711.4 737.0 763.5 766.6 4145.5 4453.6 4468.9 4582.2 4606.6 87530.0 90988.0 91266.5 92530.5 94239.5 81828.0 82781.6 83134.6 83796.6 87205.0 69990.0 71878.3 72270.0 73581.0 74108.6 8277.3 8364.2 8459.5 8605.6 8821.6 49647.5 49946.5 49980.8 50312.0 50380.7 62716.0 63428.4 64879.0 65769.0 66930.0 11293.9 11682.4 11770.6 11784.4 11818.6 12533.9 12704.7 12922.9 12967.5 13131.7 11793.4 12243.2 12322.3 12419.2 13142.3 12173.6 12381.3 12607.4 12732.3 12806.2 12282.1 12852.8 13027.3 13344.4 13373.0 10321.2 10698.9 10729.9 10908.8 11311.7 10164.4 10552.5 10876.1 10928.9 11016.8 09:51:12 INFO - PROCESS | 11758 | -------- Summary: end -------- 09:51:12 INFO - PROCESS | 11758 | 09:51:13 INFO - TEST-INFO | 11758: exit 0 09:51:13 INFO - TEST-OK | dromaeo_css | took 1115961ms 09:51:13 INFO - TEST-START | kraken 09:51:13 INFO - operating with platform_type : linux_ 09:51:13 INFO - Initialising browser for kraken test... 09:51:13 INFO - TEST-INFO | started process 12074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_DcExt/profile http://localhost:33767/getInfo.html) 09:51:17 INFO - PROCESS | 12074 | __metrics Screen width/height:1600/1200 09:51:17 INFO - PROCESS | 12074 | colorDepth:24 09:51:17 INFO - PROCESS | 12074 | Browser inner width/height: 1024/697 09:51:17 INFO - PROCESS | 12074 | __metrics 09:51:17 INFO - PROCESS | 12074 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:51:17 INFO - PROCESS | 12074 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:51:18 INFO - PROCESS | 12074 | console.error: PushService: 09:51:18 INFO - PROCESS | 12074 | stateChangeProcessEnqueue: Error transitioning state 09:51:18 INFO - PROCESS | 12074 | UnknownError 09:51:18 INFO - TEST-INFO | 12074: exit 0 09:51:18 INFO - Browser initialized. 09:51:18 INFO - Running cycle 1/1 for kraken test... 09:51:18 INFO - TEST-INFO | started process 12167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_DcExt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:30 INFO - PROCESS | 12167 | RSS: Main: 144392192 09:51:30 INFO - PROCESS | 12167 | 09:51:33 INFO - PROCESS | 12167 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33767/tests/kraken/driver.html?testName=audio-beat-detection) 09:51:34 INFO - PROCESS | 12167 | RSS: Main: 186433536 09:51:34 INFO - PROCESS | 12167 | 09:51:36 INFO - PROCESS | 12167 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33767/tests/kraken/driver.html?testName=audio-dft) 09:51:37 INFO - PROCESS | 12167 | RSS: Main: 175464448 09:51:37 INFO - PROCESS | 12167 | 09:51:40 INFO - PROCESS | 12167 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33767/tests/kraken/driver.html?testName=audio-fft) 09:51:40 INFO - PROCESS | 12167 | RSS: Main: 266125312 09:51:40 INFO - PROCESS | 12167 | 09:51:42 INFO - PROCESS | 12167 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33767/tests/kraken/driver.html?testName=audio-oscillator) 09:51:43 INFO - PROCESS | 12167 | RSS: Main: 173154304 09:51:43 INFO - PROCESS | 12167 | 09:51:45 INFO - PROCESS | 12167 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33767/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:51:45 INFO - PROCESS | 12167 | RSS: Main: 175349760 09:51:45 INFO - PROCESS | 12167 | 09:51:48 INFO - PROCESS | 12167 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33767/tests/kraken/driver.html?testName=imaging-darkroom) 09:51:49 INFO - PROCESS | 12167 | RSS: Main: 214286336 09:51:49 INFO - PROCESS | 12167 | 09:51:52 INFO - PROCESS | 12167 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33767/tests/kraken/driver.html?testName=imaging-desaturate) 09:51:53 INFO - PROCESS | 12167 | RSS: Main: 212738048 09:51:53 INFO - PROCESS | 12167 | 09:51:56 INFO - PROCESS | 12167 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33767/tests/kraken/driver.html?testName=json-parse-financial) 09:51:56 INFO - PROCESS | 12167 | RSS: Main: 211021824 09:51:56 INFO - PROCESS | 12167 | 09:51:58 INFO - PROCESS | 12167 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33767/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:51:58 INFO - PROCESS | 12167 | RSS: Main: 173236224 09:51:58 INFO - PROCESS | 12167 | 09:52:00 INFO - PROCESS | 12167 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:52:01 INFO - PROCESS | 12167 | RSS: Main: 180895744 09:52:01 INFO - PROCESS | 12167 | 09:52:02 INFO - PROCESS | 12167 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:52:03 INFO - PROCESS | 12167 | RSS: Main: 189988864 09:52:03 INFO - PROCESS | 12167 | 09:52:06 INFO - PROCESS | 12167 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:52:06 INFO - PROCESS | 12167 | RSS: Main: 198889472 09:52:06 INFO - PROCESS | 12167 | 09:52:09 INFO - PROCESS | 12167 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:52:10 INFO - PROCESS | 12167 | RSS: Main: 194220032 09:52:10 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33767/tests/kraken/driver.html?testName=ai-astar) 09:52:11 INFO - PROCESS | 12167 | RSS: Main: 245420032 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | __start_tp_report 09:52:11 INFO - PROCESS | 12167 | _x_x_mozilla_page_load 09:52:11 INFO - PROCESS | 12167 | _x_x_mozilla_page_load_details 09:52:11 INFO - PROCESS | 12167 | |i|pagename|runs| 09:52:11 INFO - PROCESS | 12167 | |0;ai-astar;102;109;112;111;113;113;113;111;112;111 09:52:11 INFO - PROCESS | 12167 | |1;audio-beat-detection;145;118;118;166;118;120;117;119;167;117 09:52:11 INFO - PROCESS | 12167 | |2;audio-dft;161;161;159;159;161;161;160;160;161;159 09:52:11 INFO - PROCESS | 12167 | |3;audio-fft;75;76;75;110;75;75;79;76;96;74 09:52:11 INFO - PROCESS | 12167 | |4;audio-oscillator;81;81;113;81;81;82;98;82;81;112 09:52:11 INFO - PROCESS | 12167 | |5;imaging-gaussian-blur;116;116;117;117;116;118;117;117;117;116 09:52:11 INFO - PROCESS | 12167 | |6;imaging-darkroom;146;146;146;147;147;147;146;146;147;146 09:52:11 INFO - PROCESS | 12167 | |7;imaging-desaturate;84;84;85;86;85;84;84;84;84;85 09:52:11 INFO - PROCESS | 12167 | |8;json-parse-financial;50;51;50;49;49;51;53;50;53;49 09:52:11 INFO - PROCESS | 12167 | |9;json-stringify-tinderbox;58;59;59;59;59;58;58;58;59;59 09:52:11 INFO - PROCESS | 12167 | |10;stanford-crypto-aes;75;74;73;74;74;74;74;75;74;73 09:52:11 INFO - PROCESS | 12167 | |11;stanford-crypto-ccm;125;128;120;124;137;119;120;119;161;136 09:52:11 INFO - PROCESS | 12167 | |12;stanford-crypto-pbkdf2;155;151;151;156;151;154;154;156;153;151 09:52:11 INFO - PROCESS | 12167 | |13;stanford-crypto-sha256-iterative;62;61;62;61;65;66;62;61;63;61 09:52:11 INFO - PROCESS | 12167 | __end_tp_report 09:52:11 INFO - PROCESS | 12167 | __start_cc_report 09:52:11 INFO - PROCESS | 12167 | _x_x_mozilla_cycle_collect,1592 09:52:11 INFO - PROCESS | 12167 | __end_cc_report 09:52:11 INFO - PROCESS | 12167 | __startTimestamp1482429131925__endTimestamp 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | ------- Summary: start ------- 09:52:11 INFO - PROCESS | 12167 | Number of tests: 14 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.30 (2.9%) stddev-sans-first:1.32 09:52:11 INFO - PROCESS | 12167 | Values: 102.0 109.0 112.0 111.0 113.0 113.0 113.0 111.0 112.0 111.0 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:119.50 stddev:20.76 (17.4%) stddev-sans-first:21.35 09:52:11 INFO - PROCESS | 12167 | Values: 145.0 118.0 118.0 166.0 118.0 120.0 117.0 119.0 167.0 117.0 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | [#2] audio-dft Cycles:10 Average:160.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 09:52:11 INFO - PROCESS | 12167 | Values: 161.0 161.0 159.0 159.0 161.0 161.0 160.0 160.0 161.0 159.0 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.50 stddev:12.08 (16.0%) stddev-sans-first:12.61 09:52:11 INFO - PROCESS | 12167 | Values: 75.0 76.0 75.0 110.0 75.0 75.0 79.0 76.0 96.0 74.0 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:81.00 stddev:13.35 (16.5%) stddev-sans-first:13.82 09:52:11 INFO - PROCESS | 12167 | Values: 81.0 81.0 113.0 81.0 81.0 82.0 98.0 82.0 81.0 112.0 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 09:52:11 INFO - PROCESS | 12167 | Values: 116.0 116.0 117.0 117.0 116.0 118.0 117.0 117.0 117.0 116.0 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:52:11 INFO - PROCESS | 12167 | Values: 146.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 147.0 146.0 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 09:52:11 INFO - PROCESS | 12167 | Values: 84.0 84.0 85.0 86.0 85.0 84.0 84.0 84.0 84.0 85.0 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:50.50 stddev:1.51 (3.0%) stddev-sans-first:1.59 09:52:11 INFO - PROCESS | 12167 | Values: 50.0 51.0 50.0 49.0 49.0 51.0 53.0 50.0 53.0 49.0 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 09:52:11 INFO - PROCESS | 12167 | Values: 58.0 59.0 59.0 59.0 59.0 58.0 58.0 58.0 59.0 59.0 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:0.67 (0.9%) stddev-sans-first:0.60 09:52:11 INFO - PROCESS | 12167 | Values: 75.0 74.0 73.0 74.0 74.0 74.0 74.0 75.0 74.0 73.0 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:126.50 stddev:13.08 (10.3%) stddev-sans-first:13.80 09:52:11 INFO - PROCESS | 12167 | Values: 125.0 128.0 120.0 124.0 137.0 119.0 120.0 119.0 161.0 136.0 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.20 Median:154.00 stddev:2.10 (1.4%) stddev-sans-first:2.12 09:52:11 INFO - PROCESS | 12167 | Values: 155.0 151.0 151.0 156.0 151.0 154.0 154.0 156.0 153.0 151.0 09:52:11 INFO - PROCESS | 12167 | 09:52:11 INFO - PROCESS | 12167 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.78 (2.9%) stddev-sans-first:1.88 09:52:11 INFO - PROCESS | 12167 | Values: 62.0 61.0 62.0 61.0 65.0 66.0 62.0 61.0 63.0 61.0 09:52:11 INFO - PROCESS | 12167 | -------- Summary: end -------- 09:52:11 INFO - PROCESS | 12167 | 09:52:12 INFO - TEST-INFO | 12167: exit 0 09:52:13 INFO - TEST-OK | kraken | took 59959ms 09:52:13 INFO - SUITE-END | took 1175s 09:52:13 INFO - Completed test suite (00:19:35) 09:52:13 INFO - javascript benchmark 09:52:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3247.155739507728, 3289.013296011196, 3295.505674148878, 3319.5186697928784, 3335.616404113526, 5665.971670141648, 5715.628484148533, 5722.885542289152, 5726.3414707308675, 5727.055035919078, 5628.240187574676, 5650.378458369586, 5654.293213348332, 5656.066748986423, 5688.829335119943, 5142.537171654551, 5157.871053223662, 5158.226266060084, 5183.585313174937, 5220.321358223426, 5040.319556859832, 5043.092243396187, 5052.242163675442, 5209.062368773619, 5223.921641175385, 5136.58907287418, 5216.765245563959, 5231.163013917774, 5234.42421333653, 5245.082110630643, 5217.843464696046, 5227.059129356695, 5229.712365819878, 5231.712255825928, 5267.3679158500845, 4966.404031516205, 5077.441481437039, 5134.871628209325, 5157.767900444489, 5208.218767184915, 5519.668819870821, 5541.556675465993, 5570.303712035996, 5617.831465056055, 5619.662820230758, 6006.669633170174, 6015.578909476339, 6019.0, 6052.515798736091, 6088.995315772892, 6123.295820980599, 6134.0, 6134.754609815602, 6137.9386206137815, 6146.35463276354, 5516.172574113875, 5562.833115006556, 5601.7759289628775, 5653.689047102366, 5657.4908258256955, 6179.938200618026, 6180.103884936749, 6185.072239164161, 6185.350538193425, 6207.472364848948, 5940.435658612425, 5952.7321270542925, 5953.642781433128, 5954.85112872173, 5956.1065840123465, 5811.389804070512, 5821.27234095738, 5988.9101663475085, 5990.490808281258, 6049.1833602463985, 6072.392760723892, 6078.1186727924205, 6098.1157732128595, 6109.480694141048, 6109.572329936862, 5999.610025348338, 6056.182415373956, 6062.181605483292, 6072.51419886408, 6072.787452439232, 4530.70550414222, 4533.274676051816, 4634.0500197460115, 4698.107359601665, 4706.835260765857, 4175.832966681299, 4185.769782661982, 4186.497620285585, 4218.0720241546815, 4227.3447615619625, 5815.970920145457, 5817.0711688363135, 5822.737976791054, 5829.5044921181325, 5850.736716847752, 5818.8254352369495, 5871.148683440877, 5972.940270597325, 6144.631322120687, 6150.3849615039035, 5558.110702287696, 5674.404187560329, 5700.401457846866, 5721.256236689287, 5790.623609465371, 5131.435542090367, 5165.845024649267, 5173.818916337986, 5176.689398636018, 5200.401953775288, 6267.341929097379, 6276.0, 6285.088662144055, 6287.0, 6294.213223347082, 5891.351951285441, 5939.316978547349, 6000.819975400745, 6054.54590905675, 6067.635941843503, 6299.181106456314, 6314.842128946813, 6315.810525684236, 6325.367463253822, 6327.810165694852, 5928.851778705567, 5980.372060933713, 5989.2812862456785, 5990.4908082813445, 5997.880042399215, 5876.030454974882, 5920.79277225295, 5938.0, 5955.464008239279, 6104.256155771938, 5877.764889404376, 5878.2064421302575, 5884.117382392676, 5895.29256489224, 5900.262467191601, 5885.0, 5890.4698577128265, 5892.7642894283745, 5893.557983151195, 5899.616524925866, 5622.6064175508955, 5742.540596752333, 5770.6249093808765, 5827.504662103599, 5830.941690583039, 5537.501624853782, 6002.639841609517, 6005.699715014319, 6030.849228769141, 6035.969820150871, 5830.708464576839, 5852.7658893645485, 5872.618279811799, 5873.0, 5877.529797616095], "value": 5577.010981197362, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.4561938967674, 604.1210039392683, 611.6391329115818, 620.0977577624556, 629.9023651334045, 33991.0, 35906.281874362496, 36054.63945360549, 36157.819210903945, 44909.32636010463, 45463.77268113655, 45887.541124588744, 45918.0, 45932.54067459324, 46013.53986460134, 8689.087645797212, 8819.95590022049, 8824.735257942271, 8825.602847871829, 8827.470351778882, 8389.916100838975, 8545.914540854605, 8557.529335886524, 8685.913140868573, 8713.041565427799, 10454.4772761362, 10707.250492465531, 10719.249652524326, 10918.945405272963, 10996.450177491133, 10509.106725928266, 10592.947035264851, 10594.41730704807, 10597.576096956112, 10606.098481629071, 10440.37357758537, 10473.47632618366, 10494.317869338469, 10505.107065899409, 10508.527116279785, 42346.15307693829, 42803.785981069894, 42880.571194288284, 42905.35641965373, 42919.35620965688, 3123.141136187544, 3186.8406579671155, 3508.964910350915, 3837.2517359114986, 3845.807709614508, 32035.679643203504, 32509.51235731466, 32509.6749032509, 32548.837255813807, 33423.83288083544, 4419.4254746883025, 4450.933236001462, 4460.643148548108, 4517.5256598057385, 4523.592876641085, 247414.0, 252812.0, 253276.0, 253497.0, 253541.0, 59469.70265148733, 59737.40262597406, 59871.0, 59896.0, 59906.101408478906, 40291.798541007105, 41069.794651026554, 41246.112772106266, 43308.78345608315, 56104.43895560992, 18545.629087418176, 18762.249510019446, 18770.155343009596, 18773.530661733294, 18788.342408015655, 14046.508372207129, 14158.929205354114, 14159.221242831743, 14169.574912752634, 14179.85820141806, 17990.640187196183, 18464.538386540444, 19673.819570825795, 20106.69839952402, 20364.18543258253, 7284.526505777108, 7330.816729581697, 7438.6280685965485, 7479.177290498041, 7614.543127412373, 1007.8840933292619, 1047.9580816767395, 1131.1449223273837, 1144.1533265383723, 1228.993855030737, 32957.17607059843, 33253.0, 33425.49861752076, 33486.114855756015, 33608.1597960053, 1000.8048430556117, 1146.7075895646556, 1150.2523359816187, 1150.4592841364545, 1175.7766024455327, 16064.67870642604, 17713.645727085386, 17741.822581774017, 18522.259109635732, 18600.720989185174, 529085.0, 531574.0, 532497.0, 533400.0, 533492.0, 53580.0, 54867.45132548623, 57999.130013049835, 58880.705596471744, 59107.70446147828, 1412.7033323002079, 1416.7449859025473, 1424.7934049562755, 1425.5794540610545, 1448.4206317472883, 31783.364332712754, 34178.0, 34601.0, 34714.0, 34756.30487390289, 47087.17476951394, 47250.76374618243, 47257.0, 47278.29082563833, 47382.76308618435, 435619.0, 436390.0, 436499.0, 436596.0, 437326.0, 29873.402531949672, 29942.550861736654, 30506.694933050385, 30594.847025764728, 30635.693643063285, 48554.514454855, 50173.0, 50206.0, 50382.0, 50634.240486391995, 41126.79436602798, 41342.793286033375, 41480.58519414767, 41768.0, 42548.149037019706, 41727.79136104421, 41820.58179418167, 42831.0, 43153.35269971016, 43174.568254318314, 41751.373729393476, 42888.78555607202, 43278.0, 43348.783256083516, 43405.78297108494, 35340.0, 36721.44917826288, 37645.0, 38216.61783382131, 38380.42429363506, 28727.425451490435, 28887.277818054717, 29079.0, 29192.124236272946, 29227.85386073056], "value": 20423.943060417227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.36818458650737, 433.6920786241768, 436.23876335794046, 437.78548511229496, 438.5570573720543, 16107.919460402696, 19128.234870605178, 21372.89313553434, 21439.464013399673, 21548.245811396606, 19732.605347893033, 19808.90095549524, 20183.29358472454, 20333.0, 20387.28644497443, 5742.28221472316, 5949.375315591866, 5950.37521060289, 5950.732217050221, 5956.076808094752, 5688.687122208277, 5943.732532036047, 5975.462208401243, 6045.607035542697, 6051.939480605181, 6029.758809647631, 6043.395660433944, 6049.001914684072, 6056.515478761688, 6394.71223794928, 6476.352364763533, 6551.836204094888, 6577.440917522016, 6582.5063120265695, 6583.769568065095, 5746.827595172152, 5906.704664766788, 5944.286685597756, 5947.732352044169, 5958.255218097738, 14777.70444591113, 14816.925915370353, 14846.925765371105, 14963.0, 15035.849641503664, 2298.230092918874, 2419.27421773469, 2537.9873100634377, 2548.9745102548923, 2751.435955629091, 10686.358818470917, 10762.3542587445, 10857.131429485622, 11337.603183888525, 11512.19414640967, 1952.2678995376734, 1992.6911328744068, 2029.7158397824169, 2035.2469586253033, 2056.270024141423, 84693.0, 85940.57029714811, 87144.0, 88580.0, 92354.0, 9465.621375145054, 9942.204623630092, 10366.844497332546, 10431.321964072311, 11919.284842909454, 15477.690446191013, 15584.298706558233, 16406.917965410095, 16408.917955410147, 16966.15169241533, 8589.484630922165, 8613.741587752378, 8739.388242823068, 8775.648974041094, 8833.116688331243, 7563.886541701879, 7645.273698998586, 7733.651985660659, 8315.708950186714, 8467.534285614227, 4904.337914381513, 5072.163093089599, 5110.540051395392, 5147.716875571805, 5193.506616871391, 1935.7193206984907, 2006.9498262543552, 2016.7176595276674, 2041.0, 2050.384884534634, 960.558143254097, 983.685220729374, 1007.778288776468, 1035.994820025895, 1043.843423486483, 19963.101660425316, 20299.594008119755, 20428.182872684927, 20798.0, 21032.263870764757, 1012.86832711747, 1018.7554986803262, 1024.5850430575629, 1026.0867827633413, 1044.0864243786687, 10634.41510716918, 11283.60507382254, 11385.430728463709, 11411.942940285246, 11480.540778368939, 508432.0, 524558.0, 530033.0, 533657.0, 535217.0, 91489.0, 94252.0, 94481.0, 94884.52557737305, 95531.52234238785, 1008.606643409071, 1010.4745532323298, 1027.8715160604925, 1031.9226058045676, 1034.4930983817876, 17764.91117544456, 17875.46373608742, 18182.363617273862, 18361.816381836546, 18696.906515467337, 43767.343489847044, 43908.341374878764, 44234.0, 45925.54074459346, 46126.53873461222, 59384.0, 60504.39495604987, 62018.0, 62569.68715156395, 63373.36626633674, 6179.474744646755, 8440.746777596682, 8984.55077246122, 9069.727908162766, 9373.1564159226, 9829.754256143653, 13016.674583135497, 13809.930950345184, 13813.309334533033, 14135.717285654435, 11296.096312294832, 11497.770044598894, 11624.767504650028, 11642.6507204784, 11790.823137653113, 11161.107111431229, 11348.489317980875, 11402.94298528502, 11441.256318339281, 11447.599334023269, 11470.311781293149, 11746.17776755619, 11811.468483918072, 11877.168598198388, 12171.81742273849, 8792.912070879465, 8882.111788821325, 8927.0, 8934.28525717928, 8992.190702836515, 10806.621768238074, 11495.137864660017, 11834.940825295818, 11893.345865977455, 12208.816867746813], "value": 9452.158609507782, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.9647508812284, 1517.5599076267883, 1518.4761257366206, 1720.6816738903303, 1855.8979256140906, 7445.143808462021, 8559.358048146383, 8808.955955220215, 8815.559222038888, 9033.277337812975, 8866.77833054174, 8956.641734330618, 8962.596683149257, 8962.820743585124, 8967.372283940127, 2490.464550121728, 2498.775110240078, 2502.336880726609, 2521.369657585604, 2525.078346403568, 2222.4666080140732, 2318.1654604342425, 2322.198841399714, 2325.186184835311, 2327.650852372141, 2301.367124040894, 2325.9651105233434, 2422.697162854643, 2507.962380564293, 2510.347309699473, 2212.7787221277904, 2233.1737257214854, 2236.7875051870046, 2253.5718213539376, 2258.0741895822716, 2245.5396643688005, 2257.8983945722316, 2265.76209498002, 2266.7393249776324, 2268.3081660093667, 8760.912390876138, 8779.604917778715, 8882.289416846701, 8908.8663670045, 9019.864702029476, 5592.6085174037835, 5708.7145642718115, 5720.084786434192, 5731.799387021476, 5745.683987380692, 3546.2730140321432, 3567.161716996504, 3614.331348700499, 3623.0942264433893, 3715.2755212733528, 1152.4986630815538, 1164.4177911044478, 1183.9881601183963, 1184.1414974143763, 1199.9980016686077, 12687.619371418872, 12748.553800616934, 12773.29746863922, 12784.872151278461, 12809.487620495169, 4587.08258348325, 4700.95299047012, 4730.113494823448, 4833.081714474239, 4910.140725373046, 10029.498525073717, 10036.146927511243, 10045.54339620751, 10047.296689231829, 10055.0, 5449.809256675997, 5453.072977593819, 5461.044317244467, 5471.261379713687, 5481.205225242317, 4318.417013703172, 4455.242608756519, 4567.9086418271445, 5114.105031619451, 5164.586833053347, 4111.753294802322, 4114.934723021853, 4167.884115389377, 4190.790460477025, 4225.809838557211, 1235.932023738703, 1245.6823510005072, 1259.420666493405, 1267.765463389276, 1269.7079671675567, 997.7306127345576, 1004.4726518577659, 1007.7531004903699, 1013.1489548779061, 1018.0888105145852, 5797.710114494343, 5929.37741537141, 5986.97531877634, 6085.17850090241, 6313.273973493016, 470.78579246442786, 475.8881662809237, 477.6489280378919, 479.0658216477882, 487.14992338369063, 4203.516595591546, 4244.87265382039, 4256.1487702459635, 4282.978585107055, 4318.352247162888, 11057.336559806437, 11411.48648310828, 11415.771684566262, 11422.828657570142, 11518.94240528792, 11323.263987840764, 11343.773124537629, 11350.09199264057, 11353.772924541629, 11360.659180224606, 7984.441089123706, 8249.175082491824, 8250.54621995796, 8435.409521333448, 8463.984321881291, 5801.0, 5840.795572154954, 6036.275646922398, 6090.269167699905, 6311.053341998553, 10218.54016569271, 10332.793344133226, 10419.42693151884, 10497.895021049691, 10499.790004200026, 8704.390692651454, 10222.846657299997, 10501.054905058581, 10603.098736607475, 10692.411917344309, 7741.148473667779, 8086.474379165335, 8283.37874659391, 8284.130166332448, 8288.254057134887, 8580.828383432421, 8810.25112865388, 8853.51305678194, 8855.203031727175, 8881.73354799357, 7871.409644276588, 7877.84244315099, 7923.920760792318, 8024.759257222293, 8162.591870406337, 7728.381729461742, 7909.209079092045, 7936.56348900816, 7945.761627151194, 7978.760637180894, 7197.0, 7222.133343998754, 7293.197748247795, 7304.269573042653, 7378.852422951618, 5329.626926115135, 5376.6773993558945, 5430.945690543202, 5434.347878254634, 5531.695756733418, 5161.019406312788, 5269.499397557226, 5305.045091883498, 5319.281896944018, 5386.919196211981], "value": 4665.852552804177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.7201982453687, 369.83727160049574, 370.712697659314, 371.7342100398218, 374.47386422076977, 5186.781106439984, 5286.762095705692, 5293.57651387889, 5374.274472946156, 5395.946040539593, 5138.845834624958, 5240.973795131029, 5272.839975205448, 5284.44513326101, 5311.964166987439, 4287.892802679942, 4292.14157168566, 4293.570642935712, 4311.82752689892, 4331.133773245348, 4165.146145040259, 4218.725782824106, 4226.0, 4268.850590229343, 4312.266914624522, 4206.149294310509, 4221.662267018631, 4224.408582798395, 4228.851990180345, 4237.343211802176, 4234.386014027964, 4234.513031001444, 4246.065865509599, 4256.702030857841, 4288.721233119868, 3643.1074386775144, 3741.8316175772156, 3764.360058789985, 3773.509443772292, 3838.5201849768778, 5147.4080480744815, 5155.0, 5166.173412254059, 5176.990486855065, 5178.482151784791, 4759.904801903977, 4777.140114779373, 4786.569208771228, 4792.305115758196, 4803.447603525569, 5345.572354211693, 5455.618106732531, 5516.365617953947, 5519.806806761744, 5521.199426083195, 4070.9389359159636, 4074.8573799916862, 4092.7953602319767, 4101.37995491782, 4107.767669699078, 5713.714314284269, 5725.826205627878, 5732.5127364174095, 5746.25298711169, 5774.076147816371, 4039.7374170678813, 4181.954511372157, 4191.203671302443, 4195.601417865298, 4217.367394890791, 4245.363195520635, 4246.193223287565, 4251.553586873396, 4257.361395790656, 4276.679249056333, 4799.208130658402, 4804.95195048052, 4823.662343635911, 4840.410380446444, 4851.587615052689, 5293.285406470154, 5554.472325129106, 5565.970295495346, 5602.0029284333505, 5605.299337582802, 1395.107131435882, 1419.884372285308, 1432.842387337392, 1469.926503674812, 1476.5496523560203, 1030.896910308978, 1050.5974524010378, 1059.2849826367171, 1074.8387741838787, 1075.9623413180502, 5135.922961155586, 5160.148575485003, 5185.248139019821, 5186.662866913639, 5199.66202196856, 5407.242985981966, 5467.917981230285, 5477.342718873681, 5517.200005999108, 5531.6957567333375, 5014.197728363444, 5127.948720512747, 5139.58883289336, 5245.186996015624, 5260.894782104337, 2886.7546258567836, 2898.3333833218476, 2901.7812518741757, 2902.490704833475, 2916.1397387770235, 5639.746211420496, 5644.774209031675, 5645.379008309083, 5668.149777533403, 5673.886522269531, 5551.306086739158, 5563.972180139154, 5834.212381328466, 5873.676947767828, 5883.911476376884, 5951.137085122633, 5952.821415357546, 5955.791547295824, 5971.402859713994, 5973.820785376446, 5583.776648934159, 5731.254936858182, 5772.797952071657, 5778.393268706725, 5786.450287222707, 5665.206871037975, 5667.858303542444, 5670.858228544319, 5671.893980673729, 5698.065496269507, 5915.166298447495, 5924.733386997509, 5946.43508866657, 5968.910466342922, 5980.531291850629, 4060.0, 4166.270902591974, 4190.51809041964, 4216.936745948875, 4223.704340696245, 5512.669239845462, 5659.547236221175, 5787.977355737722, 5811.27359080115, 5825.70871456434, 5469.288992430958, 5589.860253493695, 5602.523785478117, 5605.495505404533, 5606.831795046155, 5544.750486228048, 5572.582056345871, 5583.804566840141, 5607.130894711327, 5621.831345059655, 5336.95929293784, 5484.149956756709, 5544.667319960815, 5569.66582005081, 5583.385827559046, 5622.0, 5627.268455100811, 5633.577481688808, 5643.689597072201, 5653.830385088454, 5310.973445132904, 5508.944910550843, 5530.364008138955, 5533.501984821385, 5539.476643922953], "value": 4288.706933476841, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.1391776005272, 800.1958032177664, 809.5587904592004, 818.5661599352343, 821.5686764448664, 14949.103053816765, 15062.0, 15068.849311506881, 15117.773233401495, 15453.922730386346, 13912.373943172557, 14212.928935355334, 14241.501547445841, 14246.430142794301, 14276.143431394124, 709.7373971630504, 727.2037119354299, 829.1625458287143, 845.8181490979438, 855.6406309350087, 815.8980127484065, 816.4488969945263, 816.5549775372407, 816.6039470856659, 818.0633175014605, 718.9460790440738, 890.0698769785589, 890.8619164029586, 891.6789955615973, 891.7592250092471, 747.1445195251434, 869.7390782765177, 880.6477409036405, 889.4796544021755, 899.9325050621229, 654.4339146638172, 656.5207398599001, 658.1937127019411, 658.8945768677037, 659.8416380068749, 12463.875361246362, 12485.375731213493, 12505.0, 12562.0, 12604.558840440632, 13083.476660933551, 13302.201867887958, 13386.0, 13885.514007009706, 13986.0, 13151.86848131516, 13164.341782910817, 13248.47006119754, 13349.733005339936, 13613.319334033258, 4370.737755734666, 4426.867193984153, 4465.37484752135, 4523.547645235483, 4617.930731039037, 60806.391936080516, 60822.69588652073, 63032.68483657552, 63677.68161159211, 67790.66104669495, 11453.484593193327, 11506.367149806674, 11573.363465009505, 11646.184767066394, 11821.940890295493, 20529.79470205309, 20648.0, 20742.58514829695, 20837.583248334948, 21311.893440532698, 8280.337572994145, 8403.621837017226, 8520.829583408296, 8610.741677749553, 8671.0, 4126.793660316972, 4209.494860616745, 4224.936625950613, 4289.849855255114, 4350.71720338177, 3439.6216416194197, 3474.7046501047694, 3498.352804731133, 3524.2951409718157, 3556.1820781220463, 642.3159335307882, 648.7437462202404, 657.7599176300616, 660.6531570925303, 668.6222284409293, 617.7745123030062, 696.585531608692, 702.7294491620661, 709.2694524639629, 723.8660847743184, 9131.452112873249, 9308.394954327947, 9548.952255238679, 9649.179819715262, 9661.227101831837, 690.4234963805279, 711.4024219655514, 736.9557826530425, 763.5151678684076, 766.6166916541729, 4145.481814773153, 4453.576910193527, 4468.932966005513, 4582.243929751554, 4606.585407313358, 87530.0, 90988.0, 91266.54366728124, 92530.53734731283, 94239.52880235692, 81828.0, 82781.58609206915, 83134.58432707797, 83796.58101709574, 87205.0, 69990.0, 71878.28121718716, 72270.0, 73580.99999999892, 74108.62945685345, 8277.296429803535, 8364.205400486944, 8459.534725590152, 8605.612747426507, 8821.647134114564, 49647.50352496429, 49946.500534994186, 49980.75009625074, 50312.0, 50380.74809625928, 62716.0, 63428.36571634225, 64879.0, 65769.0, 66930.0, 11293.943530282624, 11682.357470339213, 11770.646880593597, 11784.410779461165, 11818.587360594796, 12533.87466125327, 12704.74590508203, 12922.935385323013, 12967.546135885199, 13131.737365252833, 11793.351365674971, 12243.20419172751, 12322.260664360167, 12419.19275247106, 13142.34288285601, 12173.573924912585, 12381.257124572554, 12607.43266552989, 12732.299723515296, 12806.167599106027, 12282.14025018276, 12852.807207892076, 13027.283499407624, 13344.399502022237, 13372.997025222952, 10321.225908057077, 10698.946505267424, 10729.9463502682, 10908.781824363627, 11311.717207069889, 10164.390136591828, 10552.5380406566, 10876.12990960737, 10928.890711092787, 11016.834747478633], "value": 7216.09350968499, "unit": "score"}], "name": "dromaeo_css", "value": 7332.959936329044, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 112.0, 111.0, 113.0, 113.0, 113.0, 111.0, 112.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 118.0, 166.0, 118.0, 120.0, 117.0, 119.0, 167.0, 117.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 159.0, 161.0, 161.0, 160.0, 160.0, 161.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 110.0, 75.0, 75.0, 79.0, 76.0, 96.0, 74.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 113.0, 81.0, 81.0, 82.0, 98.0, 82.0, 81.0, 112.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 86.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 49.0, 49.0, 51.0, 53.0, 50.0, 53.0, 49.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 58.0, 58.0, 58.0, 59.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 74.0, 74.0, 74.0, 74.0, 75.0, 74.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 128.0, 120.0, 124.0, 137.0, 119.0, 120.0, 119.0, 161.0, 136.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 151.0, 151.0, 156.0, 151.0, 154.0, 154.0, 156.0, 153.0, 151.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 61.0, 65.0, 66.0, 62.0, 61.0, 63.0, 61.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1446.9000000000003, "alertThreshold": 2.0}]} 09:52:13 INFO - Return code: 0 09:52:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:52:13 INFO - # TBPL SUCCESS # 09:52:13 INFO - Running post-action listener: _resource_record_post_action 09:52:13 INFO - [mozharness: 2016-12-22 17:52:13.253431Z] Finished run-tests step (success) 09:52:13 INFO - Running post-run listener: _resource_record_post_run 09:52:13 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 355659776; Read time: 12; Write time: 203484 09:52:13 INFO - TinderboxPrint: CPU usage
13.0% 09:52:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:52:13 INFO - TinderboxPrint: I/O write bytes / time
355,659,776 / 203,484 09:52:13 INFO - TinderboxPrint: CPU idle
8,280.5 (87.0%) 09:52:13 INFO - TinderboxPrint: CPU user
1,187.6 (12.5%) 09:52:13 INFO - TinderboxPrint: Swap in / out
0 / 0 09:52:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108064768; Read time: 0; Write time: 86084 09:52:13 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 247259136; Read time: 0; Write time: 117396 09:52:13 INFO - Running post-run listener: _upload_blobber_files 09:52:13 INFO - Blob upload gear active. 09:52:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:52:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:52:14 INFO - (blobuploader) - INFO - Open directory for files ... 09:52:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:52:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:52:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:17 INFO - (blobuploader) - INFO - Done attempting. 09:52:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:52:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:52:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:18 INFO - (blobuploader) - INFO - Done attempting. 09:52:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:52:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:52:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:18 INFO - (blobuploader) - INFO - Done attempting. 09:52:18 INFO - (blobuploader) - INFO - Iteration through files over. 09:52:18 INFO - Return code: 0 09:52:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:52:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:52:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9864bb8f03828466c99d39ffe363059fa172a20808abe9ff350ed2c2c5320c62a62ef3cc5912a9931b5e64f8db64db6ce66bdf3c4af4aa473e0b14e167b883b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e79050b11b6447c9b7fb8f3e357281d285aafab31025f77cc53064dd6f3eb46d2722351d8a5c0ceb6cb4d214af0dd6e6fb1f4934d0c855a77b3b017cb0667f20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3b0d1548f23f8a626e34ea938ac829b714266d8f6f8a31a43f4dd604495a8077f0669e0ff238568d0e4912183262d6303d1cf14b5771f68d893c0f98b069cab"} 09:52:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:52:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:52:18 INFO - Contents: 09:52:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9864bb8f03828466c99d39ffe363059fa172a20808abe9ff350ed2c2c5320c62a62ef3cc5912a9931b5e64f8db64db6ce66bdf3c4af4aa473e0b14e167b883b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e79050b11b6447c9b7fb8f3e357281d285aafab31025f77cc53064dd6f3eb46d2722351d8a5c0ceb6cb4d214af0dd6e6fb1f4934d0c855a77b3b017cb0667f20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3b0d1548f23f8a626e34ea938ac829b714266d8f6f8a31a43f4dd604495a8077f0669e0ff238568d0e4912183262d6303d1cf14b5771f68d893c0f98b069cab"} 09:52:18 INFO - Running post-run listener: copy_logs_to_upload_dir 09:52:18 INFO - Copying logs to upload dir... 09:52:18 INFO - mkdir: /builds/slave/test/build/upload/logs 09:52:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.487505 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-22 09:52:18.607055) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 09:52:18.610874) ========= 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=3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9864bb8f03828466c99d39ffe363059fa172a20808abe9ff350ed2c2c5320c62a62ef3cc5912a9931b5e64f8db64db6ce66bdf3c4af4aa473e0b14e167b883b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e79050b11b6447c9b7fb8f3e357281d285aafab31025f77cc53064dd6f3eb46d2722351d8a5c0ceb6cb4d214af0dd6e6fb1f4934d0c855a77b3b017cb0667f20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3b0d1548f23f8a626e34ea938ac829b714266d8f6f8a31a43f4dd604495a8077f0669e0ff238568d0e4912183262d6303d1cf14b5771f68d893c0f98b069cab"} build_url:https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/IgogvhV3S2STb8_0f7dSzg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9864bb8f03828466c99d39ffe363059fa172a20808abe9ff350ed2c2c5320c62a62ef3cc5912a9931b5e64f8db64db6ce66bdf3c4af4aa473e0b14e167b883b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e79050b11b6447c9b7fb8f3e357281d285aafab31025f77cc53064dd6f3eb46d2722351d8a5c0ceb6cb4d214af0dd6e6fb1f4934d0c855a77b3b017cb0667f20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d3b0d1548f23f8a626e34ea938ac829b714266d8f6f8a31a43f4dd604495a8077f0669e0ff238568d0e4912183262d6303d1cf14b5771f68d893c0f98b069cab"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 09:52:18.636273) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:52:18.636633) ========= 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=3836458cccd887f2d2de3cf1000001de-1482427900.136406-1564627105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:52:18.719411) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 09:52:18.719746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 09:52:18.720035) ========= ========= Total master_lag: 0.18 =========