builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1483010156.57 results: success (0) buildid: 20161229013937 builduid: f360bf03ea4e41b9ae05d6af79031c1b revision: 80e89a0b39c5c21de97eb9f1ad1c60fcdc618992 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 03:15:56.569399) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 03:15:56.569827) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 03:15:56.570095) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 03:15:56.586247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 03:15:56.586507) ========= 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=3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-29 03:15:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.1M=0s 2016-12-29 03:15:57 (96.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085347 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 03:15:56.693688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 03:15:56.693970) ========= 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=3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021548 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 03:15:56.752171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 03:15:56.752503) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 80e89a0b39c5c21de97eb9f1ad1c60fcdc618992 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 80e89a0b39c5c21de97eb9f1ad1c60fcdc618992 --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=3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-29 03:15:57,230 truncating revision to first 12 chars 2016-12-29 03:15:57,230 Setting DEBUG logging. 2016-12-29 03:15:57,230 attempt 1/10 2016-12-29 03:15:57,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/80e89a0b39c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-29 03:15:57,532 unpacking tar archive at: mozilla-aurora-80e89a0b39c5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592305 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 03:15:57.361208) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 03:15:57.361512) ========= script_repo_revision: 80e89a0b39c5c21de97eb9f1ad1c60fcdc618992 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 03:15:57.361949) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 03:15:57.362212) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 03:15:57.369593) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-29 03:15:57.369886) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:15:57 INFO - MultiFileLogger online at 20161229 03:15:57 in /builds/slave/test 03:15:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:15:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:15:57 INFO - {'append_to_log': False, 03:15:57 INFO - 'base_work_dir': '/builds/slave/test', 03:15:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:15:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:15:57 INFO - 'branch': 'Mozilla-Aurora', 03:15:57 INFO - 'buildbot_json_path': 'buildprops.json', 03:15:57 INFO - 'config_files': ('talos/linux_config.py',), 03:15:57 INFO - 'default_actions': ('clobber', 03:15:57 INFO - 'read-buildbot-config', 03:15:57 INFO - 'download-and-extract', 03:15:57 INFO - 'populate-webroot', 03:15:57 INFO - 'create-virtualenv', 03:15:57 INFO - 'install', 03:15:57 INFO - 'run-tests'), 03:15:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:15:57 INFO - 'download_minidump_stackwalk': True, 03:15:57 INFO - 'download_symbols': 'ondemand', 03:15:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:15:57 INFO - 'tooltool.py': '/tools/tooltool.py', 03:15:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:15:57 INFO - '/tools/misc-python/virtualenv.py')}, 03:15:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:15:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:15:57 INFO - 'installer_path': 'installer.exe', 03:15:57 INFO - 'log_level': 'info', 03:15:57 INFO - 'log_name': 'talos', 03:15:57 INFO - 'log_to_console': True, 03:15:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:15:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:15:57 INFO - 'opt_config_files': (), 03:15:57 INFO - 'pip_index': False, 03:15:57 INFO - 'sps_profile': False, 03:15:57 INFO - 'sps_profile_interval': 0, 03:15:57 INFO - 'suite': 'dromaeojs', 03:15:57 INFO - 'system_bits': '32', 03:15:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:15:57 INFO - 'title': 'talos-linux64-ix-059', 03:15:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:15:57 INFO - 'use_talos_json': True, 03:15:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:15:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:15:57 INFO - 'work_dir': 'build'} 03:15:57 INFO - [mozharness: 2016-12-29 11:15:57.937731Z] Running clobber step. 03:15:57 INFO - Running pre-action listener: _resource_record_pre_action 03:15:57 INFO - Running main action method: clobber 03:15:57 INFO - rmtree: /builds/slave/test/build 03:15:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:15:58 INFO - Running post-action listener: _resource_record_post_action 03:15:58 INFO - [mozharness: 2016-12-29 11:15:58.386984Z] Finished clobber step (success) 03:15:58 INFO - [mozharness: 2016-12-29 11:15:58.387085Z] Running read-buildbot-config step. 03:15:58 INFO - Running pre-action listener: _resource_record_pre_action 03:15:58 INFO - Running main action method: read_buildbot_config 03:15:58 INFO - Using buildbot properties: 03:15:58 INFO - { 03:15:58 INFO - "project": "", 03:15:58 INFO - "product": "firefox", 03:15:58 INFO - "script_repo_revision": "production", 03:15:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:15:58 INFO - "repository": "", 03:15:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:15:58 INFO - "buildid": "20161229013937", 03:15:58 INFO - "pgo_build": "True", 03:15:58 INFO - "basedir": "/builds/slave/test", 03:15:58 INFO - "buildnumber": 663, 03:15:58 INFO - "slavename": "talos-linux64-ix-059", 03:15:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:15:58 INFO - "platform": "ubuntu64_hw", 03:15:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:15:58 INFO - "branch": "mozilla-aurora", 03:15:58 INFO - "repo_path": "releases/mozilla-aurora", 03:15:58 INFO - "revision": "80e89a0b39c5c21de97eb9f1ad1c60fcdc618992", 03:15:58 INFO - "stage_platform": "linux64-pgo", 03:15:58 INFO - "builduid": "f360bf03ea4e41b9ae05d6af79031c1b", 03:15:58 INFO - "slavebuilddir": "test" 03:15:58 INFO - } 03:15:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 03:15:58 INFO - Running post-action listener: _resource_record_post_action 03:15:58 INFO - [mozharness: 2016-12-29 11:15:58.389553Z] Finished read-buildbot-config step (success) 03:15:58 INFO - [mozharness: 2016-12-29 11:15:58.389643Z] Running download-and-extract step. 03:15:58 INFO - Running pre-action listener: _resource_record_pre_action 03:15:58 INFO - Running main action method: download_and_extract 03:15:58 INFO - mkdir: /builds/slave/test/build/tests 03:15:58 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')]} 03:15:58 INFO - trying https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:15:58 INFO - Downloading https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:15:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:15:58 INFO - Downloaded 1361 bytes. 03:15:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:15:58 INFO - Using the following test package requirements: 03:15:58 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:15:58 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:15:58 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:15:58 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:58 INFO - u'jsshell-linux-x86_64.zip'], 03:15:58 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:15:58 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:15:58 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:15:58 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:15:58 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:15:58 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:15:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:15:58 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:15:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:15:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:15:58 INFO - Fetch https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:15:59 INFO - Http code: 200 03:15:59 INFO - via: 1.1 3344ddc09ccf1d185bb41add18940cc4.cloudfront.net (CloudFront) 03:15:59 INFO - x-amz-cf-id: 4Vu0CV_CoFkpXd7Dz0r9NJBTMPGRXQdDwDt0z9D6fylz2sxqAM0fpw== 03:15:59 INFO - x-amz-version-id: RGzLpVICLQu60PYGD34qag03C80hxBP9 03:15:59 INFO - Expected file size: 21941210 03:15:59 INFO - Obtained file size: 21941210 03:16:03 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:16:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:16:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:16:03 INFO - Fetch https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:16:04 INFO - Http code: 200 03:16:04 INFO - via: 1.1 55676da1e5c0a9c4e60a94a95b01dc04.cloudfront.net (CloudFront) 03:16:04 INFO - x-amz-cf-id: 5UhoYbB5b5P7O8NOkSqBMku6vCIF6menZPELbeIcumfbyQGuf_xEoQ== 03:16:04 INFO - x-amz-version-id: RGzLpVICLQu60PYGD34qag03C80hxBP9 03:16:04 INFO - Expected file size: 21941210 03:16:04 INFO - Obtained file size: 21941210 03:16:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:16:09 INFO - Fetch https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:16:09 INFO - Http code: 200 03:16:09 INFO - via: 1.1 6eaa7f856e226a0db7cef6201d3b8393.cloudfront.net (CloudFront) 03:16:09 INFO - x-amz-cf-id: Qv9TQNoTsfZA1Do7wHNcFHInF1UHH8wP5zOBVF_1ILAmMWB0rDMTGQ== 03:16:09 INFO - x-amz-version-id: oLdgIA_pZEmmJSvg6YucJ_AR3m15iL_z 03:16:10 INFO - Expected file size: 14409038 03:16:10 INFO - Obtained file size: 14409038 03:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:10 INFO - trying https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:16:10 INFO - Downloading https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:16:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:16:13 INFO - Downloaded 64005615 bytes. 03:16:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:16:13 INFO - mkdir: /builds/slave/test/properties 03:16:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:16:13 INFO - Writing to file /builds/slave/test/properties/build_url 03:16:13 INFO - Contents: 03:16:13 INFO - build_url:https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:16:14 INFO - Running post-action listener: _resource_record_post_action 03:16:14 INFO - Running post-action listener: set_extra_try_arguments 03:16:14 INFO - [mozharness: 2016-12-29 11:16:14.306187Z] Finished download-and-extract step (success) 03:16:14 INFO - [mozharness: 2016-12-29 11:16:14.306415Z] Running populate-webroot step. 03:16:14 INFO - Running pre-action listener: _resource_record_pre_action 03:16:14 INFO - Running main action method: populate_webroot 03:16:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:16:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:16:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:16:14 INFO - '--tppagecycles', 03:16:14 INFO - '7'], 03:16:14 INFO - 'tests': ['tsvgm']}}, 03:16:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:16:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:16:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:16:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:16:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:16:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:16:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:14 INFO - 'talos_options': ['--disable-e10s'], 03:16:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:14 INFO - 'talos_options': ['--disable-e10s'], 03:16:14 INFO - 'tests': ['damp', 'tps']}, 03:16:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:14 INFO - 'tests': ['damp', 'tps']}, 03:16:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:16:14 INFO - 'tests': ['dromaeo_dom']}, 03:16:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:16:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:16:14 INFO - 'tests': ['basic_compositor_video']}, 03:16:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:16:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:16:14 INFO - 'tests': ['a11yr', 03:16:14 INFO - 'ts_paint', 03:16:14 INFO - 'tpaint', 03:16:14 INFO - 'sessionrestore', 03:16:14 INFO - 'sessionrestore_no_auto_restore', 03:16:14 INFO - 'tabpaint']}, 03:16:14 INFO - 'other-e10s': {'tests': ['a11yr', 03:16:14 INFO - 'ts_paint', 03:16:14 INFO - 'tpaint', 03:16:14 INFO - 'sessionrestore', 03:16:14 INFO - 'sessionrestore_no_auto_restore', 03:16:14 INFO - 'tabpaint']}, 03:16:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:16:14 INFO - 'ts_paint', 03:16:14 INFO - 'tpaint', 03:16:14 INFO - 'sessionrestore', 03:16:14 INFO - 'sessionrestore_no_auto_restore', 03:16:14 INFO - 'tabpaint']}, 03:16:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:16:14 INFO - 'ts_paint', 03:16:14 INFO - 'tpaint', 03:16:14 INFO - 'sessionrestore', 03:16:14 INFO - 'sessionrestore_no_auto_restore', 03:16:14 INFO - 'tabpaint']}, 03:16:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:16:14 INFO - 'tests': ['a11yr', 03:16:14 INFO - 'ts_paint', 03:16:14 INFO - 'tpaint', 03:16:14 INFO - 'sessionrestore', 03:16:14 INFO - 'sessionrestore_no_auto_restore', 03:16:14 INFO - 'tabpaint']}, 03:16:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:16:14 INFO - 'tests': ['a11yr', 03:16:14 INFO - 'ts_paint', 03:16:14 INFO - 'tpaint', 03:16:14 INFO - 'sessionrestore', 03:16:14 INFO - 'sessionrestore_no_auto_restore', 03:16:14 INFO - 'tabpaint']}, 03:16:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:16:14 INFO - 'tests': ['tsvgx', 03:16:14 INFO - 'tsvgr_opacity', 03:16:14 INFO - 'tart', 03:16:14 INFO - 'tscrollx', 03:16:14 INFO - 'cart']}, 03:16:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:16:14 INFO - 'tsvgr_opacity', 03:16:14 INFO - 'tart', 03:16:14 INFO - 'tscrollx', 03:16:14 INFO - 'cart']}, 03:16:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:14 INFO - 'talos_options': ['--disable-e10s'], 03:16:14 INFO - 'tests': ['tp5o']}, 03:16:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:14 INFO - 'tests': ['tp5o']}, 03:16:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:14 INFO - 'talos_options': ['--disable-e10s', 03:16:14 INFO - '--xperf_path', 03:16:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:14 INFO - 'tests': ['tp5n']}, 03:16:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:14 INFO - 'talos_options': ['--xperf_path', 03:16:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:14 INFO - 'tests': ['tp5n']}}, 03:16:14 INFO - 'talos.zip': {'path': '', 03:16:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:16:14 INFO - Running post-action listener: _resource_record_post_action 03:16:14 INFO - [mozharness: 2016-12-29 11:16:14.324188Z] Finished populate-webroot step (success) 03:16:14 INFO - [mozharness: 2016-12-29 11:16:14.324277Z] Running create-virtualenv step. 03:16:14 INFO - Running pre-action listener: _resource_record_pre_action 03:16:14 INFO - Running main action method: create_virtualenv 03:16:14 INFO - Creating virtualenv /builds/slave/test/build/venv 03:16:14 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 03:16:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:16:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:16:14 INFO - Using real prefix '/usr' 03:16:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:16:14 INFO - Installing distribute.............................................................................................................................................................................................done. 03:16:16 INFO - Installing pip.................done. 03:16:16 INFO - Return code: 0 03:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:16:17 INFO - Reading from file tmpfile_stdout 03:16:17 INFO - Output received: 03:16:17 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) 03:16:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:17 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 0x7f98b4426f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2170ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216df60>, '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 0x216ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216f1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', '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 03:16:17 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 03:16:17 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 03:16:17 INFO - Using env: {'DISPLAY': ':0', 03:16:17 INFO - 'HOME': '/home/cltbld', 03:16:17 INFO - 'LANG': 'en_US.UTF-8', 03:16:17 INFO - 'LANGUAGE': 'en_US:en', 03:16:17 INFO - 'LOGNAME': 'cltbld', 03:16:17 INFO - 'MAIL': '/var/mail/cltbld', 03:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:17 INFO - 'MOZ_NO_REMOTE': '1', 03:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:17 INFO - 'NO_EM_RESTART': '1', 03:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:17 INFO - 'PWD': '/builds/slave/test', 03:16:17 INFO - 'SHELL': '/bin/bash', 03:16:17 INFO - 'SHLVL': '1', 03:16:17 INFO - 'TERM': 'linux', 03:16:17 INFO - 'TMOUT': '86400', 03:16:17 INFO - 'USER': 'cltbld', 03:16:17 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', 03:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:17 INFO - '_': '/tools/buildbot/bin/python'} 03:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:17 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 03:16:17 INFO - Cleaning up... 03:16:17 INFO - Return code: 0 03:16:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:17 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 0x7f98b4426f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2170ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216df60>, '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 0x216ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216f1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', '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 03:16:17 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 03:16:17 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 03:16:17 INFO - Using env: {'DISPLAY': ':0', 03:16:17 INFO - 'HOME': '/home/cltbld', 03:16:17 INFO - 'LANG': 'en_US.UTF-8', 03:16:17 INFO - 'LANGUAGE': 'en_US:en', 03:16:17 INFO - 'LOGNAME': 'cltbld', 03:16:17 INFO - 'MAIL': '/var/mail/cltbld', 03:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:17 INFO - 'MOZ_NO_REMOTE': '1', 03:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:17 INFO - 'NO_EM_RESTART': '1', 03:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:17 INFO - 'PWD': '/builds/slave/test', 03:16:17 INFO - 'SHELL': '/bin/bash', 03:16:17 INFO - 'SHLVL': '1', 03:16:17 INFO - 'TERM': 'linux', 03:16:17 INFO - 'TMOUT': '86400', 03:16:17 INFO - 'USER': 'cltbld', 03:16:17 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', 03:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:17 INFO - '_': '/tools/buildbot/bin/python'} 03:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:17 INFO - Downloading/unpacking psutil>=3.1.1 03:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:16:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:19 INFO - Installing collected packages: psutil 03:16:19 INFO - Running setup.py install for psutil 03:16:19 INFO - building 'psutil._psutil_linux' extension 03:16:19 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 03:16:19 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 03:16:19 INFO - building 'psutil._psutil_posix' extension 03:16:19 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 03:16:20 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 03:16:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:20 INFO - Successfully installed psutil 03:16:20 INFO - Cleaning up... 03:16:20 INFO - Return code: 0 03:16:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b4426f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2170ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216df60>, '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 0x216ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216f1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', '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 03:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:16:20 INFO - Using env: {'DISPLAY': ':0', 03:16:20 INFO - 'HOME': '/home/cltbld', 03:16:20 INFO - 'LANG': 'en_US.UTF-8', 03:16:20 INFO - 'LANGUAGE': 'en_US:en', 03:16:20 INFO - 'LOGNAME': 'cltbld', 03:16:20 INFO - 'MAIL': '/var/mail/cltbld', 03:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:20 INFO - 'MOZ_NO_REMOTE': '1', 03:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:20 INFO - 'NO_EM_RESTART': '1', 03:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:20 INFO - 'PWD': '/builds/slave/test', 03:16:20 INFO - 'SHELL': '/bin/bash', 03:16:20 INFO - 'SHLVL': '1', 03:16:20 INFO - 'TERM': 'linux', 03:16:20 INFO - 'TMOUT': '86400', 03:16:20 INFO - 'USER': 'cltbld', 03:16:20 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', 03:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:20 INFO - '_': '/tools/buildbot/bin/python'} 03:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:16:20 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 03:16:20 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 03:16:20 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 03:16:20 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 03:16:20 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 03:16:20 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 03:16:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:16:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:16:22 INFO - Installing collected packages: mozsystemmonitor 03:16:22 INFO - Running setup.py install for mozsystemmonitor 03:16:22 INFO - Successfully installed mozsystemmonitor 03:16:22 INFO - Cleaning up... 03:16:22 INFO - Return code: 0 03:16:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:16: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')]} 03:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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')]} 03:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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', '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 0x7f98b4426f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2170ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216df60>, '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 0x216ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216f1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', '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 03:16: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:16: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 jsonschema==2.5.1 03:16:22 INFO - Using env: {'DISPLAY': ':0', 03:16:22 INFO - 'HOME': '/home/cltbld', 03:16:22 INFO - 'LANG': 'en_US.UTF-8', 03:16:22 INFO - 'LANGUAGE': 'en_US:en', 03:16:22 INFO - 'LOGNAME': 'cltbld', 03:16:22 INFO - 'MAIL': '/var/mail/cltbld', 03:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:22 INFO - 'MOZ_NO_REMOTE': '1', 03:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:22 INFO - 'NO_EM_RESTART': '1', 03:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:22 INFO - 'PWD': '/builds/slave/test', 03:16:22 INFO - 'SHELL': '/bin/bash', 03:16:22 INFO - 'SHLVL': '1', 03:16:22 INFO - 'TERM': 'linux', 03:16:22 INFO - 'TMOUT': '86400', 03:16:22 INFO - 'USER': 'cltbld', 03:16:22 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', 03:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:22 INFO - '_': '/tools/buildbot/bin/python'} 03:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:22 INFO - Downloading/unpacking jsonschema==2.5.1 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:16:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:16:24 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 03:16:24 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 03:16:24 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 03:16:24 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 03:16:24 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 03:16:24 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 03:16:25 INFO - Downloading functools32-3.2.3-2.tar.gz 03:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:16:25 INFO - warning: no files found matching '*.txt' 03:16:25 INFO - no previously-included directories found matching 'build' 03:16:25 INFO - no previously-included directories found matching 'dist' 03:16:25 INFO - no previously-included directories found matching '.git*' 03:16:25 INFO - Installing collected packages: jsonschema, functools32 03:16:25 INFO - Running setup.py install for functools32 03:16:25 INFO - warning: no files found matching '*.txt' 03:16:25 INFO - no previously-included directories found matching 'build' 03:16:25 INFO - no previously-included directories found matching 'dist' 03:16:25 INFO - no previously-included directories found matching '.git*' 03:16:25 INFO - Successfully installed jsonschema functools32 03:16:25 INFO - Cleaning up... 03:16:25 INFO - Return code: 0 03:16:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:16:25 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')]} 03:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:25 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')]} 03:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:25 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 0x7f98b4426f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2170ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216df60>, '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 0x216ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216f1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', '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 03:16:25 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 03:16:25 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 03:16:25 INFO - Using env: {'DISPLAY': ':0', 03:16:25 INFO - 'HOME': '/home/cltbld', 03:16:25 INFO - 'LANG': 'en_US.UTF-8', 03:16:25 INFO - 'LANGUAGE': 'en_US:en', 03:16:25 INFO - 'LOGNAME': 'cltbld', 03:16:25 INFO - 'MAIL': '/var/mail/cltbld', 03:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:25 INFO - 'MOZ_NO_REMOTE': '1', 03:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:25 INFO - 'NO_EM_RESTART': '1', 03:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:25 INFO - 'PWD': '/builds/slave/test', 03:16:25 INFO - 'SHELL': '/bin/bash', 03:16:25 INFO - 'SHLVL': '1', 03:16:25 INFO - 'TERM': 'linux', 03:16:25 INFO - 'TMOUT': '86400', 03:16:25 INFO - 'USER': 'cltbld', 03:16:25 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', 03:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:25 INFO - '_': '/tools/buildbot/bin/python'} 03:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:16:25 INFO - Cleaning up... 03:16:25 INFO - Return code: 0 03:16:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:16:25 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')]} 03:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:25 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')]} 03:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:25 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 0x7f98b4426f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2170ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216df60>, '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 0x216ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216f1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', '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 03:16:25 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 03:16:25 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 03:16:25 INFO - Using env: {'DISPLAY': ':0', 03:16:25 INFO - 'HOME': '/home/cltbld', 03:16:25 INFO - 'LANG': 'en_US.UTF-8', 03:16:25 INFO - 'LANGUAGE': 'en_US:en', 03:16:25 INFO - 'LOGNAME': 'cltbld', 03:16:25 INFO - 'MAIL': '/var/mail/cltbld', 03:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:25 INFO - 'MOZ_NO_REMOTE': '1', 03:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:25 INFO - 'NO_EM_RESTART': '1', 03:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:25 INFO - 'PWD': '/builds/slave/test', 03:16:25 INFO - 'SHELL': '/bin/bash', 03:16:25 INFO - 'SHLVL': '1', 03:16:25 INFO - 'TERM': 'linux', 03:16:25 INFO - 'TMOUT': '86400', 03:16:25 INFO - 'USER': 'cltbld', 03:16:25 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', 03:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:25 INFO - '_': '/tools/buildbot/bin/python'} 03:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:25 INFO - Downloading/unpacking blobuploader==1.2.4 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:27 INFO - Downloading blobuploader-1.2.4.tar.gz 03:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:16:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:16:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:16:28 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 03:16:28 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 03:16:28 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 03:16:28 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 03:16:28 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 03:16:28 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 03:16:28 INFO - Downloading docopt-0.6.1.tar.gz 03:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:16:28 INFO - Installing collected packages: blobuploader, requests, docopt 03:16:28 INFO - Running setup.py install for blobuploader 03:16:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:16:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:16:28 INFO - Running setup.py install for requests 03:16:29 INFO - Running setup.py install for docopt 03:16:29 INFO - Successfully installed blobuploader requests docopt 03:16:29 INFO - Cleaning up... 03:16:29 INFO - Return code: 0 03:16:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:29 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')]} 03:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:29 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')]} 03:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:29 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 0x7f98b4426f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2170ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216df60>, '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 0x216ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216f1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', '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 03:16:29 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 03:16:29 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 03:16:29 INFO - Using env: {'DISPLAY': ':0', 03:16:29 INFO - 'HOME': '/home/cltbld', 03:16:29 INFO - 'LANG': 'en_US.UTF-8', 03:16:29 INFO - 'LANGUAGE': 'en_US:en', 03:16:29 INFO - 'LOGNAME': 'cltbld', 03:16:29 INFO - 'MAIL': '/var/mail/cltbld', 03:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:29 INFO - 'MOZ_NO_REMOTE': '1', 03:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:29 INFO - 'NO_EM_RESTART': '1', 03:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:29 INFO - 'PWD': '/builds/slave/test', 03:16:29 INFO - 'SHELL': '/bin/bash', 03:16:29 INFO - 'SHLVL': '1', 03:16:29 INFO - 'TERM': 'linux', 03:16:29 INFO - 'TMOUT': '86400', 03:16:29 INFO - 'USER': 'cltbld', 03:16:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', 03:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:29 INFO - '_': '/tools/buildbot/bin/python'} 03:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:29 INFO - Running setup.py (path:/tmp/pip-ZuwcA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:29 INFO - Running setup.py (path:/tmp/pip-OHdD9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:29 INFO - Running setup.py (path:/tmp/pip-rIkjfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:29 INFO - Running setup.py (path:/tmp/pip-Sru716-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:29 INFO - Running setup.py (path:/tmp/pip-ysibOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:29 INFO - Running setup.py (path:/tmp/pip-eRbYkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:29 INFO - Running setup.py (path:/tmp/pip-7QJK3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:29 INFO - Running setup.py (path:/tmp/pip-ar3RWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:30 INFO - Running setup.py (path:/tmp/pip-9f7uxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:30 INFO - Running setup.py (path:/tmp/pip-zP0L0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:30 INFO - Running setup.py (path:/tmp/pip-HxkGtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:30 INFO - Running setup.py (path:/tmp/pip-mZJWq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:30 INFO - Running setup.py (path:/tmp/pip-RWTKq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:30 INFO - Running setup.py (path:/tmp/pip-MmJ_63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:30 INFO - Running setup.py (path:/tmp/pip-f86RVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:30 INFO - Running setup.py (path:/tmp/pip-S9TpE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:30 INFO - Running setup.py (path:/tmp/pip-joZhc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:30 INFO - Running setup.py install for manifestparser 03:16:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:16:30 INFO - Running setup.py install for mozcrash 03:16:30 INFO - Running setup.py install for mozdebug 03:16:30 INFO - Running setup.py install for mozdevice 03:16:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:16:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:16:31 INFO - Running setup.py install for mozfile 03:16:31 INFO - Running setup.py install for mozhttpd 03:16:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:16:31 INFO - Running setup.py install for mozinfo 03:16:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:16:31 INFO - Running setup.py install for mozInstall 03:16:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:16:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:16:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:16:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:16:31 INFO - Running setup.py install for mozleak 03:16:31 INFO - Running setup.py install for mozlog 03:16:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:16:31 INFO - Running setup.py install for moznetwork 03:16:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:16:31 INFO - Running setup.py install for mozprocess 03:16:31 INFO - Running setup.py install for mozprofile 03:16:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:16:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:16:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:16:32 INFO - Running setup.py install for mozrunner 03:16:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:16:32 INFO - Running setup.py install for mozscreenshot 03:16:32 INFO - Running setup.py install for moztest 03:16:32 INFO - Running setup.py install for mozversion 03:16:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:16:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:16:32 INFO - Cleaning up... 03:16:32 INFO - Return code: 0 03:16:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:32 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')]} 03:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:32 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')]} 03:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:32 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 0x7f98b4426f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2170ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216df60>, '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 0x216ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216f1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', '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 03:16:32 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 03:16:32 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 03:16:32 INFO - Using env: {'DISPLAY': ':0', 03:16:32 INFO - 'HOME': '/home/cltbld', 03:16:32 INFO - 'LANG': 'en_US.UTF-8', 03:16:32 INFO - 'LANGUAGE': 'en_US:en', 03:16:32 INFO - 'LOGNAME': 'cltbld', 03:16:32 INFO - 'MAIL': '/var/mail/cltbld', 03:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:32 INFO - 'MOZ_NO_REMOTE': '1', 03:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:32 INFO - 'NO_EM_RESTART': '1', 03:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:32 INFO - 'PWD': '/builds/slave/test', 03:16:32 INFO - 'SHELL': '/bin/bash', 03:16:32 INFO - 'SHLVL': '1', 03:16:32 INFO - 'TERM': 'linux', 03:16:32 INFO - 'TMOUT': '86400', 03:16:32 INFO - 'USER': 'cltbld', 03:16:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', 03:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:32 INFO - '_': '/tools/buildbot/bin/python'} 03:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:32 INFO - Running setup.py (path:/tmp/pip-iO3dRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:32 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)) 03:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:32 INFO - Running setup.py (path:/tmp/pip-ORw8hS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:32 INFO - Running setup.py (path:/tmp/pip-ePxnmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:32 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)) 03:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:32 INFO - Running setup.py (path:/tmp/pip-PsktWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:32 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)) 03:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:33 INFO - Running setup.py (path:/tmp/pip-hsk9Mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:33 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)) 03:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:33 INFO - Running setup.py (path:/tmp/pip-oYOJYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:33 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)) 03:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:33 INFO - Running setup.py (path:/tmp/pip-_xOdnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:33 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)) 03:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:33 INFO - Running setup.py (path:/tmp/pip-TBFBn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:33 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)) 03:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:33 INFO - Running setup.py (path:/tmp/pip-E9kzRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:33 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)) 03:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:33 INFO - Running setup.py (path:/tmp/pip-DPJfgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:33 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)) 03:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:33 INFO - Running setup.py (path:/tmp/pip-G0uAwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:33 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)) 03:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:33 INFO - Running setup.py (path:/tmp/pip-QDrTGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:33 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)) 03:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:33 INFO - Running setup.py (path:/tmp/pip-Uz5K_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:33 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)) 03:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:33 INFO - Running setup.py (path:/tmp/pip-76CasA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:33 INFO - Running setup.py (path:/tmp/pip-E3I6Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:33 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)) 03:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:33 INFO - Running setup.py (path:/tmp/pip-TgHKjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:33 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)) 03:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:33 INFO - Running setup.py (path:/tmp/pip-dmel_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:33 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)) 03:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:33 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)) 03:16:33 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)) 03:16:33 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)) 03:16:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:33 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 03:16:33 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 03:16:33 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 03:16:33 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 03:16:33 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 03:16:33 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 03:16:35 INFO - Downloading blessings-1.6.tar.gz 03:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:16:36 INFO - Installing collected packages: blessings 03:16:36 INFO - Running setup.py install for blessings 03:16:36 INFO - Successfully installed blessings 03:16:36 INFO - Cleaning up... 03:16:36 INFO - Return code: 0 03:16:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:16:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:36 INFO - Reading from file tmpfile_stdout 03:16:36 INFO - Current package versions: 03:16:36 INFO - argparse == 1.2.1 03:16:36 INFO - blessings == 1.6 03:16:36 INFO - blobuploader == 1.2.4 03:16:36 INFO - docopt == 0.6.1 03:16:36 INFO - functools32 == 3.2.3-2 03:16:36 INFO - jsonschema == 2.5.1 03:16:36 INFO - manifestparser == 1.1 03:16:36 INFO - mozInstall == 1.12 03:16:36 INFO - mozcrash == 1.0 03:16:36 INFO - mozdebug == 0.1 03:16:36 INFO - mozdevice == 0.48 03:16:36 INFO - mozfile == 1.2 03:16:36 INFO - mozhttpd == 0.7 03:16:36 INFO - mozinfo == 0.9 03:16:36 INFO - mozleak == 0.1 03:16:36 INFO - mozlog == 3.4 03:16:36 INFO - moznetwork == 0.27 03:16:36 INFO - mozprocess == 0.23 03:16:36 INFO - mozprofile == 0.28 03:16:36 INFO - mozrunner == 6.13 03:16:36 INFO - mozscreenshot == 0.1 03:16:36 INFO - mozsystemmonitor == 0.3 03:16:36 INFO - moztest == 0.7 03:16:36 INFO - mozversion == 1.4 03:16:36 INFO - psutil == 3.1.1 03:16:36 INFO - requests == 1.2.3 03:16:36 INFO - wsgiref == 0.1.2 03:16:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:36 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 0x7f98b4426f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2170ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216df60>, '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 0x216ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216f1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', '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 03:16:36 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 03:16:36 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 03:16:36 INFO - Using env: {'DISPLAY': ':0', 03:16:36 INFO - 'HOME': '/home/cltbld', 03:16:36 INFO - 'LANG': 'en_US.UTF-8', 03:16:36 INFO - 'LANGUAGE': 'en_US:en', 03:16:36 INFO - 'LOGNAME': 'cltbld', 03:16:36 INFO - 'MAIL': '/var/mail/cltbld', 03:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:36 INFO - 'MOZ_NO_REMOTE': '1', 03:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:36 INFO - 'NO_EM_RESTART': '1', 03:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:36 INFO - 'PWD': '/builds/slave/test', 03:16:36 INFO - 'SHELL': '/bin/bash', 03:16:36 INFO - 'SHLVL': '1', 03:16:36 INFO - 'TERM': 'linux', 03:16:36 INFO - 'TMOUT': '86400', 03:16:36 INFO - 'USER': 'cltbld', 03:16:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', 03:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:36 INFO - '_': '/tools/buildbot/bin/python'} 03:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:36 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)) 03:16:36 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)) 03:16:36 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)) 03:16:36 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)) 03:16:36 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)) 03:16:36 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)) 03:16:36 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)) 03:16:36 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)) 03:16:36 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)) 03:16:36 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)) 03:16:36 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)) 03:16:36 INFO - Cleaning up... 03:16:36 INFO - Return code: 0 03:16:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:36 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 0x7f98b4426f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2170ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216df60>, '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 0x216ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216f1d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', '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 03:16:36 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 03:16:36 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 03:16:36 INFO - Using env: {'DISPLAY': ':0', 03:16:36 INFO - 'HOME': '/home/cltbld', 03:16:36 INFO - 'LANG': 'en_US.UTF-8', 03:16:36 INFO - 'LANGUAGE': 'en_US:en', 03:16:36 INFO - 'LOGNAME': 'cltbld', 03:16:36 INFO - 'MAIL': '/var/mail/cltbld', 03:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:36 INFO - 'MOZ_NO_REMOTE': '1', 03:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:36 INFO - 'NO_EM_RESTART': '1', 03:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:36 INFO - 'PWD': '/builds/slave/test', 03:16:36 INFO - 'SHELL': '/bin/bash', 03:16:36 INFO - 'SHLVL': '1', 03:16:36 INFO - 'TERM': 'linux', 03:16:36 INFO - 'TMOUT': '86400', 03:16:36 INFO - 'USER': 'cltbld', 03:16:36 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', 03:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:36 INFO - '_': '/tools/buildbot/bin/python'} 03:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:16:36 INFO - Cleaning up... 03:16:36 INFO - Return code: 0 03:16:36 INFO - Running post-action listener: _resource_record_post_action 03:16:36 INFO - Running post-action listener: _start_resource_monitoring 03:16:36 INFO - Starting resource monitoring. 03:16:36 INFO - [mozharness: 2016-12-29 11:16:36.903117Z] Finished create-virtualenv step (success) 03:16:36 INFO - [mozharness: 2016-12-29 11:16:36.903577Z] Running install step. 03:16:36 INFO - Running pre-action listener: _resource_record_pre_action 03:16:36 INFO - Running main action method: install 03:16:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:37 INFO - Reading from file tmpfile_stdout 03:16:37 INFO - Detecting whether we're running mozinstall >=1.0... 03:16:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:16:37 INFO - Reading from file tmpfile_stdout 03:16:37 INFO - Output received: 03:16:37 INFO - Usage: mozinstall [options] installer 03:16:37 INFO - Options: 03:16:37 INFO - -h, --help show this help message and exit 03:16:37 INFO - -d DEST, --destination=DEST 03:16:37 INFO - Directory to install application into. [default: 03:16:37 INFO - "/builds/slave/test"] 03:16:37 INFO - --app=APP Application being installed. [default: firefox] 03:16:37 INFO - mkdir: /builds/slave/test/build/application 03:16:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:16:53 INFO - Reading from file tmpfile_stdout 03:16:53 INFO - Output received: 03:16:53 INFO - /builds/slave/test/build/application/firefox/firefox 03:16:53 INFO - Running post-action listener: _resource_record_post_action 03:16:53 INFO - [mozharness: 2016-12-29 11:16:53.131803Z] Finished install step (success) 03:16:53 INFO - [mozharness: 2016-12-29 11:16:53.132047Z] Running run-tests step. 03:16:53 INFO - Running pre-action listener: _resource_record_pre_action 03:16:53 INFO - Running main action method: run_tests 03:16:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:16:53 INFO - Python 2.7.3 03:16:53 INFO - Return code: 0 03:16:53 INFO - grabbing minidump binary from tooltool 03:16:53 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')]} 03:16:53 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 0x216df60>, '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 0x216ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:16:53 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 03:16:53 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 03:16:53 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 03:16:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:16:53 INFO - Return code: 0 03:16:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:16:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:16:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:16:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:16:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:16:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 03:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 03:16:53 INFO - Using env: {'DISPLAY': ':0', 03:16:53 INFO - 'HOME': '/home/cltbld', 03:16:53 INFO - 'LANG': 'en_US.UTF-8', 03:16:53 INFO - 'LANGUAGE': 'en_US:en', 03:16:53 INFO - 'LOGNAME': 'cltbld', 03:16:53 INFO - 'MAIL': '/var/mail/cltbld', 03:16:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:53 INFO - 'MOZ_NO_REMOTE': '1', 03:16:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:53 INFO - 'NO_EM_RESTART': '1', 03:16:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:53 INFO - 'PWD': '/builds/slave/test', 03:16:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:53 INFO - 'SHELL': '/bin/bash', 03:16:53 INFO - 'SHLVL': '1', 03:16:53 INFO - 'TERM': 'linux', 03:16:53 INFO - 'TMOUT': '86400', 03:16:53 INFO - 'USER': 'cltbld', 03:16:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051', 03:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:53 INFO - '_': '/tools/buildbot/bin/python'} 03:16:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 03:16:53 INFO - mozversion application_buildid: 20161229013937 03:16:53 INFO - mozversion application_changeset: 80e89a0b39c5c21de97eb9f1ad1c60fcdc618992 03:16:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:16:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:16:53 INFO - mozversion application_name: Firefox 03:16:53 INFO - mozversion application_remotingname: firefox-dev 03:16:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:16:53 INFO - mozversion application_vendor: Mozilla 03:16:53 INFO - mozversion application_version: 52.0a2 03:16:53 INFO - mozversion platform_buildid: 20161229013937 03:16:53 INFO - mozversion platform_changeset: 80e89a0b39c5c21de97eb9f1ad1c60fcdc618992 03:16:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:16:53 INFO - mozversion platform_version: 52.0a2 03:16:53 INFO - using testdate: 1483010213 03:16:53 INFO - actual date: 1483010213 03:16:53 INFO - starting webserver on 'localhost:40196' 03:16:53 INFO - SUITE-START | Running 2 tests 03:16:53 INFO - TEST-START | dromaeo_css 03:16:53 INFO - operating with platform_type : linux_ 03:16:53 INFO - Initialising browser for dromaeo_css test... 03:16:53 INFO - TEST-INFO | started process 32197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA1ZASB/profile http://localhost:40196/getInfo.html) 03:16:57 INFO - PROCESS | 32197 | __metrics Screen width/height:1600/1200 03:16:57 INFO - PROCESS | 32197 | colorDepth:24 03:16:57 INFO - PROCESS | 32197 | Browser inner width/height: 1024/697 03:16:57 INFO - PROCESS | 32197 | __metrics 03:16:57 INFO - PROCESS | 32197 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:16:57 INFO - PROCESS | 32197 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:16:58 INFO - PROCESS | 32197 | console.error: PushService: 03:16:58 INFO - PROCESS | 32197 | stateChangeProcessEnqueue: Error transitioning state 03:16:58 INFO - PROCESS | 32197 | UnknownError 03:16:58 INFO - TEST-INFO | 32197: exit 0 03:16:58 INFO - Browser initialized. 03:16:58 INFO - Running cycle 1/1 for dromaeo_css test... 03:16:58 INFO - TEST-INFO | started process 32293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA1ZASB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:10 INFO - PROCESS | 32293 | RSS: Main: 144699392 03:17:10 INFO - PROCESS | 32293 | 03:18:02 INFO - PROCESS | 32293 | 1483010282428 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] 03:20:12 INFO - PROCESS | 32293 | Cycle 1(1): loaded http://localhost:40196/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40196/tests/dromaeo/cssquery-ext.html) 03:20:13 INFO - PROCESS | 32293 | RSS: Main: 292601856 03:20:13 INFO - PROCESS | 32293 | 03:23:16 INFO - PROCESS | 32293 | Cycle 1(1): loaded http://localhost:40196/tests/dromaeo/cssquery-ext.html (next: http://localhost:40196/tests/dromaeo/cssquery-jquery.html) 03:23:16 INFO - PROCESS | 32293 | RSS: Main: 219037696 03:23:16 INFO - PROCESS | 32293 | 03:26:18 INFO - PROCESS | 32293 | Cycle 1(1): loaded http://localhost:40196/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40196/tests/dromaeo/cssquery-mootools.html) 03:26:19 INFO - PROCESS | 32293 | RSS: Main: 175960064 03:26:19 INFO - PROCESS | 32293 | 03:29:21 INFO - PROCESS | 32293 | Cycle 1(1): loaded http://localhost:40196/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40196/tests/dromaeo/cssquery-prototype.html) 03:29:22 INFO - PROCESS | 32293 | RSS: Main: 220639232 03:29:22 INFO - PROCESS | 32293 | 03:32:24 INFO - PROCESS | 32293 | Cycle 1(1): loaded http://localhost:40196/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40196/tests/dromaeo/cssquery-yui.html) 03:32:25 INFO - PROCESS | 32293 | RSS: Main: 174051328 03:32:25 INFO - PROCESS | 32293 | 03:35:28 INFO - PROCESS | 32293 | Cycle 1(1): loaded http://localhost:40196/tests/dromaeo/cssquery-yui.html (next: http://localhost:40196/tests/dromaeo/cssquery-dojo.html) 03:35:28 INFO - PROCESS | 32293 | RSS: Main: 257757184 03:35:28 INFO - PROCESS | 32293 | 03:35:28 INFO - PROCESS | 32293 | __start_tp_report 03:35:28 INFO - PROCESS | 32293 | _x_x_mozilla_page_load 03:35:28 INFO - PROCESS | 32293 | _x_x_mozilla_page_load_details 03:35:28 INFO - PROCESS | 32293 | |i|pagename|runs| 03:35:28 INFO - PROCESS | 32293 | |0;dojo.html;3128.4212420702165;3160.4153231652144;3207.1982004498877;3224.4196044711944;3248.139243100579;5371.973140134299;5420.322459692538;5468.152436372358;5473.233747275374;5477.945220547794;5415.783368665258;5504.2294078829;5534.08687566552;5536.778528858841;5552.250446189763;4972.602191824645;4984.601231901457;5005.74971251436;5017.874553136183;5084.313617661605;4787.114383839001;4810.25441056635;5019.67372120811;5059.822906198284;5069.721165335924;4890.706557606537;4896.706197628136;4939.975300123512;4955.677880937746;5005.824796132136;4995.125852975715;5017.448080711119;5025.3718285214345;5046.26829109777;5052.191649336089;5003.653571801395;5013.749312534359;5042.092423363793;5071.39143302806;5079.161938280179;5266.789328426858;5319.707416092114;5333.839984800462;5399.163129714901;5430.647007944471;5750.05124154514;5760.539156867482;5761.769529218868;5884.911726324109;5891.617044892068;5893.5579831512805;5932.3474417814;5935.169076329317;5945.31628862682;5946;5308.389535203462;5337.519623233928;5339.172428273585;5366.517013468807;5427.050266203399;5899.17411562373;5908.704564771744;5917.763289468373;5931.110333450017;5943.58394912352;5704.942950570441;5718.885622287614;5720.628159169641;5721.656700597978;5732.426757324234;5619.8595035124445;5677.233573467529;5819.418058194231;5836.124581312837;5908.379620139909;5847.1229315603;5848.093545500455;5854.356020837705;5879.2944846618675;5893.381194974466;5796.362400135981;5842.036064049469;5850.5904586678525;5858.677772722541;5874.765009399576;4467.5755803198645;4491.685582009228;4492.842750503717;4586.587207151306;4591.95408045922;3992.201559688074;4032.2540330039037;4051.8379264829077;4072.1855628874346;4079.918401631951;5502.724863756796;5511.889762204733;5517.69652669099;5545.029619816516;5548.195511650788;5750.568707346965;5816.680082595498;5817.0983497557945;5845.649261044351;5858.882822343615;5474.124140137638;5529.336479622471;5533.889322213533;5575.358833734092;5617.8595535111135;5071.290019397287;5081.568066714297;5083.7203953782155;5091.1854103343285;5111.488851114858;5893.381194974466;6121.449069583669;6124.173236613089;6127.019676851683;6136.2636483622255;5683.8863222736145;5693.202951586698;5726.198332233574;5758.798442054508;5845.795397161079;6022.036474164112;6026.608270462406;6037.818865434044;6051.485623721856;6064.3935606439;5709.143628455765;5716.628419152742;5716.971415142898;5719.256496655408;5727.599068065196;5683.204351390891;5704.743286552032;5718.685472299064;5731.828045158652;5799.971000145141;5699.914501282401;5707.029804933254;5730.312362516524;5735.971320143372;5736.397678243891;5654.85862853432;5666.603337766317;5666.858328541819;5687.317521897398;5688.744006519633;5509.228707980806;5583;5583.944160558505;5602.551795856403;5605.243292155506;5686.090225564056;5752.539796816161;5768.2501274834;5823.388544202967;5853.473187413153;5477.233187353694;5658.490735833795;5663.065594177079;5665.433456654301;5674.971625141848 03:35:28 INFO - PROCESS | 32293 | |1;ext.html;559.7872808332835;617.3980369140089;638.0843489592435;656.8981807819787;666.8766278238523;33559.49660755088;44942.55057449424;45869.08261834765;45931.54068459314;45980.310295345516;46226.768866155704;46243.53756462434;46400.071998560095;46407.30389044167;46744.2988355175;8168.550729709864;8396.370272229577;8748.212660860521;8900.554972251393;8913.910860891372;10529;10802.837957430645;10809.891901081006;11092.500837462334;11102.111831053497;10820.350778953249;10904.836427453594;10913.781724365548;10917.181211409137;10942.398168100792;10764.78470430591;10800.351978881214;10819.567217311298;10822;10822.512986915608;10721.624743133953;10763.892361076367;10779;10784.406857622827;10790.784184316348;42788.1442371154;43059.13881722379;43094.353584696255;43101.35347969783;43200.783996080136;3686.7787932724123;3733.21602463483;3745.400735882246;3750.4374343848367;4168.3955826405;32205.257044868944;32306.515402268986;32624.6737532624;33106.17234569131;33507;4272.4445822042935;4345.953332244127;4368.825246990116;4413.337999300099;4424.225760491901;260068;260166;260720;261359;262117.5835329056;58659;59113;59299;59306.40693593095;59490.405095949354;39598.208035839125;40426.39360409596;40466.79766601148;42784.786076069424;42872;17649.823501765073;17889.28442862271;17917.910410447865;17926.641467170582;17937.641247175245;12857.357132143356;13069.215847049207;13254.204747715168;13434.529791457253;13592.456301748018;20902.47743806417;20912.790872091085;20966.685499717518;21003.474913127295;21053.157873684882;7607.006321681051;7640.69437222516;7679.347255483235;7689.19263477338;7801.336886364723;1037.870266216723;1121.2487633285718;1176.6058370445826;1188.8573371195512;1193.8149586814059;33856.49215261773;34378.3280414891;34432;34432;34604.134896627285;1063.4576366053368;1155.225998580936;1160.7040204747905;1170.5610396101463;1190.9285442873456;14927.925360373129;16836.413429150976;17498.82501174972;17532.509736672524;17675;547763;550072;551729;552136;553026;60063.69968150131;60525;60780;60847.69576152091;60924.390756092755;1333.3599872061466;1374.752544541992;1384.3286006286742;1403.4105675616265;1433.677422579911;29461.705382945896;34116.97649070532;34302.65697342995;34461.827690861384;34622.65377346194;51759;52384;52401.213981789544;52424.73787631038;52466.475335246156;405813;406205;406908;407066;408421;27513.587296190173;27549.31126721848;27986.86006569954;29007.404592746756;29474.557881631365;45471.54528454673;45903.77048114738;46136.76931615321;46143.76928115338;46200.7689961548;38229;38654.420183696704;39613.80193099016;40273.798631006655;40550.79724601358;38684.80657596694;38739.612603874724;39463.21073578455;39532;40549.594504054585;40535.1892962145;42813.35779963241;43612.56387436085;43757;46275.53724462712;35383.29233415369;37980.810095949346;38266;38304.42543361796;39377.21245575015;26945;27603;27975;28356.57465138066;29862.552061718656 03:35:28 INFO - PROCESS | 32293 | |2;jquery.html;393.0684278260523;430.6920551805458;432.190905454581;434.9869503914883;445.41872855923026;15988.200589970498;19053.9520326382;21183.364499065014;21210.151593936225;21296.574068518657;20150.899245503788;20400.285989990352;20410.897945510253;20566.89716551419;20600.072996715146;5696;5898.351181370046;5906.911396329058;5907.5864689471755;5907.616004959664;5644.604877658566;5850.122481627769;5883.735231914574;5914.822555323326;5923.081922302029;5721.34204566476;5915.822525324225;5932.762689492415;5937;5937.70311484424;5841.7955371562;5914.585978981473;5929;5941.7920372787175;5947.167396564506;5629.521490673298;5790.073588225863;5790.652560846363;5790.7683692652245;5843.357230704619;14626.341814618261;14745.189014604193;14747.336369863382;14851.777223341658;14866.851331486654;2263.954720905589;2402;2416.2738774497643;2427.174760581393;2541.5171117487616;10342.172626189888;10532.684019479428;10616.256862019662;10756.085732712729;10898.618548350849;1878.389523404899;1894.355918987551;1895.5640202753307;1907.265702704455;1959.3142400159973;84214.57892710558;90012;91626.5418672909;91841;94255.52872235664;10329.896701032894;11666.241694289844;11669.533218671328;11833.219193489524;11971.401429928468;15281.770773438186;15462.9226853865;16296.34814607426;16304.755428668579;16650.417235396704;8203.466774659628;8252.46358986676;8263.132371101068;8369.874451883226;8586.65653373858;7987.720429784929;8040.437169398086;8082.595870206466;8232.794180145544;8238.423310368216;4900.26496025599;4967.627427942919;5066.949330506648;5094;5137;2025.4835017070848;2040.1227472186806;2045.858178967944;2101.812475951083;2167.674848772665;924.916757491829;981.916537094355;986.8075725233654;1048.5700862646431;1061.2889364126054;19847.206111755368;20266.088026038862;20444.488887777923;21142.154313827275;21142.577148456945;1019.4472264159399;1041.146260066738;1049.9317544359592;1070.5236169904474;1074.3607553505651;10884.510197041152;11502.252353596989;11759.941200293944;11765.176437649283;11795.646130616095;491946;492285;500295;501582;507055;91518;91766;92970.53514732383;102172.89556757164;108670;1023.7696518283476;1070.8661417322835;1071.2875937501474;1072.6299426697776;1077.353587847301;18075.909620451814;18555;18702.812971870106;18864.905675471535;18925.526861828563;44193.33709994288;44264.7786761077;45726.31410528778;45803.77098114621;46872.53127468818;65426.345736542025;65927.6703616498;67485.3251467479;68029.65985170043;68184.6590767043;8850.557472126497;8979.595918183566;9063.501507417155;9166.129217724305;9245.07549245097;10052.849207262043;13124.14693044949;13953.860461395256;14100.506482273071;14232.074915130483;12073.879261207276;12526.185797923106;12529.18560293578;12538.314271259893;12634.936825315815;11898.048156147313;11906.880931190577;12105.576304829288;12301.569445069379;12359.814602781145;6906.930930690629;12041.397930103634;12100.213486123374;12129.272243665408;12380.319082450551;8801.51591662439;8837.91162088371;8877.422967507091;9123.263021093779;9193.448393096436;9473.763155921157;12258.387080646111;12629.93685031569;12651.114421990373;12727.809082863949 03:35:28 INFO - PROCESS | 32293 | |3;mootools.html;1292.4700872642206;1444.6027342480816;1495.7606782914736;1635.566574857662;1802.7386029025793;7311.195768465471;7957.681692732291;8236.341092712584;8257.463264887785;8389.328853691706;8337.583120843949;8382.455140415868;8400.285975692073;8402.327813774898;8409.327253819694;2333.416645838545;2359.7758212969825;2365.0303375616;2365.4086478380405;2367.3016460144213;2380.381100913766;2407.807375409972;2435.476372579895;2442.5237078769646;2444.4866578018637;2296.357020034393;2309.261036468331;2319.130326127702;2323.0707716913284;2341.9765802342013;2209.1163534586135;2273.693051438051;2327.592671282527;2349.2952114365708;2349.776771206741;2333.2766842278947;2352.9764702352927;2362.11420717231;2365.8225633077586;2367.171489978494;8244.587770611446;8349.03986041601;8376.83246335076;8394.958025209897;8414.705485307984;5184.896302073975;5292.994331077083;5312.2297266896085;5312.840614781563;5326.813561525367;3279.212988882675;3292.27569934614;3331.6335203127637;3354.815485148316;3356.3790698720813;1138.2203190814319;1173.1904985559936;1184.8696643369221;1194.892459678633;1211.648621899648;11675.94162029193;11731.824022639667;11771.117166212569;11854.644360669194;11945.044396448264;4319.265724826787;4558.088382323548;4619.3994780678295;4639.698419602715;4645;9418.29362797793;9438;9439.622415103318;9446.102620251066;9456.716298511055;5287.4976877196605;5290.232916227125;5291.206319052096;5291.3121294231505;5292.285541451932;4347.6304514116655;4375.453068366454;4852.8786780330065;4916.631252656065;4937.654364194472;3805.7145714071557;3935.626115519021;3978.6817054635558;3980.86066987654;4040.91918161641;1250.5935570939298;1260.0423678004781;1268.258069029628;1270.5743575902177;1281.4425724809737;985.7732721474101;987.0968064221157;989.8812142542797;1003.5032658833924;1034.0486752188006;5851.824445266649;5859.912101318484;5945.583809133319;6130.785422510191;6231.9688401557705;429.4245710747551;435.32524586890196;447.05671034117984;453.6144277364214;463.49710564037724;4104.712670113064;4264.573542645772;4272.594103560157;4291.506476755213;4457.175422546839;9808.803823923481;10260.179185665129;10267.897321026694;10326.741831454274;10348.586056557804;10142.18862490999;10184.388936663676;10195.796084078425;10246.180305575535;10308.381497110197;7603.619819009027;7924.524528528307;7998.960005199937;8008.879866802003;8067.193280672003;6136.662483563447;6217.285012223652;6243.937560624518;6265.74937002533;6352.269489008639;9649.179819715402;9655.565499552396;9655.806883862142;9680;9699.563519641491;9230.630774768933;9565.186959108554;9612.66355677548;9711.611535538499;9761.316707830383;6640.236372816995;6823.727050917908;6829.385355318045;7008.7546935857;7075.646217689198;8109.59452027408;8112.634931427981;8227.629756660845;8238.670453181805;8248.092709802037;7268.164161121539;7282.927170728437;7406.407487401103;7510.737124200627;7690.461667683208;7204.963975180301;7423.183449820407;7433.070866141732;7492.737754178577;7653.617319133909;6850.588964662136;6948.861022779617;6973.686184121828;6990.860182796418;6992.195897471653;5263.6578622389425;5292;5313.415524292247;5314.601404894725;5524.779008839601;5414.296141501737;5454.781808727766;5461.290032295935;5478.561715062706;5526.143447765603 03:35:28 INFO - PROCESS | 32293 | |4;prototype.html;342.65049649357655;353.90621485306417;355.42776130430013;355.71720482216625;359.37110057399553;5283.2867562879;5318.414974352823;5322.4411436799155;5331.493508116722;5343.366510772673;4994.97502512487;5109.591232701384;5129.769160387782;5157.530103920383;5291.9571246533205;4159.209750147477;4178.519470260913;4185.267578173823;4186.6441352485;4189.811458484361;4182.498100227962;4193.43388642534;4197.677731514578;4200.180964711867;4202.579742025803;3959.7030222733265;3983.780892050936;4000.639942405183;4164.7709375984305;4168.687348448863;4157.625813676784;4158.438610787535;4161.75029498228;4171.416001759756;4173.916521669565;3726.6646001859963;3735.9439608405896;3745.419459983707;3746.138388170736;3760.9845341757846;5041.873953151164;5129.717865517395;5133.101707201225;5165.974170129125;5179.482051794828;4808.471068182497;4810.7835147418455;4812.663113582051;4815.3258543803895;4821.397325334333;5529.364123125852;5537.504873684123;5548.920349206189;5554.444555544454;5567.248421463091;3947.1118998225456;4091.9590804091877;4110.835566577333;4128.690348223865;4148.91702165955;5693.886122277531;5697.6866272355;5711.971440142773;5713.628614140068;5716.514096301819;4224.640905523003;4224.8732538023905;4226.936595951063;4233.5554766749665;4238.915221695611;4016.6184212499766;4211.494620645542;4231.894202644897;4273.709243882194;4274.422952901318;4747.7626118693925;4764.309175169581;4766.285057241442;4767.046590681877;4778.904421911542;5435.755391007414;5548.91676624851;5556.222128901957;5574.665520068809;5594.580406469449;1346.4479563378968;1394.974693600203;1399.1814788348727;1404.4831581891533;1411.8517555656713;924.6671198368582;941.2328951904176;950.9857352139724;974.9268804839666;976.1605019683067;5160.845174644766;5184.481551844785;5195;5197.636165468457;5205.27126202332;5464.9180262296095;5466.469388571207;5472.370677372153;5478.315210598676;5478.384266384167;5163.535281824654;5184.481551844785;5356.437968750737;5469.835904922858;5478.287822583039;2910.359720861407;2941.2793865502663;2947.616809814753;2949;2955.335049613863;5613.158026296007;5762.366139724627;5765.711714414262;5779.942200578024;5784.4504772046585;5602.915956260659;5641.502268593416;5644.407337229614;5666.631668941505;5672.404397538199;5744;5757.280339957505;5761.8559536011935;5771.220885180447;5781.768729250783;5379.193121031876;5496.4503549646315;5515.889682206253;5534.501894829324;5544.3346798384455;5474.616776825584;5477.397486276586;5480.616356855141;5498.505134537911;5502.312210973629;5506.862328441821;5728;5771.162177152147;5778.439821248324;5780.508656764054;4112.979435102805;4156.729812562174;4165.916681666289;4166.520850102156;4171.791410429406;5448.972755136199;5464.371597266365;5493.450654934634;5506.972465137648;5533.7786488540005;5330;5390;5396.892062158813;5418.130744893006;5423.538999185113;5615.775368985195;5616.354119276172;5616.550675945996;5625.521830644441;5638.2670252866865;5325.97337013328;5406.864828379322;5566.471185237396;5581.860453488695;5602.0196465619165;5475.397706252389;5612.270404847343;5625.015622266005;5632.239647647679;5634.295713035871;5503.11950087984;5507.339119305549;5514.283143191359;5518.696471694096;5527.088030474926 03:35:28 INFO - PROCESS | 32293 | |5;yui.html;740.2264633458033;759.0890930882941;813.6338647608576;827.2306754718112;879.7976465412959;14796.408143674254;15583.610409739747;15989.120598367084;16121.435749748762;16155.596110097253;12913.548025819098;14335.211563364011;14440.711185776277;14471.204083775388;14473.63815904603;829.448416802827;834.9833003339929;835.1147783349669;835.4778263585259;838.4717627894448;846.2426128614886;849.2993280543545;849.371465115813;849.4436144325476;849.6006876767909;883.0198479687542;885.1679421343948;885.8449771289999;886.2909672262197;886.6630680341461;866.0646501778127;876.2551830943647;876.8597024476085;877.5568337989306;878.6485405837652;639;639.0414378432351;640.961542307463;641.272156102822;648.5492582655056;14771.409143634242;15145.167015814126;15158.696826063528;15195.696086078327;15344.923275383664;14853.183074930874;14985.475508357154;15351.155686437241;15581.844181558152;15663.843361566353;11641.534338626445;11677.2409793364;11754.29474231549;11762.58830940913;11770.293782372999;3762.02799788167;3792.260509200707;3822.10180607557;3868.207017561393;3937.7637341759587;47047.52952470466;47859.28211076836;54625;59950.400495994916;66264.66867665679;11865.881341186478;12057;12131.878681213251;12162.635120946386;12320.260784352968;22421.77578224197;22589.43526411853;22625.88687056554;22706.545869082525;23082.76917230806;8938.597763100675;8953.418027828171;8962.507062111647;9014.368994170345;9074.909250907538;4661.184292748755;4905.87735306613;4913.533214344631;4928;5016.473270306638;3365.9326813463595;3443.741719371057;3473.8610455581997;3498.9475157872653;3522.682958533744;623.9625622462667;626.4299487466384;630.4483576870239;632.6330728177646;634.2737565487583;649.525846132326;715.445529714465;754.9807759524598;767.2595944913186;780.4653812138703;9177.693340400989;9475.810483790285;9617.471039092778;9816.607335706634;9922.305438619373;747.6635514018714;766.1801871997021;774.8837674348893;783.7100272899064;787.688862899163;4472.932906006413;4615.423072115986;4660.440747110369;4670.906581868344;4682.461516925529;92839.28642854345;93959;94464;94829.5258523703;96920.51539742397;79628;81642.59178704188;81645.59177204076;82455.17544824595;85437.57281213554;73682.99999999892;75785.24214757892;76246;76505.2349476498;76541.61729191318;8366.079731229438;8710.956445217733;8764.21122099014;8811.295096392401;8925.241354484682;49116.263256051905;50212.748936255084;50705.746471267405;51560.74219628878;51780.741096294274;42285.15429691327;42560.36159457549;56606;63970.36029639644;64081.35918640754;11644.475998580254;11734.178607497393;12254.509819607116;12495.062870284582;12685.23888566689;12268.32524211177;12528.812067819172;13804.792928105886;14141.222232777296;14192.611887989904;12730.87269127334;13061.738765224833;13252.46990120423;13550;14028.789568156282;12815.679608009874;12918.160319579198;13022.934885325512;13602.86397136016;13732.313384330942;12368.257904525757;12378.75242495163;12629.242245464933;12882.291473968648;12886.806697899352;10020.298579099393;10140.391576505433;10215.846762298423;10229.386236825814;10373;11323.490442929924;11331.537837340116;11420.543178272776;11534.711632209262;11625.36060516646 03:35:28 INFO - PROCESS | 32293 | __end_tp_report 03:35:28 INFO - PROCESS | 32293 | __start_cc_report 03:35:28 INFO - PROCESS | 32293 | _x_x_mozilla_cycle_collect,1548 03:35:28 INFO - PROCESS | 32293 | __end_cc_report 03:35:28 INFO - PROCESS | 32293 | __startTimestamp1483011328287__endTimestamp 03:35:28 INFO - PROCESS | 32293 | 03:35:28 INFO - PROCESS | 32293 | ------- Summary: start ------- 03:35:28 INFO - PROCESS | 32293 | Number of tests: 6 03:35:28 INFO - PROCESS | 32293 | 03:35:28 INFO - PROCESS | 32293 | [#0] dojo.html Cycles:165 Average:5421.64 Median:5654.86 stddev:596.41 (10.5%) stddev-sans-first:570.46 03:35:28 INFO - PROCESS | 32293 | Values: 3128.4 3160.4 3207.2 3224.4 3248.1 5372.0 5420.3 5468.2 5473.2 5477.9 5415.8 5504.2 5534.1 5536.8 5552.3 4972.6 4984.6 5005.7 5017.9 5084.3 4787.1 4810.3 5019.7 5059.8 5069.7 4890.7 4896.7 4940.0 4955.7 5005.8 4995.1 5017.4 5025.4 5046.3 5052.2 5003.7 5013.7 5042.1 5071.4 5079.2 5266.8 5319.7 5333.8 5399.2 5430.6 5750.1 5760.5 5761.8 5884.9 5891.6 5893.6 5932.3 5935.2 5945.3 5946.0 5308.4 5337.5 5339.2 5366.5 5427.1 5899.2 5908.7 5917.8 5931.1 5943.6 5704.9 5718.9 5720.6 5721.7 5732.4 5619.9 5677.2 5819.4 5836.1 5908.4 5847.1 5848.1 5854.4 5879.3 5893.4 5796.4 5842.0 5850.6 5858.7 5874.8 4467.6 4491.7 4492.8 4586.6 4592.0 3992.2 4032.3 4051.8 4072.2 4079.9 5502.7 5511.9 5517.7 5545.0 5548.2 5750.6 5816.7 5817.1 5845.6 5858.9 5474.1 5529.3 5533.9 5575.4 5617.9 5071.3 5081.6 5083.7 5091.2 5111.5 5893.4 6121.4 6124.2 6127.0 6136.3 5683.9 5693.2 5726.2 5758.8 5845.8 6022.0 6026.6 6037.8 6051.5 6064.4 5709.1 5716.6 5717.0 5719.3 5727.6 5683.2 5704.7 5718.7 5731.8 5800.0 5699.9 5707.0 5730.3 5736.0 5736.4 5654.9 5666.6 5666.9 5687.3 5688.7 5509.2 5583.0 5583.9 5602.6 5605.2 5686.1 5752.5 5768.3 5823.4 5853.5 5477.2 5658.5 5663.1 5665.4 5675.0 03:35:28 INFO - PROCESS | 32293 | 03:35:28 INFO - PROCESS | 32293 | [#1] ext.html Cycles:180 Average:57468.78 Median:20865.62 stddev:112258.95 (538.0%) stddev-sans-first:112492.55 03:35:28 INFO - PROCESS | 32293 | Values: 559.8 617.4 638.1 656.9 666.9 33559.5 44942.6 45869.1 45931.5 45980.3 46226.8 46243.5 46400.1 46407.3 46744.3 8168.6 8396.4 8748.2 8900.6 8913.9 10529.0 10802.8 10809.9 11092.5 11102.1 10820.4 10904.8 10913.8 10917.2 10942.4 10764.8 10800.4 10819.6 10822.0 10822.5 10721.6 10763.9 10779.0 10784.4 10790.8 42788.1 43059.1 43094.4 43101.4 43200.8 3686.8 3733.2 3745.4 3750.4 4168.4 32205.3 32306.5 32624.7 33106.2 33507.0 4272.4 4346.0 4368.8 4413.3 4424.2 260068.0 260166.0 260720.0 261359.0 262117.6 58659.0 59113.0 59299.0 59306.4 59490.4 39598.2 40426.4 40466.8 42784.8 42872.0 17649.8 17889.3 17917.9 17926.6 17937.6 12857.4 13069.2 13254.2 13434.5 13592.5 20902.5 20912.8 20966.7 21003.5 21053.2 7607.0 7640.7 7679.3 7689.2 7801.3 1037.9 1121.2 1176.6 1188.9 1193.8 33856.5 34378.3 34432.0 34432.0 34604.1 1063.5 1155.2 1160.7 1170.6 1190.9 14927.9 16836.4 17498.8 17532.5 17675.0 547763.0 550072.0 551729.0 552136.0 553026.0 60063.7 60525.0 60780.0 60847.7 60924.4 1333.4 1374.8 1384.3 1403.4 1433.7 29461.7 34117.0 34302.7 34461.8 34622.7 51759.0 52384.0 52401.2 52424.7 52466.5 405813.0 406205.0 406908.0 407066.0 408421.0 27513.6 27549.3 27986.9 29007.4 29474.6 45471.5 45903.8 46136.8 46143.8 46200.8 38229.0 38654.4 39613.8 40273.8 40550.8 38684.8 38739.6 39463.2 39532.0 40549.6 40535.2 42813.4 43612.6 43757.0 46275.5 35383.3 37980.8 38266.0 38304.4 39377.2 26945.0 27603.0 27975.0 28356.6 29862.6 03:35:28 INFO - PROCESS | 32293 | 03:35:28 INFO - PROCESS | 32293 | [#2] jquery.html Cycles:180 Average:30057.68 Median:11732.12 stddev:82575.35 (703.8%) stddev-sans-first:82776.95 03:35:28 INFO - PROCESS | 32293 | Values: 393.1 430.7 432.2 435.0 445.4 15988.2 19054.0 21183.4 21210.2 21296.6 20150.9 20400.3 20410.9 20566.9 20600.1 5696.0 5898.4 5906.9 5907.6 5907.6 5644.6 5850.1 5883.7 5914.8 5923.1 5721.3 5915.8 5932.8 5937.0 5937.7 5841.8 5914.6 5929.0 5941.8 5947.2 5629.5 5790.1 5790.7 5790.8 5843.4 14626.3 14745.2 14747.3 14851.8 14866.9 2264.0 2402.0 2416.3 2427.2 2541.5 10342.2 10532.7 10616.3 10756.1 10898.6 1878.4 1894.4 1895.6 1907.3 1959.3 84214.6 90012.0 91626.5 91841.0 94255.5 10329.9 11666.2 11669.5 11833.2 11971.4 15281.8 15462.9 16296.3 16304.8 16650.4 8203.5 8252.5 8263.1 8369.9 8586.7 7987.7 8040.4 8082.6 8232.8 8238.4 4900.3 4967.6 5066.9 5094.0 5137.0 2025.5 2040.1 2045.9 2101.8 2167.7 924.9 981.9 986.8 1048.6 1061.3 19847.2 20266.1 20444.5 21142.2 21142.6 1019.4 1041.1 1049.9 1070.5 1074.4 10884.5 11502.3 11759.9 11765.2 11795.6 491946.0 492285.0 500295.0 501582.0 507055.0 91518.0 91766.0 92970.5 102172.9 108670.0 1023.8 1070.9 1071.3 1072.6 1077.4 18075.9 18555.0 18702.8 18864.9 18925.5 44193.3 44264.8 45726.3 45803.8 46872.5 65426.3 65927.7 67485.3 68029.7 68184.7 8850.6 8979.6 9063.5 9166.1 9245.1 10052.8 13124.1 13953.9 14100.5 14232.1 12073.9 12526.2 12529.2 12538.3 12634.9 11898.0 11906.9 12105.6 12301.6 12359.8 6906.9 12041.4 12100.2 12129.3 12380.3 8801.5 8837.9 8877.4 9123.3 9193.4 9473.8 12258.4 12629.9 12651.1 12727.8 03:35:28 INFO - PROCESS | 32293 | 03:35:28 INFO - PROCESS | 32293 | [#3] mootools.html Cycles:180 Average:5613.49 Median:5291.26 stddev:3080.97 (58.2%) stddev-sans-first:3072.50 03:35:28 INFO - PROCESS | 32293 | Values: 1292.5 1444.6 1495.8 1635.6 1802.7 7311.2 7957.7 8236.3 8257.5 8389.3 8337.6 8382.5 8400.3 8402.3 8409.3 2333.4 2359.8 2365.0 2365.4 2367.3 2380.4 2407.8 2435.5 2442.5 2444.5 2296.4 2309.3 2319.1 2323.1 2342.0 2209.1 2273.7 2327.6 2349.3 2349.8 2333.3 2353.0 2362.1 2365.8 2367.2 8244.6 8349.0 8376.8 8395.0 8414.7 5184.9 5293.0 5312.2 5312.8 5326.8 3279.2 3292.3 3331.6 3354.8 3356.4 1138.2 1173.2 1184.9 1194.9 1211.6 11675.9 11731.8 11771.1 11854.6 11945.0 4319.3 4558.1 4619.4 4639.7 4645.0 9418.3 9438.0 9439.6 9446.1 9456.7 5287.5 5290.2 5291.2 5291.3 5292.3 4347.6 4375.5 4852.9 4916.6 4937.7 3805.7 3935.6 3978.7 3980.9 4040.9 1250.6 1260.0 1268.3 1270.6 1281.4 985.8 987.1 989.9 1003.5 1034.0 5851.8 5859.9 5945.6 6130.8 6232.0 429.4 435.3 447.1 453.6 463.5 4104.7 4264.6 4272.6 4291.5 4457.2 9808.8 10260.2 10267.9 10326.7 10348.6 10142.2 10184.4 10195.8 10246.2 10308.4 7603.6 7924.5 7999.0 8008.9 8067.2 6136.7 6217.3 6243.9 6265.7 6352.3 9649.2 9655.6 9655.8 9680.0 9699.6 9230.6 9565.2 9612.7 9711.6 9761.3 6640.2 6823.7 6829.4 7008.8 7075.6 8109.6 8112.6 8227.6 8238.7 8248.1 7268.2 7282.9 7406.4 7510.7 7690.5 7205.0 7423.2 7433.1 7492.7 7653.6 6850.6 6948.9 6973.7 6990.9 6992.2 5263.7 5292.0 5313.4 5314.6 5524.8 5414.3 5454.8 5461.3 5478.6 5526.1 03:35:28 INFO - PROCESS | 32293 | 03:35:28 INFO - PROCESS | 32293 | [#4] prototype.html Cycles:180 Average:4654.33 Median:5327.99 stddev:1338.78 (25.1%) stddev-sans-first:1302.84 03:35:28 INFO - PROCESS | 32293 | Values: 342.7 353.9 355.4 355.7 359.4 5283.3 5318.4 5322.4 5331.5 5343.4 4995.0 5109.6 5129.8 5157.5 5292.0 4159.2 4178.5 4185.3 4186.6 4189.8 4182.5 4193.4 4197.7 4200.2 4202.6 3959.7 3983.8 4000.6 4164.8 4168.7 4157.6 4158.4 4161.8 4171.4 4173.9 3726.7 3735.9 3745.4 3746.1 3761.0 5041.9 5129.7 5133.1 5166.0 5179.5 4808.5 4810.8 4812.7 4815.3 4821.4 5529.4 5537.5 5548.9 5554.4 5567.2 3947.1 4092.0 4110.8 4128.7 4148.9 5693.9 5697.7 5712.0 5713.6 5716.5 4224.6 4224.9 4226.9 4233.6 4238.9 4016.6 4211.5 4231.9 4273.7 4274.4 4747.8 4764.3 4766.3 4767.0 4778.9 5435.8 5548.9 5556.2 5574.7 5594.6 1346.4 1395.0 1399.2 1404.5 1411.9 924.7 941.2 951.0 974.9 976.2 5160.8 5184.5 5195.0 5197.6 5205.3 5464.9 5466.5 5472.4 5478.3 5478.4 5163.5 5184.5 5356.4 5469.8 5478.3 2910.4 2941.3 2947.6 2949.0 2955.3 5613.2 5762.4 5765.7 5779.9 5784.5 5602.9 5641.5 5644.4 5666.6 5672.4 5744.0 5757.3 5761.9 5771.2 5781.8 5379.2 5496.5 5515.9 5534.5 5544.3 5474.6 5477.4 5480.6 5498.5 5502.3 5506.9 5728.0 5771.2 5778.4 5780.5 4113.0 4156.7 4165.9 4166.5 4171.8 5449.0 5464.4 5493.5 5507.0 5533.8 5330.0 5390.0 5396.9 5418.1 5423.5 5615.8 5616.4 5616.6 5625.5 5638.3 5326.0 5406.9 5566.5 5581.9 5602.0 5475.4 5612.3 5625.0 5632.2 5634.3 5503.1 5507.3 5514.3 5518.7 5527.1 03:35:28 INFO - PROCESS | 32293 | 03:35:28 INFO - PROCESS | 32293 | [#5] yui.html Cycles:180 Average:18236.70 Median:27011.07 stddev:24361.57 (90.2%) stddev-sans-first:24394.48 03:35:28 INFO - PROCESS | 32293 | Values: 740.2 759.1 813.6 827.2 879.8 14796.4 15583.6 15989.1 16121.4 16155.6 12913.5 14335.2 14440.7 14471.2 14473.6 829.4 835.0 835.1 835.5 838.5 846.2 849.3 849.4 849.4 849.6 883.0 885.2 885.8 886.3 886.7 866.1 876.3 876.9 877.6 878.6 639.0 639.0 641.0 641.3 648.5 14771.4 15145.2 15158.7 15195.7 15344.9 14853.2 14985.5 15351.2 15581.8 15663.8 11641.5 11677.2 11754.3 11762.6 11770.3 3762.0 3792.3 3822.1 3868.2 3937.8 47047.5 47859.3 54625.0 59950.4 66264.7 11865.9 12057.0 12131.9 12162.6 12320.3 22421.8 22589.4 22625.9 22706.5 23082.8 8938.6 8953.4 8962.5 9014.4 9074.9 4661.2 4905.9 4913.5 4928.0 5016.5 3365.9 3443.7 3473.9 3498.9 3522.7 624.0 626.4 630.4 632.6 634.3 649.5 715.4 755.0 767.3 780.5 9177.7 9475.8 9617.5 9816.6 9922.3 747.7 766.2 774.9 783.7 787.7 4472.9 4615.4 4660.4 4670.9 4682.5 92839.3 93959.0 94464.0 94829.5 96920.5 79628.0 81642.6 81645.6 82455.2 85437.6 73683.0 75785.2 76246.0 76505.2 76541.6 8366.1 8711.0 8764.2 8811.3 8925.2 49116.3 50212.7 50705.7 51560.7 51780.7 42285.2 42560.4 56606.0 63970.4 64081.4 11644.5 11734.2 12254.5 12495.1 12685.2 12268.3 12528.8 13804.8 14141.2 14192.6 12730.9 13061.7 13252.5 13550.0 14028.8 12815.7 12918.2 13022.9 13602.9 13732.3 12368.3 12378.8 12629.2 12882.3 12886.8 10020.3 10140.4 10215.8 10229.4 10373.0 11323.5 11331.5 11420.5 11534.7 11625.4 03:35:28 INFO - PROCESS | 32293 | -------- Summary: end -------- 03:35:28 INFO - PROCESS | 32293 | 03:35:29 INFO - TEST-INFO | 32293: exit 0 03:35:29 INFO - TEST-OK | dromaeo_css | took 1115665ms 03:35:29 INFO - TEST-START | kraken 03:35:29 INFO - operating with platform_type : linux_ 03:35:29 INFO - Initialising browser for kraken test... 03:35:29 INFO - TEST-INFO | started process 32614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTSQMbW/profile http://localhost:40196/getInfo.html) 03:35:32 INFO - PROCESS | 32614 | __metrics Screen width/height:1600/1200 03:35:32 INFO - PROCESS | 32614 | colorDepth:24 03:35:32 INFO - PROCESS | 32614 | Browser inner width/height: 1024/697 03:35:32 INFO - PROCESS | 32614 | __metrics 03:35:33 INFO - PROCESS | 32614 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:35:33 INFO - PROCESS | 32614 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:35:33 INFO - PROCESS | 32614 | console.error: PushService: 03:35:33 INFO - PROCESS | 32614 | stateChangeProcessEnqueue: Error transitioning state 03:35:33 INFO - PROCESS | 32614 | UnknownError 03:35:34 INFO - TEST-INFO | 32614: exit 0 03:35:34 INFO - Browser initialized. 03:35:34 INFO - Running cycle 1/1 for kraken test... 03:35:34 INFO - TEST-INFO | started process 32707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTSQMbW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:46 INFO - PROCESS | 32707 | RSS: Main: 144261120 03:35:46 INFO - PROCESS | 32707 | 03:35:48 INFO - PROCESS | 32707 | Cycle 1(1): loaded http://localhost:40196/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40196/tests/kraken/driver.html?testName=audio-beat-detection) 03:35:49 INFO - PROCESS | 32707 | RSS: Main: 186335232 03:35:49 INFO - PROCESS | 32707 | 03:35:52 INFO - PROCESS | 32707 | Cycle 1(1): loaded http://localhost:40196/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40196/tests/kraken/driver.html?testName=audio-dft) 03:35:52 INFO - PROCESS | 32707 | RSS: Main: 175099904 03:35:52 INFO - PROCESS | 32707 | 03:35:55 INFO - PROCESS | 32707 | Cycle 1(1): loaded http://localhost:40196/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40196/tests/kraken/driver.html?testName=audio-fft) 03:35:56 INFO - PROCESS | 32707 | RSS: Main: 266051584 03:35:56 INFO - PROCESS | 32707 | 03:35:58 INFO - PROCESS | 32707 | Cycle 1(1): loaded http://localhost:40196/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40196/tests/kraken/driver.html?testName=audio-oscillator) 03:35:58 INFO - PROCESS | 32707 | RSS: Main: 173277184 03:35:58 INFO - PROCESS | 32707 | 03:36:00 INFO - PROCESS | 32707 | Cycle 1(1): loaded http://localhost:40196/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40196/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:36:01 INFO - PROCESS | 32707 | RSS: Main: 175398912 03:36:01 INFO - PROCESS | 32707 | 03:36:04 INFO - PROCESS | 32707 | Cycle 1(1): loaded http://localhost:40196/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40196/tests/kraken/driver.html?testName=imaging-darkroom) 03:36:04 INFO - PROCESS | 32707 | RSS: Main: 213975040 03:36:04 INFO - PROCESS | 32707 | 03:36:08 INFO - PROCESS | 32707 | Cycle 1(1): loaded http://localhost:40196/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40196/tests/kraken/driver.html?testName=imaging-desaturate) 03:36:08 INFO - PROCESS | 32707 | RSS: Main: 212484096 03:36:08 INFO - PROCESS | 32707 | 03:36:11 INFO - PROCESS | 32707 | Cycle 1(1): loaded http://localhost:40196/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40196/tests/kraken/driver.html?testName=json-parse-financial) 03:36:12 INFO - PROCESS | 32707 | RSS: Main: 211341312 03:36:12 INFO - PROCESS | 32707 | 03:36:13 INFO - PROCESS | 32707 | Cycle 1(1): loaded http://localhost:40196/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40196/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:36:14 INFO - PROCESS | 32707 | RSS: Main: 173465600 03:36:14 INFO - PROCESS | 32707 | 03:36:15 INFO - PROCESS | 32707 | Cycle 1(1): loaded http://localhost:40196/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40196/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:36:16 INFO - PROCESS | 32707 | RSS: Main: 180371456 03:36:16 INFO - PROCESS | 32707 | 03:36:18 INFO - PROCESS | 32707 | Cycle 1(1): loaded http://localhost:40196/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40196/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:36:19 INFO - PROCESS | 32707 | RSS: Main: 189640704 03:36:19 INFO - PROCESS | 32707 | 03:36:21 INFO - PROCESS | 32707 | Cycle 1(1): loaded http://localhost:40196/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40196/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:36:22 INFO - PROCESS | 32707 | RSS: Main: 197861376 03:36:22 INFO - PROCESS | 32707 | 03:36:25 INFO - PROCESS | 32707 | Cycle 1(1): loaded http://localhost:40196/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40196/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:25 INFO - PROCESS | 32707 | RSS: Main: 194183168 03:36:25 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | Cycle 1(1): loaded http://localhost:40196/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40196/tests/kraken/driver.html?testName=ai-astar) 03:36:27 INFO - PROCESS | 32707 | RSS: Main: 246374400 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | __start_tp_report 03:36:27 INFO - PROCESS | 32707 | _x_x_mozilla_page_load 03:36:27 INFO - PROCESS | 32707 | _x_x_mozilla_page_load_details 03:36:27 INFO - PROCESS | 32707 | |i|pagename|runs| 03:36:27 INFO - PROCESS | 32707 | |0;ai-astar;102;112;113;111;112;113;112;113;112;112 03:36:27 INFO - PROCESS | 32707 | |1;audio-beat-detection;143;117;117;157;118;119;118;117;148;118 03:36:27 INFO - PROCESS | 32707 | |2;audio-dft;163;161;161;160;161;160;160;160;163;159 03:36:27 INFO - PROCESS | 32707 | |3;audio-fft;75;75;76;108;76;75;75;76;97;75 03:36:27 INFO - PROCESS | 32707 | |4;audio-oscillator;81;82;117;83;82;82;112;83;82;110 03:36:27 INFO - PROCESS | 32707 | |5;imaging-gaussian-blur;117;118;117;118;117;117;117;116;117;117 03:36:27 INFO - PROCESS | 32707 | |6;imaging-darkroom;146;147;145;146;146;145;145;146;146;145 03:36:27 INFO - PROCESS | 32707 | |7;imaging-desaturate;84;84;84;85;84;84;85;84;85;85 03:36:27 INFO - PROCESS | 32707 | |8;json-parse-financial;49;56;48;49;49;49;49;49;51;50 03:36:27 INFO - PROCESS | 32707 | |9;json-stringify-tinderbox;59;60;59;59;61;60;60;60;61;60 03:36:27 INFO - PROCESS | 32707 | |10;stanford-crypto-aes;81;79;82;74;75;75;75;91;78;79 03:36:27 INFO - PROCESS | 32707 | |11;stanford-crypto-ccm;133;130;127;129;138;121;120;118;167;119 03:36:27 INFO - PROCESS | 32707 | |12;stanford-crypto-pbkdf2;154;159;159;152;153;152;158;154;158;158 03:36:27 INFO - PROCESS | 32707 | |13;stanford-crypto-sha256-iterative;64;62;63;63;64;66;61;65;62;62 03:36:27 INFO - PROCESS | 32707 | __end_tp_report 03:36:27 INFO - PROCESS | 32707 | __start_cc_report 03:36:27 INFO - PROCESS | 32707 | _x_x_mozilla_cycle_collect,1616 03:36:27 INFO - PROCESS | 32707 | __end_cc_report 03:36:27 INFO - PROCESS | 32707 | __startTimestamp1483011387514__endTimestamp 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | ------- Summary: start ------- 03:36:27 INFO - PROCESS | 32707 | Number of tests: 14 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:3.29 (2.9%) stddev-sans-first:0.67 03:36:27 INFO - PROCESS | 32707 | Values: 102.0 112.0 113.0 111.0 112.0 113.0 112.0 113.0 112.0 112.0 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:118.50 stddev:15.65 (13.2%) stddev-sans-first:15.52 03:36:27 INFO - PROCESS | 32707 | Values: 143.0 117.0 117.0 157.0 118.0 119.0 118.0 117.0 148.0 118.0 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.13 03:36:27 INFO - PROCESS | 32707 | Values: 163.0 161.0 161.0 160.0 161.0 160.0 160.0 160.0 163.0 159.0 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.50 stddev:11.74 (15.5%) stddev-sans-first:12.26 03:36:27 INFO - PROCESS | 32707 | Values: 75.0 75.0 76.0 108.0 76.0 75.0 75.0 76.0 97.0 75.0 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:82.00 stddev:15.01 (18.3%) stddev-sans-first:15.44 03:36:27 INFO - PROCESS | 32707 | Values: 81.0 82.0 117.0 83.0 82.0 82.0 112.0 83.0 82.0 110.0 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:36:27 INFO - PROCESS | 32707 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:36:27 INFO - PROCESS | 32707 | Values: 146.0 147.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 03:36:27 INFO - PROCESS | 32707 | Values: 84.0 84.0 84.0 85.0 84.0 84.0 85.0 84.0 85.0 85.0 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:49.00 stddev:2.28 (4.7%) stddev-sans-first:2.40 03:36:27 INFO - PROCESS | 32707 | Values: 49.0 56.0 48.0 49.0 49.0 49.0 49.0 49.0 51.0 50.0 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 03:36:27 INFO - PROCESS | 32707 | Values: 59.0 60.0 59.0 59.0 61.0 60.0 60.0 60.0 61.0 60.0 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:5.07 (6.4%) stddev-sans-first:5.32 03:36:27 INFO - PROCESS | 32707 | Values: 81.0 79.0 82.0 74.0 75.0 75.0 75.0 91.0 78.0 79.0 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:129.50 stddev:14.52 (11.2%) stddev-sans-first:15.37 03:36:27 INFO - PROCESS | 32707 | Values: 133.0 130.0 127.0 129.0 138.0 121.0 120.0 118.0 167.0 119.0 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:158.00 stddev:2.95 (1.9%) stddev-sans-first:3.06 03:36:27 INFO - PROCESS | 32707 | Values: 154.0 159.0 159.0 152.0 153.0 152.0 158.0 154.0 158.0 158.0 03:36:27 INFO - PROCESS | 32707 | 03:36:27 INFO - PROCESS | 32707 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:1.55 (2.4%) stddev-sans-first:1.62 03:36:27 INFO - PROCESS | 32707 | Values: 64.0 62.0 63.0 63.0 64.0 66.0 61.0 65.0 62.0 62.0 03:36:27 INFO - PROCESS | 32707 | -------- Summary: end -------- 03:36:27 INFO - PROCESS | 32707 | 03:36:28 INFO - TEST-INFO | 32707: exit 0 03:36:28 INFO - TEST-OK | kraken | took 59495ms 03:36:28 INFO - SUITE-END | took 1175s 03:36:28 INFO - Completed test suite (00:19:35) 03:36:28 INFO - javascript benchmark 03:36:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.4212420702165, 3160.4153231652144, 3207.1982004498877, 3224.4196044711944, 3248.139243100579, 5371.973140134299, 5420.322459692538, 5468.152436372358, 5473.233747275374, 5477.945220547794, 5415.783368665258, 5504.2294078829, 5534.08687566552, 5536.778528858841, 5552.250446189763, 4972.602191824645, 4984.601231901457, 5005.74971251436, 5017.874553136183, 5084.313617661605, 4787.114383839001, 4810.25441056635, 5019.67372120811, 5059.822906198284, 5069.721165335924, 4890.706557606537, 4896.706197628136, 4939.975300123512, 4955.677880937746, 5005.824796132136, 4995.125852975715, 5017.448080711119, 5025.3718285214345, 5046.26829109777, 5052.191649336089, 5003.653571801395, 5013.749312534359, 5042.092423363793, 5071.39143302806, 5079.161938280179, 5266.789328426858, 5319.707416092114, 5333.839984800462, 5399.163129714901, 5430.647007944471, 5750.05124154514, 5760.539156867482, 5761.769529218868, 5884.911726324109, 5891.617044892068, 5893.5579831512805, 5932.3474417814, 5935.169076329317, 5945.31628862682, 5946.0, 5308.389535203462, 5337.519623233928, 5339.172428273585, 5366.517013468807, 5427.050266203399, 5899.17411562373, 5908.704564771744, 5917.763289468373, 5931.110333450017, 5943.58394912352, 5704.942950570441, 5718.885622287614, 5720.628159169641, 5721.656700597978, 5732.426757324234, 5619.8595035124445, 5677.233573467529, 5819.418058194231, 5836.124581312837, 5908.379620139909, 5847.1229315603, 5848.093545500455, 5854.356020837705, 5879.2944846618675, 5893.381194974466, 5796.362400135981, 5842.036064049469, 5850.5904586678525, 5858.677772722541, 5874.765009399576, 4467.5755803198645, 4491.685582009228, 4492.842750503717, 4586.587207151306, 4591.95408045922, 3992.201559688074, 4032.2540330039037, 4051.8379264829077, 4072.1855628874346, 4079.918401631951, 5502.724863756796, 5511.889762204733, 5517.69652669099, 5545.029619816516, 5548.195511650788, 5750.568707346965, 5816.680082595498, 5817.0983497557945, 5845.649261044351, 5858.882822343615, 5474.124140137638, 5529.336479622471, 5533.889322213533, 5575.358833734092, 5617.8595535111135, 5071.290019397287, 5081.568066714297, 5083.7203953782155, 5091.1854103343285, 5111.488851114858, 5893.381194974466, 6121.449069583669, 6124.173236613089, 6127.019676851683, 6136.2636483622255, 5683.8863222736145, 5693.202951586698, 5726.198332233574, 5758.798442054508, 5845.795397161079, 6022.036474164112, 6026.608270462406, 6037.818865434044, 6051.485623721856, 6064.3935606439, 5709.143628455765, 5716.628419152742, 5716.971415142898, 5719.256496655408, 5727.599068065196, 5683.204351390891, 5704.743286552032, 5718.685472299064, 5731.828045158652, 5799.971000145141, 5699.914501282401, 5707.029804933254, 5730.312362516524, 5735.971320143372, 5736.397678243891, 5654.85862853432, 5666.603337766317, 5666.858328541819, 5687.317521897398, 5688.744006519633, 5509.228707980806, 5583.0, 5583.944160558505, 5602.551795856403, 5605.243292155506, 5686.090225564056, 5752.539796816161, 5768.2501274834, 5823.388544202967, 5853.473187413153, 5477.233187353694, 5658.490735833795, 5663.065594177079, 5665.433456654301, 5674.971625141848], "value": 5382.717159003828, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.7872808332835, 617.3980369140089, 638.0843489592435, 656.8981807819787, 666.8766278238523, 33559.49660755088, 44942.55057449424, 45869.08261834765, 45931.54068459314, 45980.310295345516, 46226.768866155704, 46243.53756462434, 46400.071998560095, 46407.30389044167, 46744.2988355175, 8168.550729709864, 8396.370272229577, 8748.212660860521, 8900.554972251393, 8913.910860891372, 10529.0, 10802.837957430645, 10809.891901081006, 11092.500837462334, 11102.111831053497, 10820.350778953249, 10904.836427453594, 10913.781724365548, 10917.181211409137, 10942.398168100792, 10764.78470430591, 10800.351978881214, 10819.567217311298, 10822.0, 10822.512986915608, 10721.624743133953, 10763.892361076367, 10779.0, 10784.406857622827, 10790.784184316348, 42788.1442371154, 43059.13881722379, 43094.353584696255, 43101.35347969783, 43200.783996080136, 3686.7787932724123, 3733.21602463483, 3745.400735882246, 3750.4374343848367, 4168.3955826405, 32205.257044868944, 32306.515402268986, 32624.6737532624, 33106.17234569131, 33507.0, 4272.4445822042935, 4345.953332244127, 4368.825246990116, 4413.337999300099, 4424.225760491901, 260068.0, 260166.0, 260720.0, 261359.0, 262117.5835329056, 58659.0, 59113.0, 59299.0, 59306.40693593095, 59490.405095949354, 39598.208035839125, 40426.39360409596, 40466.79766601148, 42784.786076069424, 42872.0, 17649.823501765073, 17889.28442862271, 17917.910410447865, 17926.641467170582, 17937.641247175245, 12857.357132143356, 13069.215847049207, 13254.204747715168, 13434.529791457253, 13592.456301748018, 20902.47743806417, 20912.790872091085, 20966.685499717518, 21003.474913127295, 21053.157873684882, 7607.006321681051, 7640.69437222516, 7679.347255483235, 7689.19263477338, 7801.336886364723, 1037.870266216723, 1121.2487633285718, 1176.6058370445826, 1188.8573371195512, 1193.8149586814059, 33856.49215261773, 34378.3280414891, 34432.0, 34432.0, 34604.134896627285, 1063.4576366053368, 1155.225998580936, 1160.7040204747905, 1170.5610396101463, 1190.9285442873456, 14927.925360373129, 16836.413429150976, 17498.82501174972, 17532.509736672524, 17675.0, 547763.0, 550072.0, 551729.0, 552136.0, 553026.0, 60063.69968150131, 60525.0, 60780.0, 60847.69576152091, 60924.390756092755, 1333.3599872061466, 1374.752544541992, 1384.3286006286742, 1403.4105675616265, 1433.677422579911, 29461.705382945896, 34116.97649070532, 34302.65697342995, 34461.827690861384, 34622.65377346194, 51759.0, 52384.0, 52401.213981789544, 52424.73787631038, 52466.475335246156, 405813.0, 406205.0, 406908.0, 407066.0, 408421.0, 27513.587296190173, 27549.31126721848, 27986.86006569954, 29007.404592746756, 29474.557881631365, 45471.54528454673, 45903.77048114738, 46136.76931615321, 46143.76928115338, 46200.7689961548, 38229.0, 38654.420183696704, 39613.80193099016, 40273.798631006655, 40550.79724601358, 38684.80657596694, 38739.612603874724, 39463.21073578455, 39532.0, 40549.594504054585, 40535.1892962145, 42813.35779963241, 43612.56387436085, 43757.0, 46275.53724462712, 35383.29233415369, 37980.810095949346, 38266.0, 38304.42543361796, 39377.21245575015, 26945.0, 27603.0, 27975.0, 28356.57465138066, 29862.552061718656], "value": 20605.037624959237, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.0684278260523, 430.6920551805458, 432.190905454581, 434.9869503914883, 445.41872855923026, 15988.200589970498, 19053.9520326382, 21183.364499065014, 21210.151593936225, 21296.574068518657, 20150.899245503788, 20400.285989990352, 20410.897945510253, 20566.89716551419, 20600.072996715146, 5696.0, 5898.351181370046, 5906.911396329058, 5907.5864689471755, 5907.616004959664, 5644.604877658566, 5850.122481627769, 5883.735231914574, 5914.822555323326, 5923.081922302029, 5721.34204566476, 5915.822525324225, 5932.762689492415, 5937.0, 5937.70311484424, 5841.7955371562, 5914.585978981473, 5929.0, 5941.7920372787175, 5947.167396564506, 5629.521490673298, 5790.073588225863, 5790.652560846363, 5790.7683692652245, 5843.357230704619, 14626.341814618261, 14745.189014604193, 14747.336369863382, 14851.777223341658, 14866.851331486654, 2263.954720905589, 2402.0, 2416.2738774497643, 2427.174760581393, 2541.5171117487616, 10342.172626189888, 10532.684019479428, 10616.256862019662, 10756.085732712729, 10898.618548350849, 1878.389523404899, 1894.355918987551, 1895.5640202753307, 1907.265702704455, 1959.3142400159973, 84214.57892710558, 90012.0, 91626.5418672909, 91841.0, 94255.52872235664, 10329.896701032894, 11666.241694289844, 11669.533218671328, 11833.219193489524, 11971.401429928468, 15281.770773438186, 15462.9226853865, 16296.34814607426, 16304.755428668579, 16650.417235396704, 8203.466774659628, 8252.46358986676, 8263.132371101068, 8369.874451883226, 8586.65653373858, 7987.720429784929, 8040.437169398086, 8082.595870206466, 8232.794180145544, 8238.423310368216, 4900.26496025599, 4967.627427942919, 5066.949330506648, 5094.0, 5137.0, 2025.4835017070848, 2040.1227472186806, 2045.858178967944, 2101.812475951083, 2167.674848772665, 924.916757491829, 981.916537094355, 986.8075725233654, 1048.5700862646431, 1061.2889364126054, 19847.206111755368, 20266.088026038862, 20444.488887777923, 21142.154313827275, 21142.577148456945, 1019.4472264159399, 1041.146260066738, 1049.9317544359592, 1070.5236169904474, 1074.3607553505651, 10884.510197041152, 11502.252353596989, 11759.941200293944, 11765.176437649283, 11795.646130616095, 491946.0, 492285.0, 500295.0, 501582.0, 507055.0, 91518.0, 91766.0, 92970.53514732383, 102172.89556757164, 108670.0, 1023.7696518283476, 1070.8661417322835, 1071.2875937501474, 1072.6299426697776, 1077.353587847301, 18075.909620451814, 18555.0, 18702.812971870106, 18864.905675471535, 18925.526861828563, 44193.33709994288, 44264.7786761077, 45726.31410528778, 45803.77098114621, 46872.53127468818, 65426.345736542025, 65927.6703616498, 67485.3251467479, 68029.65985170043, 68184.6590767043, 8850.557472126497, 8979.595918183566, 9063.501507417155, 9166.129217724305, 9245.07549245097, 10052.849207262043, 13124.14693044949, 13953.860461395256, 14100.506482273071, 14232.074915130483, 12073.879261207276, 12526.185797923106, 12529.18560293578, 12538.314271259893, 12634.936825315815, 11898.048156147313, 11906.880931190577, 12105.576304829288, 12301.569445069379, 12359.814602781145, 6906.930930690629, 12041.397930103634, 12100.213486123374, 12129.272243665408, 12380.319082450551, 8801.51591662439, 8837.91162088371, 8877.422967507091, 9123.263021093779, 9193.448393096436, 9473.763155921157, 12258.387080646111, 12629.93685031569, 12651.114421990373, 12727.809082863949], "value": 9499.42669434754, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.4700872642206, 1444.6027342480816, 1495.7606782914736, 1635.566574857662, 1802.7386029025793, 7311.195768465471, 7957.681692732291, 8236.341092712584, 8257.463264887785, 8389.328853691706, 8337.583120843949, 8382.455140415868, 8400.285975692073, 8402.327813774898, 8409.327253819694, 2333.416645838545, 2359.7758212969825, 2365.0303375616, 2365.4086478380405, 2367.3016460144213, 2380.381100913766, 2407.807375409972, 2435.476372579895, 2442.5237078769646, 2444.4866578018637, 2296.357020034393, 2309.261036468331, 2319.130326127702, 2323.0707716913284, 2341.9765802342013, 2209.1163534586135, 2273.693051438051, 2327.592671282527, 2349.2952114365708, 2349.776771206741, 2333.2766842278947, 2352.9764702352927, 2362.11420717231, 2365.8225633077586, 2367.171489978494, 8244.587770611446, 8349.03986041601, 8376.83246335076, 8394.958025209897, 8414.705485307984, 5184.896302073975, 5292.994331077083, 5312.2297266896085, 5312.840614781563, 5326.813561525367, 3279.212988882675, 3292.27569934614, 3331.6335203127637, 3354.815485148316, 3356.3790698720813, 1138.2203190814319, 1173.1904985559936, 1184.8696643369221, 1194.892459678633, 1211.648621899648, 11675.94162029193, 11731.824022639667, 11771.117166212569, 11854.644360669194, 11945.044396448264, 4319.265724826787, 4558.088382323548, 4619.3994780678295, 4639.698419602715, 4645.0, 9418.29362797793, 9438.0, 9439.622415103318, 9446.102620251066, 9456.716298511055, 5287.4976877196605, 5290.232916227125, 5291.206319052096, 5291.3121294231505, 5292.285541451932, 4347.6304514116655, 4375.453068366454, 4852.8786780330065, 4916.631252656065, 4937.654364194472, 3805.7145714071557, 3935.626115519021, 3978.6817054635558, 3980.86066987654, 4040.91918161641, 1250.5935570939298, 1260.0423678004781, 1268.258069029628, 1270.5743575902177, 1281.4425724809737, 985.7732721474101, 987.0968064221157, 989.8812142542797, 1003.5032658833924, 1034.0486752188006, 5851.824445266649, 5859.912101318484, 5945.583809133319, 6130.785422510191, 6231.9688401557705, 429.4245710747551, 435.32524586890196, 447.05671034117984, 453.6144277364214, 463.49710564037724, 4104.712670113064, 4264.573542645772, 4272.594103560157, 4291.506476755213, 4457.175422546839, 9808.803823923481, 10260.179185665129, 10267.897321026694, 10326.741831454274, 10348.586056557804, 10142.18862490999, 10184.388936663676, 10195.796084078425, 10246.180305575535, 10308.381497110197, 7603.619819009027, 7924.524528528307, 7998.960005199937, 8008.879866802003, 8067.193280672003, 6136.662483563447, 6217.285012223652, 6243.937560624518, 6265.74937002533, 6352.269489008639, 9649.179819715402, 9655.565499552396, 9655.806883862142, 9680.0, 9699.563519641491, 9230.630774768933, 9565.186959108554, 9612.66355677548, 9711.611535538499, 9761.316707830383, 6640.236372816995, 6823.727050917908, 6829.385355318045, 7008.7546935857, 7075.646217689198, 8109.59452027408, 8112.634931427981, 8227.629756660845, 8238.670453181805, 8248.092709802037, 7268.164161121539, 7282.927170728437, 7406.407487401103, 7510.737124200627, 7690.461667683208, 7204.963975180301, 7423.183449820407, 7433.070866141732, 7492.737754178577, 7653.617319133909, 6850.588964662136, 6948.861022779617, 6973.686184121828, 6990.860182796418, 6992.195897471653, 5263.6578622389425, 5292.0, 5313.415524292247, 5314.601404894725, 5524.779008839601, 5414.296141501737, 5454.781808727766, 5461.290032295935, 5478.561715062706, 5526.143447765603], "value": 4480.40704415223, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.65049649357655, 353.90621485306417, 355.42776130430013, 355.71720482216625, 359.37110057399553, 5283.2867562879, 5318.414974352823, 5322.4411436799155, 5331.493508116722, 5343.366510772673, 4994.97502512487, 5109.591232701384, 5129.769160387782, 5157.530103920383, 5291.9571246533205, 4159.209750147477, 4178.519470260913, 4185.267578173823, 4186.6441352485, 4189.811458484361, 4182.498100227962, 4193.43388642534, 4197.677731514578, 4200.180964711867, 4202.579742025803, 3959.7030222733265, 3983.780892050936, 4000.639942405183, 4164.7709375984305, 4168.687348448863, 4157.625813676784, 4158.438610787535, 4161.75029498228, 4171.416001759756, 4173.916521669565, 3726.6646001859963, 3735.9439608405896, 3745.419459983707, 3746.138388170736, 3760.9845341757846, 5041.873953151164, 5129.717865517395, 5133.101707201225, 5165.974170129125, 5179.482051794828, 4808.471068182497, 4810.7835147418455, 4812.663113582051, 4815.3258543803895, 4821.397325334333, 5529.364123125852, 5537.504873684123, 5548.920349206189, 5554.444555544454, 5567.248421463091, 3947.1118998225456, 4091.9590804091877, 4110.835566577333, 4128.690348223865, 4148.91702165955, 5693.886122277531, 5697.6866272355, 5711.971440142773, 5713.628614140068, 5716.514096301819, 4224.640905523003, 4224.8732538023905, 4226.936595951063, 4233.5554766749665, 4238.915221695611, 4016.6184212499766, 4211.494620645542, 4231.894202644897, 4273.709243882194, 4274.422952901318, 4747.7626118693925, 4764.309175169581, 4766.285057241442, 4767.046590681877, 4778.904421911542, 5435.755391007414, 5548.91676624851, 5556.222128901957, 5574.665520068809, 5594.580406469449, 1346.4479563378968, 1394.974693600203, 1399.1814788348727, 1404.4831581891533, 1411.8517555656713, 924.6671198368582, 941.2328951904176, 950.9857352139724, 974.9268804839666, 976.1605019683067, 5160.845174644766, 5184.481551844785, 5195.0, 5197.636165468457, 5205.27126202332, 5464.9180262296095, 5466.469388571207, 5472.370677372153, 5478.315210598676, 5478.384266384167, 5163.535281824654, 5184.481551844785, 5356.437968750737, 5469.835904922858, 5478.287822583039, 2910.359720861407, 2941.2793865502663, 2947.616809814753, 2949.0, 2955.335049613863, 5613.158026296007, 5762.366139724627, 5765.711714414262, 5779.942200578024, 5784.4504772046585, 5602.915956260659, 5641.502268593416, 5644.407337229614, 5666.631668941505, 5672.404397538199, 5744.0, 5757.280339957505, 5761.8559536011935, 5771.220885180447, 5781.768729250783, 5379.193121031876, 5496.4503549646315, 5515.889682206253, 5534.501894829324, 5544.3346798384455, 5474.616776825584, 5477.397486276586, 5480.616356855141, 5498.505134537911, 5502.312210973629, 5506.862328441821, 5728.0, 5771.162177152147, 5778.439821248324, 5780.508656764054, 4112.979435102805, 4156.729812562174, 4165.916681666289, 4166.520850102156, 4171.791410429406, 5448.972755136199, 5464.371597266365, 5493.450654934634, 5506.972465137648, 5533.7786488540005, 5330.0, 5390.0, 5396.892062158813, 5418.130744893006, 5423.538999185113, 5615.775368985195, 5616.354119276172, 5616.550675945996, 5625.521830644441, 5638.2670252866865, 5325.97337013328, 5406.864828379322, 5566.471185237396, 5581.860453488695, 5602.0196465619165, 5475.397706252389, 5612.270404847343, 5625.015622266005, 5632.239647647679, 5634.295713035871, 5503.11950087984, 5507.339119305549, 5514.283143191359, 5518.696471694096, 5527.088030474926], "value": 4231.697895113667, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.2264633458033, 759.0890930882941, 813.6338647608576, 827.2306754718112, 879.7976465412959, 14796.408143674254, 15583.610409739747, 15989.120598367084, 16121.435749748762, 16155.596110097253, 12913.548025819098, 14335.211563364011, 14440.711185776277, 14471.204083775388, 14473.63815904603, 829.448416802827, 834.9833003339929, 835.1147783349669, 835.4778263585259, 838.4717627894448, 846.2426128614886, 849.2993280543545, 849.371465115813, 849.4436144325476, 849.6006876767909, 883.0198479687542, 885.1679421343948, 885.8449771289999, 886.2909672262197, 886.6630680341461, 866.0646501778127, 876.2551830943647, 876.8597024476085, 877.5568337989306, 878.6485405837652, 639.0, 639.0414378432351, 640.961542307463, 641.272156102822, 648.5492582655056, 14771.409143634242, 15145.167015814126, 15158.696826063528, 15195.696086078327, 15344.923275383664, 14853.183074930874, 14985.475508357154, 15351.155686437241, 15581.844181558152, 15663.843361566353, 11641.534338626445, 11677.2409793364, 11754.29474231549, 11762.58830940913, 11770.293782372999, 3762.02799788167, 3792.260509200707, 3822.10180607557, 3868.207017561393, 3937.7637341759587, 47047.52952470466, 47859.28211076836, 54625.0, 59950.400495994916, 66264.66867665679, 11865.881341186478, 12057.0, 12131.878681213251, 12162.635120946386, 12320.260784352968, 22421.77578224197, 22589.43526411853, 22625.88687056554, 22706.545869082525, 23082.76917230806, 8938.597763100675, 8953.418027828171, 8962.507062111647, 9014.368994170345, 9074.909250907538, 4661.184292748755, 4905.87735306613, 4913.533214344631, 4928.0, 5016.473270306638, 3365.9326813463595, 3443.741719371057, 3473.8610455581997, 3498.9475157872653, 3522.682958533744, 623.9625622462667, 626.4299487466384, 630.4483576870239, 632.6330728177646, 634.2737565487583, 649.525846132326, 715.445529714465, 754.9807759524598, 767.2595944913186, 780.4653812138703, 9177.693340400989, 9475.810483790285, 9617.471039092778, 9816.607335706634, 9922.305438619373, 747.6635514018714, 766.1801871997021, 774.8837674348893, 783.7100272899064, 787.688862899163, 4472.932906006413, 4615.423072115986, 4660.440747110369, 4670.906581868344, 4682.461516925529, 92839.28642854345, 93959.0, 94464.0, 94829.5258523703, 96920.51539742397, 79628.0, 81642.59178704188, 81645.59177204076, 82455.17544824595, 85437.57281213554, 73682.99999999892, 75785.24214757892, 76246.0, 76505.2349476498, 76541.61729191318, 8366.079731229438, 8710.956445217733, 8764.21122099014, 8811.295096392401, 8925.241354484682, 49116.263256051905, 50212.748936255084, 50705.746471267405, 51560.74219628878, 51780.741096294274, 42285.15429691327, 42560.36159457549, 56606.0, 63970.36029639644, 64081.35918640754, 11644.475998580254, 11734.178607497393, 12254.509819607116, 12495.062870284582, 12685.23888566689, 12268.32524211177, 12528.812067819172, 13804.792928105886, 14141.222232777296, 14192.611887989904, 12730.87269127334, 13061.738765224833, 13252.46990120423, 13550.0, 14028.789568156282, 12815.679608009874, 12918.160319579198, 13022.934885325512, 13602.86397136016, 13732.313384330942, 12368.257904525757, 12378.75242495163, 12629.242245464933, 12882.291473968648, 12886.806697899352, 10020.298579099393, 10140.391576505433, 10215.846762298423, 10229.386236825814, 10373.0, 11323.490442929924, 11331.537837340116, 11420.543178272776, 11534.711632209262, 11625.36060516646], "value": 7334.675259396009, "unit": "score"}], "name": "dromaeo_css", "value": 7260.872166172583, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 113.0, 111.0, 112.0, 113.0, 112.0, 113.0, 112.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 117.0, 157.0, 118.0, 119.0, 118.0, 117.0, 148.0, 118.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 160.0, 161.0, 160.0, 160.0, 160.0, 163.0, 159.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 108.0, 76.0, 75.0, 75.0, 76.0, 97.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 117.0, 83.0, 82.0, 82.0, 112.0, 83.0, 82.0, 110.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 56.0, 48.0, 49.0, 49.0, 49.0, 49.0, 49.0, 51.0, 50.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 61.0, 60.0, 60.0, 60.0, 61.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 82.0, 74.0, 75.0, 75.0, 75.0, 91.0, 78.0, 79.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 127.0, 129.0, 138.0, 121.0, 120.0, 118.0, 167.0, 119.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 159.0, 159.0, 152.0, 153.0, 152.0, 158.0, 154.0, 158.0, 158.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 64.0, 66.0, 61.0, 65.0, 62.0, 62.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1456.4000000000003, "alertThreshold": 2.0}]} 03:36:28 INFO - Return code: 0 03:36:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:36:28 INFO - # TBPL SUCCESS # 03:36:28 INFO - Running post-action listener: _resource_record_post_action 03:36:28 INFO - [mozharness: 2016-12-29 11:36:28.839358Z] Finished run-tests step (success) 03:36:28 INFO - Running post-run listener: _resource_record_post_run 03:36:28 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 356843520; Read time: 12; Write time: 225188 03:36:28 INFO - TinderboxPrint: CPU usage
13.0% 03:36:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:36:28 INFO - TinderboxPrint: I/O write bytes / time
356,843,520 / 225,188 03:36:28 INFO - TinderboxPrint: CPU idle
8,270.0 (87.0%) 03:36:28 INFO - TinderboxPrint: CPU user
1,191.4 (12.5%) 03:36:28 INFO - TinderboxPrint: Swap in / out
0 / 0 03:36:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108175360; Read time: 0; Write time: 77236 03:36:28 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 237084672; Read time: 0; Write time: 144688 03:36:29 INFO - Running post-run listener: _upload_blobber_files 03:36:29 INFO - Blob upload gear active. 03:36:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:36:29 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 03:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:36:29 INFO - (blobuploader) - INFO - Open directory for files ... 03:36:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:36:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:36:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:32 INFO - (blobuploader) - INFO - Done attempting. 03:36:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:36:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:36:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:33 INFO - (blobuploader) - INFO - Done attempting. 03:36:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:36:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:36:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:34 INFO - (blobuploader) - INFO - Done attempting. 03:36:34 INFO - (blobuploader) - INFO - Iteration through files over. 03:36:34 INFO - Return code: 0 03:36:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:36:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:36:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb00c863aff7e8c8e4ad5c4849dcadcd84a9ac91bc2731b9c331ca18d28a94c63fa8766a4fb2ad67eced0654e06546131d7d34ef9296beb23fd5bcf00e65596e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b608ac9286be3a9ef8e16c4645f66a47771ce011324e35f34f92759a37d382f79e82b9d93cfd79dde6fda101a1a4cf06f2c5fe32652aedec33f83bf54bc216f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e66bc7152eac1ecc825de03bc956a95d51220b376896997a2d9973a3136fd78ba6c8235a2eec107cf4334b7e762dc0ba71d6e12ccc4e8e73113fa90f6e968c5d"} 03:36:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:36:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:36:34 INFO - Contents: 03:36:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb00c863aff7e8c8e4ad5c4849dcadcd84a9ac91bc2731b9c331ca18d28a94c63fa8766a4fb2ad67eced0654e06546131d7d34ef9296beb23fd5bcf00e65596e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b608ac9286be3a9ef8e16c4645f66a47771ce011324e35f34f92759a37d382f79e82b9d93cfd79dde6fda101a1a4cf06f2c5fe32652aedec33f83bf54bc216f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e66bc7152eac1ecc825de03bc956a95d51220b376896997a2d9973a3136fd78ba6c8235a2eec107cf4334b7e762dc0ba71d6e12ccc4e8e73113fa90f6e968c5d"} 03:36:34 INFO - Running post-run listener: copy_logs_to_upload_dir 03:36:34 INFO - Copying logs to upload dir... 03:36:34 INFO - mkdir: /builds/slave/test/build/upload/logs 03:36:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.830082 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-29 03:36:34.194326) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 03:36:34.197964) ========= 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=3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb00c863aff7e8c8e4ad5c4849dcadcd84a9ac91bc2731b9c331ca18d28a94c63fa8766a4fb2ad67eced0654e06546131d7d34ef9296beb23fd5bcf00e65596e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b608ac9286be3a9ef8e16c4645f66a47771ce011324e35f34f92759a37d382f79e82b9d93cfd79dde6fda101a1a4cf06f2c5fe32652aedec33f83bf54bc216f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e66bc7152eac1ecc825de03bc956a95d51220b376896997a2d9973a3136fd78ba6c8235a2eec107cf4334b7e762dc0ba71d6e12ccc4e8e73113fa90f6e968c5d"} build_url:https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/EKOTeC_iSrGkcOHr80cH1Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb00c863aff7e8c8e4ad5c4849dcadcd84a9ac91bc2731b9c331ca18d28a94c63fa8766a4fb2ad67eced0654e06546131d7d34ef9296beb23fd5bcf00e65596e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b608ac9286be3a9ef8e16c4645f66a47771ce011324e35f34f92759a37d382f79e82b9d93cfd79dde6fda101a1a4cf06f2c5fe32652aedec33f83bf54bc216f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e66bc7152eac1ecc825de03bc956a95d51220b376896997a2d9973a3136fd78ba6c8235a2eec107cf4334b7e762dc0ba71d6e12ccc4e8e73113fa90f6e968c5d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 03:36:34.224897) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 03:36:34.225259) ========= 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=3a3620fb28aea1604ab609ef000001d2-1483008835.129185-571810051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 03:36:34.310166) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 03:36:34.310538) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 03:36:34.310886) ========= ========= Total master_lag: 0.17 =========