builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1484239777.52 results: success (0) buildid: 20170112070319 builduid: e5c01d1d48724cec85de695dfd1a88cf revision: 7bd54083f7a1446f8df22310c6833a59aa2d96cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 08:49:37.519459) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 08:49:37.520109) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 08:49:37.520390) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 08:49:37.537489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 08:49:37.538152) ========= 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=826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-12 08:49:38-- 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% 111M=0s 2017-01-12 08:49:38 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 08:49:37.649991) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 08:49:37.650319) ========= 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=826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016704 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 08:49:37.700816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 08:49:37.701181) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7bd54083f7a1446f8df22310c6833a59aa2d96cd --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 7bd54083f7a1446f8df22310c6833a59aa2d96cd --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=826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-12 08:49:38,484 truncating revision to first 12 chars 2017-01-12 08:49:38,484 Setting DEBUG logging. 2017-01-12 08:49:38,484 attempt 1/10 2017-01-12 08:49:38,484 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7bd54083f7a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 08:49:38,786 unpacking tar archive at: mozilla-aurora-7bd54083f7a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638795 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 08:49:38.353639) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 08:49:38.353960) ========= script_repo_revision: 7bd54083f7a1446f8df22310c6833a59aa2d96cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 08:49:38.354382) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 08:49:38.354679) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 08:49:38.364665) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-12 08:49:38.365069) ========= /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=826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:49:39 INFO - MultiFileLogger online at 20170112 08:49:39 in /builds/slave/test 08:49:39 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 08:49:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:49:39 INFO - {'append_to_log': False, 08:49:39 INFO - 'base_work_dir': '/builds/slave/test', 08:49:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:49:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:49:39 INFO - 'branch': 'Mozilla-Aurora', 08:49:39 INFO - 'buildbot_json_path': 'buildprops.json', 08:49:39 INFO - 'config_files': ('talos/linux_config.py',), 08:49:39 INFO - 'default_actions': ('clobber', 08:49:39 INFO - 'read-buildbot-config', 08:49:39 INFO - 'download-and-extract', 08:49:39 INFO - 'populate-webroot', 08:49:39 INFO - 'create-virtualenv', 08:49:39 INFO - 'install', 08:49:39 INFO - 'run-tests'), 08:49:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:49:39 INFO - 'download_minidump_stackwalk': True, 08:49:39 INFO - 'download_symbols': 'ondemand', 08:49:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:49:39 INFO - 'tooltool.py': '/tools/tooltool.py', 08:49:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:49:39 INFO - '/tools/misc-python/virtualenv.py')}, 08:49:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:49:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:49:39 INFO - 'installer_path': 'installer.exe', 08:49:39 INFO - 'log_level': 'info', 08:49:39 INFO - 'log_name': 'talos', 08:49:39 INFO - 'log_to_console': True, 08:49:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:49:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:49:39 INFO - 'opt_config_files': (), 08:49:39 INFO - 'pip_index': False, 08:49:39 INFO - 'sps_profile': False, 08:49:39 INFO - 'sps_profile_interval': 0, 08:49:39 INFO - 'suite': 'dromaeojs', 08:49:39 INFO - 'system_bits': '32', 08:49:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:49:39 INFO - 'title': 'talos-linux64-ix-052', 08:49:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:49:39 INFO - 'use_talos_json': True, 08:49:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:49:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:49:39 INFO - 'work_dir': 'build'} 08:49:39 INFO - [mozharness: 2017-01-12 16:49:39.254208Z] Running clobber step. 08:49:39 INFO - Running pre-action listener: _resource_record_pre_action 08:49:39 INFO - Running main action method: clobber 08:49:39 INFO - rmtree: /builds/slave/test/build 08:49:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:49:40 INFO - Running post-action listener: _resource_record_post_action 08:49:40 INFO - [mozharness: 2017-01-12 16:49:40.225166Z] Finished clobber step (success) 08:49:40 INFO - [mozharness: 2017-01-12 16:49:40.225263Z] Running read-buildbot-config step. 08:49:40 INFO - Running pre-action listener: _resource_record_pre_action 08:49:40 INFO - Running main action method: read_buildbot_config 08:49:40 INFO - Using buildbot properties: 08:49:40 INFO - { 08:49:40 INFO - "project": "", 08:49:40 INFO - "product": "firefox", 08:49:40 INFO - "script_repo_revision": "production", 08:49:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:49:40 INFO - "repository": "", 08:49:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:49:40 INFO - "buildid": "20170112070319", 08:49:40 INFO - "pgo_build": "True", 08:49:40 INFO - "basedir": "/builds/slave/test", 08:49:40 INFO - "buildnumber": 733, 08:49:40 INFO - "slavename": "talos-linux64-ix-052", 08:49:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:49:40 INFO - "platform": "ubuntu64_hw", 08:49:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:49:40 INFO - "branch": "mozilla-aurora", 08:49:40 INFO - "repo_path": "releases/mozilla-aurora", 08:49:40 INFO - "revision": "7bd54083f7a1446f8df22310c6833a59aa2d96cd", 08:49:40 INFO - "stage_platform": "linux64-pgo", 08:49:40 INFO - "builduid": "e5c01d1d48724cec85de695dfd1a88cf", 08:49:40 INFO - "slavebuilddir": "test" 08:49:40 INFO - } 08:49:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:49:40 INFO - Running post-action listener: _resource_record_post_action 08:49:40 INFO - [mozharness: 2017-01-12 16:49:40.227687Z] Finished read-buildbot-config step (success) 08:49:40 INFO - [mozharness: 2017-01-12 16:49:40.227776Z] Running download-and-extract step. 08:49:40 INFO - Running pre-action listener: _resource_record_pre_action 08:49:40 INFO - Running main action method: download_and_extract 08:49:40 INFO - mkdir: /builds/slave/test/build/tests 08:49:40 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')]} 08:49:40 INFO - trying https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:49:40 INFO - Downloading https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/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 08:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/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 08:49:40 INFO - Downloaded 1361 bytes. 08:49:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:49:40 INFO - Using the following test package requirements: 08:49:40 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:49:40 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:49:40 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:49:40 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:40 INFO - u'jsshell-linux-x86_64.zip'], 08:49:40 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:49:40 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:49:40 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:49:40 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:49:40 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:49:40 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:49:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:49:40 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:49:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:49:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:49:40 INFO - Fetch https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:49:41 INFO - Http code: 200 08:49:41 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 08:49:41 INFO - x-amz-cf-id: XQzYMiB8S_xpXhoQPJmaS0NJuoZjcWEpOd6MifErrHzPgoi0CHdWRw== 08:49:41 INFO - x-amz-version-id: _451xz6BCi6PnFPeGG6wA_kehwpftnHT 08:49:41 INFO - Expected file size: 21948693 08:49:41 INFO - Obtained file size: 21948693 08:49:45 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 08:49:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:49:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:49:45 INFO - Fetch https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:49:46 INFO - Http code: 200 08:49:46 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 08:49:46 INFO - x-amz-cf-id: xngDQ7R6W_HG_SIZnJq36wSXXWEOLJkDMFnvZY8Z06wegNwVRWgfmQ== 08:49:46 INFO - x-amz-version-id: _451xz6BCi6PnFPeGG6wA_kehwpftnHT 08:49:46 INFO - Expected file size: 21948693 08:49:46 INFO - Obtained file size: 21948693 08:49:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:49:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:49:51 INFO - Fetch https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:49:51 INFO - Http code: 200 08:49:51 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 08:49:51 INFO - x-amz-cf-id: 6l1oW9n78ukyxT-ayvVxTipn7lJSAhjRKQvaHeqOXuBjO57fiU36Og== 08:49:51 INFO - x-amz-version-id: ii22k3uh0hVcA8UsfvujjPRrpOLYaayN 08:49:51 INFO - Expected file size: 14409038 08:49:51 INFO - Obtained file size: 14409038 08:49:51 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')]} 08:49:51 INFO - trying https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:49:51 INFO - Downloading https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/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 08:49:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/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 08:49:53 INFO - Downloaded 64127907 bytes. 08:49:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:49:53 INFO - mkdir: /builds/slave/test/properties 08:49:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:49:53 INFO - Writing to file /builds/slave/test/properties/build_url 08:49:53 INFO - Contents: 08:49:53 INFO - build_url:https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:49:54 INFO - Running post-action listener: _resource_record_post_action 08:49:54 INFO - Running post-action listener: set_extra_try_arguments 08:49:54 INFO - [mozharness: 2017-01-12 16:49:54.051916Z] Finished download-and-extract step (success) 08:49:54 INFO - [mozharness: 2017-01-12 16:49:54.052143Z] Running populate-webroot step. 08:49:54 INFO - Running pre-action listener: _resource_record_pre_action 08:49:54 INFO - Running main action method: populate_webroot 08:49:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:49:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:49:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:49:54 INFO - '--tppagecycles', 08:49:54 INFO - '7'], 08:49:54 INFO - 'tests': ['tsvgm']}}, 08:49:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:49:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:49:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:49:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:49:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:49:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:49:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:54 INFO - 'talos_options': ['--disable-e10s'], 08:49:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:54 INFO - 'talos_options': ['--disable-e10s'], 08:49:54 INFO - 'tests': ['damp', 'tps']}, 08:49:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:54 INFO - 'tests': ['damp', 'tps']}, 08:49:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:49:54 INFO - 'tests': ['dromaeo_dom']}, 08:49:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:49:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:49:54 INFO - 'tests': ['basic_compositor_video']}, 08:49:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:49:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:49:54 INFO - 'tests': ['a11yr', 08:49:54 INFO - 'ts_paint', 08:49:54 INFO - 'tpaint', 08:49:54 INFO - 'sessionrestore', 08:49:54 INFO - 'sessionrestore_no_auto_restore', 08:49:54 INFO - 'tabpaint']}, 08:49:54 INFO - 'other-e10s': {'tests': ['a11yr', 08:49:54 INFO - 'ts_paint', 08:49:54 INFO - 'tpaint', 08:49:54 INFO - 'sessionrestore', 08:49:54 INFO - 'sessionrestore_no_auto_restore', 08:49:54 INFO - 'tabpaint']}, 08:49:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:49:54 INFO - 'ts_paint', 08:49:54 INFO - 'tpaint', 08:49:54 INFO - 'sessionrestore', 08:49:54 INFO - 'sessionrestore_no_auto_restore', 08:49:54 INFO - 'tabpaint']}, 08:49:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:49:54 INFO - 'ts_paint', 08:49:54 INFO - 'tpaint', 08:49:54 INFO - 'sessionrestore', 08:49:54 INFO - 'sessionrestore_no_auto_restore', 08:49:54 INFO - 'tabpaint']}, 08:49:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:49:54 INFO - 'tests': ['a11yr', 08:49:54 INFO - 'ts_paint', 08:49:54 INFO - 'tpaint', 08:49:54 INFO - 'sessionrestore', 08:49:54 INFO - 'sessionrestore_no_auto_restore', 08:49:54 INFO - 'tabpaint']}, 08:49:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:49:54 INFO - 'tests': ['a11yr', 08:49:54 INFO - 'ts_paint', 08:49:54 INFO - 'tpaint', 08:49:54 INFO - 'sessionrestore', 08:49:54 INFO - 'sessionrestore_no_auto_restore', 08:49:54 INFO - 'tabpaint']}, 08:49:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:49:54 INFO - 'tests': ['tsvgx', 08:49:54 INFO - 'tsvgr_opacity', 08:49:54 INFO - 'tart', 08:49:54 INFO - 'tscrollx', 08:49:54 INFO - 'cart']}, 08:49:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:49:54 INFO - 'tsvgr_opacity', 08:49:54 INFO - 'tart', 08:49:54 INFO - 'tscrollx', 08:49:54 INFO - 'cart']}, 08:49:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:54 INFO - 'talos_options': ['--disable-e10s'], 08:49:54 INFO - 'tests': ['tp5o']}, 08:49:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:54 INFO - 'tests': ['tp5o']}, 08:49:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:54 INFO - 'talos_options': ['--disable-e10s', 08:49:54 INFO - '--xperf_path', 08:49:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:54 INFO - 'tests': ['tp5n']}, 08:49:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:54 INFO - 'talos_options': ['--xperf_path', 08:49:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:54 INFO - 'tests': ['tp5n']}}, 08:49:54 INFO - 'talos.zip': {'path': '', 08:49:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:49:54 INFO - Running post-action listener: _resource_record_post_action 08:49:54 INFO - [mozharness: 2017-01-12 16:49:54.069715Z] Finished populate-webroot step (success) 08:49:54 INFO - [mozharness: 2017-01-12 16:49:54.069802Z] Running create-virtualenv step. 08:49:54 INFO - Running pre-action listener: _resource_record_pre_action 08:49:54 INFO - Running main action method: create_virtualenv 08:49:54 INFO - Creating virtualenv /builds/slave/test/build/venv 08:49:54 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 08:49:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:49:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:49:54 INFO - Using real prefix '/usr' 08:49:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:49:54 INFO - Installing distribute.............................................................................................................................................................................................done. 08:49:56 INFO - Installing pip.................done. 08:49:56 INFO - Return code: 0 08:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:49:56 INFO - Reading from file tmpfile_stdout 08:49:56 INFO - Output received: 08:49:56 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) 08:49:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:49:56 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')]} 08:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:56 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')]} 08:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:56 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 0x7f7a666bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e3f60>, '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 0x26e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e51d0>, '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': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', '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 08:49:56 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 08:49:56 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 08:49:56 INFO - Using env: {'DISPLAY': ':0', 08:49:56 INFO - 'HOME': '/home/cltbld', 08:49:56 INFO - 'LANG': 'en_US.UTF-8', 08:49:56 INFO - 'LANGUAGE': 'en_US:en', 08:49:56 INFO - 'LOGNAME': 'cltbld', 08:49:56 INFO - 'MAIL': '/var/mail/cltbld', 08:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:56 INFO - 'MOZ_NO_REMOTE': '1', 08:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:56 INFO - 'NO_EM_RESTART': '1', 08:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:56 INFO - 'PWD': '/builds/slave/test', 08:49:56 INFO - 'SHELL': '/bin/bash', 08:49:56 INFO - 'SHLVL': '1', 08:49:56 INFO - 'TERM': 'linux', 08:49:56 INFO - 'TMOUT': '86400', 08:49:56 INFO - 'USER': 'cltbld', 08:49:56 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', 08:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:56 INFO - '_': '/tools/buildbot/bin/python'} 08:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:57 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 08:49:57 INFO - Cleaning up... 08:49:57 INFO - Return code: 0 08:49:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7a666bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e3f60>, '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 0x26e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e51d0>, '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': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', '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 08:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:49:57 INFO - Using env: {'DISPLAY': ':0', 08:49:57 INFO - 'HOME': '/home/cltbld', 08:49:57 INFO - 'LANG': 'en_US.UTF-8', 08:49:57 INFO - 'LANGUAGE': 'en_US:en', 08:49:57 INFO - 'LOGNAME': 'cltbld', 08:49:57 INFO - 'MAIL': '/var/mail/cltbld', 08:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:57 INFO - 'MOZ_NO_REMOTE': '1', 08:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:57 INFO - 'NO_EM_RESTART': '1', 08:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:57 INFO - 'PWD': '/builds/slave/test', 08:49:57 INFO - 'SHELL': '/bin/bash', 08:49:57 INFO - 'SHLVL': '1', 08:49:57 INFO - 'TERM': 'linux', 08:49:57 INFO - 'TMOUT': '86400', 08:49:57 INFO - 'USER': 'cltbld', 08:49:57 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', 08:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:57 INFO - '_': '/tools/buildbot/bin/python'} 08:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:57 INFO - Downloading/unpacking psutil>=3.1.1 08:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:49:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:59 INFO - Installing collected packages: psutil 08:49:59 INFO - Running setup.py install for psutil 08:49:59 INFO - building 'psutil._psutil_linux' extension 08:49:59 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 08:49:59 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 08:49:59 INFO - building 'psutil._psutil_posix' extension 08:49:59 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 08:49:59 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 08:49:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:59 INFO - Successfully installed psutil 08:49:59 INFO - Cleaning up... 08:49:59 INFO - Return code: 0 08:49:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:49:59 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')]} 08:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:59 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')]} 08:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a666bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e3f60>, '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 0x26e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e51d0>, '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': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', '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 08:50: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:50: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 mozsystemmonitor==0.3 08:50:00 INFO - Using env: {'DISPLAY': ':0', 08:50:00 INFO - 'HOME': '/home/cltbld', 08:50:00 INFO - 'LANG': 'en_US.UTF-8', 08:50:00 INFO - 'LANGUAGE': 'en_US:en', 08:50:00 INFO - 'LOGNAME': 'cltbld', 08:50:00 INFO - 'MAIL': '/var/mail/cltbld', 08:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:00 INFO - 'MOZ_NO_REMOTE': '1', 08:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:00 INFO - 'NO_EM_RESTART': '1', 08:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:00 INFO - 'PWD': '/builds/slave/test', 08:50:00 INFO - 'SHELL': '/bin/bash', 08:50:00 INFO - 'SHLVL': '1', 08:50:00 INFO - 'TERM': 'linux', 08:50:00 INFO - 'TMOUT': '86400', 08:50:00 INFO - 'USER': 'cltbld', 08:50:00 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', 08:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:00 INFO - '_': '/tools/buildbot/bin/python'} 08:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:50:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:50:02 INFO - Installing collected packages: mozsystemmonitor 08:50:02 INFO - Running setup.py install for mozsystemmonitor 08:50:02 INFO - Successfully installed mozsystemmonitor 08:50:02 INFO - Cleaning up... 08:50:02 INFO - Return code: 0 08:50:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7a666bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e3f60>, '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 0x26e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e51d0>, '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': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', '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 08:50:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:50:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:50:02 INFO - Using env: {'DISPLAY': ':0', 08:50:02 INFO - 'HOME': '/home/cltbld', 08:50:02 INFO - 'LANG': 'en_US.UTF-8', 08:50:02 INFO - 'LANGUAGE': 'en_US:en', 08:50:02 INFO - 'LOGNAME': 'cltbld', 08:50:02 INFO - 'MAIL': '/var/mail/cltbld', 08:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:02 INFO - 'MOZ_NO_REMOTE': '1', 08:50:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:02 INFO - 'NO_EM_RESTART': '1', 08:50:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:02 INFO - 'PWD': '/builds/slave/test', 08:50:02 INFO - 'SHELL': '/bin/bash', 08:50:02 INFO - 'SHLVL': '1', 08:50:02 INFO - 'TERM': 'linux', 08:50:02 INFO - 'TMOUT': '86400', 08:50:02 INFO - 'USER': 'cltbld', 08:50:02 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', 08:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:02 INFO - '_': '/tools/buildbot/bin/python'} 08:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:02 INFO - Downloading/unpacking jsonschema==2.5.1 08:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:50:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:50:04 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 08:50:04 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 08:50:04 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 08:50:04 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 08:50:04 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 08:50:04 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 08:50:04 INFO - Downloading functools32-3.2.3-2.tar.gz 08:50:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:50:05 INFO - warning: no files found matching '*.txt' 08:50:05 INFO - no previously-included directories found matching 'build' 08:50:05 INFO - no previously-included directories found matching 'dist' 08:50:05 INFO - no previously-included directories found matching '.git*' 08:50:05 INFO - Installing collected packages: jsonschema, functools32 08:50:05 INFO - Running setup.py install for functools32 08:50:05 INFO - warning: no files found matching '*.txt' 08:50:05 INFO - no previously-included directories found matching 'build' 08:50:05 INFO - no previously-included directories found matching 'dist' 08:50:05 INFO - no previously-included directories found matching '.git*' 08:50:05 INFO - Successfully installed jsonschema functools32 08:50:05 INFO - Cleaning up... 08:50:05 INFO - Return code: 0 08:50:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7a666bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e3f60>, '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 0x26e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e51d0>, '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': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', '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 08:50:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:50:05 INFO - Using env: {'DISPLAY': ':0', 08:50:05 INFO - 'HOME': '/home/cltbld', 08:50:05 INFO - 'LANG': 'en_US.UTF-8', 08:50:05 INFO - 'LANGUAGE': 'en_US:en', 08:50:05 INFO - 'LOGNAME': 'cltbld', 08:50:05 INFO - 'MAIL': '/var/mail/cltbld', 08:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:05 INFO - 'MOZ_NO_REMOTE': '1', 08:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:05 INFO - 'NO_EM_RESTART': '1', 08:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:05 INFO - 'PWD': '/builds/slave/test', 08:50:05 INFO - 'SHELL': '/bin/bash', 08:50:05 INFO - 'SHLVL': '1', 08:50:05 INFO - 'TERM': 'linux', 08:50:05 INFO - 'TMOUT': '86400', 08:50:05 INFO - 'USER': 'cltbld', 08:50:05 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', 08:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:05 INFO - '_': '/tools/buildbot/bin/python'} 08:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:50:05 INFO - Cleaning up... 08:50:05 INFO - Return code: 0 08:50:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7a666bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e3f60>, '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 0x26e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e51d0>, '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': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', '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 08:50:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:50:05 INFO - Using env: {'DISPLAY': ':0', 08:50:05 INFO - 'HOME': '/home/cltbld', 08:50:05 INFO - 'LANG': 'en_US.UTF-8', 08:50:05 INFO - 'LANGUAGE': 'en_US:en', 08:50:05 INFO - 'LOGNAME': 'cltbld', 08:50:05 INFO - 'MAIL': '/var/mail/cltbld', 08:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:05 INFO - 'MOZ_NO_REMOTE': '1', 08:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:05 INFO - 'NO_EM_RESTART': '1', 08:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:05 INFO - 'PWD': '/builds/slave/test', 08:50:05 INFO - 'SHELL': '/bin/bash', 08:50:05 INFO - 'SHLVL': '1', 08:50:05 INFO - 'TERM': 'linux', 08:50:05 INFO - 'TMOUT': '86400', 08:50:05 INFO - 'USER': 'cltbld', 08:50:05 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', 08:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:05 INFO - '_': '/tools/buildbot/bin/python'} 08:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:05 INFO - Downloading/unpacking blobuploader==1.2.4 08:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:07 INFO - Downloading blobuploader-1.2.4.tar.gz 08:50:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:50:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:50:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:08 INFO - Downloading docopt-0.6.1.tar.gz 08:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:50:08 INFO - Installing collected packages: blobuploader, requests, docopt 08:50:08 INFO - Running setup.py install for blobuploader 08:50:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:50:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:50:08 INFO - Running setup.py install for requests 08:50:08 INFO - Running setup.py install for docopt 08:50:09 INFO - Successfully installed blobuploader requests docopt 08:50:09 INFO - Cleaning up... 08:50:09 INFO - Return code: 0 08:50:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:09 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 0x7f7a666bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e3f60>, '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 0x26e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e51d0>, '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': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', '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 08:50:09 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 08:50:09 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 08:50:09 INFO - Using env: {'DISPLAY': ':0', 08:50:09 INFO - 'HOME': '/home/cltbld', 08:50:09 INFO - 'LANG': 'en_US.UTF-8', 08:50:09 INFO - 'LANGUAGE': 'en_US:en', 08:50:09 INFO - 'LOGNAME': 'cltbld', 08:50:09 INFO - 'MAIL': '/var/mail/cltbld', 08:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:09 INFO - 'MOZ_NO_REMOTE': '1', 08:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:09 INFO - 'NO_EM_RESTART': '1', 08:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:09 INFO - 'PWD': '/builds/slave/test', 08:50:09 INFO - 'SHELL': '/bin/bash', 08:50:09 INFO - 'SHLVL': '1', 08:50:09 INFO - 'TERM': 'linux', 08:50:09 INFO - 'TMOUT': '86400', 08:50:09 INFO - 'USER': 'cltbld', 08:50:09 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', 08:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:09 INFO - '_': '/tools/buildbot/bin/python'} 08:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:09 INFO - Running setup.py (path:/tmp/pip-5Ypb8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:09 INFO - Running setup.py (path:/tmp/pip-q9wM9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:09 INFO - Running setup.py (path:/tmp/pip-3Z6HwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:09 INFO - Running setup.py (path:/tmp/pip-AowV7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:09 INFO - Running setup.py (path:/tmp/pip-wv6Z1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:09 INFO - Running setup.py (path:/tmp/pip-LkOMA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:09 INFO - Running setup.py (path:/tmp/pip-LC1Tyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:09 INFO - Running setup.py (path:/tmp/pip-Ka5Nja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:09 INFO - Running setup.py (path:/tmp/pip-8Mz_rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:10 INFO - Running setup.py (path:/tmp/pip-biFpv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:10 INFO - Running setup.py (path:/tmp/pip-1ozM3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:10 INFO - Running setup.py (path:/tmp/pip-8PbXml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:10 INFO - Running setup.py (path:/tmp/pip-bD9B1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:10 INFO - Running setup.py (path:/tmp/pip-1mattK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:10 INFO - Running setup.py (path:/tmp/pip-ugVncA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:10 INFO - Running setup.py (path:/tmp/pip-Lt7RO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:10 INFO - Running setup.py (path:/tmp/pip-B4nXBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:50:10 INFO - Running setup.py install for manifestparser 08:50:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:50:10 INFO - Running setup.py install for mozcrash 08:50:10 INFO - Running setup.py install for mozdebug 08:50:10 INFO - Running setup.py install for mozdevice 08:50:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:50:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:50:11 INFO - Running setup.py install for mozfile 08:50:11 INFO - Running setup.py install for mozhttpd 08:50:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:50:11 INFO - Running setup.py install for mozinfo 08:50:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:50:11 INFO - Running setup.py install for mozInstall 08:50:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:50:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:50:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:50:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:50:11 INFO - Running setup.py install for mozleak 08:50:11 INFO - Running setup.py install for mozlog 08:50:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:50:11 INFO - Running setup.py install for moznetwork 08:50:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:50:11 INFO - Running setup.py install for mozprocess 08:50:11 INFO - Running setup.py install for mozprofile 08:50:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:50:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:50:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:50:11 INFO - Running setup.py install for mozrunner 08:50:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:50:12 INFO - Running setup.py install for mozscreenshot 08:50:12 INFO - Running setup.py install for moztest 08:50:12 INFO - Running setup.py install for mozversion 08:50:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:50:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:50:12 INFO - Cleaning up... 08:50:12 INFO - Return code: 0 08:50:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:12 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 0x7f7a666bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e3f60>, '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 0x26e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e51d0>, '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': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', '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 08:50:12 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 08:50:12 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 08:50:12 INFO - Using env: {'DISPLAY': ':0', 08:50:12 INFO - 'HOME': '/home/cltbld', 08:50:12 INFO - 'LANG': 'en_US.UTF-8', 08:50:12 INFO - 'LANGUAGE': 'en_US:en', 08:50:12 INFO - 'LOGNAME': 'cltbld', 08:50:12 INFO - 'MAIL': '/var/mail/cltbld', 08:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:12 INFO - 'MOZ_NO_REMOTE': '1', 08:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:12 INFO - 'NO_EM_RESTART': '1', 08:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:12 INFO - 'PWD': '/builds/slave/test', 08:50:12 INFO - 'SHELL': '/bin/bash', 08:50:12 INFO - 'SHLVL': '1', 08:50:12 INFO - 'TERM': 'linux', 08:50:12 INFO - 'TMOUT': '86400', 08:50:12 INFO - 'USER': 'cltbld', 08:50:12 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', 08:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:12 INFO - '_': '/tools/buildbot/bin/python'} 08:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:12 INFO - Running setup.py (path:/tmp/pip-mkuVup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:12 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)) 08:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:12 INFO - Running setup.py (path:/tmp/pip-5wWLXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:12 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)) 08:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:12 INFO - Running setup.py (path:/tmp/pip-QBlUO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:12 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)) 08:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:12 INFO - Running setup.py (path:/tmp/pip-0Vd5fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:12 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)) 08:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:12 INFO - Running setup.py (path:/tmp/pip-yL1FYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:12 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)) 08:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:12 INFO - Running setup.py (path:/tmp/pip-m6jT_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:13 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)) 08:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:13 INFO - Running setup.py (path:/tmp/pip-l3oHKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:13 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)) 08:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:13 INFO - Running setup.py (path:/tmp/pip-SQpcf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:13 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)) 08:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:13 INFO - Running setup.py (path:/tmp/pip-wQYpRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:13 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)) 08:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:13 INFO - Running setup.py (path:/tmp/pip-xJQWFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:13 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)) 08:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:13 INFO - Running setup.py (path:/tmp/pip-K_a8cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:13 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)) 08:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:13 INFO - Running setup.py (path:/tmp/pip-kMtQQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:13 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)) 08:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:13 INFO - Running setup.py (path:/tmp/pip-IknpmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:13 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)) 08:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:13 INFO - Running setup.py (path:/tmp/pip-kdjz2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:13 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)) 08:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:13 INFO - Running setup.py (path:/tmp/pip-NQc7mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:13 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)) 08:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:13 INFO - Running setup.py (path:/tmp/pip-pjZd6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:13 INFO - Running setup.py (path:/tmp/pip-Jf2v_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:13 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)) 08:50:13 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)) 08:50:13 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)) 08:50:13 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)) 08:50:13 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)) 08:50:13 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)) 08:50:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:15 INFO - Downloading blessings-1.6.tar.gz 08:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:50:15 INFO - Installing collected packages: blessings 08:50:15 INFO - Running setup.py install for blessings 08:50:16 INFO - Successfully installed blessings 08:50:16 INFO - Cleaning up... 08:50:16 INFO - Return code: 0 08:50:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:50:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:16 INFO - Reading from file tmpfile_stdout 08:50:16 INFO - Current package versions: 08:50:16 INFO - argparse == 1.2.1 08:50:16 INFO - blessings == 1.6 08:50:16 INFO - blobuploader == 1.2.4 08:50:16 INFO - docopt == 0.6.1 08:50:16 INFO - functools32 == 3.2.3-2 08:50:16 INFO - jsonschema == 2.5.1 08:50:16 INFO - manifestparser == 1.1 08:50:16 INFO - mozInstall == 1.12 08:50:16 INFO - mozcrash == 1.0 08:50:16 INFO - mozdebug == 0.1 08:50:16 INFO - mozdevice == 0.48 08:50:16 INFO - mozfile == 1.2 08:50:16 INFO - mozhttpd == 0.7 08:50:16 INFO - mozinfo == 0.9 08:50:16 INFO - mozleak == 0.1 08:50:16 INFO - mozlog == 3.4 08:50:16 INFO - moznetwork == 0.27 08:50:16 INFO - mozprocess == 0.23 08:50:16 INFO - mozprofile == 0.28 08:50:16 INFO - mozrunner == 6.13 08:50:16 INFO - mozscreenshot == 0.1 08:50:16 INFO - mozsystemmonitor == 0.3 08:50:16 INFO - moztest == 0.8 08:50:16 INFO - mozversion == 1.4 08:50:16 INFO - psutil == 3.1.1 08:50:16 INFO - requests == 1.2.3 08:50:16 INFO - wsgiref == 0.1.2 08:50:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:16 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 0x7f7a666bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e3f60>, '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 0x26e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e51d0>, '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': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', '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 08:50:16 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 08:50:16 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 08:50:16 INFO - Using env: {'DISPLAY': ':0', 08:50:16 INFO - 'HOME': '/home/cltbld', 08:50:16 INFO - 'LANG': 'en_US.UTF-8', 08:50:16 INFO - 'LANGUAGE': 'en_US:en', 08:50:16 INFO - 'LOGNAME': 'cltbld', 08:50:16 INFO - 'MAIL': '/var/mail/cltbld', 08:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:16 INFO - 'MOZ_NO_REMOTE': '1', 08:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:16 INFO - 'NO_EM_RESTART': '1', 08:50:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:16 INFO - 'PWD': '/builds/slave/test', 08:50:16 INFO - 'SHELL': '/bin/bash', 08:50:16 INFO - 'SHLVL': '1', 08:50:16 INFO - 'TERM': 'linux', 08:50:16 INFO - 'TMOUT': '86400', 08:50:16 INFO - 'USER': 'cltbld', 08:50:16 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', 08:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:16 INFO - '_': '/tools/buildbot/bin/python'} 08:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:16 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)) 08:50:16 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)) 08:50:16 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)) 08:50:16 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)) 08:50:16 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)) 08:50:16 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)) 08:50:16 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)) 08:50:16 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)) 08:50:16 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)) 08:50:16 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)) 08:50:16 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)) 08:50:16 INFO - Cleaning up... 08:50:16 INFO - Return code: 0 08:50:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:16 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 0x7f7a666bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e3f60>, '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 0x26e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e51d0>, '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': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', '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 08:50:16 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 08:50:16 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 08:50:16 INFO - Using env: {'DISPLAY': ':0', 08:50:16 INFO - 'HOME': '/home/cltbld', 08:50:16 INFO - 'LANG': 'en_US.UTF-8', 08:50:16 INFO - 'LANGUAGE': 'en_US:en', 08:50:16 INFO - 'LOGNAME': 'cltbld', 08:50:16 INFO - 'MAIL': '/var/mail/cltbld', 08:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:16 INFO - 'MOZ_NO_REMOTE': '1', 08:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:16 INFO - 'NO_EM_RESTART': '1', 08:50:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:16 INFO - 'PWD': '/builds/slave/test', 08:50:16 INFO - 'SHELL': '/bin/bash', 08:50:16 INFO - 'SHLVL': '1', 08:50:16 INFO - 'TERM': 'linux', 08:50:16 INFO - 'TMOUT': '86400', 08:50:16 INFO - 'USER': 'cltbld', 08:50:16 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', 08:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:16 INFO - '_': '/tools/buildbot/bin/python'} 08:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:50:16 INFO - Cleaning up... 08:50:16 INFO - Return code: 0 08:50:16 INFO - Running post-action listener: _resource_record_post_action 08:50:16 INFO - Running post-action listener: _start_resource_monitoring 08:50:16 INFO - Starting resource monitoring. 08:50:16 INFO - [mozharness: 2017-01-12 16:50:16.996487Z] Finished create-virtualenv step (success) 08:50:16 INFO - [mozharness: 2017-01-12 16:50:16.996977Z] Running install step. 08:50:16 INFO - Running pre-action listener: _resource_record_pre_action 08:50:16 INFO - Running main action method: install 08:50:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:17 INFO - Reading from file tmpfile_stdout 08:50:17 INFO - Detecting whether we're running mozinstall >=1.0... 08:50:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:50:17 INFO - Reading from file tmpfile_stdout 08:50:17 INFO - Output received: 08:50:17 INFO - Usage: mozinstall [options] installer 08:50:17 INFO - Options: 08:50:17 INFO - -h, --help show this help message and exit 08:50:17 INFO - -d DEST, --destination=DEST 08:50:17 INFO - Directory to install application into. [default: 08:50:17 INFO - "/builds/slave/test"] 08:50:17 INFO - --app=APP Application being installed. [default: firefox] 08:50:17 INFO - mkdir: /builds/slave/test/build/application 08:50:17 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'] 08:50:17 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 08:50:33 INFO - Reading from file tmpfile_stdout 08:50:33 INFO - Output received: 08:50:33 INFO - /builds/slave/test/build/application/firefox/firefox 08:50:33 INFO - Running post-action listener: _resource_record_post_action 08:50:33 INFO - [mozharness: 2017-01-12 16:50:33.284643Z] Finished install step (success) 08:50:33 INFO - [mozharness: 2017-01-12 16:50:33.284886Z] Running run-tests step. 08:50:33 INFO - Running pre-action listener: _resource_record_pre_action 08:50:33 INFO - Running main action method: run_tests 08:50:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:50:33 INFO - Python 2.7.3 08:50:33 INFO - Return code: 0 08:50:33 INFO - grabbing minidump binary from tooltool 08:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:33 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 0x26e3f60>, '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 0x26e4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:50:33 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 08:50:33 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 08:50:33 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 08:50:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:50:33 INFO - Return code: 0 08:50:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:50:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:50:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:50:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:50:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:50:33 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/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 08:50:33 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/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 08:50:33 INFO - Using env: {'DISPLAY': ':0', 08:50:33 INFO - 'HOME': '/home/cltbld', 08:50:33 INFO - 'LANG': 'en_US.UTF-8', 08:50:33 INFO - 'LANGUAGE': 'en_US:en', 08:50:33 INFO - 'LOGNAME': 'cltbld', 08:50:33 INFO - 'MAIL': '/var/mail/cltbld', 08:50:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:50:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:33 INFO - 'MOZ_NO_REMOTE': '1', 08:50:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:33 INFO - 'NO_EM_RESTART': '1', 08:50:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:33 INFO - 'PWD': '/builds/slave/test', 08:50:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:50:33 INFO - 'SHELL': '/bin/bash', 08:50:33 INFO - 'SHLVL': '1', 08:50:33 INFO - 'TERM': 'linux', 08:50:33 INFO - 'TMOUT': '86400', 08:50:33 INFO - 'USER': 'cltbld', 08:50:33 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441', 08:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:33 INFO - '_': '/tools/buildbot/bin/python'} 08:50:33 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/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 08:50:33 INFO - mozversion application_buildid: 20170112070319 08:50:33 INFO - mozversion application_changeset: 7bd54083f7a1446f8df22310c6833a59aa2d96cd 08:50:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:50:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:50:33 INFO - mozversion application_name: Firefox 08:50:33 INFO - mozversion application_remotingname: firefox-dev 08:50:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:50:33 INFO - mozversion application_vendor: Mozilla 08:50:33 INFO - mozversion application_version: 52.0a2 08:50:33 INFO - mozversion platform_buildid: 20170112070319 08:50:33 INFO - mozversion platform_changeset: 7bd54083f7a1446f8df22310c6833a59aa2d96cd 08:50:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:50:33 INFO - mozversion platform_version: 52.0a2 08:50:33 INFO - using testdate: 1484239833 08:50:33 INFO - actual date: 1484239833 08:50:33 INFO - starting webserver on 'localhost:36158' 08:50:33 INFO - SUITE-START | Running 2 tests 08:50:33 INFO - TEST-START | dromaeo_css 08:50:33 INFO - operating with platform_type : linux_ 08:50:33 INFO - Initialising browser for dromaeo_css test... 08:50:33 INFO - TEST-INFO | started process 29505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzaotvG/profile http://localhost:36158/getInfo.html) 08:50:37 INFO - PROCESS | 29505 | __metrics Screen width/height:1600/1200 08:50:37 INFO - PROCESS | 29505 | colorDepth:24 08:50:37 INFO - PROCESS | 29505 | Browser inner width/height: 1024/697 08:50:37 INFO - PROCESS | 29505 | __metrics 08:50:37 INFO - PROCESS | 29505 | 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" 08:50:37 INFO - PROCESS | 29505 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:50:38 INFO - PROCESS | 29505 | console.error: PushService: 08:50:38 INFO - PROCESS | 29505 | stateChangeProcessEnqueue: Error transitioning state 08:50:38 INFO - PROCESS | 29505 | UnknownError 08:50:38 INFO - TEST-INFO | 29505: exit 0 08:50:38 INFO - Browser initialized. 08:50:38 INFO - Running cycle 1/1 for dromaeo_css test... 08:50:38 INFO - TEST-INFO | started process 29598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzaotvG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:50 INFO - PROCESS | 29598 | RSS: Main: 144171008 08:50:50 INFO - PROCESS | 29598 | 08:53:52 INFO - PROCESS | 29598 | Cycle 1(1): loaded http://localhost:36158/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36158/tests/dromaeo/cssquery-ext.html) 08:53:53 INFO - PROCESS | 29598 | RSS: Main: 242438144 08:53:53 INFO - PROCESS | 29598 | 08:56:55 INFO - PROCESS | 29598 | Cycle 1(1): loaded http://localhost:36158/tests/dromaeo/cssquery-ext.html (next: http://localhost:36158/tests/dromaeo/cssquery-jquery.html) 08:56:56 INFO - PROCESS | 29598 | RSS: Main: 226148352 08:56:56 INFO - PROCESS | 29598 | 08:59:57 INFO - PROCESS | 29598 | Cycle 1(1): loaded http://localhost:36158/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36158/tests/dromaeo/cssquery-mootools.html) 08:59:58 INFO - PROCESS | 29598 | RSS: Main: 216621056 08:59:58 INFO - PROCESS | 29598 | 09:03:00 INFO - PROCESS | 29598 | Cycle 1(1): loaded http://localhost:36158/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36158/tests/dromaeo/cssquery-prototype.html) 09:03:01 INFO - PROCESS | 29598 | RSS: Main: 212881408 09:03:01 INFO - PROCESS | 29598 | 09:06:03 INFO - PROCESS | 29598 | Cycle 1(1): loaded http://localhost:36158/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36158/tests/dromaeo/cssquery-yui.html) 09:06:04 INFO - PROCESS | 29598 | RSS: Main: 174854144 09:06:04 INFO - PROCESS | 29598 | 09:09:06 INFO - PROCESS | 29598 | Cycle 1(1): loaded http://localhost:36158/tests/dromaeo/cssquery-yui.html (next: http://localhost:36158/tests/dromaeo/cssquery-dojo.html) 09:09:07 INFO - PROCESS | 29598 | RSS: Main: 269189120 09:09:07 INFO - PROCESS | 29598 | 09:09:07 INFO - PROCESS | 29598 | __start_tp_report 09:09:07 INFO - PROCESS | 29598 | _x_x_mozilla_page_load 09:09:07 INFO - PROCESS | 29598 | _x_x_mozilla_page_load_details 09:09:07 INFO - PROCESS | 29598 | |i|pagename|runs| 09:09:07 INFO - PROCESS | 29598 | |0;dojo.html;3188.984055079725;3230.806151630902;3234.708876201142;3241.0276916924918;3263.8041717496953;5437.782488700453;5534.418886016971;5540.390557038722;5572.5820563457755;5597.244372009787;5493.23094766732;5556.86107847303;5567.415421380758;5584.078627026546;5596.664200147984;5010.0981823271795;5033.54698077173;5042.369703787027;5111.667741596803;5139.100657384962;4919.11455937931;5058.696478211319;5095.235714642796;5100.362454693163;5105.770240339194;4891.266310053503;4923.852284431473;4968.35411396518;4977.203647416414;5000.19996800512;4954.281629163769;4997.850064498053;4999.500049995007;5077.771500282496;5102.285680004802;4936.6297527685565;4979.925301120486;5027.296178535008;5042.773075211624;5057.165567681328;5283.471652834724;5285.2600635911;5390.8921821563345;5453.945460545423;5459.262999495057;5862.413758624146;5876.11858221266;5881.117832325142;5944.494717948979;5983.58114931955;6009.188759517453;6015.879682406371;6028.608140470856;6030.849228769272;6034.034554471264;5356.4107948125675;5394.757235924393;5395.379531353905;5501.4223506532035;5530.695811730394;6060.33336333003;6070.575059745775;6070.605410648382;6073.0283154695035;6073.362296958844;5852.590318677651;5853.824385268449;5854.385289544622;5871.3541510433815;5871.911921321183;5705.429457054262;5748.166515855178;5810.94189058104;5861.531077513789;5873.647581145145;5916.645001299936;5922.674252916131;5945.702714864239;5946.970265148647;5971.820845374646;5868.589198756046;5910.527157827363;5919.230500035054;5922.141289512996;5945.078512830518;4409.647228221735;4449.377087207794;4504.234280172379;4532.818687252473;4586.793594288265;4071.42999980003;4079.0840792838612;4081.2449696806184;4123.97938010308;4126.66986641068;5662.292213473316;5667.1782591524;5667.234923285304;5667.376588575254;5673.1490276458035;5693.117566777156;5747.3677895431465;5750.367459579443;5910.497607703393;5928;5562.777488900399;5589.916151257735;5593.161025846156;5631.211630371751;5639.6334238274385;4979.2033274676605;4986.426560945465;4988.276699878497;4990.251462280687;5022.372203474566;5966.76132954677;5972.850678733066;6100.511959043266;6131.846703832351;6133;5809.099589563624;5818.709064546841;5847.736851841592;5899.705014749331;5954.10688396744;6095.329513753572;6102.9694851525455;6103.633781973096;6104.8779024420155;6146.661933593696;5642.830715078554;5799.594028417971;5802.47777700009;5813.302403711582;5821.301443826768;5773.336066352424;5923.111533269872;5961.582689211714;5973.581849270683;6034.426729460694;5857.238558987305;5881.05903055509;5902.350741418526;5914.172015917861;5927.911081333697;5710.628809127559;5849.766009359748;5853.473187413153;5855.677937713466;5863.00328944072;5559.138333558305;5614.85962850932;5676.375598684224;5730.398308177581;5737.540996720169;5857.677827719516;5871.706414679164;5904.793332233351;5915.290165180206;5916.822495325147;5581.274434323512;5581.49766521015;5730.74211660468;5737.225474560881;5741.5119714824705 09:09:07 INFO - PROCESS | 29598 | |1;ext.html;595.0806004722702;596.0433504225717;645.7062036773267;656.5797889350816;680.1056610557114;33507;34059.65940340596;43200.56799432009;43467.78266108665;43558.34662480065;42427.57572424275;46812.76593617027;46839.76580117095;46870.76564617181;46901.765491172584;8774.210321071103;8912.554372281393;8922.955385223066;8924.286057115447;8933.15135062168;8100.311473524728;8289;10550.419726915017;10869.45652717361;10891.67324980248;10592.78814423711;10689.198310126732;10692.144628429745;10696.304740191863;10701.83947240792;10584.364938103738;10647.30792498485;10655.573777048909;10658.893411065868;10668.626598069108;10561.471926403648;10612.151027917747;10631.52158152885;10636.680899573024;10638.255322127454;42436.363454548205;42691.78654106709;42743;42753.78623106896;42787.57212427898;3827.7129215308964;3859.4403811447464;3879.243547508237;3894.6884249259992;3903.8048097595006;32026.83986580052;34216;34255.82872085649;34463.48304775431;34479.827600861834;4520.932186017212;4571.108633816407;4633;4642.396488456513;4642.744649044301;402318;412020;412848;413211.999999997;416438;71289.28710712827;72060;72212.63893680499;72307.63846180735;72336.63831680808;43543.34684979728;44342.11315773666;44569.777151114686;44731.329030064575;44818.55181448209;16502.66994660124;16633.3346666132;16634.251458684146;16637.50087497377;16649.750253746202;12281.447334869952;12526.123171378098;12623.93688031554;12624.936875315565;12630.873691263154;21143.8942805285;21909.123635054737;22112.33662990113;22765.544689106457;22897.427564310692;8047.637856296481;8064.354851611857;8106.432549721463;8254;8291.35180520569;1015.6140666546665;1070.8982646648712;1094.3816743539874;1112.5327362507767;1176.7940610393148;34244.952436177475;34268.48597271043;34388.312233755685;34674.47988280178;35076.82461587676;1154.7632735289246;1169.1114752787773;1179.3454632678774;1204.283451346465;1251.086706704111;17127.82872171287;17979.370722024927;18237.45287641373;18248.908755456137;18259.72610410845;525291;527010;527014;529346;533504;60292;60704.69647651822;60727.08909366363;60969.39030609726;61040.084398734056;1269.10528077705;1330.328184266939;1356.803263526783;1373.587923622929;1389.6248013036625;30527.54208686827;34677.306453871286;34870.47694284537;35227.47158792672;35258.29483410369;52290.738546307024;52741.208881866034;52882.73558632336;53314;53325.73337133289;433745;438436;439401;440094;440153;30274.394512110073;30856.537151943186;32183.034508964767;32299.19252018718;32448.35103297968;48775.5122448771;49326.75336623294;49547.30142035724;49901;50717.746411267704;42437;42443;42904;42927.356089659304;44258.77870610755;41855.7907210462;42071.36892946547;42575.7871210642;43546.78226608847;43591.34612980871;43215.35176972411;43758.34362484629;44454;44831.32753008773;45098.09803803971;36287.455688165224;38059.809700951315;38472.80763596164;38621.6137838618;38724.80637596794;28402.147935561967;28699;29605.5559166617;29795.404091918474;29815.403691926473 09:09:07 INFO - PROCESS | 29598 | |2;jquery.html;404.91294371710075;422.26947381030817;425.5106627378514;432.77063156527043;441.17500274486713;15455.613609659764;18742.62514749704;19635.803641963576;19905.104270307835;19942.401727948167;19929.202831886745;20636.17455301786;20684.8965755171;20693.482662933435;20823.16707331705;5654.491095801377;5858.062709966406;5860.677662728548;5863.941360586404;5864.76540938362;5709.600327977043;5987.760489580412;6006.42938920804;6072.605280656765;6075.787347442841;5952.868954898577;5959.761609535635;6057.485113765313;6063.666498342589;6064.96967515164;5976.491998180139;6033.004554248544;6040.456358927674;6047.455728984391;6059.0608455689435;5250.08123578376;5504.119340905436;5539.362973258047;5883.970580147072;5886.087656413263;15015.849841501555;15128.924355378263;15918.840811591852;23065.76934230653;23509.41226469335;2366.6923299971068;2416.5891798394314;2597.6752905886765;2628.290361602376;2990.7158819912074;11280;11457.02615277694;13940.442382304696;14546.199959002251;14685.339159737838;1923.278770461077;1934.7775005874364;1963.6548963959733;1985.2356842615698;2005.5487515309085;75667;76984;77238.61380693117;81792;82926;9455.19630831387;11460.656180314603;11470.827937580943;11908.642740717793;11935.641930742091;13510.121842080232;15355.692886142439;16345.182740862909;16353.34586616522;17070.40253591143;8302.169783021649;8382.87425688615;8519.531425771642;8582.399232053696;8696.086910874394;7876.173001834725;7887.2507111825435;7984.800379990546;8036.598170091472;8097.2307630774985;5018.824341148043;5118.25785261135;5125.769340379692;5145.048166089286;5268.183431568036;2027.2600500817096;2110.5673336965883;2113.3659902029635;2119.872807631516;2130.488682716168;1001.2740762946805;1029.341221618165;1077.1329080090602;1087.0488322717622;1095.1293721491434;20056.197752090044;20213;20400.183992640425;20459.18163273482;20462.79537204609;973.5181085362791;1021.8313978193663;1054.6835949215358;1063.7819247054335;1086.245059683528;10349.387909910678;11000.559977600966;11098.5560577576;11125.944370278097;11244.887551124548;434362;437032;473065;478938;479381;91223;92160.53919730493;93708;95171;95657;997.590987695056;1005.9849102263472;1028.6245520385155;1032.0608246495653;1035.7669524356959;16662.666746664756;16962;17538.649227015645;17643.117844107488;17972.10139493046;41356;41643.16713665771;42319.57680423156;42446.15107697767;42921;58305.70847145907;58778.706106469195;59074.40925590861;59809;61155.38844611497;9155.496447695441;9166.312526560669;9177.08229177077;9195.080491950752;9602.519874006131;10161.796764064826;12632.936835315764;12633.747325053264;13125.343732813511;13438;11396.487158078073;11566.132540059361;11651.708707282047;11847.940760296144;12149.635510934333;11369.658910232707;11437.428128593703;11617.48972633586;11968.76062478763;12187.20783149128;11596.768064638829;11847.170698051399;11897.524099035942;12061.396930153282;12419.565315213924;8961.103889611248;9040.819183616422;9061.728148155566;9109;9194.770130746785;10426.322289051188;11251.212415130862;11324.263922845319;11888.940555297168;11976.28142311464 09:09:07 INFO - PROCESS | 29598 | |3;mootools.html;1376.552620398371;1546.559230619273;1570.43464352833;1751.6409136127095;1861.9534511637207;7787.883181752279;8534.402591818574;8909.198172164504;8917.643294268222;9130.543472826364;8976.596053177607;8978.281737461004;9040.72877813665;9055.411398259108;9074.682386116487;2472.901083956644;2490.0537795637633;2490.091116742385;2497.825152239344;2500.037485568051;2440.4386990992084;2534.6831646044243;2537.53055684698;2539.4032402385424;2549.821512494126;2484.503099380122;2488.925332240036;2527.317624241454;2527.9873600632063;2529;2448.608222684371;2448.742881997391;2470.049031123013;2473.6165894286414;2481.10680155144;2375.3230329356225;2423.491066875958;2439.78041976223;2443.5357282116343;2484.1305543059966;8765.649374025032;8810.735677929672;8851.291896648252;8997.190252877206;8997.235235005033;5433.375161856358;5558.249636299089;5563.415841336642;5563.805266815682;5564;3635.563732352108;3652.6164752700847;3732.701383889282;3735.8505659773577;3753.6997040236715;1225.2403509823878;1230.2188110549864;1308.4439113376873;1324.5165514587202;1357.911735737174;11752.706182345424;11849.585264515787;11868.465919033664;11892.04863610909;11944.163908526407;4681.133990211822;4775.880602984953;4781.760911954458;4926.827561035347;5018.799248030038;9942.353747006422;10060.49697515136;10081.647142349982;10119.9494002531;10123.493825308706;5528.226048353234;5535.750891209906;5572.554195664337;5578.525825304813;5579.4420557944695;4387.890302742457;4561.178987782165;4703.764811759398;5170.121079416508;5228.869278267997;3891.7664940103687;4025.8590949316635;4083.530394004668;4180.7909604519655;4201.411802347674;1257.7421628566121;1295.5724610878576;1297.357807885084;1301.0567338679382;1308.9738205235842;880.4673172730534;999.8500224966314;1002.7092143278513;1020.7754294055296;1025.9897401026044;5958.19564358806;6009.098635204667;6061.757529698851;6294.716737746812;6322.178116844781;964.6720115160739;969.345691658128;982.0081023115464;992.6327258914104;1032.6850310655173;4131.731437456556;4176.2691528982305;4182.602652747984;4236.788160591958;4365.607095361433;11002.394868282161;11151.665450036511;11228.831567526493;11229.27009744364;11263.324200547993;11146.154576671035;11171;11190.608328708619;11211.047060999907;11214.10287177024;8014.679412823539;8420.705275315335;8424.536650484282;8605.182507661762;8631.525266110299;5990.221271234712;6020.939790602038;6174.351693072163;6233;6394.71223794921;10173.542190601293;10199.13307368882;10240.590376384862;10241.590336386462;10342.741431464274;8801.075887032026;9094.045125261753;9766.267529935425;9927.106560409598;10393.116585090353;7734.381249499914;8111.148329425326;8136.389770767098;8147.226013528705;8287.171282871665;8661;8669.913300867163;8690.000649925087;8702.651893924425;8713.52075635846;7736.226377362219;7868.803279918048;7911.090224624242;7923.049234091715;8040.919590804017;7601.733939312097;7739.613019349123;7854.764357069297;7882.408819338687;8090.352771778126;7296.306850849161;7320.780376588711;7384.3354098129275;7388.926110739038;7460.925390746023;5230.555402790806;5273.8681532960445;5275.129603615514;5300.655457395257;5380.139177731544;5022.3219865317715;5131.769070391767;5240.109181439088;5285.154375299933;5304.628675992798 09:09:07 INFO - PROCESS | 29598 | |4;prototype.html;349.2473719135263;358.96769290763837;360.3405767445575;363.54012174599137;364;5175.922361164586;5316.175992721134;5421.186821976706;5438.1510286502635;5489.835304940853;5132.871678208046;5258.158694608864;5259.526642602165;5271.733154743469;5291.153415453528;4223.3031549794405;4228.26005449046;4233.343831706091;4233.555476674951;4234.237837189305;4077.3068578341604;4178.725488725938;4215.557366476522;4248.936265955997;4265.826897603153;4163.854265100722;4164.687648426365;4164.833406663745;4166.8749937501925;4179.289520781459;4159.23054234966;4166.791660416982;4185.267578173838;4186.35111557709;4204.516480604739;3750.662440380379;3759.8120093995462;3774.245150969817;3776.2825063237897;3786.734928555002;5062.620303477254;5174.43081261061;5180.481951804827;5187.19598462239;5254.894902101936;4798.664093513456;4801.351817504662;4801.879953001168;4802.855914322576;4813.735244561548;5445.455454454563;5548.809434575135;5551.278333816578;5560.193771903092;5562.273276904483;4074.5110586729784;4089.9591004089875;4099.795010249505;4119.526254480743;4127.133302006582;5731.570132240098;5750.87857867716;5751.482366586985;5777.133429985493;5814.883702325972;4200.201961627281;4215.725977811432;4227.534971153171;4235.851745188966;4238.385434112098;4136.952208656734;4234.597713217239;4241.724287921275;4245.596668316505;4252.255855225323;4767.189577771787;4781.469929622487;4783.569478746929;4793.352897358882;4807.326974223612;5583.609147359646;5587.357453892773;5609.382967873531;5617.831465055973;5628.324601047901;1307.895368370528;1336.3562817734241;1367.2548461088732;1383.8823699985412;1387.3479464651598;966.7486453522135;973.9172170365598;982.3614650477247;984.5175863826673;991.4844280973854;5184.5593124584075;5209.088409528317;5215.348081489814;5239.29269548606;5245.501677340647;5485.4492660912865;5499.075323636695;5506.752196151183;5527.44725527444;5543.200683654729;5123.359580052494;5209;5255.185446255837;5299.2845965794895;5407.675539467645;2861.554914768029;2889.5665650152646;2919.3139612191117;2924.5759364891974;2928.6632037315553;5707.914381284201;5710.2576665033275;5721.199032135504;5755.942440575541;5765.423457654201;5470.56235501159;5579.163125531121;5602.915956260659;5611.270534830446;5626.352969408488;5745.712714364265;5771.538276937751;5774.509166720792;5775.440631029683;5781.71091445426;5373.9731301343245;5539.473749993744;5594.356648985418;5600.355959064596;5612.635178713371;5471.206675032177;5486.698231597141;5492.340919089735;5492.862678433071;5494.697791621499;5737.282839645044;5787.305523337226;5791.305043394819;5795;5811.79658711943;3980.383040628707;4070.3690927906223;4071.2875246832277;4172.582741725924;4212.115455754326;5460.754266058117;5692.430756924275;5723.8569035774435;5725.7137143141845;5726.255586773693;5469.562435005269;5478.643888147258;5573.303337082864;5586.86032849182;5606.6636001840025;5619.269494965628;5620.915686264628;5650.378458369658;5662.98963867821;5667.659940403589;5328.57371410294;5573.498385145356;5597.972010139923;5615.887682246251;5625;5671.517920976598;5676.262085928803;5689.431056894277;5690.658560486384;5691.601587888808;5423.891522169455;5548.528375088002;5568.248286481436;5601.747921343468;5608.943910560843 09:09:07 INFO - PROCESS | 29598 | |5;yui.html;785.3520845302627;809.6073404398869;850.366476974654;852.2159613155897;907.0566610724844;14898.180600067006;15920.601984950383;16026.75959860603;16089.115098669568;16150.75773863393;14832.18422986738;15279.618009549768;15766.132862692548;15846;16446.67106657866;712.6650474277108;738.8559230949967;845.471580262336;849.978750531237;873.4366333714751;849.7195925344653;869.9478031318109;870.0255713600776;870.2646263906988;870.4168207301124;918.6141820435433;918.9310801689867;919.498873114151;920.2086205862986;920.5029284186531;755.6939439527;785.8742601183841;873.5108339329995;914.1041779056495;914.4193437167413;668.2448832818884;672.3310306245318;672.4149989509109;672.4855485553555;672.7342699633666;15709.371625134982;15721.213939302988;15722.37110515578;15762;15819.52541423759;13753.174809511362;14195.219262940534;14275.428982840675;14307.21310327942;14484.855151448455;12820.461803241149;12916.41876115577;12922.353882305848;13093.803592946113;13851.376688049062;3818.713596480275;3891.5135608048995;4487.663425243087;4537.568930951555;4562.977185114087;63857.36142638561;64564.3543564563;64715.3528464714;64965.67517162431;65213.67393163051;11082.279651822606;11175.608853690082;11183.552657893755;11231.045361144232;11519.71200719972;20665.070071846803;20695.8965205173;20783.68824467634;20831.16675333;20860.687089693667;8156.510609363457;8247.628856701464;8386.8322633547;8439.746807595782;8662.35032372562;4719.433667959866;4730.88172795676;4780.091782561302;4827.131116399082;4851.902961940741;3596.8381422836037;3703.7407381483577;3708.165662725919;3749.887503374903;3763.1532905096133;633.9270983836918;637.073058699591;651.3876955661758;659.9175103112111;660.0165753027953;745.9403247740167;755.3353049316567;765.8812884002989;772.4052479590796;785.1951749456853;9386.624535018524;9535.47554884488;9731.41611503312;9765.853512197322;10351.896481035245;693.9340762627543;697.6407150317591;699.8040548646387;701.4809041309496;720.585663243637;4681.652618377876;4804.2073057945745;4845.1520983828395;4897.045076210176;4937.728424936663;68750.65624671844;89364;91968.54015729879;92237;92459;49956;51330;63014;66141.33858661448;79584.60207698925;71922;72287.63856180686;74180.25819741841;74570.62714686501;74766.62616686882;9616.855747163938;9731.708048758548;9761.170300524534;9772.12050915421;9826.508674566387;47557.524424756695;48682;48968.75515622399;49392.25911611401;49891.25163122483;62242;68046.319536804;68086.319136808;68550.31449685639;69113;11745.588904388305;11948.820767688318;12112.636620901034;12356.876431235572;12392.81410778821;12311.815322770344;12325.198862073936;13029.804552931902;13045.412956416794;13098.2141071536;12310.938445307716;12881.742365152832;12943.417546210254;13181.472741090249;13498.86501134976;12303;12392.504299827906;12647.304398258184;12649.458485553594;12815.42330595144;11625.24435911663;12215.144939854124;12840.165389249669;12843.100982931104;12922.483100675867;10572.629957951434;10696;10952.945235273774;11024.5038973248;11042.447877606248;10818.729531761768;11059.22585419013;11271.887281127083;11312.717182070513;11338.376389298668 09:09:07 INFO - PROCESS | 29598 | __end_tp_report 09:09:07 INFO - PROCESS | 29598 | __start_cc_report 09:09:07 INFO - PROCESS | 29598 | _x_x_mozilla_cycle_collect,919 09:09:07 INFO - PROCESS | 29598 | __end_cc_report 09:09:07 INFO - PROCESS | 29598 | __startTimestamp1484240947167__endTimestamp 09:09:07 INFO - PROCESS | 29598 | 09:09:07 INFO - PROCESS | 29598 | ------- Summary: start ------- 09:09:07 INFO - PROCESS | 29598 | Number of tests: 6 09:09:07 INFO - PROCESS | 29598 | 09:09:07 INFO - PROCESS | 29598 | [#0] dojo.html Cycles:165 Average:5488.80 Median:5705.43 stddev:621.79 (10.9%) stddev-sans-first:596.95 09:09:07 INFO - PROCESS | 29598 | Values: 3189.0 3230.8 3234.7 3241.0 3263.8 5437.8 5534.4 5540.4 5572.6 5597.2 5493.2 5556.9 5567.4 5584.1 5596.7 5010.1 5033.5 5042.4 5111.7 5139.1 4919.1 5058.7 5095.2 5100.4 5105.8 4891.3 4923.9 4968.4 4977.2 5000.2 4954.3 4997.9 4999.5 5077.8 5102.3 4936.6 4979.9 5027.3 5042.8 5057.2 5283.5 5285.3 5390.9 5453.9 5459.3 5862.4 5876.1 5881.1 5944.5 5983.6 6009.2 6015.9 6028.6 6030.8 6034.0 5356.4 5394.8 5395.4 5501.4 5530.7 6060.3 6070.6 6070.6 6073.0 6073.4 5852.6 5853.8 5854.4 5871.4 5871.9 5705.4 5748.2 5810.9 5861.5 5873.6 5916.6 5922.7 5945.7 5947.0 5971.8 5868.6 5910.5 5919.2 5922.1 5945.1 4409.6 4449.4 4504.2 4532.8 4586.8 4071.4 4079.1 4081.2 4124.0 4126.7 5662.3 5667.2 5667.2 5667.4 5673.1 5693.1 5747.4 5750.4 5910.5 5928.0 5562.8 5589.9 5593.2 5631.2 5639.6 4979.2 4986.4 4988.3 4990.3 5022.4 5966.8 5972.9 6100.5 6131.8 6133.0 5809.1 5818.7 5847.7 5899.7 5954.1 6095.3 6103.0 6103.6 6104.9 6146.7 5642.8 5799.6 5802.5 5813.3 5821.3 5773.3 5923.1 5961.6 5973.6 6034.4 5857.2 5881.1 5902.4 5914.2 5927.9 5710.6 5849.8 5853.5 5855.7 5863.0 5559.1 5614.9 5676.4 5730.4 5737.5 5857.7 5871.7 5904.8 5915.3 5916.8 5581.3 5581.5 5730.7 5737.2 5741.5 09:09:07 INFO - PROCESS | 29598 | 09:09:07 INFO - PROCESS | 29598 | [#1] ext.html Cycles:180 Average:62730.82 Median:407169.00 stddev:122241.90 (30.0%) stddev-sans-first:122495.80 09:09:07 INFO - PROCESS | 29598 | Values: 595.1 596.0 645.7 656.6 680.1 33507.0 34059.7 43200.6 43467.8 43558.3 42427.6 46812.8 46839.8 46870.8 46901.8 8774.2 8912.6 8923.0 8924.3 8933.2 8100.3 8289.0 10550.4 10869.5 10891.7 10592.8 10689.2 10692.1 10696.3 10701.8 10584.4 10647.3 10655.6 10658.9 10668.6 10561.5 10612.2 10631.5 10636.7 10638.3 42436.4 42691.8 42743.0 42753.8 42787.6 3827.7 3859.4 3879.2 3894.7 3903.8 32026.8 34216.0 34255.8 34463.5 34479.8 4520.9 4571.1 4633.0 4642.4 4642.7 402318.0 412020.0 412848.0 413212.0 416438.0 71289.3 72060.0 72212.6 72307.6 72336.6 43543.3 44342.1 44569.8 44731.3 44818.6 16502.7 16633.3 16634.3 16637.5 16649.8 12281.4 12526.1 12623.9 12624.9 12630.9 21143.9 21909.1 22112.3 22765.5 22897.4 8047.6 8064.4 8106.4 8254.0 8291.4 1015.6 1070.9 1094.4 1112.5 1176.8 34245.0 34268.5 34388.3 34674.5 35076.8 1154.8 1169.1 1179.3 1204.3 1251.1 17127.8 17979.4 18237.5 18248.9 18259.7 525291.0 527010.0 527014.0 529346.0 533504.0 60292.0 60704.7 60727.1 60969.4 61040.1 1269.1 1330.3 1356.8 1373.6 1389.6 30527.5 34677.3 34870.5 35227.5 35258.3 52290.7 52741.2 52882.7 53314.0 53325.7 433745.0 438436.0 439401.0 440094.0 440153.0 30274.4 30856.5 32183.0 32299.2 32448.4 48775.5 49326.8 49547.3 49901.0 50717.7 42437.0 42443.0 42904.0 42927.4 44258.8 41855.8 42071.4 42575.8 43546.8 43591.3 43215.4 43758.3 44454.0 44831.3 45098.1 36287.5 38059.8 38472.8 38621.6 38724.8 28402.1 28699.0 29605.6 29795.4 29815.4 09:09:07 INFO - PROCESS | 29598 | 09:09:07 INFO - PROCESS | 29598 | [#2] jquery.html Cycles:180 Average:28333.60 Median:23287.59 stddev:76165.35 (327.1%) stddev-sans-first:76350.15 09:09:07 INFO - PROCESS | 29598 | Values: 404.9 422.3 425.5 432.8 441.2 15455.6 18742.6 19635.8 19905.1 19942.4 19929.2 20636.2 20684.9 20693.5 20823.2 5654.5 5858.1 5860.7 5863.9 5864.8 5709.6 5987.8 6006.4 6072.6 6075.8 5952.9 5959.8 6057.5 6063.7 6065.0 5976.5 6033.0 6040.5 6047.5 6059.1 5250.1 5504.1 5539.4 5884.0 5886.1 15015.8 15128.9 15918.8 23065.8 23509.4 2366.7 2416.6 2597.7 2628.3 2990.7 11280.0 11457.0 13940.4 14546.2 14685.3 1923.3 1934.8 1963.7 1985.2 2005.5 75667.0 76984.0 77238.6 81792.0 82926.0 9455.2 11460.7 11470.8 11908.6 11935.6 13510.1 15355.7 16345.2 16353.3 17070.4 8302.2 8382.9 8519.5 8582.4 8696.1 7876.2 7887.3 7984.8 8036.6 8097.2 5018.8 5118.3 5125.8 5145.0 5268.2 2027.3 2110.6 2113.4 2119.9 2130.5 1001.3 1029.3 1077.1 1087.0 1095.1 20056.2 20213.0 20400.2 20459.2 20462.8 973.5 1021.8 1054.7 1063.8 1086.2 10349.4 11000.6 11098.6 11125.9 11244.9 434362.0 437032.0 473065.0 478938.0 479381.0 91223.0 92160.5 93708.0 95171.0 95657.0 997.6 1006.0 1028.6 1032.1 1035.8 16662.7 16962.0 17538.6 17643.1 17972.1 41356.0 41643.2 42319.6 42446.2 42921.0 58305.7 58778.7 59074.4 59809.0 61155.4 9155.5 9166.3 9177.1 9195.1 9602.5 10161.8 12632.9 12633.7 13125.3 13438.0 11396.5 11566.1 11651.7 11847.9 12149.6 11369.7 11437.4 11617.5 11968.8 12187.2 11596.8 11847.2 11897.5 12061.4 12419.6 8961.1 9040.8 9061.7 9109.0 9194.8 10426.3 11251.2 11324.3 11888.9 11976.3 09:09:07 INFO - PROCESS | 29598 | 09:09:07 INFO - PROCESS | 29598 | [#3] mootools.html Cycles:180 Average:5919.38 Median:4972.81 stddev:3254.12 (65.4%) stddev-sans-first:3245.34 09:09:07 INFO - PROCESS | 29598 | Values: 1376.6 1546.6 1570.4 1751.6 1862.0 7787.9 8534.4 8909.2 8917.6 9130.5 8976.6 8978.3 9040.7 9055.4 9074.7 2472.9 2490.1 2490.1 2497.8 2500.0 2440.4 2534.7 2537.5 2539.4 2549.8 2484.5 2488.9 2527.3 2528.0 2529.0 2448.6 2448.7 2470.0 2473.6 2481.1 2375.3 2423.5 2439.8 2443.5 2484.1 8765.6 8810.7 8851.3 8997.2 8997.2 5433.4 5558.2 5563.4 5563.8 5564.0 3635.6 3652.6 3732.7 3735.9 3753.7 1225.2 1230.2 1308.4 1324.5 1357.9 11752.7 11849.6 11868.5 11892.0 11944.2 4681.1 4775.9 4781.8 4926.8 5018.8 9942.4 10060.5 10081.6 10119.9 10123.5 5528.2 5535.8 5572.6 5578.5 5579.4 4387.9 4561.2 4703.8 5170.1 5228.9 3891.8 4025.9 4083.5 4180.8 4201.4 1257.7 1295.6 1297.4 1301.1 1309.0 880.5 999.9 1002.7 1020.8 1026.0 5958.2 6009.1 6061.8 6294.7 6322.2 964.7 969.3 982.0 992.6 1032.7 4131.7 4176.3 4182.6 4236.8 4365.6 11002.4 11151.7 11228.8 11229.3 11263.3 11146.2 11171.0 11190.6 11211.0 11214.1 8014.7 8420.7 8424.5 8605.2 8631.5 5990.2 6020.9 6174.4 6233.0 6394.7 10173.5 10199.1 10240.6 10241.6 10342.7 8801.1 9094.0 9766.3 9927.1 10393.1 7734.4 8111.1 8136.4 8147.2 8287.2 8661.0 8669.9 8690.0 8702.7 8713.5 7736.2 7868.8 7911.1 7923.0 8040.9 7601.7 7739.6 7854.8 7882.4 8090.4 7296.3 7320.8 7384.3 7388.9 7460.9 5230.6 5273.9 5275.1 5300.7 5380.1 5022.3 5131.8 5240.1 5285.2 5304.6 09:09:07 INFO - PROCESS | 29598 | 09:09:07 INFO - PROCESS | 29598 | [#4] prototype.html Cycles:180 Average:4683.17 Median:5322.37 stddev:1353.01 (25.4%) stddev-sans-first:1317.12 09:09:07 INFO - PROCESS | 29598 | Values: 349.2 359.0 360.3 363.5 364.0 5175.9 5316.2 5421.2 5438.2 5489.8 5132.9 5258.2 5259.5 5271.7 5291.2 4223.3 4228.3 4233.3 4233.6 4234.2 4077.3 4178.7 4215.6 4248.9 4265.8 4163.9 4164.7 4164.8 4166.9 4179.3 4159.2 4166.8 4185.3 4186.4 4204.5 3750.7 3759.8 3774.2 3776.3 3786.7 5062.6 5174.4 5180.5 5187.2 5254.9 4798.7 4801.4 4801.9 4802.9 4813.7 5445.5 5548.8 5551.3 5560.2 5562.3 4074.5 4090.0 4099.8 4119.5 4127.1 5731.6 5750.9 5751.5 5777.1 5814.9 4200.2 4215.7 4227.5 4235.9 4238.4 4137.0 4234.6 4241.7 4245.6 4252.3 4767.2 4781.5 4783.6 4793.4 4807.3 5583.6 5587.4 5609.4 5617.8 5628.3 1307.9 1336.4 1367.3 1383.9 1387.3 966.7 973.9 982.4 984.5 991.5 5184.6 5209.1 5215.3 5239.3 5245.5 5485.4 5499.1 5506.8 5527.4 5543.2 5123.4 5209.0 5255.2 5299.3 5407.7 2861.6 2889.6 2919.3 2924.6 2928.7 5707.9 5710.3 5721.2 5755.9 5765.4 5470.6 5579.2 5602.9 5611.3 5626.4 5745.7 5771.5 5774.5 5775.4 5781.7 5374.0 5539.5 5594.4 5600.4 5612.6 5471.2 5486.7 5492.3 5492.9 5494.7 5737.3 5787.3 5791.3 5795.0 5811.8 3980.4 4070.4 4071.3 4172.6 4212.1 5460.8 5692.4 5723.9 5725.7 5726.3 5469.6 5478.6 5573.3 5586.9 5606.7 5619.3 5620.9 5650.4 5663.0 5667.7 5328.6 5573.5 5598.0 5615.9 5625.0 5671.5 5676.3 5689.4 5690.7 5691.6 5423.9 5548.5 5568.2 5601.7 5608.9 09:09:07 INFO - PROCESS | 29598 | 09:09:07 INFO - PROCESS | 29598 | [#5] yui.html Cycles:180 Average:17978.60 Median:48825.38 stddev:23357.40 (47.8%) stddev-sans-first:23387.24 09:09:07 INFO - PROCESS | 29598 | Values: 785.4 809.6 850.4 852.2 907.1 14898.2 15920.6 16026.8 16089.1 16150.8 14832.2 15279.6 15766.1 15846.0 16446.7 712.7 738.9 845.5 850.0 873.4 849.7 869.9 870.0 870.3 870.4 918.6 918.9 919.5 920.2 920.5 755.7 785.9 873.5 914.1 914.4 668.2 672.3 672.4 672.5 672.7 15709.4 15721.2 15722.4 15762.0 15819.5 13753.2 14195.2 14275.4 14307.2 14484.9 12820.5 12916.4 12922.4 13093.8 13851.4 3818.7 3891.5 4487.7 4537.6 4563.0 63857.4 64564.4 64715.4 64965.7 65213.7 11082.3 11175.6 11183.6 11231.0 11519.7 20665.1 20695.9 20783.7 20831.2 20860.7 8156.5 8247.6 8386.8 8439.7 8662.4 4719.4 4730.9 4780.1 4827.1 4851.9 3596.8 3703.7 3708.2 3749.9 3763.2 633.9 637.1 651.4 659.9 660.0 745.9 755.3 765.9 772.4 785.2 9386.6 9535.5 9731.4 9765.9 10351.9 693.9 697.6 699.8 701.5 720.6 4681.7 4804.2 4845.2 4897.0 4937.7 68750.7 89364.0 91968.5 92237.0 92459.0 49956.0 51330.0 63014.0 66141.3 79584.6 71922.0 72287.6 74180.3 74570.6 74766.6 9616.9 9731.7 9761.2 9772.1 9826.5 47557.5 48682.0 48968.8 49392.3 49891.3 62242.0 68046.3 68086.3 68550.3 69113.0 11745.6 11948.8 12112.6 12356.9 12392.8 12311.8 12325.2 13029.8 13045.4 13098.2 12310.9 12881.7 12943.4 13181.5 13498.9 12303.0 12392.5 12647.3 12649.5 12815.4 11625.2 12215.1 12840.2 12843.1 12922.5 10572.6 10696.0 10952.9 11024.5 11042.4 10818.7 11059.2 11271.9 11312.7 11338.4 09:09:07 INFO - PROCESS | 29598 | -------- Summary: end -------- 09:09:07 INFO - PROCESS | 29598 | 09:09:07 INFO - TEST-INFO | 29598: exit 0 09:09:07 INFO - TEST-OK | dromaeo_css | took 1114284ms 09:09:07 INFO - TEST-START | kraken 09:09:07 INFO - operating with platform_type : linux_ 09:09:07 INFO - Initialising browser for kraken test... 09:09:07 INFO - TEST-INFO | started process 29916 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_KrJz/profile http://localhost:36158/getInfo.html) 09:09:11 INFO - PROCESS | 29916 | __metrics Screen width/height:1600/1200 09:09:11 INFO - PROCESS | 29916 | colorDepth:24 09:09:11 INFO - PROCESS | 29916 | Browser inner width/height: 1024/697 09:09:11 INFO - PROCESS | 29916 | __metrics 09:09:11 INFO - PROCESS | 29916 | 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:09:11 INFO - PROCESS | 29916 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:09:12 INFO - PROCESS | 29916 | console.error: PushService: 09:09:12 INFO - PROCESS | 29916 | stateChangeProcessEnqueue: Error transitioning state 09:09:12 INFO - PROCESS | 29916 | UnknownError 09:09:12 INFO - TEST-INFO | 29916: exit 0 09:09:12 INFO - Browser initialized. 09:09:12 INFO - Running cycle 1/1 for kraken test... 09:09:12 INFO - TEST-INFO | started process 30013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_KrJz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:24 INFO - PROCESS | 30013 | RSS: Main: 143884288 09:09:24 INFO - PROCESS | 30013 | 09:09:27 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36158/tests/kraken/driver.html?testName=audio-beat-detection) 09:09:28 INFO - PROCESS | 30013 | RSS: Main: 184184832 09:09:28 INFO - PROCESS | 30013 | 09:09:30 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36158/tests/kraken/driver.html?testName=audio-dft) 09:09:31 INFO - PROCESS | 30013 | RSS: Main: 175005696 09:09:31 INFO - PROCESS | 30013 | 09:09:33 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36158/tests/kraken/driver.html?testName=audio-fft) 09:09:34 INFO - PROCESS | 30013 | RSS: Main: 266854400 09:09:34 INFO - PROCESS | 30013 | 09:09:36 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36158/tests/kraken/driver.html?testName=audio-oscillator) 09:09:37 INFO - PROCESS | 30013 | RSS: Main: 173158400 09:09:37 INFO - PROCESS | 30013 | 09:09:39 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36158/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:39 INFO - PROCESS | 30013 | RSS: Main: 175058944 09:09:39 INFO - PROCESS | 30013 | 09:09:42 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36158/tests/kraken/driver.html?testName=imaging-darkroom) 09:09:43 INFO - PROCESS | 30013 | RSS: Main: 213233664 09:09:43 INFO - PROCESS | 30013 | 09:09:46 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36158/tests/kraken/driver.html?testName=imaging-desaturate) 09:09:47 INFO - PROCESS | 30013 | RSS: Main: 212508672 09:09:47 INFO - PROCESS | 30013 | 09:09:49 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36158/tests/kraken/driver.html?testName=json-parse-financial) 09:09:50 INFO - PROCESS | 30013 | RSS: Main: 211021824 09:09:50 INFO - PROCESS | 30013 | 09:09:52 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36158/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:52 INFO - PROCESS | 30013 | RSS: Main: 173871104 09:09:52 INFO - PROCESS | 30013 | 09:09:54 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:54 INFO - PROCESS | 30013 | RSS: Main: 180637696 09:09:54 INFO - PROCESS | 30013 | 09:09:56 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:57 INFO - PROCESS | 30013 | RSS: Main: 189181952 09:09:57 INFO - PROCESS | 30013 | 09:09:59 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:10:00 INFO - PROCESS | 30013 | RSS: Main: 198303744 09:10:00 INFO - PROCESS | 30013 | 09:10:03 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:10:03 INFO - PROCESS | 30013 | RSS: Main: 194666496 09:10:03 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36158/tests/kraken/driver.html?testName=ai-astar) 09:10:05 INFO - PROCESS | 30013 | RSS: Main: 246788096 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | __start_tp_report 09:10:05 INFO - PROCESS | 30013 | _x_x_mozilla_page_load 09:10:05 INFO - PROCESS | 30013 | _x_x_mozilla_page_load_details 09:10:05 INFO - PROCESS | 30013 | |i|pagename|runs| 09:10:05 INFO - PROCESS | 30013 | |0;ai-astar;101;110;110;109;109;110;109;111;110;111 09:10:05 INFO - PROCESS | 30013 | |1;audio-beat-detection;150;124;122;159;119;117;121;119;145;118 09:10:05 INFO - PROCESS | 30013 | |2;audio-dft;161;160;159;160;160;161;160;161;167;161 09:10:05 INFO - PROCESS | 30013 | |3;audio-fft;74;76;75;108;75;75;74;73;95;74 09:10:05 INFO - PROCESS | 30013 | |4;audio-oscillator;81;82;106;81;81;81;96;82;81;106 09:10:05 INFO - PROCESS | 30013 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;116;117;117 09:10:05 INFO - PROCESS | 30013 | |6;imaging-darkroom;146;146;146;147;145;146;146;146;146;146 09:10:05 INFO - PROCESS | 30013 | |7;imaging-desaturate;85;85;84;84;84;84;84;85;85;84 09:10:05 INFO - PROCESS | 30013 | |8;json-parse-financial;53;50;50;51;49;52;49;50;51;50 09:10:05 INFO - PROCESS | 30013 | |9;json-stringify-tinderbox;60;61;60;59;60;60;59;59;59;59 09:10:05 INFO - PROCESS | 30013 | |10;stanford-crypto-aes;74;78;81;74;75;74;78;75;74;75 09:10:05 INFO - PROCESS | 30013 | |11;stanford-crypto-ccm;123;124;126;130;121;122;119;127;157;122 09:10:05 INFO - PROCESS | 30013 | |12;stanford-crypto-pbkdf2;151;149;153;152;154;154;151;150;152;153 09:10:05 INFO - PROCESS | 30013 | |13;stanford-crypto-sha256-iterative;63;62;63;62;62;66;64;61;59;59 09:10:05 INFO - PROCESS | 30013 | __end_tp_report 09:10:05 INFO - PROCESS | 30013 | __start_cc_report 09:10:05 INFO - PROCESS | 30013 | _x_x_mozilla_cycle_collect,1591 09:10:05 INFO - PROCESS | 30013 | __end_cc_report 09:10:05 INFO - PROCESS | 30013 | __startTimestamp1484241005799__endTimestamp 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | ------- Summary: start ------- 09:10:05 INFO - PROCESS | 30013 | Number of tests: 14 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.91 (2.6%) stddev-sans-first:0.78 09:10:05 INFO - PROCESS | 30013 | Values: 101.0 110.0 110.0 109.0 109.0 110.0 109.0 111.0 110.0 111.0 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:123.00 stddev:15.63 (12.7%) stddev-sans-first:14.69 09:10:05 INFO - PROCESS | 30013 | Values: 150.0 124.0 122.0 159.0 119.0 117.0 121.0 119.0 145.0 118.0 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:2.21 (1.4%) stddev-sans-first:2.35 09:10:05 INFO - PROCESS | 30013 | Values: 161.0 160.0 159.0 160.0 160.0 161.0 160.0 161.0 167.0 161.0 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | [#3] audio-fft Cycles:10 Average:79.90 Median:75.00 stddev:11.82 (15.8%) stddev-sans-first:12.34 09:10:05 INFO - PROCESS | 30013 | Values: 74.0 76.0 75.0 108.0 75.0 75.0 74.0 73.0 95.0 74.0 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:81.00 stddev:10.69 (13.2%) stddev-sans-first:11.06 09:10:05 INFO - PROCESS | 30013 | Values: 81.0 82.0 106.0 81.0 81.0 81.0 96.0 82.0 81.0 106.0 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 09:10:05 INFO - PROCESS | 30013 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 09:10:05 INFO - PROCESS | 30013 | Values: 146.0 146.0 146.0 147.0 145.0 146.0 146.0 146.0 146.0 146.0 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 09:10:05 INFO - PROCESS | 30013 | Values: 85.0 85.0 84.0 84.0 84.0 84.0 84.0 85.0 85.0 84.0 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:50.50 stddev:1.27 (2.5%) stddev-sans-first:0.97 09:10:05 INFO - PROCESS | 30013 | Values: 53.0 50.0 50.0 51.0 49.0 52.0 49.0 50.0 51.0 50.0 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 09:10:05 INFO - PROCESS | 30013 | Values: 60.0 61.0 60.0 59.0 60.0 60.0 59.0 59.0 59.0 59.0 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.00 stddev:2.39 (3.2%) stddev-sans-first:2.45 09:10:05 INFO - PROCESS | 30013 | Values: 74.0 78.0 81.0 74.0 75.0 74.0 78.0 75.0 74.0 75.0 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:125.00 stddev:10.98 (8.8%) stddev-sans-first:11.54 09:10:05 INFO - PROCESS | 30013 | Values: 123.0 124.0 126.0 130.0 121.0 122.0 119.0 127.0 157.0 122.0 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:152.50 stddev:1.66 (1.1%) stddev-sans-first:1.73 09:10:05 INFO - PROCESS | 30013 | Values: 151.0 149.0 153.0 152.0 154.0 154.0 151.0 150.0 152.0 153.0 09:10:05 INFO - PROCESS | 30013 | 09:10:05 INFO - PROCESS | 30013 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.50 stddev:2.13 (3.4%) stddev-sans-first:2.24 09:10:05 INFO - PROCESS | 30013 | Values: 63.0 62.0 63.0 62.0 62.0 66.0 64.0 61.0 59.0 59.0 09:10:05 INFO - PROCESS | 30013 | -------- Summary: end -------- 09:10:05 INFO - PROCESS | 30013 | 09:10:06 INFO - TEST-INFO | 30013: exit 0 09:10:06 INFO - TEST-OK | kraken | took 58970ms 09:10:06 INFO - SUITE-END | took 1173s 09:10:06 INFO - Completed test suite (00:19:33) 09:10:06 INFO - javascript benchmark 09:10:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3188.984055079725, 3230.806151630902, 3234.708876201142, 3241.0276916924918, 3263.8041717496953, 5437.782488700453, 5534.418886016971, 5540.390557038722, 5572.5820563457755, 5597.244372009787, 5493.23094766732, 5556.86107847303, 5567.415421380758, 5584.078627026546, 5596.664200147984, 5010.0981823271795, 5033.54698077173, 5042.369703787027, 5111.667741596803, 5139.100657384962, 4919.11455937931, 5058.696478211319, 5095.235714642796, 5100.362454693163, 5105.770240339194, 4891.266310053503, 4923.852284431473, 4968.35411396518, 4977.203647416414, 5000.19996800512, 4954.281629163769, 4997.850064498053, 4999.500049995007, 5077.771500282496, 5102.285680004802, 4936.6297527685565, 4979.925301120486, 5027.296178535008, 5042.773075211624, 5057.165567681328, 5283.471652834724, 5285.2600635911, 5390.8921821563345, 5453.945460545423, 5459.262999495057, 5862.413758624146, 5876.11858221266, 5881.117832325142, 5944.494717948979, 5983.58114931955, 6009.188759517453, 6015.879682406371, 6028.608140470856, 6030.849228769272, 6034.034554471264, 5356.4107948125675, 5394.757235924393, 5395.379531353905, 5501.4223506532035, 5530.695811730394, 6060.33336333003, 6070.575059745775, 6070.605410648382, 6073.0283154695035, 6073.362296958844, 5852.590318677651, 5853.824385268449, 5854.385289544622, 5871.3541510433815, 5871.911921321183, 5705.429457054262, 5748.166515855178, 5810.94189058104, 5861.531077513789, 5873.647581145145, 5916.645001299936, 5922.674252916131, 5945.702714864239, 5946.970265148647, 5971.820845374646, 5868.589198756046, 5910.527157827363, 5919.230500035054, 5922.141289512996, 5945.078512830518, 4409.647228221735, 4449.377087207794, 4504.234280172379, 4532.818687252473, 4586.793594288265, 4071.42999980003, 4079.0840792838612, 4081.2449696806184, 4123.97938010308, 4126.66986641068, 5662.292213473316, 5667.1782591524, 5667.234923285304, 5667.376588575254, 5673.1490276458035, 5693.117566777156, 5747.3677895431465, 5750.367459579443, 5910.497607703393, 5928.0, 5562.777488900399, 5589.916151257735, 5593.161025846156, 5631.211630371751, 5639.6334238274385, 4979.2033274676605, 4986.426560945465, 4988.276699878497, 4990.251462280687, 5022.372203474566, 5966.76132954677, 5972.850678733066, 6100.511959043266, 6131.846703832351, 6133.0, 5809.099589563624, 5818.709064546841, 5847.736851841592, 5899.705014749331, 5954.10688396744, 6095.329513753572, 6102.9694851525455, 6103.633781973096, 6104.8779024420155, 6146.661933593696, 5642.830715078554, 5799.594028417971, 5802.47777700009, 5813.302403711582, 5821.301443826768, 5773.336066352424, 5923.111533269872, 5961.582689211714, 5973.581849270683, 6034.426729460694, 5857.238558987305, 5881.05903055509, 5902.350741418526, 5914.172015917861, 5927.911081333697, 5710.628809127559, 5849.766009359748, 5853.473187413153, 5855.677937713466, 5863.00328944072, 5559.138333558305, 5614.85962850932, 5676.375598684224, 5730.398308177581, 5737.540996720169, 5857.677827719516, 5871.706414679164, 5904.793332233351, 5915.290165180206, 5916.822495325147, 5581.274434323512, 5581.49766521015, 5730.74211660468, 5737.225474560881, 5741.5119714824705], "value": 5447.295878761402, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.0806004722702, 596.0433504225717, 645.7062036773267, 656.5797889350816, 680.1056610557114, 33507.0, 34059.65940340596, 43200.56799432009, 43467.78266108665, 43558.34662480065, 42427.57572424275, 46812.76593617027, 46839.76580117095, 46870.76564617181, 46901.765491172584, 8774.210321071103, 8912.554372281393, 8922.955385223066, 8924.286057115447, 8933.15135062168, 8100.311473524728, 8289.0, 10550.419726915017, 10869.45652717361, 10891.67324980248, 10592.78814423711, 10689.198310126732, 10692.144628429745, 10696.304740191863, 10701.83947240792, 10584.364938103738, 10647.30792498485, 10655.573777048909, 10658.893411065868, 10668.626598069108, 10561.471926403648, 10612.151027917747, 10631.52158152885, 10636.680899573024, 10638.255322127454, 42436.363454548205, 42691.78654106709, 42743.0, 42753.78623106896, 42787.57212427898, 3827.7129215308964, 3859.4403811447464, 3879.243547508237, 3894.6884249259992, 3903.8048097595006, 32026.83986580052, 34216.0, 34255.82872085649, 34463.48304775431, 34479.827600861834, 4520.932186017212, 4571.108633816407, 4633.0, 4642.396488456513, 4642.744649044301, 402318.0, 412020.0, 412848.0, 413211.999999997, 416438.0, 71289.28710712827, 72060.0, 72212.63893680499, 72307.63846180735, 72336.63831680808, 43543.34684979728, 44342.11315773666, 44569.777151114686, 44731.329030064575, 44818.55181448209, 16502.66994660124, 16633.3346666132, 16634.251458684146, 16637.50087497377, 16649.750253746202, 12281.447334869952, 12526.123171378098, 12623.93688031554, 12624.936875315565, 12630.873691263154, 21143.8942805285, 21909.123635054737, 22112.33662990113, 22765.544689106457, 22897.427564310692, 8047.637856296481, 8064.354851611857, 8106.432549721463, 8254.0, 8291.35180520569, 1015.6140666546665, 1070.8982646648712, 1094.3816743539874, 1112.5327362507767, 1176.7940610393148, 34244.952436177475, 34268.48597271043, 34388.312233755685, 34674.47988280178, 35076.82461587676, 1154.7632735289246, 1169.1114752787773, 1179.3454632678774, 1204.283451346465, 1251.086706704111, 17127.82872171287, 17979.370722024927, 18237.45287641373, 18248.908755456137, 18259.72610410845, 525291.0, 527010.0, 527014.0, 529346.0, 533504.0, 60292.0, 60704.69647651822, 60727.08909366363, 60969.39030609726, 61040.084398734056, 1269.10528077705, 1330.328184266939, 1356.803263526783, 1373.587923622929, 1389.6248013036625, 30527.54208686827, 34677.306453871286, 34870.47694284537, 35227.47158792672, 35258.29483410369, 52290.738546307024, 52741.208881866034, 52882.73558632336, 53314.0, 53325.73337133289, 433745.0, 438436.0, 439401.0, 440094.0, 440153.0, 30274.394512110073, 30856.537151943186, 32183.034508964767, 32299.19252018718, 32448.35103297968, 48775.5122448771, 49326.75336623294, 49547.30142035724, 49901.0, 50717.746411267704, 42437.0, 42443.0, 42904.0, 42927.356089659304, 44258.77870610755, 41855.7907210462, 42071.36892946547, 42575.7871210642, 43546.78226608847, 43591.34612980871, 43215.35176972411, 43758.34362484629, 44454.0, 44831.32753008773, 45098.09803803971, 36287.455688165224, 38059.809700951315, 38472.80763596164, 38621.6137838618, 38724.80637596794, 28402.147935561967, 28699.0, 29605.5559166617, 29795.404091918474, 29815.403691926473], "value": 21247.228992631644, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.91294371710075, 422.26947381030817, 425.5106627378514, 432.77063156527043, 441.17500274486713, 15455.613609659764, 18742.62514749704, 19635.803641963576, 19905.104270307835, 19942.401727948167, 19929.202831886745, 20636.17455301786, 20684.8965755171, 20693.482662933435, 20823.16707331705, 5654.491095801377, 5858.062709966406, 5860.677662728548, 5863.941360586404, 5864.76540938362, 5709.600327977043, 5987.760489580412, 6006.42938920804, 6072.605280656765, 6075.787347442841, 5952.868954898577, 5959.761609535635, 6057.485113765313, 6063.666498342589, 6064.96967515164, 5976.491998180139, 6033.004554248544, 6040.456358927674, 6047.455728984391, 6059.0608455689435, 5250.08123578376, 5504.119340905436, 5539.362973258047, 5883.970580147072, 5886.087656413263, 15015.849841501555, 15128.924355378263, 15918.840811591852, 23065.76934230653, 23509.41226469335, 2366.6923299971068, 2416.5891798394314, 2597.6752905886765, 2628.290361602376, 2990.7158819912074, 11280.0, 11457.02615277694, 13940.442382304696, 14546.199959002251, 14685.339159737838, 1923.278770461077, 1934.7775005874364, 1963.6548963959733, 1985.2356842615698, 2005.5487515309085, 75667.0, 76984.0, 77238.61380693117, 81792.0, 82926.0, 9455.19630831387, 11460.656180314603, 11470.827937580943, 11908.642740717793, 11935.641930742091, 13510.121842080232, 15355.692886142439, 16345.182740862909, 16353.34586616522, 17070.40253591143, 8302.169783021649, 8382.87425688615, 8519.531425771642, 8582.399232053696, 8696.086910874394, 7876.173001834725, 7887.2507111825435, 7984.800379990546, 8036.598170091472, 8097.2307630774985, 5018.824341148043, 5118.25785261135, 5125.769340379692, 5145.048166089286, 5268.183431568036, 2027.2600500817096, 2110.5673336965883, 2113.3659902029635, 2119.872807631516, 2130.488682716168, 1001.2740762946805, 1029.341221618165, 1077.1329080090602, 1087.0488322717622, 1095.1293721491434, 20056.197752090044, 20213.0, 20400.183992640425, 20459.18163273482, 20462.79537204609, 973.5181085362791, 1021.8313978193663, 1054.6835949215358, 1063.7819247054335, 1086.245059683528, 10349.387909910678, 11000.559977600966, 11098.5560577576, 11125.944370278097, 11244.887551124548, 434362.0, 437032.0, 473065.0, 478938.0, 479381.0, 91223.0, 92160.53919730493, 93708.0, 95171.0, 95657.0, 997.590987695056, 1005.9849102263472, 1028.6245520385155, 1032.0608246495653, 1035.7669524356959, 16662.666746664756, 16962.0, 17538.649227015645, 17643.117844107488, 17972.10139493046, 41356.0, 41643.16713665771, 42319.57680423156, 42446.15107697767, 42921.0, 58305.70847145907, 58778.706106469195, 59074.40925590861, 59809.0, 61155.38844611497, 9155.496447695441, 9166.312526560669, 9177.08229177077, 9195.080491950752, 9602.519874006131, 10161.796764064826, 12632.936835315764, 12633.747325053264, 13125.343732813511, 13438.0, 11396.487158078073, 11566.132540059361, 11651.708707282047, 11847.940760296144, 12149.635510934333, 11369.658910232707, 11437.428128593703, 11617.48972633586, 11968.76062478763, 12187.20783149128, 11596.768064638829, 11847.170698051399, 11897.524099035942, 12061.396930153282, 12419.565315213924, 8961.103889611248, 9040.819183616422, 9061.728148155566, 9109.0, 9194.770130746785, 10426.322289051188, 11251.212415130862, 11324.263922845319, 11888.940555297168, 11976.28142311464], "value": 9459.28279295284, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.552620398371, 1546.559230619273, 1570.43464352833, 1751.6409136127095, 1861.9534511637207, 7787.883181752279, 8534.402591818574, 8909.198172164504, 8917.643294268222, 9130.543472826364, 8976.596053177607, 8978.281737461004, 9040.72877813665, 9055.411398259108, 9074.682386116487, 2472.901083956644, 2490.0537795637633, 2490.091116742385, 2497.825152239344, 2500.037485568051, 2440.4386990992084, 2534.6831646044243, 2537.53055684698, 2539.4032402385424, 2549.821512494126, 2484.503099380122, 2488.925332240036, 2527.317624241454, 2527.9873600632063, 2529.0, 2448.608222684371, 2448.742881997391, 2470.049031123013, 2473.6165894286414, 2481.10680155144, 2375.3230329356225, 2423.491066875958, 2439.78041976223, 2443.5357282116343, 2484.1305543059966, 8765.649374025032, 8810.735677929672, 8851.291896648252, 8997.190252877206, 8997.235235005033, 5433.375161856358, 5558.249636299089, 5563.415841336642, 5563.805266815682, 5564.0, 3635.563732352108, 3652.6164752700847, 3732.701383889282, 3735.8505659773577, 3753.6997040236715, 1225.2403509823878, 1230.2188110549864, 1308.4439113376873, 1324.5165514587202, 1357.911735737174, 11752.706182345424, 11849.585264515787, 11868.465919033664, 11892.04863610909, 11944.163908526407, 4681.133990211822, 4775.880602984953, 4781.760911954458, 4926.827561035347, 5018.799248030038, 9942.353747006422, 10060.49697515136, 10081.647142349982, 10119.9494002531, 10123.493825308706, 5528.226048353234, 5535.750891209906, 5572.554195664337, 5578.525825304813, 5579.4420557944695, 4387.890302742457, 4561.178987782165, 4703.764811759398, 5170.121079416508, 5228.869278267997, 3891.7664940103687, 4025.8590949316635, 4083.530394004668, 4180.7909604519655, 4201.411802347674, 1257.7421628566121, 1295.5724610878576, 1297.357807885084, 1301.0567338679382, 1308.9738205235842, 880.4673172730534, 999.8500224966314, 1002.7092143278513, 1020.7754294055296, 1025.9897401026044, 5958.19564358806, 6009.098635204667, 6061.757529698851, 6294.716737746812, 6322.178116844781, 964.6720115160739, 969.345691658128, 982.0081023115464, 992.6327258914104, 1032.6850310655173, 4131.731437456556, 4176.2691528982305, 4182.602652747984, 4236.788160591958, 4365.607095361433, 11002.394868282161, 11151.665450036511, 11228.831567526493, 11229.27009744364, 11263.324200547993, 11146.154576671035, 11171.0, 11190.608328708619, 11211.047060999907, 11214.10287177024, 8014.679412823539, 8420.705275315335, 8424.536650484282, 8605.182507661762, 8631.525266110299, 5990.221271234712, 6020.939790602038, 6174.351693072163, 6233.0, 6394.71223794921, 10173.542190601293, 10199.13307368882, 10240.590376384862, 10241.590336386462, 10342.741431464274, 8801.075887032026, 9094.045125261753, 9766.267529935425, 9927.106560409598, 10393.116585090353, 7734.381249499914, 8111.148329425326, 8136.389770767098, 8147.226013528705, 8287.171282871665, 8661.0, 8669.913300867163, 8690.000649925087, 8702.651893924425, 8713.52075635846, 7736.226377362219, 7868.803279918048, 7911.090224624242, 7923.049234091715, 8040.919590804017, 7601.733939312097, 7739.613019349123, 7854.764357069297, 7882.408819338687, 8090.352771778126, 7296.306850849161, 7320.780376588711, 7384.3354098129275, 7388.926110739038, 7460.925390746023, 5230.555402790806, 5273.8681532960445, 5275.129603615514, 5300.655457395257, 5380.139177731544, 5022.3219865317715, 5131.769070391767, 5240.109181439088, 5285.154375299933, 5304.628675992798], "value": 4795.706032573692, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.2473719135263, 358.96769290763837, 360.3405767445575, 363.54012174599137, 364.0, 5175.922361164586, 5316.175992721134, 5421.186821976706, 5438.1510286502635, 5489.835304940853, 5132.871678208046, 5258.158694608864, 5259.526642602165, 5271.733154743469, 5291.153415453528, 4223.3031549794405, 4228.26005449046, 4233.343831706091, 4233.555476674951, 4234.237837189305, 4077.3068578341604, 4178.725488725938, 4215.557366476522, 4248.936265955997, 4265.826897603153, 4163.854265100722, 4164.687648426365, 4164.833406663745, 4166.8749937501925, 4179.289520781459, 4159.23054234966, 4166.791660416982, 4185.267578173838, 4186.35111557709, 4204.516480604739, 3750.662440380379, 3759.8120093995462, 3774.245150969817, 3776.2825063237897, 3786.734928555002, 5062.620303477254, 5174.43081261061, 5180.481951804827, 5187.19598462239, 5254.894902101936, 4798.664093513456, 4801.351817504662, 4801.879953001168, 4802.855914322576, 4813.735244561548, 5445.455454454563, 5548.809434575135, 5551.278333816578, 5560.193771903092, 5562.273276904483, 4074.5110586729784, 4089.9591004089875, 4099.795010249505, 4119.526254480743, 4127.133302006582, 5731.570132240098, 5750.87857867716, 5751.482366586985, 5777.133429985493, 5814.883702325972, 4200.201961627281, 4215.725977811432, 4227.534971153171, 4235.851745188966, 4238.385434112098, 4136.952208656734, 4234.597713217239, 4241.724287921275, 4245.596668316505, 4252.255855225323, 4767.189577771787, 4781.469929622487, 4783.569478746929, 4793.352897358882, 4807.326974223612, 5583.609147359646, 5587.357453892773, 5609.382967873531, 5617.831465055973, 5628.324601047901, 1307.895368370528, 1336.3562817734241, 1367.2548461088732, 1383.8823699985412, 1387.3479464651598, 966.7486453522135, 973.9172170365598, 982.3614650477247, 984.5175863826673, 991.4844280973854, 5184.5593124584075, 5209.088409528317, 5215.348081489814, 5239.29269548606, 5245.501677340647, 5485.4492660912865, 5499.075323636695, 5506.752196151183, 5527.44725527444, 5543.200683654729, 5123.359580052494, 5209.0, 5255.185446255837, 5299.2845965794895, 5407.675539467645, 2861.554914768029, 2889.5665650152646, 2919.3139612191117, 2924.5759364891974, 2928.6632037315553, 5707.914381284201, 5710.2576665033275, 5721.199032135504, 5755.942440575541, 5765.423457654201, 5470.56235501159, 5579.163125531121, 5602.915956260659, 5611.270534830446, 5626.352969408488, 5745.712714364265, 5771.538276937751, 5774.509166720792, 5775.440631029683, 5781.71091445426, 5373.9731301343245, 5539.473749993744, 5594.356648985418, 5600.355959064596, 5612.635178713371, 5471.206675032177, 5486.698231597141, 5492.340919089735, 5492.862678433071, 5494.697791621499, 5737.282839645044, 5787.305523337226, 5791.305043394819, 5795.0, 5811.79658711943, 3980.383040628707, 4070.3690927906223, 4071.2875246832277, 4172.582741725924, 4212.115455754326, 5460.754266058117, 5692.430756924275, 5723.8569035774435, 5725.7137143141845, 5726.255586773693, 5469.562435005269, 5478.643888147258, 5573.303337082864, 5586.86032849182, 5606.6636001840025, 5619.269494965628, 5620.915686264628, 5650.378458369658, 5662.98963867821, 5667.659940403589, 5328.57371410294, 5573.498385145356, 5597.972010139923, 5615.887682246251, 5625.0, 5671.517920976598, 5676.262085928803, 5689.431056894277, 5690.658560486384, 5691.601587888808, 5423.891522169455, 5548.528375088002, 5568.248286481436, 5601.747921343468, 5608.943910560843], "value": 4256.868040280877, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.3520845302627, 809.6073404398869, 850.366476974654, 852.2159613155897, 907.0566610724844, 14898.180600067006, 15920.601984950383, 16026.75959860603, 16089.115098669568, 16150.75773863393, 14832.18422986738, 15279.618009549768, 15766.132862692548, 15846.0, 16446.67106657866, 712.6650474277108, 738.8559230949967, 845.471580262336, 849.978750531237, 873.4366333714751, 849.7195925344653, 869.9478031318109, 870.0255713600776, 870.2646263906988, 870.4168207301124, 918.6141820435433, 918.9310801689867, 919.498873114151, 920.2086205862986, 920.5029284186531, 755.6939439527, 785.8742601183841, 873.5108339329995, 914.1041779056495, 914.4193437167413, 668.2448832818884, 672.3310306245318, 672.4149989509109, 672.4855485553555, 672.7342699633666, 15709.371625134982, 15721.213939302988, 15722.37110515578, 15762.0, 15819.52541423759, 13753.174809511362, 14195.219262940534, 14275.428982840675, 14307.21310327942, 14484.855151448455, 12820.461803241149, 12916.41876115577, 12922.353882305848, 13093.803592946113, 13851.376688049062, 3818.713596480275, 3891.5135608048995, 4487.663425243087, 4537.568930951555, 4562.977185114087, 63857.36142638561, 64564.3543564563, 64715.3528464714, 64965.67517162431, 65213.67393163051, 11082.279651822606, 11175.608853690082, 11183.552657893755, 11231.045361144232, 11519.71200719972, 20665.070071846803, 20695.8965205173, 20783.68824467634, 20831.16675333, 20860.687089693667, 8156.510609363457, 8247.628856701464, 8386.8322633547, 8439.746807595782, 8662.35032372562, 4719.433667959866, 4730.88172795676, 4780.091782561302, 4827.131116399082, 4851.902961940741, 3596.8381422836037, 3703.7407381483577, 3708.165662725919, 3749.887503374903, 3763.1532905096133, 633.9270983836918, 637.073058699591, 651.3876955661758, 659.9175103112111, 660.0165753027953, 745.9403247740167, 755.3353049316567, 765.8812884002989, 772.4052479590796, 785.1951749456853, 9386.624535018524, 9535.47554884488, 9731.41611503312, 9765.853512197322, 10351.896481035245, 693.9340762627543, 697.6407150317591, 699.8040548646387, 701.4809041309496, 720.585663243637, 4681.652618377876, 4804.2073057945745, 4845.1520983828395, 4897.045076210176, 4937.728424936663, 68750.65624671844, 89364.0, 91968.54015729879, 92237.0, 92459.0, 49956.0, 51330.0, 63014.0, 66141.33858661448, 79584.60207698925, 71922.0, 72287.63856180686, 74180.25819741841, 74570.62714686501, 74766.62616686882, 9616.855747163938, 9731.708048758548, 9761.170300524534, 9772.12050915421, 9826.508674566387, 47557.524424756695, 48682.0, 48968.75515622399, 49392.25911611401, 49891.25163122483, 62242.0, 68046.319536804, 68086.319136808, 68550.31449685639, 69113.0, 11745.588904388305, 11948.820767688318, 12112.636620901034, 12356.876431235572, 12392.81410778821, 12311.815322770344, 12325.198862073936, 13029.804552931902, 13045.412956416794, 13098.2141071536, 12310.938445307716, 12881.742365152832, 12943.417546210254, 13181.472741090249, 13498.86501134976, 12303.0, 12392.504299827906, 12647.304398258184, 12649.458485553594, 12815.42330595144, 11625.24435911663, 12215.144939854124, 12840.165389249669, 12843.100982931104, 12922.483100675867, 10572.629957951434, 10696.0, 10952.945235273774, 11024.5038973248, 11042.447877606248, 10818.729531761768, 11059.22585419013, 11271.887281127083, 11312.717182070513, 11338.376389298668], "value": 7371.282743445826, "unit": "score"}], "name": "dromaeo_css", "value": 7404.211568907318, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 111.0, 110.0, 111.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 122.0, 159.0, 119.0, 117.0, 121.0, 119.0, 145.0, 118.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 160.0, 160.0, 161.0, 160.0, 161.0, 167.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 108.0, 75.0, 75.0, 74.0, 73.0, 95.0, 74.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 106.0, 81.0, 81.0, 81.0, 96.0, 82.0, 81.0, 106.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 50.0, 51.0, 49.0, 52.0, 49.0, 50.0, 51.0, 50.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 59.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 81.0, 74.0, 75.0, 74.0, 78.0, 75.0, 74.0, 75.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 126.0, 130.0, 121.0, 122.0, 119.0, 127.0, 157.0, 122.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 153.0, 152.0, 154.0, 154.0, 151.0, 150.0, 152.0, 153.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 62.0, 66.0, 64.0, 61.0, 59.0, 59.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1441.1, "alertThreshold": 2.0}]} 09:10:07 INFO - Return code: 0 09:10:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:10:07 INFO - # TBPL SUCCESS # 09:10:07 INFO - Running post-action listener: _resource_record_post_action 09:10:07 INFO - [mozharness: 2017-01-12 17:10:07.121999Z] Finished run-tests step (success) 09:10:07 INFO - Running post-run listener: _resource_record_post_run 09:10:07 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 262144; Write bytes: 362205184; Read time: 8; Write time: 214092 09:10:07 INFO - TinderboxPrint: CPU usage
13.0% 09:10:07 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 8 09:10:07 INFO - TinderboxPrint: I/O write bytes / time
362,205,184 / 214,092 09:10:07 INFO - TinderboxPrint: CPU idle
8,265.3 (87.0%) 09:10:07 INFO - TinderboxPrint: CPU user
1,190.7 (12.5%) 09:10:07 INFO - TinderboxPrint: Swap in / out
0 / 0 09:10:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124166144; Read time: 0; Write time: 85260 09:10:07 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 237105152; Read time: 8; Write time: 128788 09:10:07 INFO - Running post-run listener: _upload_blobber_files 09:10:07 INFO - Blob upload gear active. 09:10:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:10:07 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:10:07 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:10:07 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:10:08 INFO - (blobuploader) - INFO - Open directory for files ... 09:10:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:10:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:10:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:09 INFO - (blobuploader) - INFO - Done attempting. 09:10:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:10:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:10:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:13 INFO - (blobuploader) - INFO - Done attempting. 09:10:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:10:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:10:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:14 INFO - (blobuploader) - INFO - Done attempting. 09:10:14 INFO - (blobuploader) - INFO - Iteration through files over. 09:10:14 INFO - Return code: 0 09:10:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:10:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:10:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52c80a9c45eec1f73264be867978fdaf9461a2ec46612bc1c4f522c486cccdd36889cbea8e943586f4aaefb297a017de35a8e1a35bfd116a995632a27bfd3051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc07765a28117aa40aca80f947fab8e0879d171e1b668f347659e8dc57134053485396aa660249af61f246f1a8eb57a25911875cf1ac99f909ef8279cae29af8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaca6ad55dfdce424b784aa88d1d0e1a5e04193865903c7bc215be4ed2896d136d2564638362bc3d3a1e8300f583b977461f281015b3ed5f633df9bbff85a0c6"} 09:10:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:10:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:10:14 INFO - Contents: 09:10:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/52c80a9c45eec1f73264be867978fdaf9461a2ec46612bc1c4f522c486cccdd36889cbea8e943586f4aaefb297a017de35a8e1a35bfd116a995632a27bfd3051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc07765a28117aa40aca80f947fab8e0879d171e1b668f347659e8dc57134053485396aa660249af61f246f1a8eb57a25911875cf1ac99f909ef8279cae29af8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaca6ad55dfdce424b784aa88d1d0e1a5e04193865903c7bc215be4ed2896d136d2564638362bc3d3a1e8300f583b977461f281015b3ed5f633df9bbff85a0c6"} 09:10:14 INFO - Running post-run listener: copy_logs_to_upload_dir 09:10:14 INFO - Copying logs to upload dir... 09:10:14 INFO - mkdir: /builds/slave/test/build/upload/logs 09:10:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.076363 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-12 09:10:13.442497) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:13.446813) ========= 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=826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441 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/52c80a9c45eec1f73264be867978fdaf9461a2ec46612bc1c4f522c486cccdd36889cbea8e943586f4aaefb297a017de35a8e1a35bfd116a995632a27bfd3051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc07765a28117aa40aca80f947fab8e0879d171e1b668f347659e8dc57134053485396aa660249af61f246f1a8eb57a25911875cf1ac99f909ef8279cae29af8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaca6ad55dfdce424b784aa88d1d0e1a5e04193865903c7bc215be4ed2896d136d2564638362bc3d3a1e8300f583b977461f281015b3ed5f633df9bbff85a0c6"} build_url:https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/PGs6GCrnRaetm1dZiNf0wQ/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/52c80a9c45eec1f73264be867978fdaf9461a2ec46612bc1c4f522c486cccdd36889cbea8e943586f4aaefb297a017de35a8e1a35bfd116a995632a27bfd3051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc07765a28117aa40aca80f947fab8e0879d171e1b668f347659e8dc57134053485396aa660249af61f246f1a8eb57a25911875cf1ac99f909ef8279cae29af8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaca6ad55dfdce424b784aa88d1d0e1a5e04193865903c7bc215be4ed2896d136d2564638362bc3d3a1e8300f583b977461f281015b3ed5f633df9bbff85a0c6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:13.472659) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:13.473033) ========= 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=826874ccc97bd7bf541b4875000001d5-1484239298.373941-2107808441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:13.557115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 09:10:13.557450) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 09:10:13.557764) ========= ========= Total master_lag: 0.16 =========