builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1475990340.38 results: success (0) buildid: 20161008193154 builduid: 45b5e64eaed1434ca7282953b5d21bc7 revision: 7a7ba250bb2f5a7cc7acf4b97145425c5292e894 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-08 22:19:00.384074) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-08 22:19:00.384483) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-08 22:19:00.384747) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-08 22:19:00.398996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 22:19:00.399258) ========= 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=337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-08 22:19:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-10-08 22:19:01 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.253706 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 22:19:00.675425) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 22:19:00.675695) ========= 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=337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022615 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 22:19:00.728439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 22:19:00.728726) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7a7ba250bb2f5a7cc7acf4b97145425c5292e894 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7a7ba250bb2f5a7cc7acf4b97145425c5292e894 --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=337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-08 22:19:01,420 truncating revision to first 12 chars 2016-10-08 22:19:01,420 Setting DEBUG logging. 2016-10-08 22:19:01,420 attempt 1/10 2016-10-08 22:19:01,420 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7a7ba250bb2f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-08 22:19:01,762 unpacking tar archive at: mozilla-central-7a7ba250bb2f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695179 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 22:19:01.436630) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-08 22:19:01.436908) ========= script_repo_revision: 7a7ba250bb2f5a7cc7acf4b97145425c5292e894 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-08 22:19:01.437332) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-08 22:19:01.437635) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-08 22:19:01.446433) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-08 22:19:01.446759) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:19:02 INFO - MultiFileLogger online at 20161008 22:19:02 in /builds/slave/test 22:19:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:19:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:19:02 INFO - {'append_to_log': False, 22:19:02 INFO - 'base_work_dir': '/builds/slave/test', 22:19:02 INFO - 'blob_upload_branch': 'Firefox', 22:19:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:19:02 INFO - 'branch': 'Firefox', 22:19:02 INFO - 'buildbot_json_path': 'buildprops.json', 22:19:02 INFO - 'config_files': ('talos/linux_config.py',), 22:19:02 INFO - 'default_actions': ('clobber', 22:19:02 INFO - 'read-buildbot-config', 22:19:02 INFO - 'download-and-extract', 22:19:02 INFO - 'populate-webroot', 22:19:02 INFO - 'create-virtualenv', 22:19:02 INFO - 'install', 22:19:02 INFO - 'run-tests'), 22:19:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:19:02 INFO - 'download_minidump_stackwalk': True, 22:19:02 INFO - 'download_symbols': 'ondemand', 22:19:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:19:02 INFO - 'tooltool.py': '/tools/tooltool.py', 22:19:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:19:02 INFO - '/tools/misc-python/virtualenv.py')}, 22:19:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:19:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:19:02 INFO - 'installer_path': 'installer.exe', 22:19:02 INFO - 'log_level': 'info', 22:19:02 INFO - 'log_name': 'talos', 22:19:02 INFO - 'log_to_console': True, 22:19:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:19:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:19:02 INFO - 'opt_config_files': (), 22:19:02 INFO - 'pip_index': False, 22:19:02 INFO - 'sps_profile': False, 22:19:02 INFO - 'sps_profile_interval': 0, 22:19:02 INFO - 'suite': 'dromaeojs', 22:19:02 INFO - 'system_bits': '32', 22:19:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:19:02 INFO - 'title': 'talos-linux64-ix-060', 22:19:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:19:02 INFO - 'use_talos_json': True, 22:19:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:19:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:19:02 INFO - 'work_dir': 'build'} 22:19:02 INFO - [mozharness: 2016-10-09 05:19:02.240399Z] Running clobber step. 22:19:02 INFO - Running pre-action listener: _resource_record_pre_action 22:19:02 INFO - Running main action method: clobber 22:19:02 INFO - rmtree: /builds/slave/test/build 22:19:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:19:02 INFO - Running post-action listener: _resource_record_post_action 22:19:02 INFO - [mozharness: 2016-10-09 05:19:02.702011Z] Finished clobber step (success) 22:19:02 INFO - [mozharness: 2016-10-09 05:19:02.702113Z] Running read-buildbot-config step. 22:19:02 INFO - Running pre-action listener: _resource_record_pre_action 22:19:02 INFO - Running main action method: read_buildbot_config 22:19:02 INFO - Using buildbot properties: 22:19:02 INFO - { 22:19:02 INFO - "project": "", 22:19:02 INFO - "product": "firefox", 22:19:02 INFO - "script_repo_revision": "production", 22:19:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:19:02 INFO - "repository": "", 22:19:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 22:19:02 INFO - "buildid": "20161008193154", 22:19:02 INFO - "pgo_build": "True", 22:19:02 INFO - "basedir": "/builds/slave/test", 22:19:02 INFO - "buildnumber": 27, 22:19:02 INFO - "slavename": "talos-linux64-ix-060", 22:19:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:19:02 INFO - "platform": "ubuntu64_hw", 22:19:02 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:19:02 INFO - "branch": "mozilla-central", 22:19:02 INFO - "repo_path": "mozilla-central", 22:19:02 INFO - "revision": "7a7ba250bb2f5a7cc7acf4b97145425c5292e894", 22:19:02 INFO - "stage_platform": "linux64-pgo", 22:19:02 INFO - "builduid": "45b5e64eaed1434ca7282953b5d21bc7", 22:19:02 INFO - "slavebuilddir": "test" 22:19:02 INFO - } 22:19:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:19:02 INFO - Running post-action listener: _resource_record_post_action 22:19:02 INFO - [mozharness: 2016-10-09 05:19:02.704542Z] Finished read-buildbot-config step (success) 22:19:02 INFO - [mozharness: 2016-10-09 05:19:02.704631Z] Running download-and-extract step. 22:19:02 INFO - Running pre-action listener: _resource_record_pre_action 22:19:02 INFO - Running main action method: download_and_extract 22:19:02 INFO - mkdir: /builds/slave/test/build/tests 22:19: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')]} 22:19:02 INFO - trying https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:19:02 INFO - Downloading https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:19:03 INFO - Downloaded 1361 bytes. 22:19:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:19:03 INFO - Using the following test package requirements: 22:19:03 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:19:03 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:19:03 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:19:03 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:03 INFO - u'jsshell-linux-x86_64.zip'], 22:19:03 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:19:03 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:19:03 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:19:03 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:19:03 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:19:03 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:19:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:19:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:19:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:19:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:19:03 INFO - Fetch https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:19:03 INFO - Http code: 200 22:19:03 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 22:19:03 INFO - x-amz-cf-id: jXAuX86anvMtCbryBSXd65vKXUapz3-ZVqtYcbf64TJtAZYUS7Guug== 22:19:03 INFO - x-amz-version-id: zf9EivTztI7hOYZl58V4bYmjFJpiCJDs 22:19:04 INFO - Expected file size: 22096486 22:19:04 INFO - Obtained file size: 22096486 22:19:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:19:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:19:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:19:08 INFO - Fetch https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:19:08 INFO - Http code: 200 22:19:08 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 22:19:08 INFO - x-amz-cf-id: tz8REH5l0jTmqzJa6_CWIU-iu2uiSB3iqyRQX-X8LCauqAlZVM-JtQ== 22:19:08 INFO - x-amz-version-id: zf9EivTztI7hOYZl58V4bYmjFJpiCJDs 22:19:09 INFO - Expected file size: 22096486 22:19:09 INFO - Obtained file size: 22096486 22:19:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:19:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:19:13 INFO - Fetch https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:19:14 INFO - Http code: 200 22:19:14 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 22:19:14 INFO - x-amz-cf-id: lT8KAPE3rXblecYfzcACZ6O3arhTYjSnFiaEcShZrLF-qU80uAkmtg== 22:19:14 INFO - x-amz-version-id: O8BiYHlVMHMunZXju3HUK._b0NcHNBDx 22:19:14 INFO - Expected file size: 14409006 22:19:14 INFO - Obtained file size: 14409006 22:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:14 INFO - trying https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:19:14 INFO - Downloading https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:19:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:19:16 INFO - Downloaded 59734224 bytes. 22:19:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:19:16 INFO - mkdir: /builds/slave/test/properties 22:19:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:19:16 INFO - Writing to file /builds/slave/test/properties/build_url 22:19:16 INFO - Contents: 22:19:16 INFO - build_url:https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:19:16 INFO - Running post-action listener: _resource_record_post_action 22:19:16 INFO - Running post-action listener: set_extra_try_arguments 22:19:16 INFO - [mozharness: 2016-10-09 05:19:16.755514Z] Finished download-and-extract step (success) 22:19:16 INFO - [mozharness: 2016-10-09 05:19:16.755742Z] Running populate-webroot step. 22:19:16 INFO - Running pre-action listener: _resource_record_pre_action 22:19:16 INFO - Running main action method: populate_webroot 22:19:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:19:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:19:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:19:16 INFO - '--tppagecycles', 22:19:16 INFO - '7'], 22:19:16 INFO - 'tests': ['tsvgm']}}, 22:19:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:19:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:19:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:19:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:19:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:19:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:19:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['damp', 'tps']}, 22:19:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'tests': ['damp', 'tps']}, 22:19:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['dromaeo_dom']}, 22:19:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:19:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['basic_compositor_video']}, 22:19:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:19:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['a11yr', 22:19:16 INFO - 'ts_paint', 22:19:16 INFO - 'tpaint', 22:19:16 INFO - 'sessionrestore', 22:19:16 INFO - 'sessionrestore_no_auto_restore', 22:19:16 INFO - 'tabpaint']}, 22:19:16 INFO - 'other-e10s': {'tests': ['a11yr', 22:19:16 INFO - 'ts_paint', 22:19:16 INFO - 'tpaint', 22:19:16 INFO - 'sessionrestore', 22:19:16 INFO - 'sessionrestore_no_auto_restore', 22:19:16 INFO - 'tabpaint']}, 22:19:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:19:16 INFO - 'ts_paint', 22:19:16 INFO - 'tpaint', 22:19:16 INFO - 'sessionrestore', 22:19:16 INFO - 'sessionrestore_no_auto_restore', 22:19:16 INFO - 'tabpaint']}, 22:19:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:19:16 INFO - 'ts_paint', 22:19:16 INFO - 'tpaint', 22:19:16 INFO - 'sessionrestore', 22:19:16 INFO - 'sessionrestore_no_auto_restore', 22:19:16 INFO - 'tabpaint']}, 22:19:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['a11yr', 22:19:16 INFO - 'ts_paint', 22:19:16 INFO - 'tpaint', 22:19:16 INFO - 'sessionrestore', 22:19:16 INFO - 'sessionrestore_no_auto_restore', 22:19:16 INFO - 'tabpaint']}, 22:19:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['a11yr', 22:19:16 INFO - 'ts_paint', 22:19:16 INFO - 'tpaint', 22:19:16 INFO - 'sessionrestore', 22:19:16 INFO - 'sessionrestore_no_auto_restore', 22:19:16 INFO - 'tabpaint']}, 22:19:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['tsvgx', 22:19:16 INFO - 'tsvgr_opacity', 22:19:16 INFO - 'tart', 22:19:16 INFO - 'tscrollx', 22:19:16 INFO - 'cart']}, 22:19:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:19:16 INFO - 'tsvgr_opacity', 22:19:16 INFO - 'tart', 22:19:16 INFO - 'tscrollx', 22:19:16 INFO - 'cart']}, 22:19:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'talos_options': ['--disable-e10s'], 22:19:16 INFO - 'tests': ['tp5o']}, 22:19:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'tests': ['tp5o']}, 22:19:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'talos_options': ['--disable-e10s', 22:19:16 INFO - '--xperf_path', 22:19:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:19:16 INFO - 'tests': ['tp5n']}, 22:19:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:19:16 INFO - 'talos_options': ['--xperf_path', 22:19:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:19:16 INFO - 'tests': ['tp5n']}}, 22:19:16 INFO - 'talos.zip': {'path': '', 22:19:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:19:16 INFO - Running post-action listener: _resource_record_post_action 22:19:16 INFO - [mozharness: 2016-10-09 05:19:16.777626Z] Finished populate-webroot step (success) 22:19:16 INFO - [mozharness: 2016-10-09 05:19:16.777715Z] Running create-virtualenv step. 22:19:16 INFO - Running pre-action listener: _resource_record_pre_action 22:19:16 INFO - Running main action method: create_virtualenv 22:19:16 INFO - Creating virtualenv /builds/slave/test/build/venv 22:19:16 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 22:19:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:19:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:19:16 INFO - Using real prefix '/usr' 22:19:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:19:17 INFO - Installing distribute.............................................................................................................................................................................................done. 22:19:19 INFO - Installing pip.................done. 22:19:19 INFO - Return code: 0 22:19:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:19:19 INFO - Reading from file tmpfile_stdout 22:19:19 INFO - Output received: 22:19:19 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) 22:19:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:19:19 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')]} 22:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:19 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')]} 22:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:19 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 0x7fa9af2a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58930>, '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 0x1b59830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', '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 22:19:19 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 22:19:19 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 22:19:19 INFO - Using env: {'DISPLAY': ':0', 22:19:19 INFO - 'HOME': '/home/cltbld', 22:19:19 INFO - 'LANG': 'en_US.UTF-8', 22:19:19 INFO - 'LANGUAGE': 'en_US:en', 22:19:19 INFO - 'LOGNAME': 'cltbld', 22:19:19 INFO - 'MAIL': '/var/mail/cltbld', 22:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:19 INFO - 'MOZ_NO_REMOTE': '1', 22:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:19 INFO - 'NO_EM_RESTART': '1', 22:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:19 INFO - 'PWD': '/builds/slave/test', 22:19:19 INFO - 'SHELL': '/bin/bash', 22:19:19 INFO - 'SHLVL': '1', 22:19:19 INFO - 'TERM': 'linux', 22:19:19 INFO - 'TMOUT': '86400', 22:19:19 INFO - 'USER': 'cltbld', 22:19:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', 22:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:19 INFO - '_': '/tools/buildbot/bin/python'} 22:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:19 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 22:19:19 INFO - Cleaning up... 22:19:19 INFO - Return code: 0 22:19:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:19:19 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')]} 22:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:19 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')]} 22:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:19 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 0x7fa9af2a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58930>, '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 0x1b59830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', '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 22:19:19 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 22:19:19 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 22:19:19 INFO - Using env: {'DISPLAY': ':0', 22:19:19 INFO - 'HOME': '/home/cltbld', 22:19:19 INFO - 'LANG': 'en_US.UTF-8', 22:19:19 INFO - 'LANGUAGE': 'en_US:en', 22:19:19 INFO - 'LOGNAME': 'cltbld', 22:19:19 INFO - 'MAIL': '/var/mail/cltbld', 22:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:19 INFO - 'MOZ_NO_REMOTE': '1', 22:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:19 INFO - 'NO_EM_RESTART': '1', 22:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:19 INFO - 'PWD': '/builds/slave/test', 22:19:19 INFO - 'SHELL': '/bin/bash', 22:19:19 INFO - 'SHLVL': '1', 22:19:19 INFO - 'TERM': 'linux', 22:19:19 INFO - 'TMOUT': '86400', 22:19:19 INFO - 'USER': 'cltbld', 22:19:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', 22:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:19 INFO - '_': '/tools/buildbot/bin/python'} 22:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:19 INFO - Downloading/unpacking psutil>=3.1.1 22:19:19 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 22:19:19 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 22:19:19 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 22:19:19 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 22:19:19 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 22:19:19 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 22:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:19:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:19:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:19:22 INFO - Installing collected packages: psutil 22:19:22 INFO - Running setup.py install for psutil 22:19:22 INFO - building 'psutil._psutil_linux' extension 22:19:22 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 22:19:22 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 22:19:22 INFO - building 'psutil._psutil_posix' extension 22:19:22 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 22:19:22 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 22:19:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:19:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:19:22 INFO - Successfully installed psutil 22:19:22 INFO - Cleaning up... 22:19:22 INFO - Return code: 0 22:19:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:19:22 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')]} 22:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:22 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')]} 22:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:22 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 0x7fa9af2a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58930>, '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 0x1b59830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', '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 22:19:22 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 22:19:22 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 22:19:22 INFO - Using env: {'DISPLAY': ':0', 22:19:22 INFO - 'HOME': '/home/cltbld', 22:19:22 INFO - 'LANG': 'en_US.UTF-8', 22:19:22 INFO - 'LANGUAGE': 'en_US:en', 22:19:22 INFO - 'LOGNAME': 'cltbld', 22:19:22 INFO - 'MAIL': '/var/mail/cltbld', 22:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:22 INFO - 'MOZ_NO_REMOTE': '1', 22:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:22 INFO - 'NO_EM_RESTART': '1', 22:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:22 INFO - 'PWD': '/builds/slave/test', 22:19:22 INFO - 'SHELL': '/bin/bash', 22:19:22 INFO - 'SHLVL': '1', 22:19:22 INFO - 'TERM': 'linux', 22:19:22 INFO - 'TMOUT': '86400', 22:19:22 INFO - 'USER': 'cltbld', 22:19:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', 22:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:22 INFO - '_': '/tools/buildbot/bin/python'} 22:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:19:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:19:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:19:24 INFO - Installing collected packages: mozsystemmonitor 22:19:24 INFO - Running setup.py install for mozsystemmonitor 22:19:24 INFO - Successfully installed mozsystemmonitor 22:19:24 INFO - Cleaning up... 22:19:24 INFO - Return code: 0 22:19:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:24 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 0x7fa9af2a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58930>, '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 0x1b59830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', '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 22:19:24 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 22:19:24 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 22:19:24 INFO - Using env: {'DISPLAY': ':0', 22:19:24 INFO - 'HOME': '/home/cltbld', 22:19:24 INFO - 'LANG': 'en_US.UTF-8', 22:19:24 INFO - 'LANGUAGE': 'en_US:en', 22:19:24 INFO - 'LOGNAME': 'cltbld', 22:19:24 INFO - 'MAIL': '/var/mail/cltbld', 22:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:24 INFO - 'MOZ_NO_REMOTE': '1', 22:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:24 INFO - 'NO_EM_RESTART': '1', 22:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:24 INFO - 'PWD': '/builds/slave/test', 22:19:24 INFO - 'SHELL': '/bin/bash', 22:19:24 INFO - 'SHLVL': '1', 22:19:24 INFO - 'TERM': 'linux', 22:19:24 INFO - 'TMOUT': '86400', 22:19:24 INFO - 'USER': 'cltbld', 22:19:24 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', 22:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:24 INFO - '_': '/tools/buildbot/bin/python'} 22:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:25 INFO - Downloading/unpacking jsonschema==2.5.1 22:19:25 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 22:19:25 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 22:19:25 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 22:19:25 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 22:19:25 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 22:19:25 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 22:19:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:19:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:19:27 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 22:19:27 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 22:19:27 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 22:19:27 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 22:19:27 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 22:19:27 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 22:19:27 INFO - Downloading functools32-3.2.3-2.tar.gz 22:19:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:19:27 INFO - warning: no files found matching '*.txt' 22:19:27 INFO - no previously-included directories found matching 'build' 22:19:27 INFO - no previously-included directories found matching 'dist' 22:19:27 INFO - no previously-included directories found matching '.git*' 22:19:27 INFO - Installing collected packages: jsonschema, functools32 22:19:27 INFO - Running setup.py install for functools32 22:19:27 INFO - warning: no files found matching '*.txt' 22:19:27 INFO - no previously-included directories found matching 'build' 22:19:27 INFO - no previously-included directories found matching 'dist' 22:19:27 INFO - no previously-included directories found matching '.git*' 22:19:27 INFO - Successfully installed jsonschema functools32 22:19:27 INFO - Cleaning up... 22:19:27 INFO - Return code: 0 22:19:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:27 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 0x7fa9af2a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58930>, '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 0x1b59830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', '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 22:19:27 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 22:19:27 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 22:19:27 INFO - Using env: {'DISPLAY': ':0', 22:19:27 INFO - 'HOME': '/home/cltbld', 22:19:27 INFO - 'LANG': 'en_US.UTF-8', 22:19:27 INFO - 'LANGUAGE': 'en_US:en', 22:19:27 INFO - 'LOGNAME': 'cltbld', 22:19:27 INFO - 'MAIL': '/var/mail/cltbld', 22:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:27 INFO - 'MOZ_NO_REMOTE': '1', 22:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:27 INFO - 'NO_EM_RESTART': '1', 22:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:27 INFO - 'PWD': '/builds/slave/test', 22:19:27 INFO - 'SHELL': '/bin/bash', 22:19:27 INFO - 'SHLVL': '1', 22:19:27 INFO - 'TERM': 'linux', 22:19:27 INFO - 'TMOUT': '86400', 22:19:27 INFO - 'USER': 'cltbld', 22:19:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', 22:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:27 INFO - '_': '/tools/buildbot/bin/python'} 22:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:19:27 INFO - Cleaning up... 22:19:27 INFO - Return code: 0 22:19:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:27 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 0x7fa9af2a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58930>, '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 0x1b59830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', '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 22:19:27 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 22:19:27 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 22:19:27 INFO - Using env: {'DISPLAY': ':0', 22:19:27 INFO - 'HOME': '/home/cltbld', 22:19:27 INFO - 'LANG': 'en_US.UTF-8', 22:19:27 INFO - 'LANGUAGE': 'en_US:en', 22:19:27 INFO - 'LOGNAME': 'cltbld', 22:19:27 INFO - 'MAIL': '/var/mail/cltbld', 22:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:27 INFO - 'MOZ_NO_REMOTE': '1', 22:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:27 INFO - 'NO_EM_RESTART': '1', 22:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:27 INFO - 'PWD': '/builds/slave/test', 22:19:27 INFO - 'SHELL': '/bin/bash', 22:19:27 INFO - 'SHLVL': '1', 22:19:27 INFO - 'TERM': 'linux', 22:19:27 INFO - 'TMOUT': '86400', 22:19:27 INFO - 'USER': 'cltbld', 22:19:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', 22:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:27 INFO - '_': '/tools/buildbot/bin/python'} 22:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:27 INFO - Downloading/unpacking blobuploader==1.2.4 22:19:27 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 22:19:27 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 22:19:27 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 22:19:27 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 22:19:27 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 22:19:27 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 22:19:29 INFO - Downloading blobuploader-1.2.4.tar.gz 22:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:19:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:19:29 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 22:19:29 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 22:19:29 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 22:19:29 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 22:19:29 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 22:19:29 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 22:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:19:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:19:30 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 22:19:30 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 22:19:30 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 22:19:30 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 22:19:30 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 22:19:30 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 22:19:30 INFO - Downloading docopt-0.6.1.tar.gz 22:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:19:30 INFO - Installing collected packages: blobuploader, requests, docopt 22:19:30 INFO - Running setup.py install for blobuploader 22:19:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:19:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:19:30 INFO - Running setup.py install for requests 22:19:31 INFO - Running setup.py install for docopt 22:19:31 INFO - Successfully installed blobuploader requests docopt 22:19:31 INFO - Cleaning up... 22:19:31 INFO - Return code: 0 22:19:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:31 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')]} 22:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:31 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')]} 22:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:31 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 0x7fa9af2a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58930>, '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 0x1b59830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', '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 22:19:31 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 22:19:31 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 22:19:31 INFO - Using env: {'DISPLAY': ':0', 22:19:31 INFO - 'HOME': '/home/cltbld', 22:19:31 INFO - 'LANG': 'en_US.UTF-8', 22:19:31 INFO - 'LANGUAGE': 'en_US:en', 22:19:31 INFO - 'LOGNAME': 'cltbld', 22:19:31 INFO - 'MAIL': '/var/mail/cltbld', 22:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:31 INFO - 'MOZ_NO_REMOTE': '1', 22:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:31 INFO - 'NO_EM_RESTART': '1', 22:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:31 INFO - 'PWD': '/builds/slave/test', 22:19:31 INFO - 'SHELL': '/bin/bash', 22:19:31 INFO - 'SHLVL': '1', 22:19:31 INFO - 'TERM': 'linux', 22:19:31 INFO - 'TMOUT': '86400', 22:19:31 INFO - 'USER': 'cltbld', 22:19:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', 22:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:31 INFO - '_': '/tools/buildbot/bin/python'} 22:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:19:31 INFO - Running setup.py (path:/tmp/pip-5svE8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:19:31 INFO - Running setup.py (path:/tmp/pip-Dbdf_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:19:31 INFO - Running setup.py (path:/tmp/pip-5O4zBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:19:31 INFO - Running setup.py (path:/tmp/pip-J3chAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:19:31 INFO - Running setup.py (path:/tmp/pip-cvIvFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:19:31 INFO - Running setup.py (path:/tmp/pip-0wPznX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:19:31 INFO - Running setup.py (path:/tmp/pip-kpVAvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:19:32 INFO - Running setup.py (path:/tmp/pip-Sk5sgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:19:32 INFO - Running setup.py (path:/tmp/pip-87q_yP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:19:32 INFO - Running setup.py (path:/tmp/pip-a81NhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:19:32 INFO - Running setup.py (path:/tmp/pip-yp5BTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:19:32 INFO - Running setup.py (path:/tmp/pip-YzL7d1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:19:32 INFO - Running setup.py (path:/tmp/pip-mzeS0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:19:32 INFO - Running setup.py (path:/tmp/pip-vvDEEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:32 INFO - Running setup.py (path:/tmp/pip-c1H5yQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:19:32 INFO - Running setup.py (path:/tmp/pip-n0VYW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:19:32 INFO - Running setup.py (path:/tmp/pip-7xPa8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:19:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:19:32 INFO - Running setup.py install for manifestparser 22:19:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:19:32 INFO - Running setup.py install for mozcrash 22:19:32 INFO - Running setup.py install for mozdebug 22:19:33 INFO - Running setup.py install for mozdevice 22:19:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Running setup.py install for mozfile 22:19:33 INFO - Running setup.py install for mozhttpd 22:19:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Running setup.py install for mozinfo 22:19:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Running setup.py install for mozInstall 22:19:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Running setup.py install for mozleak 22:19:33 INFO - Running setup.py install for mozlog 22:19:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Running setup.py install for moznetwork 22:19:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:19:33 INFO - Running setup.py install for mozprocess 22:19:34 INFO - Running setup.py install for mozprofile 22:19:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:19:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:19:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:19:34 INFO - Running setup.py install for mozrunner 22:19:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:19:34 INFO - Running setup.py install for mozscreenshot 22:19:34 INFO - Running setup.py install for moztest 22:19:34 INFO - Running setup.py install for mozversion 22:19:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:19:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:19:34 INFO - Cleaning up... 22:19:34 INFO - Return code: 0 22:19:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:34 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')]} 22:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:34 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')]} 22:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:34 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 0x7fa9af2a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58930>, '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 0x1b59830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', '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 22:19:34 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 22:19:34 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 22:19:34 INFO - Using env: {'DISPLAY': ':0', 22:19:34 INFO - 'HOME': '/home/cltbld', 22:19:34 INFO - 'LANG': 'en_US.UTF-8', 22:19:34 INFO - 'LANGUAGE': 'en_US:en', 22:19:34 INFO - 'LOGNAME': 'cltbld', 22:19:34 INFO - 'MAIL': '/var/mail/cltbld', 22:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:34 INFO - 'MOZ_NO_REMOTE': '1', 22:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:34 INFO - 'NO_EM_RESTART': '1', 22:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:34 INFO - 'PWD': '/builds/slave/test', 22:19:34 INFO - 'SHELL': '/bin/bash', 22:19:34 INFO - 'SHLVL': '1', 22:19:34 INFO - 'TERM': 'linux', 22:19:34 INFO - 'TMOUT': '86400', 22:19:34 INFO - 'USER': 'cltbld', 22:19:34 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', 22:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:34 INFO - '_': '/tools/buildbot/bin/python'} 22:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:19:34 INFO - Running setup.py (path:/tmp/pip-U96pmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:19:34 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)) 22:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:19:34 INFO - Running setup.py (path:/tmp/pip-lYo29_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:19:34 INFO - Running setup.py (path:/tmp/pip-ZEByoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:19:34 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)) 22:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:19:35 INFO - Running setup.py (path:/tmp/pip-6jAvKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:19:35 INFO - Running setup.py (path:/tmp/pip-1AL6I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:19:35 INFO - Running setup.py (path:/tmp/pip-HA44qQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:19:35 INFO - Running setup.py (path:/tmp/pip-BhYeXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:19:35 INFO - Running setup.py (path:/tmp/pip-piH_jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:19:35 INFO - Running setup.py (path:/tmp/pip-WNwEJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:19:35 INFO - Running setup.py (path:/tmp/pip-SpdEvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:19:35 INFO - Running setup.py (path:/tmp/pip-9JEvp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:19:35 INFO - Running setup.py (path:/tmp/pip-AcXYVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:19:35 INFO - Running setup.py (path:/tmp/pip-l88Qcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:19:35 INFO - Running setup.py (path:/tmp/pip-KcR78e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:35 INFO - Running setup.py (path:/tmp/pip-p72VUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:19:35 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)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:19:35 INFO - Running setup.py (path:/tmp/pip-DLaC3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:19:35 INFO - Running setup.py (path:/tmp/pip-8T0pX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:19:36 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)) 22:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:19:36 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)) 22:19:36 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)) 22:19:36 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)) 22:19:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:19:36 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 22:19:36 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 22:19:36 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 22:19:36 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 22:19:36 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 22:19:36 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 22:19:37 INFO - Downloading blessings-1.6.tar.gz 22:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:19:38 INFO - Installing collected packages: blessings 22:19:38 INFO - Running setup.py install for blessings 22:19:38 INFO - Successfully installed blessings 22:19:38 INFO - Cleaning up... 22:19:38 INFO - Return code: 0 22:19:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:19:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:19:38 INFO - Reading from file tmpfile_stdout 22:19:38 INFO - Current package versions: 22:19:38 INFO - argparse == 1.2.1 22:19:38 INFO - blessings == 1.6 22:19:38 INFO - blobuploader == 1.2.4 22:19:38 INFO - docopt == 0.6.1 22:19:38 INFO - functools32 == 3.2.3-2 22:19:38 INFO - jsonschema == 2.5.1 22:19:38 INFO - manifestparser == 1.1 22:19:38 INFO - mozInstall == 1.12 22:19:38 INFO - mozcrash == 0.17 22:19:38 INFO - mozdebug == 0.1 22:19:38 INFO - mozdevice == 0.48 22:19:38 INFO - mozfile == 1.2 22:19:38 INFO - mozhttpd == 0.7 22:19:38 INFO - mozinfo == 0.9 22:19:38 INFO - mozleak == 0.1 22:19:38 INFO - mozlog == 3.4 22:19:38 INFO - moznetwork == 0.27 22:19:38 INFO - mozprocess == 0.23 22:19:38 INFO - mozprofile == 0.28 22:19:38 INFO - mozrunner == 6.12 22:19:38 INFO - mozscreenshot == 0.1 22:19:38 INFO - mozsystemmonitor == 0.3 22:19:38 INFO - moztest == 0.7 22:19:38 INFO - mozversion == 1.4 22:19:38 INFO - psutil == 3.1.1 22:19:38 INFO - requests == 1.2.3 22:19:38 INFO - wsgiref == 0.1.2 22:19:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:38 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 0x7fa9af2a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58930>, '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 0x1b59830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', '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 22:19:38 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 22:19:38 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 22:19:38 INFO - Using env: {'DISPLAY': ':0', 22:19:38 INFO - 'HOME': '/home/cltbld', 22:19:38 INFO - 'LANG': 'en_US.UTF-8', 22:19:38 INFO - 'LANGUAGE': 'en_US:en', 22:19:38 INFO - 'LOGNAME': 'cltbld', 22:19:38 INFO - 'MAIL': '/var/mail/cltbld', 22:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:38 INFO - 'MOZ_NO_REMOTE': '1', 22:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:38 INFO - 'NO_EM_RESTART': '1', 22:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:38 INFO - 'PWD': '/builds/slave/test', 22:19:38 INFO - 'SHELL': '/bin/bash', 22:19:38 INFO - 'SHLVL': '1', 22:19:38 INFO - 'TERM': 'linux', 22:19:38 INFO - 'TMOUT': '86400', 22:19:38 INFO - 'USER': 'cltbld', 22:19:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', 22:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:38 INFO - '_': '/tools/buildbot/bin/python'} 22:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 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)) 22:19:38 INFO - Cleaning up... 22:19:38 INFO - Return code: 0 22:19:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:19:38 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 0x7fa9af2a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b5b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58930>, '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 0x1b59830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', '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 22:19:38 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 22:19:38 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 22:19:38 INFO - Using env: {'DISPLAY': ':0', 22:19:38 INFO - 'HOME': '/home/cltbld', 22:19:38 INFO - 'LANG': 'en_US.UTF-8', 22:19:38 INFO - 'LANGUAGE': 'en_US:en', 22:19:38 INFO - 'LOGNAME': 'cltbld', 22:19:38 INFO - 'MAIL': '/var/mail/cltbld', 22:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:38 INFO - 'MOZ_NO_REMOTE': '1', 22:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:38 INFO - 'NO_EM_RESTART': '1', 22:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:38 INFO - 'PWD': '/builds/slave/test', 22:19:38 INFO - 'SHELL': '/bin/bash', 22:19:38 INFO - 'SHLVL': '1', 22:19:38 INFO - 'TERM': 'linux', 22:19:38 INFO - 'TMOUT': '86400', 22:19:38 INFO - 'USER': 'cltbld', 22:19:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', 22:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:38 INFO - '_': '/tools/buildbot/bin/python'} 22:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:19:38 INFO - Cleaning up... 22:19:38 INFO - Return code: 0 22:19:38 INFO - Running post-action listener: _resource_record_post_action 22:19:38 INFO - Running post-action listener: _start_resource_monitoring 22:19:38 INFO - Starting resource monitoring. 22:19:38 INFO - [mozharness: 2016-10-09 05:19:38.902841Z] Finished create-virtualenv step (success) 22:19:38 INFO - [mozharness: 2016-10-09 05:19:38.903313Z] Running install step. 22:19:38 INFO - Running pre-action listener: _resource_record_pre_action 22:19:38 INFO - Running main action method: install 22:19:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:19:39 INFO - Reading from file tmpfile_stdout 22:19:39 INFO - Detecting whether we're running mozinstall >=1.0... 22:19:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:19:39 INFO - Reading from file tmpfile_stdout 22:19:39 INFO - Output received: 22:19:39 INFO - Usage: mozinstall [options] installer 22:19:39 INFO - Options: 22:19:39 INFO - -h, --help show this help message and exit 22:19:39 INFO - -d DEST, --destination=DEST 22:19:39 INFO - Directory to install application into. [default: 22:19:39 INFO - "/builds/slave/test"] 22:19:39 INFO - --app=APP Application being installed. [default: firefox] 22:19:39 INFO - mkdir: /builds/slave/test/build/application 22:19:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:19:56 INFO - Reading from file tmpfile_stdout 22:19:56 INFO - Output received: 22:19:56 INFO - /builds/slave/test/build/application/firefox/firefox 22:19:56 INFO - Running post-action listener: _resource_record_post_action 22:19:56 INFO - [mozharness: 2016-10-09 05:19:56.217183Z] Finished install step (success) 22:19:56 INFO - [mozharness: 2016-10-09 05:19:56.217485Z] Running run-tests step. 22:19:56 INFO - Running pre-action listener: _resource_record_pre_action 22:19:56 INFO - Running main action method: run_tests 22:19:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:19:56 INFO - Python 2.7.3 22:19:56 INFO - Return code: 0 22:19:56 INFO - grabbing minidump binary from tooltool 22:19: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')]} 22:19:56 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 0x1b58930>, '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 0x1b59830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b59cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:19:56 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 22:19:56 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 22:19:56 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 22:19:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:19:56 INFO - Return code: 0 22:19:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:19:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:19:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:19:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:19:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:19:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 22:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 22:19:56 INFO - Using env: {'DISPLAY': ':0', 22:19:56 INFO - 'HOME': '/home/cltbld', 22:19:56 INFO - 'LANG': 'en_US.UTF-8', 22:19:56 INFO - 'LANGUAGE': 'en_US:en', 22:19:56 INFO - 'LOGNAME': 'cltbld', 22:19:56 INFO - 'MAIL': '/var/mail/cltbld', 22:19:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:19:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:19:56 INFO - 'MOZ_NO_REMOTE': '1', 22:19:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:19:56 INFO - 'NO_EM_RESTART': '1', 22:19:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:19:56 INFO - 'PWD': '/builds/slave/test', 22:19:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:19:56 INFO - 'SHELL': '/bin/bash', 22:19:56 INFO - 'SHLVL': '1', 22:19:56 INFO - 'TERM': 'linux', 22:19:56 INFO - 'TMOUT': '86400', 22:19:56 INFO - 'USER': 'cltbld', 22:19:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403', 22:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:19:56 INFO - '_': '/tools/buildbot/bin/python'} 22:19:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 22:19:56 INFO - mozversion application_buildid: 20161008193154 22:19:56 INFO - mozversion application_changeset: 7a7ba250bb2f5a7cc7acf4b97145425c5292e894 22:19:56 INFO - mozversion application_display_name: Nightly 22:19:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:19:56 INFO - mozversion application_name: Firefox 22:19:56 INFO - mozversion application_remotingname: firefox 22:19:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:19:56 INFO - mozversion application_vendor: Mozilla 22:19:56 INFO - mozversion application_version: 52.0a1 22:19:56 INFO - mozversion platform_buildid: 20161008193154 22:19:56 INFO - mozversion platform_changeset: 7a7ba250bb2f5a7cc7acf4b97145425c5292e894 22:19:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:19:56 INFO - mozversion platform_version: 52.0a1 22:19:56 INFO - using testdate: 1475990396 22:19:56 INFO - actual date: 1475990396 22:19:56 INFO - starting webserver on 'localhost:48945' 22:19:56 INFO - SUITE-START | Running 2 tests 22:19:56 INFO - TEST-START | dromaeo_css 22:19:56 INFO - operating with platform_type : linux_ 22:19:56 INFO - Initialising browser for dromaeo_css test... 22:19:56 INFO - TEST-INFO | started process 8629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprtiLAW/profile http://localhost:48945/getInfo.html) 22:20:00 INFO - PROCESS | 8629 | __metrics Screen width/height:1600/1200 22:20:00 INFO - PROCESS | 8629 | colorDepth:24 22:20:00 INFO - PROCESS | 8629 | Browser inner width/height: 1024/697 22:20:00 INFO - PROCESS | 8629 | __metrics 22:20:01 INFO - PROCESS | 8629 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:20:01 INFO - PROCESS | 8629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:20:01 INFO - PROCESS | 8629 | console.error: PushService: 22:20:01 INFO - PROCESS | 8629 | stateChangeProcessEnqueue: Error transitioning state 22:20:01 INFO - PROCESS | 8629 | UnknownError 22:20:02 INFO - TEST-INFO | 8629: exit 0 22:20:02 INFO - Browser initialized. 22:20:02 INFO - Running cycle 1/1 for dromaeo_css test... 22:20:02 INFO - TEST-INFO | started process 8714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprtiLAW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:14 INFO - PROCESS | 8714 | RSS: Main: 172830720 22:20:14 INFO - PROCESS | 8714 | 22:21:06 INFO - PROCESS | 8714 | 1475990466107 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:23:16 INFO - PROCESS | 8714 | Cycle 1(1): loaded http://localhost:48945/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48945/tests/dromaeo/cssquery-ext.html) 22:23:17 INFO - PROCESS | 8714 | RSS: Main: 304197632 22:23:17 INFO - PROCESS | 8714 | 22:26:20 INFO - PROCESS | 8714 | Cycle 1(1): loaded http://localhost:48945/tests/dromaeo/cssquery-ext.html (next: http://localhost:48945/tests/dromaeo/cssquery-jquery.html) 22:26:20 INFO - PROCESS | 8714 | RSS: Main: 275828736 22:26:20 INFO - PROCESS | 8714 | 22:29:22 INFO - PROCESS | 8714 | Cycle 1(1): loaded http://localhost:48945/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48945/tests/dromaeo/cssquery-mootools.html) 22:29:23 INFO - PROCESS | 8714 | RSS: Main: 218525696 22:29:23 INFO - PROCESS | 8714 | 22:32:25 INFO - PROCESS | 8714 | Cycle 1(1): loaded http://localhost:48945/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48945/tests/dromaeo/cssquery-prototype.html) 22:32:26 INFO - PROCESS | 8714 | RSS: Main: 262168576 22:32:26 INFO - PROCESS | 8714 | 22:35:28 INFO - PROCESS | 8714 | Cycle 1(1): loaded http://localhost:48945/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48945/tests/dromaeo/cssquery-yui.html) 22:35:29 INFO - PROCESS | 8714 | RSS: Main: 220160000 22:35:29 INFO - PROCESS | 8714 | 22:38:32 INFO - PROCESS | 8714 | Cycle 1(1): loaded http://localhost:48945/tests/dromaeo/cssquery-yui.html (next: http://localhost:48945/tests/dromaeo/cssquery-dojo.html) 22:38:32 INFO - PROCESS | 8714 | RSS: Main: 326066176 22:38:32 INFO - PROCESS | 8714 | 22:38:32 INFO - PROCESS | 8714 | __start_tp_report 22:38:32 INFO - PROCESS | 8714 | _x_x_mozilla_page_load 22:38:32 INFO - PROCESS | 8714 | _x_x_mozilla_page_load_details 22:38:32 INFO - PROCESS | 8714 | |i|pagename|runs| 22:38:32 INFO - PROCESS | 8714 | |0;dojo.html;2977.1515118191314;2981.254686328419;3002.219422950033;3029.6061512003434;3053.5724998500214;5122.1292380295345;5221.817236396727;5227.085260079485;5310.070737620916;5333.573314134869;5175.068487672217;5216.843494695156;5252.789888404469;5263.605229607785;5303.151495760679;4821.734804585738;4864.075825593143;4867.8783030424165;4872.098661747588;4910.410750709902;4853.174960256747;4857.125717370872;4864.246041863516;4914.410270767495;4920;4799.256115302116;4863.124637565237;4872.4640289568115;4922.950770492303;4976;4680.882977925545;4828.539905845477;4831.444383895844;4874.780634871439;4874.8537543873745;4670.276107203389;4682.836100736458;4764.95235047652;4792.760361981922;4814.1334559779225;5109.131447653907;5113.284140220335;5118.692878427306;5190.844274671766;5258.6318957672975;5484.149956756709;5540.445955404468;5540.9168862467095;5549.833504994856;5559.499645031967;5474.151506516497;5509.972450137724;5607.607467477278;5666.914996275059;5673.26247587815;5311.123664595376;5324.627276090675;5327.81352652663;5332.066888294572;5332.30680011596;5785.942140578541;5788.652680839163;5798.420157984167;5798.652080875161;5857.15071314657;5327.334083239595;5342.839714808562;5343.118385466354;5444.618876678674;5444.945550544444;5506.697131657797;5512.476314750093;5612.07400778875;5629.521490673257;5646.745896434671;5660.745266462936;5668.546516278688;5668.979583674978;5671.120976248688;5720.542356611461;5646.830595082154;5682.460166284196;5686.857828554319;5691.373948865621;5697.4302569742695;4210.494740631144;4231.61915427613;4331.285337919208;4361.062371590124;4375.759333236702;3890.06638406786;3897.317969355408;3915.7454765440157;3929.9607003929596;3938.9803050985133;5317.202419637086;5377.354717433855;5380.381256155514;5381.4349493303425;5443.482869127427;5401.495537829989;5470.316210473691;5581;5700.116481945305;5706;5271.288376069258;5281.181416880389;5299;5303.0719624066405;5330.840074797762;4903.338049363361;4909.705417674951;4913.803447862046;4915.016996600694;4958.776855041532;5686.374498805211;5737.168110624019;5843.123531470228;5843.678597677169;5843.912341314969;5530.225768392509;5582.720863956704;5582.748776304995;5587.217789509553;5591.329040515164;5800.970995144998;5802.100674395476;5804.854878627899;5805.129230615442;5805.796797112081;5537.058700020925;5544.889102218014;5550.47270509301;5575.052241118939;5580.9162862557905;5687.488126068673;5698.800541981011;5707.286589176353;5708.686022268815;5747.712614369349;5521.1442226454965;5523.502884740393;5527.972360138174;5529.087700529368;5529.557635389239;5227.163653815372;5242.580593552583;5466.72666366688;5491.643043202179;5516.696581688046;5522.806701765419;5524.889502209853;5531.529819965187;5581.274434323512;5601.215829783915;5590.189422533791;5617.522510586646;5624.550035997028;5625.8593535161945;5633.464820842013;5245.921311180259;5408.053590621546;5434.2120392542065;5482.945170548243;5568.248286481273 22:38:32 INFO - PROCESS | 8714 | |1;ext.html;560.9130584759363;600.3516202501296;600.6816387314722;614.2751553167261;636.5989426661203;34780.478292825595;43089.78455107728;44095.77952110243;44112;47555.524444755545;45711;46174.30738538925;46176.30735538961;46193.7690311548;46214.30678539816;7992.280694737473;8842.248408885253;9016.323775716848;9019.188273055424;9023.233025192867;7824.882626760603;10411.531481083332;10675.572977080947;10685.038346548808;11028.834567481494;10819.78360432791;10891.128709703244;10891.183161262898;10900.836487452694;10901.291416057931;10678.1991350649;10706;10710.357378557272;10728.892711072867;10783.352998820095;10498.317609355443;10556.630517931835;10556.947215263952;10561.577536898514;10566.788664226673;42893.78553107214;43288.78355608233;43299.78350108261;43507.56492435067;43574.553180852396;3386.847591858372;3387.8475468603974;3486.511888335635;3496.7202623790035;3501.6673416025437;31681.37971645128;32365.6763432365;32426.351472970407;32522;33393.16517087068;4260.808263628113;4274;4332.025294308787;4345.630621397185;4370.169667763115;344557;345281.9999999975;345314;345952;346116;60484;60940.99999999911;61053.69473152695;61152.38847611556;61181.388186118456;36483.635163648556;37353.626463735556;37362.43956340657;38714.80642596769;39109.41335879964;17159.828401716073;17405.129743512774;17433.82566174322;17445.47663570095;17455.476335709947;12255.387230638611;12583.370831458391;13130.737385252241;13477.932610337082;13604.455821767217;18579.163937622838;19021.33425330107;19133.33033343826;19145.712814307797;19183;6800.931990680129;7140.7857764267155;7238.167610724729;7330.523515971445;7385;930.7719608695777;1022.4018948914968;1036.7926414717087;1040.458961340099;1070.0797314309686;32248.516272255936;32546.511802322984;35257.647423525435;35510.467342989876;35637.28725425477;1047.638564695179;1059.8304271316551;1072.5441687282873;1074.0172741941192;1091.939943303126;15813.36746530149;16816.327346905986;16948.830511694727;17002.914985425243;17019.48941531756;255707;258072;258100;258192;258369;58209;58791;58833;58931.11603325953;58976.41023589709;1229.1518851992275;1272.8918041966538;1311.849137349198;1343.6640839790052;1374.8006539051783;29451.558226626188;32071.679283206868;32899.50650740289;33080;33144.83427582846;49999;50547;50682;50689.493105068475;50735.2389714162;414677;419223;419587;421364;422171;27901.162965111078;29150.854245728635;29168.27079323034;30122.09633710992;30162.396752065273;47160.29259561041;47430.28854567115;47456;47699.52300476951;47728.76135619439;38968.61031389763;40168.39747403733;40263.1947361057;41268.79365603153;42153.36769948392;39589.60410395859;39717.60282397139;39935;40138.39792403058;41281.58718412778;38482.80758596189;40078.398824018244;41012.38481422721;41280;41306.793466032475;34585.82707086549;36632.81683591672;36742.63257367499;36887;37682.246355073294;27913.58129628098;28037.859810701633;28131.498960166275;28208.85895570509;28234.576481352386 22:38:32 INFO - PROCESS | 8714 | |2;jquery.html;377.1438833847165;399.82807392821076;403.8505752871437;409.17755311823225;427.3056283539249;13376;15224.162671053102;18914.432567022995;19173.71239431406;19790.901045494753;18593.349232776854;18903.33838315659;19058.714119288223;19079.52301192471;19411;4881.365422495071;5676.347220069683;5918.171455996164;5919.852003699899;5922.555808314372;6422.454091402236;6666.100076489661;6667.299933506984;6691.866162676743;6695.799126026227;5717.857053573653;5983.9228938791;6015.428534289235;6661.9000714989315;6666.833329166761;6017.939820601781;6021.277446706401;6059.939400606004;6060.363661815534;6060.939390606081;5193.662411943212;5461.863453413656;5500.532454741352;5563.66618002917;5568.246002509197;13434.731305373936;13680.65798355039;16930.40743573969;21906.671399929015;22162.11351545936;2352.941176470602;2545;2602.0632572274158;2876.0796545105572;2920.7433711411622;10151.898481015243;10244.538995745135;10518;10614;13290.26903520306;1819.4814477873742;1843.806400327973;1845.6124213915093;1884.5853912139444;1914.5596512801994;59161.70419147877;61913.28520288797;78332;78896;82678.21252512326;10298.897011029943;10334.948325258476;10418.082936777715;10843;11421.543138274543;15919.283632236577;15931.283092260875;15939.920300398424;15941.681166376608;15963.44127955516;7820.413468989735;7823.921760782433;8007.719729809545;8070.354371650254;8248.711295104642;7289.380402665833;7490.307366401574;7555.659995300225;7635.618219089023;7649.38804895607;4770.976145119253;4777.283407488835;4835.153848076572;4860.052289803525;4871.585915197248;1912.2637784453086;1953.4823271832975;1970.1331414177716;1982.960340793176;2050.8256798172024;450.5719566411922;455.39659950565635;816.6488409983646;861.1302584389812;888.0941439731438;12015.819762703566;12087.335196564098;12362.505499780087;12543.93728031354;12958.092933494754;462.97909624488864;477.7873846138435;481.93734814473896;497.4329264638315;503.05425799496714;6428.5178611604315;6453.386928241809;6559.770408035792;6615.4046135848;6712.328767123248;476985;496160;510615;527623;541969;88955.55522222347;89479.55260223657;90873;95518;96022.51988740012;481.4727872979082;485.45386440254714;485.7886819233645;491.0669727517745;492.1264755059726;10887.836682449612;11149.554017839195;11185.776284474103;11274;11332.433378331216;37794;38068.80965595154;38481.615183848924;39110.6088939107;39401.80299098486;52451;56400.153997689245;56706;57568.4243157563;57900.4209957895;7904.960475197588;8363.95818020906;8441.70454034106;8541.273991710526;8892.955535222283;10654.467276636293;12081.637550873487;12170;12311.322877241479;12461.563845265373;9886.406815591088;10189;10222.437765922945;10270.6405275815;11005.61480348184;10775.730606734895;10975.176861735243;11036;11308.264962777394;11558.30650160993;9941.30410871232;10215.284930054824;10435.478226088817;10501.78996420052;10968.616098436516;7346.33882950537;7796.532208067307;8505.82988340242;8581.442206256574;8822.161894620001;9753.707388778348;9895.752606184902;10199.13307368882;10290.639827606297;10491.737706557396 22:38:32 INFO - PROCESS | 8714 | |3;mootools.html;1332.8880403953801;1466.7506523890938;1487.1894817324558;1636.1819090454774;1787.463760871739;7721.6911323547065;8547.230749232567;8770.824583508334;8802.735917922457;9132.908670913288;8910.97523784765;8991.59537820798;9012.819743605123;9014.23379012783;9018.594163262653;2374.7031621047367;2391.0316321889577;2396.3529846941315;2400.699912510936;2405.651180578815;2287.63397856343;2330;2357.870317132557;2358.7287461941837;2361.4332560185517;2300.102959845653;2305.8155347572156;2314.687517185184;2330.3707998840305;2337.4273303040777;2241;2250.5723912456583;2261.4459457432868;2278.7949084582383;2279.122537822942;2192.451887028243;2192.7478339990944;2194.462356722597;2198.9560208795733;2206.900689468978;8820.514871682055;8881.156290152425;8885.333599980027;9003.729888103368;9012.098790120936;5026.798928042874;5142.742862856842;5144.305518754958;5254.92117618236;5255.080360936859;3292.96707032929;3466.4107101792756;3500.4749287607065;3507.3336066147604;3522.066652337133;1138.7380902392497;1186.412725700775;1188.9108316876268;1203.175824560179;1209.9455524501418;12423.813642795365;12472.937635311766;12532.874671253261;12540.247585144829;12543.435545400387;4304.720193187432;4400.9559904401185;4535.047639995571;4542.636589072932;4563.018950925501;9710.6115755369;9771.609135634637;9779.168770654433;9779.462129582942;9785.951070244602;5231.189165679326;5231.581473482189;5233.110371236823;5235.319408476874;5236.1098613235845;4247.893802654959;4306.913861722811;4362.236608593484;4720.811167553259;4882.267659851051;3693.981530092386;3709.4621279914263;3864.42033694948;3883.3592457244804;3914.6672532835028;1132.53000004997;1160.7330314027652;1167.6555416152084;1169.7075731067234;1179.7345597240724;767.4167632599153;878.3544095090103;890.8975467821153;895.2077411490748;932.7714709896119;5602.887942241132;5705.771769129188;5715.828525144252;5736.741846616912;5984.551158663117;435.8757754040083;440.83028034207064;445.8506400355917;458.64913341293936;460.8686524340547;3610.8736194233074;3720.08857829828;3824.961750382516;3849.4225866119746;3849.8845034649007;10807.83788243177;10913.945430272957;10956.945215273872;10983.83524247121;10998;10637.627683031056;10892.727681808019;10901.781964360827;11043.226974111734;11073.5570577176;8175.100738918714;8193.180681931759;8251.133630968781;8259.339252859756;8265.421420500506;5520.365158006881;5603.8879222416135;5614.775408983595;5629.240052593012;5745.798897038583;10084.14284785772;10090.142337901361;10137.695869123938;10182.49087545605;10300.742481437725;9782.85325720129;10127.139193168663;10193.23550733683;10554.419506927192;10586.523606437575;7070.328318809705;7147.392471639969;7812.960935195288;7929.127795942326;7945.682172713026;8216.178382161735;8375.036870759697;8457.238848503664;8744.956275218583;8747.169018943445;7704.614769261627;7820.100688420677;7862.567558784322;7913.129555748748;8082.232187942136;7558.2441755823975;7580.204078571891;7721.53670779755;7746.380289576933;7831.921680783119;6680.766173183915;6782.69477873487;6782.694778735067;6785.932140678728;6787.389134977876;4870.147724148189;4880.389951256093;4903.215485522299;4948.084604348207;4999.450060493416;4973.104841128632;5008.724520151427;5145.61407894402;5214.50462206105;5216.556592689664 22:38:32 INFO - PROCESS | 8714 | |4;prototype.html;324.9593800774903;327.98360081995895;336.728933208767;337.9053864917822;344.34746156034333;5024.296598476216;5151.7424128793555;5200.583953283738;5226.712530810804;5228.633995620308;5051.408806226036;5164.380274367072;5190.169572868342;5207.453217412164;5209.843704688866;4090.8159132839096;4098.856540021085;4100.446439730636;4103.938440923389;4106.178764247147;4003.259397011562;4110;4120.773357465338;4126.855560055399;4133.152703695735;4044.3711587468233;4071.063655359269;4083.3874918762126;4086.6117718816663;4099.815508302134;4043.898902527431;4044.3933409988445;4050.979745101285;4054.513458384983;4077.9796101019306;3562.8040457774814;3582.373084710165;3592.9820350898076;3602.8018458984743;3614.8734794282072;4987.703197168726;5080.98380323933;5082.949170508285;5100.923486147711;5106.795728170869;4624.30635404692;4642.396488456479;4645.279981602857;4667.6732628716;4667.696599721007;5359.919601205985;5371.019084408152;5378.91931621026;5408.432114627986;5419.756110975016;3808.8857334280015;3911.3155197840265;3938.2320447512748;3950.9604903951167;3960.4455376247347;5590.972045139789;5625.7904550521835;5632.295963004665;5664.320281566197;5668.801591944262;3968.7618742874943;3971.1010961997904;3977.204559088136;3977.9966125575006;3990.1445827690263;3922.7640245060043;4024.6919751081014;4040.5353384360587;4049.5747946465785;4103;4642.3500709900645;4660.603848672833;4661.533846615312;4664.65015123867;4670.206064968896;5505.697186654773;5518.868631930444;5524.315083899449;5528.198411230349;5542.63972841764;1291.9935400323127;1341.872522110398;1365.9590212293647;1382.1154461144874;1405.9367328470244;882.4440602420563;893.1961234888652;910.2763303173992;911.6080085563271;920.852663573825;4630.282306242538;4658.464276608166;4658.624101708086;4660.720356778605;4675.485696573374;4885.291632713237;4887.780049897763;4906.435759887659;4909.656324057353;4919.0977323379375;4587.541245875385;4599.241125214369;4617.838375656903;4619.214733495314;4622.2835460503675;2750.8899644014414;2973.6728959814404;2975.988164024242;2980.940381192364;2982.597349357852;5806.88386232273;5820.341202757194;5821;5864.38423965486;5875.11873219012;5507.752151153208;5709.857253568611;5737.655740655574;5773.624714393551;5773.942260577341;5811.622244554091;5823.359430462646;5843.357230704619;5844.181814546052;5853.209816674779;5625.915611265917;5629.577781666309;5642.351129620146;5644.88710225785;5651.519620832275;5359.544438722753;5526.696031718294;5539.972300138474;5578.944210557843;5586.888262234814;5770.682612456188;5796.579837939732;5820.621659592113;5823.388544202967;5842.38654941242;3850.8459661614343;3983.6016398359934;3994.640482356486;4004.997501249375;4006.859759908389;5330.387005494263;5515.531179849758;5517.337919449692;5553.19521155618;5561.054620714569;5282.867928301669;5287.9471205287455;5438.809641662523;5442.537384322377;5465.945340546703;5451.611452780549;5470.234167216513;5476.151196564539;5476.890462190813;5478.233047373451;5307.416184219655;5413.619527020584;5449.509544140888;5450.94746941698;5466.945330546644;5475.878749112967;5479.3972663007835;5485.807996720096;5489.862753431196;5494.560435165257;5365.463453654604;5382.757775900172;5387.838364849061;5388.299521062237;5394.865128371665 22:38:32 INFO - PROCESS | 8714 | |5;yui.html;683.9247682754893;745.0798264143779;781.6756046240811;788.4441468764521;810.6433169405461;14964.775528367083;16023.359065637389;16111.436099736511;16123.435679751212;16144.596385090364;15426.537203883874;15709.764353534678;15725.213739313045;15766.21168941554;15774.4478943237;761.2311565319026;779.5478622399023;781.0081196879959;781.722488516577;782.5891407011336;796.9721059762909;797.0077253818974;797.8563858505496;801.6232370785722;803.4857691077715;840.8864803251574;842.2251528593708;842.2756429470651;843.0136740014198;843.2242337049929;833.8415701016787;836.807534267119;839.261449924069;839.559231403515;845.5434065604566;624.8094331228973;624.9281332646713;625.1529177963885;625.3402660193494;625.5183508698323;12942.935285323607;13322.73354532904;13341.266230357327;13363.398647060905;13943.023988320821;13070.085094043327;13145.60563183106;13234.933825330909;13660.112092713942;13713.45146194151;11494.88505114955;11527.664403607694;11660.941695291554;11711.53153873844;11951.940240298829;3692.409214525663;3759.755615884986;3894.2600905828085;3895.2014836958356;3944.23087497938;79712.60143699302;80446.99999999942;80724;81830.59084704539;82625;9753.707388778206;9992.350497217658;10003.449810260505;10081.707103770432;10132.493375331203;18077.457676269732;20815.687764683542;20851.58296834055;20928.790712092683;21063.157473701187;8025.518468891768;8126.39052071097;8342.791430214173;8460.238578527962;8498.320134389234;4382.255016647114;4429.534898835575;4544.159330523864;4598.97700511502;4741.905161896742;3588.5334906461994;3714.851405943786;3732.7013838893367;3734;3750.6061863503937;593.2850914647839;606.8240210338952;612.9632222066601;625.2559454249429;638.2309317272675;702.7652066428806;704.9436045116379;713.4720306972906;724.4277021153335;731.129955353128;10116.898831011742;10263.948680256552;10303.421562298347;10600.469976501145;10923.3992130432;595.0538643556765;634.5336177909234;654.0222367560433;676.5737585321216;745.5089820359282;4502.257127573914;4904.779284932187;4944.53026962438;4972.105021096238;4976.193068767849;69891;109651;112197;113321;114813;91343;92380;94835.52582237044;95352;99515;54400;69512.6524367375;81205.59397203094;81289;83097;8815.382923195315;8950.507722075348;8986.415882967585;9007.954960225157;9023.639054437748;49707.751461242464;51074.74462627663;51466.48533514617;51523.742381287855;52711;68272.65863670848;71080.64459677876;77058.22941770511;77818.2218177811;78668;11569.537218511501;11673.299602023906;11681.88318116808;11904.523819047141;11966.64100076999;13645.863541364857;13679.247641379421;14661.70676586441;14735.852641473877;15027.474038408604;12715.80926286088;13220.471181152647;13224;13574.79637805414;13698.178109313472;12322.876771232532;12934.41795119203;13441;13951.441942322193;14036.578902632937;12163.81754273669;12582.24506529611;12796.552120675731;13159.934200328937;13208.867911320764;10211.489425528842;10462.68611941643;10789.676309710721;11023.559057637605;11061.778764424505;10299.639512617023;11041.944790275997;11117;11268.211225214483;11440.885591144315 22:38:32 INFO - PROCESS | 8714 | __end_tp_report 22:38:32 INFO - PROCESS | 8714 | __start_cc_report 22:38:32 INFO - PROCESS | 8714 | _x_x_mozilla_cycle_collect,1181 22:38:32 INFO - PROCESS | 8714 | __end_cc_report 22:38:32 INFO - PROCESS | 8714 | __startTimestamp1475991512375__endTimestamp 22:38:32 INFO - PROCESS | 8714 | 22:38:32 INFO - PROCESS | 8714 | ------- Summary: start ------- 22:38:32 INFO - PROCESS | 8714 | Number of tests: 6 22:38:32 INFO - PROCESS | 8714 | 22:38:32 INFO - PROCESS | 8714 | [#0] dojo.html Cycles:165 Average:5235.18 Median:5434.21 stddev:585.94 (10.8%) stddev-sans-first:560.32 22:38:32 INFO - PROCESS | 8714 | Values: 2977.2 2981.3 3002.2 3029.6 3053.6 5122.1 5221.8 5227.1 5310.1 5333.6 5175.1 5216.8 5252.8 5263.6 5303.2 4821.7 4864.1 4867.9 4872.1 4910.4 4853.2 4857.1 4864.2 4914.4 4920.0 4799.3 4863.1 4872.5 4923.0 4976.0 4680.9 4828.5 4831.4 4874.8 4874.9 4670.3 4682.8 4765.0 4792.8 4814.1 5109.1 5113.3 5118.7 5190.8 5258.6 5484.1 5540.4 5540.9 5549.8 5559.5 5474.2 5510.0 5607.6 5666.9 5673.3 5311.1 5324.6 5327.8 5332.1 5332.3 5785.9 5788.7 5798.4 5798.7 5857.2 5327.3 5342.8 5343.1 5444.6 5444.9 5506.7 5512.5 5612.1 5629.5 5646.7 5660.7 5668.5 5669.0 5671.1 5720.5 5646.8 5682.5 5686.9 5691.4 5697.4 4210.5 4231.6 4331.3 4361.1 4375.8 3890.1 3897.3 3915.7 3930.0 3939.0 5317.2 5377.4 5380.4 5381.4 5443.5 5401.5 5470.3 5581.0 5700.1 5706.0 5271.3 5281.2 5299.0 5303.1 5330.8 4903.3 4909.7 4913.8 4915.0 4958.8 5686.4 5737.2 5843.1 5843.7 5843.9 5530.2 5582.7 5582.7 5587.2 5591.3 5801.0 5802.1 5804.9 5805.1 5805.8 5537.1 5544.9 5550.5 5575.1 5580.9 5687.5 5698.8 5707.3 5708.7 5747.7 5521.1 5523.5 5528.0 5529.1 5529.6 5227.2 5242.6 5466.7 5491.6 5516.7 5522.8 5524.9 5531.5 5581.3 5601.2 5590.2 5617.5 5624.6 5625.9 5633.5 5245.9 5408.1 5434.2 5482.9 5568.2 22:38:32 INFO - PROCESS | 8714 | 22:38:32 INFO - PROCESS | 8714 | [#1] ext.html Cycles:180 Average:51672.85 Median:3499.19 stddev:91180.50 (2605.8%) stddev-sans-first:91355.53 22:38:32 INFO - PROCESS | 8714 | Values: 560.9 600.4 600.7 614.3 636.6 34780.5 43089.8 44095.8 44112.0 47555.5 45711.0 46174.3 46176.3 46193.8 46214.3 7992.3 8842.2 9016.3 9019.2 9023.2 7824.9 10411.5 10675.6 10685.0 11028.8 10819.8 10891.1 10891.2 10900.8 10901.3 10678.2 10706.0 10710.4 10728.9 10783.4 10498.3 10556.6 10556.9 10561.6 10566.8 42893.8 43288.8 43299.8 43507.6 43574.6 3386.8 3387.8 3486.5 3496.7 3501.7 31681.4 32365.7 32426.4 32522.0 33393.2 4260.8 4274.0 4332.0 4345.6 4370.2 344557.0 345282.0 345314.0 345952.0 346116.0 60484.0 60941.0 61053.7 61152.4 61181.4 36483.6 37353.6 37362.4 38714.8 39109.4 17159.8 17405.1 17433.8 17445.5 17455.5 12255.4 12583.4 13130.7 13477.9 13604.5 18579.2 19021.3 19133.3 19145.7 19183.0 6800.9 7140.8 7238.2 7330.5 7385.0 930.8 1022.4 1036.8 1040.5 1070.1 32248.5 32546.5 35257.6 35510.5 35637.3 1047.6 1059.8 1072.5 1074.0 1091.9 15813.4 16816.3 16948.8 17002.9 17019.5 255707.0 258072.0 258100.0 258192.0 258369.0 58209.0 58791.0 58833.0 58931.1 58976.4 1229.2 1272.9 1311.8 1343.7 1374.8 29451.6 32071.7 32899.5 33080.0 33144.8 49999.0 50547.0 50682.0 50689.5 50735.2 414677.0 419223.0 419587.0 421364.0 422171.0 27901.2 29150.9 29168.3 30122.1 30162.4 47160.3 47430.3 47456.0 47699.5 47728.8 38968.6 40168.4 40263.2 41268.8 42153.4 39589.6 39717.6 39935.0 40138.4 41281.6 38482.8 40078.4 41012.4 41280.0 41306.8 34585.8 36632.8 36742.6 36887.0 37682.2 27913.6 28037.9 28131.5 28208.9 28234.6 22:38:32 INFO - PROCESS | 8714 | 22:38:32 INFO - PROCESS | 8714 | [#2] jquery.html Cycles:180 Average:28358.03 Median:2624.38 stddev:84179.34 (3207.6%) stddev-sans-first:84389.26 22:38:32 INFO - PROCESS | 8714 | Values: 377.1 399.8 403.9 409.2 427.3 13376.0 15224.2 18914.4 19173.7 19790.9 18593.3 18903.3 19058.7 19079.5 19411.0 4881.4 5676.3 5918.2 5919.9 5922.6 6422.5 6666.1 6667.3 6691.9 6695.8 5717.9 5983.9 6015.4 6661.9 6666.8 6017.9 6021.3 6059.9 6060.4 6060.9 5193.7 5461.9 5500.5 5563.7 5568.2 13434.7 13680.7 16930.4 21906.7 22162.1 2352.9 2545.0 2602.1 2876.1 2920.7 10151.9 10244.5 10518.0 10614.0 13290.3 1819.5 1843.8 1845.6 1884.6 1914.6 59161.7 61913.3 78332.0 78896.0 82678.2 10298.9 10334.9 10418.1 10843.0 11421.5 15919.3 15931.3 15939.9 15941.7 15963.4 7820.4 7823.9 8007.7 8070.4 8248.7 7289.4 7490.3 7555.7 7635.6 7649.4 4771.0 4777.3 4835.2 4860.1 4871.6 1912.3 1953.5 1970.1 1983.0 2050.8 450.6 455.4 816.6 861.1 888.1 12015.8 12087.3 12362.5 12543.9 12958.1 463.0 477.8 481.9 497.4 503.1 6428.5 6453.4 6559.8 6615.4 6712.3 476985.0 496160.0 510615.0 527623.0 541969.0 88955.6 89479.6 90873.0 95518.0 96022.5 481.5 485.5 485.8 491.1 492.1 10887.8 11149.6 11185.8 11274.0 11332.4 37794.0 38068.8 38481.6 39110.6 39401.8 52451.0 56400.2 56706.0 57568.4 57900.4 7905.0 8364.0 8441.7 8541.3 8893.0 10654.5 12081.6 12170.0 12311.3 12461.6 9886.4 10189.0 10222.4 10270.6 11005.6 10775.7 10975.2 11036.0 11308.3 11558.3 9941.3 10215.3 10435.5 10501.8 10968.6 7346.3 7796.5 8505.8 8581.4 8822.2 9753.7 9895.8 10199.1 10290.6 10491.7 22:38:32 INFO - PROCESS | 8714 | 22:38:32 INFO - PROCESS | 8714 | [#3] mootools.html Cycles:180 Average:5727.99 Median:459.76 stddev:3340.34 (726.5%) stddev-sans-first:3333.38 22:38:32 INFO - PROCESS | 8714 | Values: 1332.9 1466.8 1487.2 1636.2 1787.5 7721.7 8547.2 8770.8 8802.7 9132.9 8911.0 8991.6 9012.8 9014.2 9018.6 2374.7 2391.0 2396.4 2400.7 2405.7 2287.6 2330.0 2357.9 2358.7 2361.4 2300.1 2305.8 2314.7 2330.4 2337.4 2241.0 2250.6 2261.4 2278.8 2279.1 2192.5 2192.7 2194.5 2199.0 2206.9 8820.5 8881.2 8885.3 9003.7 9012.1 5026.8 5142.7 5144.3 5254.9 5255.1 3293.0 3466.4 3500.5 3507.3 3522.1 1138.7 1186.4 1188.9 1203.2 1209.9 12423.8 12472.9 12532.9 12540.2 12543.4 4304.7 4401.0 4535.0 4542.6 4563.0 9710.6 9771.6 9779.2 9779.5 9786.0 5231.2 5231.6 5233.1 5235.3 5236.1 4247.9 4306.9 4362.2 4720.8 4882.3 3694.0 3709.5 3864.4 3883.4 3914.7 1132.5 1160.7 1167.7 1169.7 1179.7 767.4 878.4 890.9 895.2 932.8 5602.9 5705.8 5715.8 5736.7 5984.6 435.9 440.8 445.9 458.6 460.9 3610.9 3720.1 3825.0 3849.4 3849.9 10807.8 10913.9 10956.9 10983.8 10998.0 10637.6 10892.7 10901.8 11043.2 11073.6 8175.1 8193.2 8251.1 8259.3 8265.4 5520.4 5603.9 5614.8 5629.2 5745.8 10084.1 10090.1 10137.7 10182.5 10300.7 9782.9 10127.1 10193.2 10554.4 10586.5 7070.3 7147.4 7813.0 7929.1 7945.7 8216.2 8375.0 8457.2 8745.0 8747.2 7704.6 7820.1 7862.6 7913.1 8082.2 7558.2 7580.2 7721.5 7746.4 7831.9 6680.8 6782.7 6782.7 6785.9 6787.4 4870.1 4880.4 4903.2 4948.1 4999.5 4973.1 5008.7 5145.6 5214.5 5216.6 22:38:32 INFO - PROCESS | 8714 | 22:38:32 INFO - PROCESS | 8714 | [#4] prototype.html Cycles:180 Average:4548.41 Median:5103.86 stddev:1339.25 (26.2%) stddev-sans-first:1304.95 22:38:32 INFO - PROCESS | 8714 | Values: 325.0 328.0 336.7 337.9 344.3 5024.3 5151.7 5200.6 5226.7 5228.6 5051.4 5164.4 5190.2 5207.5 5209.8 4090.8 4098.9 4100.4 4103.9 4106.2 4003.3 4110.0 4120.8 4126.9 4133.2 4044.4 4071.1 4083.4 4086.6 4099.8 4043.9 4044.4 4051.0 4054.5 4078.0 3562.8 3582.4 3593.0 3602.8 3614.9 4987.7 5081.0 5082.9 5100.9 5106.8 4624.3 4642.4 4645.3 4667.7 4667.7 5359.9 5371.0 5378.9 5408.4 5419.8 3808.9 3911.3 3938.2 3951.0 3960.4 5591.0 5625.8 5632.3 5664.3 5668.8 3968.8 3971.1 3977.2 3978.0 3990.1 3922.8 4024.7 4040.5 4049.6 4103.0 4642.4 4660.6 4661.5 4664.7 4670.2 5505.7 5518.9 5524.3 5528.2 5542.6 1292.0 1341.9 1366.0 1382.1 1405.9 882.4 893.2 910.3 911.6 920.9 4630.3 4658.5 4658.6 4660.7 4675.5 4885.3 4887.8 4906.4 4909.7 4919.1 4587.5 4599.2 4617.8 4619.2 4622.3 2750.9 2973.7 2976.0 2980.9 2982.6 5806.9 5820.3 5821.0 5864.4 5875.1 5507.8 5709.9 5737.7 5773.6 5773.9 5811.6 5823.4 5843.4 5844.2 5853.2 5625.9 5629.6 5642.4 5644.9 5651.5 5359.5 5526.7 5540.0 5578.9 5586.9 5770.7 5796.6 5820.6 5823.4 5842.4 3850.8 3983.6 3994.6 4005.0 4006.9 5330.4 5515.5 5517.3 5553.2 5561.1 5282.9 5287.9 5438.8 5442.5 5465.9 5451.6 5470.2 5476.2 5476.9 5478.2 5307.4 5413.6 5449.5 5450.9 5466.9 5475.9 5479.4 5485.8 5489.9 5494.6 5365.5 5382.8 5387.8 5388.3 5394.9 22:38:32 INFO - PROCESS | 8714 | 22:38:32 INFO - PROCESS | 8714 | [#5] yui.html Cycles:180 Average:19953.92 Median:4571.57 stddev:28486.38 (623.1%) stddev-sans-first:28529.54 22:38:32 INFO - PROCESS | 8714 | Values: 683.9 745.1 781.7 788.4 810.6 14964.8 16023.4 16111.4 16123.4 16144.6 15426.5 15709.8 15725.2 15766.2 15774.4 761.2 779.5 781.0 781.7 782.6 797.0 797.0 797.9 801.6 803.5 840.9 842.2 842.3 843.0 843.2 833.8 836.8 839.3 839.6 845.5 624.8 624.9 625.2 625.3 625.5 12942.9 13322.7 13341.3 13363.4 13943.0 13070.1 13145.6 13234.9 13660.1 13713.5 11494.9 11527.7 11660.9 11711.5 11951.9 3692.4 3759.8 3894.3 3895.2 3944.2 79712.6 80447.0 80724.0 81830.6 82625.0 9753.7 9992.4 10003.4 10081.7 10132.5 18077.5 20815.7 20851.6 20928.8 21063.2 8025.5 8126.4 8342.8 8460.2 8498.3 4382.3 4429.5 4544.2 4599.0 4741.9 3588.5 3714.9 3732.7 3734.0 3750.6 593.3 606.8 613.0 625.3 638.2 702.8 704.9 713.5 724.4 731.1 10116.9 10263.9 10303.4 10600.5 10923.4 595.1 634.5 654.0 676.6 745.5 4502.3 4904.8 4944.5 4972.1 4976.2 69891.0 109651.0 112197.0 113321.0 114813.0 91343.0 92380.0 94835.5 95352.0 99515.0 54400.0 69512.7 81205.6 81289.0 83097.0 8815.4 8950.5 8986.4 9008.0 9023.6 49707.8 51074.7 51466.5 51523.7 52711.0 68272.7 71080.6 77058.2 77818.2 78668.0 11569.5 11673.3 11681.9 11904.5 11966.6 13645.9 13679.2 14661.7 14735.9 15027.5 12715.8 13220.5 13224.0 13574.8 13698.2 12322.9 12934.4 13441.0 13951.4 14036.6 12163.8 12582.2 12796.6 13159.9 13208.9 10211.5 10462.7 10789.7 11023.6 11061.8 10299.6 11041.9 11117.0 11268.2 11440.9 22:38:32 INFO - PROCESS | 8714 | -------- Summary: end -------- 22:38:32 INFO - PROCESS | 8714 | 22:38:33 INFO - TEST-INFO | 8714: exit 0 22:38:33 INFO - TEST-OK | dromaeo_css | took 1116758ms 22:38:33 INFO - TEST-START | kraken 22:38:33 INFO - operating with platform_type : linux_ 22:38:33 INFO - Initialising browser for kraken test... 22:38:33 INFO - TEST-INFO | started process 9019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSAZqfd/profile http://localhost:48945/getInfo.html) 22:38:37 INFO - PROCESS | 9019 | __metrics Screen width/height:1600/1200 22:38:37 INFO - PROCESS | 9019 | colorDepth:24 22:38:37 INFO - PROCESS | 9019 | Browser inner width/height: 1024/697 22:38:37 INFO - PROCESS | 9019 | __metrics 22:38:38 INFO - PROCESS | 9019 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:38:38 INFO - PROCESS | 9019 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:38:38 INFO - PROCESS | 9019 | console.error: PushService: 22:38:38 INFO - PROCESS | 9019 | stateChangeProcessEnqueue: Error transitioning state 22:38:38 INFO - PROCESS | 9019 | UnknownError 22:38:39 INFO - TEST-INFO | 9019: exit 0 22:38:39 INFO - Browser initialized. 22:38:39 INFO - Running cycle 1/1 for kraken test... 22:38:39 INFO - TEST-INFO | started process 9103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSAZqfd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:38:51 INFO - PROCESS | 9103 | RSS: Main: 173051904 22:38:51 INFO - PROCESS | 9103 | 22:38:53 INFO - PROCESS | 9103 | Cycle 1(1): loaded http://localhost:48945/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48945/tests/kraken/driver.html?testName=audio-beat-detection) 22:38:54 INFO - PROCESS | 9103 | RSS: Main: 231956480 22:38:54 INFO - PROCESS | 9103 | 22:38:57 INFO - PROCESS | 9103 | Cycle 1(1): loaded http://localhost:48945/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48945/tests/kraken/driver.html?testName=audio-dft) 22:38:58 INFO - PROCESS | 9103 | RSS: Main: 216424448 22:38:58 INFO - PROCESS | 9103 | 22:39:01 INFO - PROCESS | 9103 | Cycle 1(1): loaded http://localhost:48945/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48945/tests/kraken/driver.html?testName=audio-fft) 22:39:01 INFO - PROCESS | 9103 | RSS: Main: 298278912 22:39:01 INFO - PROCESS | 9103 | 22:39:03 INFO - PROCESS | 9103 | Cycle 1(1): loaded http://localhost:48945/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48945/tests/kraken/driver.html?testName=audio-oscillator) 22:39:04 INFO - PROCESS | 9103 | RSS: Main: 207269888 22:39:04 INFO - PROCESS | 9103 | 22:39:06 INFO - PROCESS | 9103 | Cycle 1(1): loaded http://localhost:48945/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48945/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:39:07 INFO - PROCESS | 9103 | RSS: Main: 211824640 22:39:07 INFO - PROCESS | 9103 | 22:39:10 INFO - PROCESS | 9103 | Cycle 1(1): loaded http://localhost:48945/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48945/tests/kraken/driver.html?testName=imaging-darkroom) 22:39:10 INFO - PROCESS | 9103 | RSS: Main: 248692736 22:39:10 INFO - PROCESS | 9103 | 22:39:14 INFO - PROCESS | 9103 | Cycle 1(1): loaded http://localhost:48945/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48945/tests/kraken/driver.html?testName=imaging-desaturate) 22:39:14 INFO - PROCESS | 9103 | RSS: Main: 247758848 22:39:14 INFO - PROCESS | 9103 | 22:39:17 INFO - PROCESS | 9103 | Cycle 1(1): loaded http://localhost:48945/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48945/tests/kraken/driver.html?testName=json-parse-financial) 22:39:18 INFO - PROCESS | 9103 | RSS: Main: 248012800 22:39:18 INFO - PROCESS | 9103 | 22:39:19 INFO - PROCESS | 9103 | Cycle 1(1): loaded http://localhost:48945/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48945/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:39:20 INFO - PROCESS | 9103 | RSS: Main: 209457152 22:39:20 INFO - PROCESS | 9103 | 22:39:22 INFO - PROCESS | 9103 | Cycle 1(1): loaded http://localhost:48945/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48945/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:39:22 INFO - PROCESS | 9103 | RSS: Main: 217726976 22:39:22 INFO - PROCESS | 9103 | 22:39:24 INFO - PROCESS | 9103 | Cycle 1(1): loaded http://localhost:48945/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48945/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:39:25 INFO - PROCESS | 9103 | RSS: Main: 226381824 22:39:25 INFO - PROCESS | 9103 | 22:39:27 INFO - PROCESS | 9103 | Cycle 1(1): loaded http://localhost:48945/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48945/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:39:28 INFO - PROCESS | 9103 | RSS: Main: 234958848 22:39:28 INFO - PROCESS | 9103 | 22:39:31 INFO - PROCESS | 9103 | Cycle 1(1): loaded http://localhost:48945/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48945/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:39:32 INFO - PROCESS | 9103 | RSS: Main: 231399424 22:39:32 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | Cycle 1(1): loaded http://localhost:48945/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48945/tests/kraken/driver.html?testName=ai-astar) 22:39:33 INFO - PROCESS | 9103 | RSS: Main: 283295744 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | __start_tp_report 22:39:33 INFO - PROCESS | 9103 | _x_x_mozilla_page_load 22:39:33 INFO - PROCESS | 9103 | _x_x_mozilla_page_load_details 22:39:33 INFO - PROCESS | 9103 | |i|pagename|runs| 22:39:33 INFO - PROCESS | 9103 | |0;ai-astar;110;112;112;112;114;112;111;113;111;111 22:39:33 INFO - PROCESS | 9103 | |1;audio-beat-detection;147;126;126;167;122;125;120;120;164;132 22:39:33 INFO - PROCESS | 9103 | |2;audio-dft;160;160;163;160;161;161;161;160;161;160 22:39:33 INFO - PROCESS | 9103 | |3;audio-fft;75;75;76;105;75;75;75;75;97;74 22:39:33 INFO - PROCESS | 9103 | |4;audio-oscillator;82;83;122;83;83;82;112;82;81;116 22:39:33 INFO - PROCESS | 9103 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;118;116 22:39:33 INFO - PROCESS | 9103 | |6;imaging-darkroom;146;146;146;146;145;145;146;145;145;145 22:39:33 INFO - PROCESS | 9103 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 22:39:33 INFO - PROCESS | 9103 | |8;json-parse-financial;51;51;51;51;51;53;51;51;51;52 22:39:33 INFO - PROCESS | 9103 | |9;json-stringify-tinderbox;63;63;63;62;63;62;63;63;63;64 22:39:33 INFO - PROCESS | 9103 | |10;stanford-crypto-aes;79;79;79;79;82;79;80;79;80;79 22:39:33 INFO - PROCESS | 9103 | |11;stanford-crypto-ccm;133;129;128;135;149;135;128;133;168;129 22:39:33 INFO - PROCESS | 9103 | |12;stanford-crypto-pbkdf2;176;175;173;170;175;168;170;164;169;166 22:39:33 INFO - PROCESS | 9103 | |13;stanford-crypto-sha256-iterative;67;71;67;67;66;66;72;66;65;64 22:39:33 INFO - PROCESS | 9103 | __end_tp_report 22:39:33 INFO - PROCESS | 9103 | __start_cc_report 22:39:33 INFO - PROCESS | 9103 | _x_x_mozilla_cycle_collect,1601 22:39:33 INFO - PROCESS | 9103 | __end_cc_report 22:39:33 INFO - PROCESS | 9103 | __startTimestamp1475991573971__endTimestamp 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | ------- Summary: start ------- 22:39:33 INFO - PROCESS | 9103 | Number of tests: 14 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.14 (1.0%) stddev-sans-first:1.00 22:39:33 INFO - PROCESS | 9103 | Values: 110.0 112.0 112.0 112.0 114.0 112.0 111.0 113.0 111.0 111.0 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:129.00 stddev:17.95 (13.9%) stddev-sans-first:18.49 22:39:33 INFO - PROCESS | 9103 | Values: 147.0 126.0 126.0 167.0 122.0 125.0 120.0 120.0 164.0 132.0 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 22:39:33 INFO - PROCESS | 9103 | Values: 160.0 160.0 163.0 160.0 161.0 161.0 161.0 160.0 161.0 160.0 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | [#3] audio-fft Cycles:10 Average:80.20 Median:75.00 stddev:11.13 (14.8%) stddev-sans-first:11.65 22:39:33 INFO - PROCESS | 9103 | Values: 75.0 75.0 76.0 105.0 75.0 75.0 75.0 75.0 97.0 74.0 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:82.00 stddev:16.79 (20.5%) stddev-sans-first:17.36 22:39:33 INFO - PROCESS | 9103 | Values: 82.0 83.0 122.0 83.0 83.0 82.0 112.0 82.0 81.0 116.0 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 22:39:33 INFO - PROCESS | 9103 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 22:39:33 INFO - PROCESS | 9103 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 22:39:33 INFO - PROCESS | 9103 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 22:39:33 INFO - PROCESS | 9103 | Values: 51.0 51.0 51.0 51.0 51.0 53.0 51.0 51.0 51.0 52.0 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 22:39:33 INFO - PROCESS | 9103 | Values: 63.0 63.0 63.0 62.0 63.0 62.0 63.0 63.0 63.0 64.0 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 22:39:33 INFO - PROCESS | 9103 | Values: 79.0 79.0 79.0 79.0 82.0 79.0 80.0 79.0 80.0 79.0 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:134.00 stddev:12.62 (9.4%) stddev-sans-first:13.32 22:39:33 INFO - PROCESS | 9103 | Values: 133.0 129.0 128.0 135.0 149.0 135.0 128.0 133.0 168.0 129.0 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:171.50 stddev:4.06 (2.4%) stddev-sans-first:3.81 22:39:33 INFO - PROCESS | 9103 | Values: 176.0 175.0 173.0 170.0 175.0 168.0 170.0 164.0 169.0 166.0 22:39:33 INFO - PROCESS | 9103 | 22:39:33 INFO - PROCESS | 9103 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:2.51 (3.8%) stddev-sans-first:2.67 22:39:33 INFO - PROCESS | 9103 | Values: 67.0 71.0 67.0 67.0 66.0 66.0 72.0 66.0 65.0 64.0 22:39:33 INFO - PROCESS | 9103 | -------- Summary: end -------- 22:39:33 INFO - PROCESS | 9103 | 22:39:35 INFO - TEST-INFO | 9103: exit 0 22:39:35 INFO - TEST-OK | kraken | took 61978ms 22:39:35 INFO - SUITE-END | took 1178s 22:39:35 INFO - Completed test suite (00:19:39) 22:39:35 INFO - javascript benchmark 22:39:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2977.1515118191314, 2981.254686328419, 3002.219422950033, 3029.6061512003434, 3053.5724998500214, 5122.1292380295345, 5221.817236396727, 5227.085260079485, 5310.070737620916, 5333.573314134869, 5175.068487672217, 5216.843494695156, 5252.789888404469, 5263.605229607785, 5303.151495760679, 4821.734804585738, 4864.075825593143, 4867.8783030424165, 4872.098661747588, 4910.410750709902, 4853.174960256747, 4857.125717370872, 4864.246041863516, 4914.410270767495, 4920.0, 4799.256115302116, 4863.124637565237, 4872.4640289568115, 4922.950770492303, 4976.0, 4680.882977925545, 4828.539905845477, 4831.444383895844, 4874.780634871439, 4874.8537543873745, 4670.276107203389, 4682.836100736458, 4764.95235047652, 4792.760361981922, 4814.1334559779225, 5109.131447653907, 5113.284140220335, 5118.692878427306, 5190.844274671766, 5258.6318957672975, 5484.149956756709, 5540.445955404468, 5540.9168862467095, 5549.833504994856, 5559.499645031967, 5474.151506516497, 5509.972450137724, 5607.607467477278, 5666.914996275059, 5673.26247587815, 5311.123664595376, 5324.627276090675, 5327.81352652663, 5332.066888294572, 5332.30680011596, 5785.942140578541, 5788.652680839163, 5798.420157984167, 5798.652080875161, 5857.15071314657, 5327.334083239595, 5342.839714808562, 5343.118385466354, 5444.618876678674, 5444.945550544444, 5506.697131657797, 5512.476314750093, 5612.07400778875, 5629.521490673257, 5646.745896434671, 5660.745266462936, 5668.546516278688, 5668.979583674978, 5671.120976248688, 5720.542356611461, 5646.830595082154, 5682.460166284196, 5686.857828554319, 5691.373948865621, 5697.4302569742695, 4210.494740631144, 4231.61915427613, 4331.285337919208, 4361.062371590124, 4375.759333236702, 3890.06638406786, 3897.317969355408, 3915.7454765440157, 3929.9607003929596, 3938.9803050985133, 5317.202419637086, 5377.354717433855, 5380.381256155514, 5381.4349493303425, 5443.482869127427, 5401.495537829989, 5470.316210473691, 5581.0, 5700.116481945305, 5706.0, 5271.288376069258, 5281.181416880389, 5299.0, 5303.0719624066405, 5330.840074797762, 4903.338049363361, 4909.705417674951, 4913.803447862046, 4915.016996600694, 4958.776855041532, 5686.374498805211, 5737.168110624019, 5843.123531470228, 5843.678597677169, 5843.912341314969, 5530.225768392509, 5582.720863956704, 5582.748776304995, 5587.217789509553, 5591.329040515164, 5800.970995144998, 5802.100674395476, 5804.854878627899, 5805.129230615442, 5805.796797112081, 5537.058700020925, 5544.889102218014, 5550.47270509301, 5575.052241118939, 5580.9162862557905, 5687.488126068673, 5698.800541981011, 5707.286589176353, 5708.686022268815, 5747.712614369349, 5521.1442226454965, 5523.502884740393, 5527.972360138174, 5529.087700529368, 5529.557635389239, 5227.163653815372, 5242.580593552583, 5466.72666366688, 5491.643043202179, 5516.696581688046, 5522.806701765419, 5524.889502209853, 5531.529819965187, 5581.274434323512, 5601.215829783915, 5590.189422533791, 5617.522510586646, 5624.550035997028, 5625.8593535161945, 5633.464820842013, 5245.921311180259, 5408.053590621546, 5434.2120392542065, 5482.945170548243, 5568.248286481273], "value": 5195.846149419565, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.9130584759363, 600.3516202501296, 600.6816387314722, 614.2751553167261, 636.5989426661203, 34780.478292825595, 43089.78455107728, 44095.77952110243, 44112.0, 47555.524444755545, 45711.0, 46174.30738538925, 46176.30735538961, 46193.7690311548, 46214.30678539816, 7992.280694737473, 8842.248408885253, 9016.323775716848, 9019.188273055424, 9023.233025192867, 7824.882626760603, 10411.531481083332, 10675.572977080947, 10685.038346548808, 11028.834567481494, 10819.78360432791, 10891.128709703244, 10891.183161262898, 10900.836487452694, 10901.291416057931, 10678.1991350649, 10706.0, 10710.357378557272, 10728.892711072867, 10783.352998820095, 10498.317609355443, 10556.630517931835, 10556.947215263952, 10561.577536898514, 10566.788664226673, 42893.78553107214, 43288.78355608233, 43299.78350108261, 43507.56492435067, 43574.553180852396, 3386.847591858372, 3387.8475468603974, 3486.511888335635, 3496.7202623790035, 3501.6673416025437, 31681.37971645128, 32365.6763432365, 32426.351472970407, 32522.0, 33393.16517087068, 4260.808263628113, 4274.0, 4332.025294308787, 4345.630621397185, 4370.169667763115, 344557.0, 345281.9999999975, 345314.0, 345952.0, 346116.0, 60484.0, 60940.99999999911, 61053.69473152695, 61152.38847611556, 61181.388186118456, 36483.635163648556, 37353.626463735556, 37362.43956340657, 38714.80642596769, 39109.41335879964, 17159.828401716073, 17405.129743512774, 17433.82566174322, 17445.47663570095, 17455.476335709947, 12255.387230638611, 12583.370831458391, 13130.737385252241, 13477.932610337082, 13604.455821767217, 18579.163937622838, 19021.33425330107, 19133.33033343826, 19145.712814307797, 19183.0, 6800.931990680129, 7140.7857764267155, 7238.167610724729, 7330.523515971445, 7385.0, 930.7719608695777, 1022.4018948914968, 1036.7926414717087, 1040.458961340099, 1070.0797314309686, 32248.516272255936, 32546.511802322984, 35257.647423525435, 35510.467342989876, 35637.28725425477, 1047.638564695179, 1059.8304271316551, 1072.5441687282873, 1074.0172741941192, 1091.939943303126, 15813.36746530149, 16816.327346905986, 16948.830511694727, 17002.914985425243, 17019.48941531756, 255707.0, 258072.0, 258100.0, 258192.0, 258369.0, 58209.0, 58791.0, 58833.0, 58931.11603325953, 58976.41023589709, 1229.1518851992275, 1272.8918041966538, 1311.849137349198, 1343.6640839790052, 1374.8006539051783, 29451.558226626188, 32071.679283206868, 32899.50650740289, 33080.0, 33144.83427582846, 49999.0, 50547.0, 50682.0, 50689.493105068475, 50735.2389714162, 414677.0, 419223.0, 419587.0, 421364.0, 422171.0, 27901.162965111078, 29150.854245728635, 29168.27079323034, 30122.09633710992, 30162.396752065273, 47160.29259561041, 47430.28854567115, 47456.0, 47699.52300476951, 47728.76135619439, 38968.61031389763, 40168.39747403733, 40263.1947361057, 41268.79365603153, 42153.36769948392, 39589.60410395859, 39717.60282397139, 39935.0, 40138.39792403058, 41281.58718412778, 38482.80758596189, 40078.398824018244, 41012.38481422721, 41280.0, 41306.793466032475, 34585.82707086549, 36632.81683591672, 36742.63257367499, 36887.0, 37682.246355073294, 27913.58129628098, 28037.859810701633, 28131.498960166275, 28208.85895570509, 28234.576481352386], "value": 19856.87754307654, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.1438833847165, 399.82807392821076, 403.8505752871437, 409.17755311823225, 427.3056283539249, 13376.0, 15224.162671053102, 18914.432567022995, 19173.71239431406, 19790.901045494753, 18593.349232776854, 18903.33838315659, 19058.714119288223, 19079.52301192471, 19411.0, 4881.365422495071, 5676.347220069683, 5918.171455996164, 5919.852003699899, 5922.555808314372, 6422.454091402236, 6666.100076489661, 6667.299933506984, 6691.866162676743, 6695.799126026227, 5717.857053573653, 5983.9228938791, 6015.428534289235, 6661.9000714989315, 6666.833329166761, 6017.939820601781, 6021.277446706401, 6059.939400606004, 6060.363661815534, 6060.939390606081, 5193.662411943212, 5461.863453413656, 5500.532454741352, 5563.66618002917, 5568.246002509197, 13434.731305373936, 13680.65798355039, 16930.40743573969, 21906.671399929015, 22162.11351545936, 2352.941176470602, 2545.0, 2602.0632572274158, 2876.0796545105572, 2920.7433711411622, 10151.898481015243, 10244.538995745135, 10518.0, 10614.0, 13290.26903520306, 1819.4814477873742, 1843.806400327973, 1845.6124213915093, 1884.5853912139444, 1914.5596512801994, 59161.70419147877, 61913.28520288797, 78332.0, 78896.0, 82678.21252512326, 10298.897011029943, 10334.948325258476, 10418.082936777715, 10843.0, 11421.543138274543, 15919.283632236577, 15931.283092260875, 15939.920300398424, 15941.681166376608, 15963.44127955516, 7820.413468989735, 7823.921760782433, 8007.719729809545, 8070.354371650254, 8248.711295104642, 7289.380402665833, 7490.307366401574, 7555.659995300225, 7635.618219089023, 7649.38804895607, 4770.976145119253, 4777.283407488835, 4835.153848076572, 4860.052289803525, 4871.585915197248, 1912.2637784453086, 1953.4823271832975, 1970.1331414177716, 1982.960340793176, 2050.8256798172024, 450.5719566411922, 455.39659950565635, 816.6488409983646, 861.1302584389812, 888.0941439731438, 12015.819762703566, 12087.335196564098, 12362.505499780087, 12543.93728031354, 12958.092933494754, 462.97909624488864, 477.7873846138435, 481.93734814473896, 497.4329264638315, 503.05425799496714, 6428.5178611604315, 6453.386928241809, 6559.770408035792, 6615.4046135848, 6712.328767123248, 476985.0, 496160.0, 510615.0, 527623.0, 541969.0, 88955.55522222347, 89479.55260223657, 90873.0, 95518.0, 96022.51988740012, 481.4727872979082, 485.45386440254714, 485.7886819233645, 491.0669727517745, 492.1264755059726, 10887.836682449612, 11149.554017839195, 11185.776284474103, 11274.0, 11332.433378331216, 37794.0, 38068.80965595154, 38481.615183848924, 39110.6088939107, 39401.80299098486, 52451.0, 56400.153997689245, 56706.0, 57568.4243157563, 57900.4209957895, 7904.960475197588, 8363.95818020906, 8441.70454034106, 8541.273991710526, 8892.955535222283, 10654.467276636293, 12081.637550873487, 12170.0, 12311.322877241479, 12461.563845265373, 9886.406815591088, 10189.0, 10222.437765922945, 10270.6405275815, 11005.61480348184, 10775.730606734895, 10975.176861735243, 11036.0, 11308.264962777394, 11558.30650160993, 9941.30410871232, 10215.284930054824, 10435.478226088817, 10501.78996420052, 10968.616098436516, 7346.33882950537, 7796.532208067307, 8505.82988340242, 8581.442206256574, 8822.161894620001, 9753.707388778348, 9895.752606184902, 10199.13307368882, 10290.639827606297, 10491.737706557396], "value": 8264.883658531306, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.8880403953801, 1466.7506523890938, 1487.1894817324558, 1636.1819090454774, 1787.463760871739, 7721.6911323547065, 8547.230749232567, 8770.824583508334, 8802.735917922457, 9132.908670913288, 8910.97523784765, 8991.59537820798, 9012.819743605123, 9014.23379012783, 9018.594163262653, 2374.7031621047367, 2391.0316321889577, 2396.3529846941315, 2400.699912510936, 2405.651180578815, 2287.63397856343, 2330.0, 2357.870317132557, 2358.7287461941837, 2361.4332560185517, 2300.102959845653, 2305.8155347572156, 2314.687517185184, 2330.3707998840305, 2337.4273303040777, 2241.0, 2250.5723912456583, 2261.4459457432868, 2278.7949084582383, 2279.122537822942, 2192.451887028243, 2192.7478339990944, 2194.462356722597, 2198.9560208795733, 2206.900689468978, 8820.514871682055, 8881.156290152425, 8885.333599980027, 9003.729888103368, 9012.098790120936, 5026.798928042874, 5142.742862856842, 5144.305518754958, 5254.92117618236, 5255.080360936859, 3292.96707032929, 3466.4107101792756, 3500.4749287607065, 3507.3336066147604, 3522.066652337133, 1138.7380902392497, 1186.412725700775, 1188.9108316876268, 1203.175824560179, 1209.9455524501418, 12423.813642795365, 12472.937635311766, 12532.874671253261, 12540.247585144829, 12543.435545400387, 4304.720193187432, 4400.9559904401185, 4535.047639995571, 4542.636589072932, 4563.018950925501, 9710.6115755369, 9771.609135634637, 9779.168770654433, 9779.462129582942, 9785.951070244602, 5231.189165679326, 5231.581473482189, 5233.110371236823, 5235.319408476874, 5236.1098613235845, 4247.893802654959, 4306.913861722811, 4362.236608593484, 4720.811167553259, 4882.267659851051, 3693.981530092386, 3709.4621279914263, 3864.42033694948, 3883.3592457244804, 3914.6672532835028, 1132.53000004997, 1160.7330314027652, 1167.6555416152084, 1169.7075731067234, 1179.7345597240724, 767.4167632599153, 878.3544095090103, 890.8975467821153, 895.2077411490748, 932.7714709896119, 5602.887942241132, 5705.771769129188, 5715.828525144252, 5736.741846616912, 5984.551158663117, 435.8757754040083, 440.83028034207064, 445.8506400355917, 458.64913341293936, 460.8686524340547, 3610.8736194233074, 3720.08857829828, 3824.961750382516, 3849.4225866119746, 3849.8845034649007, 10807.83788243177, 10913.945430272957, 10956.945215273872, 10983.83524247121, 10998.0, 10637.627683031056, 10892.727681808019, 10901.781964360827, 11043.226974111734, 11073.5570577176, 8175.100738918714, 8193.180681931759, 8251.133630968781, 8259.339252859756, 8265.421420500506, 5520.365158006881, 5603.8879222416135, 5614.775408983595, 5629.240052593012, 5745.798897038583, 10084.14284785772, 10090.142337901361, 10137.695869123938, 10182.49087545605, 10300.742481437725, 9782.85325720129, 10127.139193168663, 10193.23550733683, 10554.419506927192, 10586.523606437575, 7070.328318809705, 7147.392471639969, 7812.960935195288, 7929.127795942326, 7945.682172713026, 8216.178382161735, 8375.036870759697, 8457.238848503664, 8744.956275218583, 8747.169018943445, 7704.614769261627, 7820.100688420677, 7862.567558784322, 7913.129555748748, 8082.232187942136, 7558.2441755823975, 7580.204078571891, 7721.53670779755, 7746.380289576933, 7831.921680783119, 6680.766173183915, 6782.69477873487, 6782.694778735067, 6785.932140678728, 6787.389134977876, 4870.147724148189, 4880.389951256093, 4903.215485522299, 4948.084604348207, 4999.450060493416, 4973.104841128632, 5008.724520151427, 5145.61407894402, 5214.50462206105, 5216.556592689664], "value": 4475.369449510266, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.9593800774903, 327.98360081995895, 336.728933208767, 337.9053864917822, 344.34746156034333, 5024.296598476216, 5151.7424128793555, 5200.583953283738, 5226.712530810804, 5228.633995620308, 5051.408806226036, 5164.380274367072, 5190.169572868342, 5207.453217412164, 5209.843704688866, 4090.8159132839096, 4098.856540021085, 4100.446439730636, 4103.938440923389, 4106.178764247147, 4003.259397011562, 4110.0, 4120.773357465338, 4126.855560055399, 4133.152703695735, 4044.3711587468233, 4071.063655359269, 4083.3874918762126, 4086.6117718816663, 4099.815508302134, 4043.898902527431, 4044.3933409988445, 4050.979745101285, 4054.513458384983, 4077.9796101019306, 3562.8040457774814, 3582.373084710165, 3592.9820350898076, 3602.8018458984743, 3614.8734794282072, 4987.703197168726, 5080.98380323933, 5082.949170508285, 5100.923486147711, 5106.795728170869, 4624.30635404692, 4642.396488456479, 4645.279981602857, 4667.6732628716, 4667.696599721007, 5359.919601205985, 5371.019084408152, 5378.91931621026, 5408.432114627986, 5419.756110975016, 3808.8857334280015, 3911.3155197840265, 3938.2320447512748, 3950.9604903951167, 3960.4455376247347, 5590.972045139789, 5625.7904550521835, 5632.295963004665, 5664.320281566197, 5668.801591944262, 3968.7618742874943, 3971.1010961997904, 3977.204559088136, 3977.9966125575006, 3990.1445827690263, 3922.7640245060043, 4024.6919751081014, 4040.5353384360587, 4049.5747946465785, 4103.0, 4642.3500709900645, 4660.603848672833, 4661.533846615312, 4664.65015123867, 4670.206064968896, 5505.697186654773, 5518.868631930444, 5524.315083899449, 5528.198411230349, 5542.63972841764, 1291.9935400323127, 1341.872522110398, 1365.9590212293647, 1382.1154461144874, 1405.9367328470244, 882.4440602420563, 893.1961234888652, 910.2763303173992, 911.6080085563271, 920.852663573825, 4630.282306242538, 4658.464276608166, 4658.624101708086, 4660.720356778605, 4675.485696573374, 4885.291632713237, 4887.780049897763, 4906.435759887659, 4909.656324057353, 4919.0977323379375, 4587.541245875385, 4599.241125214369, 4617.838375656903, 4619.214733495314, 4622.2835460503675, 2750.8899644014414, 2973.6728959814404, 2975.988164024242, 2980.940381192364, 2982.597349357852, 5806.88386232273, 5820.341202757194, 5821.0, 5864.38423965486, 5875.11873219012, 5507.752151153208, 5709.857253568611, 5737.655740655574, 5773.624714393551, 5773.942260577341, 5811.622244554091, 5823.359430462646, 5843.357230704619, 5844.181814546052, 5853.209816674779, 5625.915611265917, 5629.577781666309, 5642.351129620146, 5644.88710225785, 5651.519620832275, 5359.544438722753, 5526.696031718294, 5539.972300138474, 5578.944210557843, 5586.888262234814, 5770.682612456188, 5796.579837939732, 5820.621659592113, 5823.388544202967, 5842.38654941242, 3850.8459661614343, 3983.6016398359934, 3994.640482356486, 4004.997501249375, 4006.859759908389, 5330.387005494263, 5515.531179849758, 5517.337919449692, 5553.19521155618, 5561.054620714569, 5282.867928301669, 5287.9471205287455, 5438.809641662523, 5442.537384322377, 5465.945340546703, 5451.611452780549, 5470.234167216513, 5476.151196564539, 5476.890462190813, 5478.233047373451, 5307.416184219655, 5413.619527020584, 5449.509544140888, 5450.94746941698, 5466.945330546644, 5475.878749112967, 5479.3972663007835, 5485.807996720096, 5489.862753431196, 5494.560435165257, 5365.463453654604, 5382.757775900172, 5387.838364849061, 5388.299521062237, 5394.865128371665], "value": 4123.340957469725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.9247682754893, 745.0798264143779, 781.6756046240811, 788.4441468764521, 810.6433169405461, 14964.775528367083, 16023.359065637389, 16111.436099736511, 16123.435679751212, 16144.596385090364, 15426.537203883874, 15709.764353534678, 15725.213739313045, 15766.21168941554, 15774.4478943237, 761.2311565319026, 779.5478622399023, 781.0081196879959, 781.722488516577, 782.5891407011336, 796.9721059762909, 797.0077253818974, 797.8563858505496, 801.6232370785722, 803.4857691077715, 840.8864803251574, 842.2251528593708, 842.2756429470651, 843.0136740014198, 843.2242337049929, 833.8415701016787, 836.807534267119, 839.261449924069, 839.559231403515, 845.5434065604566, 624.8094331228973, 624.9281332646713, 625.1529177963885, 625.3402660193494, 625.5183508698323, 12942.935285323607, 13322.73354532904, 13341.266230357327, 13363.398647060905, 13943.023988320821, 13070.085094043327, 13145.60563183106, 13234.933825330909, 13660.112092713942, 13713.45146194151, 11494.88505114955, 11527.664403607694, 11660.941695291554, 11711.53153873844, 11951.940240298829, 3692.409214525663, 3759.755615884986, 3894.2600905828085, 3895.2014836958356, 3944.23087497938, 79712.60143699302, 80446.99999999942, 80724.0, 81830.59084704539, 82625.0, 9753.707388778206, 9992.350497217658, 10003.449810260505, 10081.707103770432, 10132.493375331203, 18077.457676269732, 20815.687764683542, 20851.58296834055, 20928.790712092683, 21063.157473701187, 8025.518468891768, 8126.39052071097, 8342.791430214173, 8460.238578527962, 8498.320134389234, 4382.255016647114, 4429.534898835575, 4544.159330523864, 4598.97700511502, 4741.905161896742, 3588.5334906461994, 3714.851405943786, 3732.7013838893367, 3734.0, 3750.6061863503937, 593.2850914647839, 606.8240210338952, 612.9632222066601, 625.2559454249429, 638.2309317272675, 702.7652066428806, 704.9436045116379, 713.4720306972906, 724.4277021153335, 731.129955353128, 10116.898831011742, 10263.948680256552, 10303.421562298347, 10600.469976501145, 10923.3992130432, 595.0538643556765, 634.5336177909234, 654.0222367560433, 676.5737585321216, 745.5089820359282, 4502.257127573914, 4904.779284932187, 4944.53026962438, 4972.105021096238, 4976.193068767849, 69891.0, 109651.0, 112197.0, 113321.0, 114813.0, 91343.0, 92380.0, 94835.52582237044, 95352.0, 99515.0, 54400.0, 69512.6524367375, 81205.59397203094, 81289.0, 83097.0, 8815.382923195315, 8950.507722075348, 8986.415882967585, 9007.954960225157, 9023.639054437748, 49707.751461242464, 51074.74462627663, 51466.48533514617, 51523.742381287855, 52711.0, 68272.65863670848, 71080.64459677876, 77058.22941770511, 77818.2218177811, 78668.0, 11569.537218511501, 11673.299602023906, 11681.88318116808, 11904.523819047141, 11966.64100076999, 13645.863541364857, 13679.247641379421, 14661.70676586441, 14735.852641473877, 15027.474038408604, 12715.80926286088, 13220.471181152647, 13224.0, 13574.79637805414, 13698.178109313472, 12322.876771232532, 12934.41795119203, 13441.0, 13951.441942322193, 14036.578902632937, 12163.81754273669, 12582.24506529611, 12796.552120675731, 13159.934200328937, 13208.867911320764, 10211.489425528842, 10462.68611941643, 10789.676309710721, 11023.559057637605, 11061.778764424505, 10299.639512617023, 11041.944790275997, 11117.0, 11268.211225214483, 11440.885591144315], "value": 7359.488147479127, "unit": "score"}], "name": "dromaeo_css", "value": 6981.723517244594, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 112.0, 112.0, 114.0, 112.0, 111.0, 113.0, 111.0, 111.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 126.0, 126.0, 167.0, 122.0, 125.0, 120.0, 120.0, 164.0, 132.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 163.0, 160.0, 161.0, 161.0, 161.0, 160.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 105.0, 75.0, 75.0, 75.0, 75.0, 97.0, 74.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 122.0, 83.0, 83.0, 82.0, 112.0, 82.0, 81.0, 116.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 51.0, 51.0, 53.0, 51.0, 51.0, 51.0, 52.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 64.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 79.0, 82.0, 79.0, 80.0, 79.0, 80.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 128.0, 135.0, 149.0, 135.0, 128.0, 133.0, 168.0, 129.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 173.0, 170.0, 175.0, 168.0, 170.0, 164.0, 169.0, 166.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 67.0, 67.0, 66.0, 66.0, 72.0, 66.0, 65.0, 64.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1505.4999999999998, "alertThreshold": 2.0}]} 22:39:35 INFO - Return code: 0 22:39:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:39:35 INFO - # TBPL SUCCESS # 22:39:35 INFO - Running post-action listener: _resource_record_post_action 22:39:35 INFO - [mozharness: 2016-10-09 05:39:35.771684Z] Finished run-tests step (success) 22:39:35 INFO - Running post-run listener: _resource_record_post_run 22:39:35 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403795968; Read time: 16; Write time: 231564 22:39:35 INFO - TinderboxPrint: CPU usage
13.0% 22:39:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 22:39:35 INFO - TinderboxPrint: I/O write bytes / time
403,795,968 / 231,564 22:39:35 INFO - TinderboxPrint: CPU idle
8,299.5 (87.0%) 22:39:35 INFO - TinderboxPrint: CPU user
1,192.5 (12.5%) 22:39:35 INFO - TinderboxPrint: Swap in / out
0 / 0 22:39:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114479104; Read time: 0; Write time: 60504 22:39:35 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288419840; Read time: 0; Write time: 171036 22:39:36 INFO - Running post-run listener: _upload_blobber_files 22:39:36 INFO - Blob upload gear active. 22:39:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:39:36 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 22:39:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:39:36 INFO - (blobuploader) - INFO - Open directory for files ... 22:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:39:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:37 INFO - (blobuploader) - INFO - Done attempting. 22:39:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:39:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:39:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:38 INFO - (blobuploader) - INFO - Done attempting. 22:39:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:39:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:39:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:39:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:39:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:39:42 INFO - (blobuploader) - INFO - Done attempting. 22:39:42 INFO - (blobuploader) - INFO - Iteration through files over. 22:39:42 INFO - Return code: 0 22:39:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:39:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:39:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c5173c2bd195e85ad2ec4c08899464d1745d7c552b9e09f1b2a7ad6d5e4f207c5928471f8931ef62e303f87dce9e8f0ddbb333b2e58d555a2def9379714fcf8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6891d5e83689bb0217eb6a67d4a5e3bc896d74ab2eb01c4110d404a990909687303a3003d0a903de8eb6932b138f5556470a7e8b34195932ac3ec76aee4090bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/474e52412cd3c0d6bcf6e87ded0398d9d316dd742e0a7ec65b78fcc871ea3dd75cbe3830d47e12d39f449b3c09e885055b6e5fe0cbce666b9a45585b51d0f03a"} 22:39:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:39:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:39:42 INFO - Contents: 22:39:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c5173c2bd195e85ad2ec4c08899464d1745d7c552b9e09f1b2a7ad6d5e4f207c5928471f8931ef62e303f87dce9e8f0ddbb333b2e58d555a2def9379714fcf8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6891d5e83689bb0217eb6a67d4a5e3bc896d74ab2eb01c4110d404a990909687303a3003d0a903de8eb6932b138f5556470a7e8b34195932ac3ec76aee4090bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/474e52412cd3c0d6bcf6e87ded0398d9d316dd742e0a7ec65b78fcc871ea3dd75cbe3830d47e12d39f449b3c09e885055b6e5fe0cbce666b9a45585b51d0f03a"} 22:39:42 INFO - Running post-run listener: copy_logs_to_upload_dir 22:39:42 INFO - Copying logs to upload dir... 22:39:42 INFO - mkdir: /builds/slave/test/build/upload/logs 22:39:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.308123 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-08 22:39:41.765799) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-08 22:39:41.769614) ========= 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=337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c5173c2bd195e85ad2ec4c08899464d1745d7c552b9e09f1b2a7ad6d5e4f207c5928471f8931ef62e303f87dce9e8f0ddbb333b2e58d555a2def9379714fcf8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6891d5e83689bb0217eb6a67d4a5e3bc896d74ab2eb01c4110d404a990909687303a3003d0a903de8eb6932b138f5556470a7e8b34195932ac3ec76aee4090bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/474e52412cd3c0d6bcf6e87ded0398d9d316dd742e0a7ec65b78fcc871ea3dd75cbe3830d47e12d39f449b3c09e885055b6e5fe0cbce666b9a45585b51d0f03a"} build_url:https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/TffdspH2TQG6lPr531MASg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c5173c2bd195e85ad2ec4c08899464d1745d7c552b9e09f1b2a7ad6d5e4f207c5928471f8931ef62e303f87dce9e8f0ddbb333b2e58d555a2def9379714fcf8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6891d5e83689bb0217eb6a67d4a5e3bc896d74ab2eb01c4110d404a990909687303a3003d0a903de8eb6932b138f5556470a7e8b34195932ac3ec76aee4090bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/474e52412cd3c0d6bcf6e87ded0398d9d316dd742e0a7ec65b78fcc871ea3dd75cbe3830d47e12d39f449b3c09e885055b6e5fe0cbce666b9a45585b51d0f03a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-08 22:39:41.794952) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 22:39:41.795269) ========= 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=337fe3f4b1febe37b85fccc40000019e-1475987396.730685-1801512403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 22:39:41.878096) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-08 22:39:41.878451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-08 22:39:41.878736) ========= ========= Total master_lag: 0.17 =========