builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1480010423.65 results: success (0) buildid: 20161124071419 builduid: 193a634596464284b078693c4532ee4f revision: 12a7e9d627b5ef91b8c1a9061012cd48ae1a6df0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 10:00:23.645986) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 10:00:23.646464) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 10:00:23.646756) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 10:00:23.659046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:00:23.659440) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-24 10:00:23-- 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% 70.2M=0s 2016-11-24 10:00:23 (70.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101698 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:00:23.772539) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:00:23.772856) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015933 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:00:23.822420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:00:23.822776) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 12a7e9d627b5ef91b8c1a9061012cd48ae1a6df0 --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 12a7e9d627b5ef91b8c1a9061012cd48ae1a6df0 --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=56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-24 10:00:24,002 truncating revision to first 12 chars 2016-11-24 10:00:24,002 Setting DEBUG logging. 2016-11-24 10:00:24,002 attempt 1/10 2016-11-24 10:00:24,002 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/12a7e9d627b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 10:00:24,630 unpacking tar archive at: mozilla-aurora-12a7e9d627b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.948293 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:00:24.784319) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 10:00:24.784683) ========= script_repo_revision: 12a7e9d627b5ef91b8c1a9061012cd48ae1a6df0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 10:00:24.785063) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 10:00:24.785325) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 10:00:24.793283) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-24 10:00:24.793598) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:00:25 INFO - MultiFileLogger online at 20161124 10:00:25 in /builds/slave/test 10:00:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:00:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:00:25 INFO - {'append_to_log': False, 10:00:25 INFO - 'base_work_dir': '/builds/slave/test', 10:00:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:00:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:00:25 INFO - 'branch': 'Mozilla-Aurora', 10:00:25 INFO - 'buildbot_json_path': 'buildprops.json', 10:00:25 INFO - 'config_files': ('talos/linux_config.py',), 10:00:25 INFO - 'default_actions': ('clobber', 10:00:25 INFO - 'read-buildbot-config', 10:00:25 INFO - 'download-and-extract', 10:00:25 INFO - 'populate-webroot', 10:00:25 INFO - 'create-virtualenv', 10:00:25 INFO - 'install', 10:00:25 INFO - 'run-tests'), 10:00:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:00:25 INFO - 'download_minidump_stackwalk': True, 10:00:25 INFO - 'download_symbols': 'ondemand', 10:00:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:00:25 INFO - 'tooltool.py': '/tools/tooltool.py', 10:00:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:00:25 INFO - '/tools/misc-python/virtualenv.py')}, 10:00:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:00:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:00:25 INFO - 'installer_path': 'installer.exe', 10:00:25 INFO - 'log_level': 'info', 10:00:25 INFO - 'log_name': 'talos', 10:00:25 INFO - 'log_to_console': True, 10:00:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:00:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:00:25 INFO - 'opt_config_files': (), 10:00:25 INFO - 'pip_index': False, 10:00:25 INFO - 'sps_profile': False, 10:00:25 INFO - 'sps_profile_interval': 0, 10:00:25 INFO - 'suite': 'dromaeojs-e10s', 10:00:25 INFO - 'system_bits': '32', 10:00:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:00:25 INFO - 'title': 'talos-linux64-ix-037', 10:00:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:00:25 INFO - 'use_talos_json': True, 10:00:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:00:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:00:25 INFO - 'work_dir': 'build'} 10:00:25 INFO - [mozharness: 2016-11-24 18:00:25.065596Z] Running clobber step. 10:00:25 INFO - Running pre-action listener: _resource_record_pre_action 10:00:25 INFO - Running main action method: clobber 10:00:25 INFO - rmtree: /builds/slave/test/build 10:00:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:00:25 INFO - Running post-action listener: _resource_record_post_action 10:00:25 INFO - [mozharness: 2016-11-24 18:00:25.526389Z] Finished clobber step (success) 10:00:25 INFO - [mozharness: 2016-11-24 18:00:25.526488Z] Running read-buildbot-config step. 10:00:25 INFO - Running pre-action listener: _resource_record_pre_action 10:00:25 INFO - Running main action method: read_buildbot_config 10:00:25 INFO - Using buildbot properties: 10:00:25 INFO - { 10:00:25 INFO - "project": "", 10:00:25 INFO - "product": "firefox", 10:00:25 INFO - "script_repo_revision": "production", 10:00:25 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:00:25 INFO - "repository": "", 10:00:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:00:25 INFO - "buildid": "20161124071419", 10:00:25 INFO - "pgo_build": "True", 10:00:25 INFO - "basedir": "/builds/slave/test", 10:00:25 INFO - "buildnumber": 725, 10:00:25 INFO - "slavename": "talos-linux64-ix-037", 10:00:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:00:25 INFO - "platform": "ubuntu64_hw", 10:00:25 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:00:25 INFO - "branch": "mozilla-aurora", 10:00:25 INFO - "repo_path": "releases/mozilla-aurora", 10:00:25 INFO - "revision": "12a7e9d627b5ef91b8c1a9061012cd48ae1a6df0", 10:00:25 INFO - "stage_platform": "linux64-pgo", 10:00:25 INFO - "builduid": "193a634596464284b078693c4532ee4f", 10:00:25 INFO - "slavebuilddir": "test" 10:00:25 INFO - } 10:00:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 10:00:25 INFO - Running post-action listener: _resource_record_post_action 10:00:25 INFO - [mozharness: 2016-11-24 18:00:25.528920Z] Finished read-buildbot-config step (success) 10:00:25 INFO - [mozharness: 2016-11-24 18:00:25.529009Z] Running download-and-extract step. 10:00:25 INFO - Running pre-action listener: _resource_record_pre_action 10:00:25 INFO - Running main action method: download_and_extract 10:00:25 INFO - mkdir: /builds/slave/test/build/tests 10:00: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')]} 10:00:25 INFO - trying https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 10:00:25 INFO - Downloading https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/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 10:00:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/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 10:00:26 INFO - Downloaded 1361 bytes. 10:00:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 10:00:26 INFO - Using the following test package requirements: 10:00:26 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 10:00:26 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:00:26 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:00:26 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:26 INFO - u'jsshell-linux-x86_64.zip'], 10:00:26 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:00:26 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 10:00:26 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:00:26 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:00:26 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:00:26 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:00:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:00:26 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:00:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 10:00:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:00:26 INFO - Fetch https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 10:00:26 INFO - Http code: 200 10:00:26 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 10:00:26 INFO - x-amz-cf-id: U03e91Y0flTOUwgHxzr6jlhdaLk4ghiZofioS9p84qcUuyJE9psc4w== 10:00:26 INFO - x-amz-version-id: Wtbp.YOQiHNFemIs7Q0uF_2sHQCYK3WJ 10:00:26 INFO - Expected file size: 21949723 10:00:26 INFO - Obtained file size: 21949723 10:00:30 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 10:00:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 10:00:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:00:30 INFO - Fetch https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 10:00:31 INFO - Http code: 200 10:00:31 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 10:00:31 INFO - x-amz-cf-id: O8RWpc0yeuQhGakoPoHCMZmNjmfYJz8nKKmtYmUVkqw3Li0ev5KZcQ== 10:00:31 INFO - x-amz-version-id: Wtbp.YOQiHNFemIs7Q0uF_2sHQCYK3WJ 10:00:31 INFO - Expected file size: 21949723 10:00:31 INFO - Obtained file size: 21949723 10:00:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 10:00:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:00:36 INFO - Fetch https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 10:00:36 INFO - Http code: 200 10:00:36 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 10:00:36 INFO - x-amz-cf-id: 7XfRTMnwWd5qrEX--i3g8EKeFuBEy9N8R9ZvsA2zAISL_PRu-KqS5g== 10:00:36 INFO - x-amz-version-id: DZjj2iUNBKPvBJqppPMCCk29aHRM7qKz 10:00:36 INFO - Expected file size: 14409038 10:00:36 INFO - Obtained file size: 14409038 10:00:37 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')]} 10:00:37 INFO - trying https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 10:00:37 INFO - Downloading https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/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 10:00:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/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 10:00:38 INFO - Downloaded 63968237 bytes. 10:00:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 10:00:38 INFO - mkdir: /builds/slave/test/properties 10:00:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:00:38 INFO - Writing to file /builds/slave/test/properties/build_url 10:00:38 INFO - Contents: 10:00:38 INFO - build_url:https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 10:00:38 INFO - Running post-action listener: _resource_record_post_action 10:00:38 INFO - Running post-action listener: set_extra_try_arguments 10:00:38 INFO - [mozharness: 2016-11-24 18:00:38.782142Z] Finished download-and-extract step (success) 10:00:38 INFO - [mozharness: 2016-11-24 18:00:38.782372Z] Running populate-webroot step. 10:00:38 INFO - Running pre-action listener: _resource_record_pre_action 10:00:38 INFO - Running main action method: populate_webroot 10:00:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:00:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:00:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:00:38 INFO - '--tppagecycles', 10:00:38 INFO - '7'], 10:00:38 INFO - 'tests': ['tsvgm']}}, 10:00:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:00:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:00:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:00:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:00:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:00:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:00:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:38 INFO - 'talos_options': ['--disable-e10s'], 10:00:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:38 INFO - 'talos_options': ['--disable-e10s'], 10:00:38 INFO - 'tests': ['damp', 'tps']}, 10:00:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:38 INFO - 'tests': ['damp', 'tps']}, 10:00:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:00:38 INFO - 'tests': ['dromaeo_dom']}, 10:00:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:00:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:00:38 INFO - 'tests': ['basic_compositor_video']}, 10:00:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:00:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:00:38 INFO - 'tests': ['a11yr', 10:00:38 INFO - 'ts_paint', 10:00:38 INFO - 'tpaint', 10:00:38 INFO - 'sessionrestore', 10:00:38 INFO - 'sessionrestore_no_auto_restore', 10:00:38 INFO - 'tabpaint']}, 10:00:38 INFO - 'other-e10s': {'tests': ['a11yr', 10:00:38 INFO - 'ts_paint', 10:00:38 INFO - 'tpaint', 10:00:38 INFO - 'sessionrestore', 10:00:38 INFO - 'sessionrestore_no_auto_restore', 10:00:38 INFO - 'tabpaint']}, 10:00:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:00:38 INFO - 'ts_paint', 10:00:38 INFO - 'tpaint', 10:00:38 INFO - 'sessionrestore', 10:00:38 INFO - 'sessionrestore_no_auto_restore', 10:00:38 INFO - 'tabpaint']}, 10:00:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:00:38 INFO - 'ts_paint', 10:00:38 INFO - 'tpaint', 10:00:38 INFO - 'sessionrestore', 10:00:38 INFO - 'sessionrestore_no_auto_restore', 10:00:38 INFO - 'tabpaint']}, 10:00:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:00:38 INFO - 'tests': ['a11yr', 10:00:38 INFO - 'ts_paint', 10:00:38 INFO - 'tpaint', 10:00:38 INFO - 'sessionrestore', 10:00:38 INFO - 'sessionrestore_no_auto_restore', 10:00:38 INFO - 'tabpaint']}, 10:00:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:00:38 INFO - 'tests': ['a11yr', 10:00:38 INFO - 'ts_paint', 10:00:38 INFO - 'tpaint', 10:00:38 INFO - 'sessionrestore', 10:00:38 INFO - 'sessionrestore_no_auto_restore', 10:00:38 INFO - 'tabpaint']}, 10:00:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:00:38 INFO - 'tests': ['tsvgx', 10:00:38 INFO - 'tsvgr_opacity', 10:00:38 INFO - 'tart', 10:00:38 INFO - 'tscrollx', 10:00:38 INFO - 'cart']}, 10:00:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:00:38 INFO - 'tsvgr_opacity', 10:00:38 INFO - 'tart', 10:00:38 INFO - 'tscrollx', 10:00:38 INFO - 'cart']}, 10:00:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:38 INFO - 'talos_options': ['--disable-e10s'], 10:00:38 INFO - 'tests': ['tp5o']}, 10:00:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:38 INFO - 'tests': ['tp5o']}, 10:00:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:38 INFO - 'talos_options': ['--disable-e10s', 10:00:38 INFO - '--xperf_path', 10:00:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:38 INFO - 'tests': ['tp5n']}, 10:00:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:38 INFO - 'talos_options': ['--xperf_path', 10:00:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:38 INFO - 'tests': ['tp5n']}}, 10:00:38 INFO - 'talos.zip': {'path': '', 10:00:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:00:38 INFO - Running post-action listener: _resource_record_post_action 10:00:38 INFO - [mozharness: 2016-11-24 18:00:38.800334Z] Finished populate-webroot step (success) 10:00:38 INFO - [mozharness: 2016-11-24 18:00:38.800422Z] Running create-virtualenv step. 10:00:38 INFO - Running pre-action listener: _resource_record_pre_action 10:00:38 INFO - Running main action method: create_virtualenv 10:00:38 INFO - Creating virtualenv /builds/slave/test/build/venv 10:00:38 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 10:00:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:00:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:00:38 INFO - Using real prefix '/usr' 10:00:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:00:39 INFO - Installing distribute.............................................................................................................................................................................................done. 10:00:41 INFO - Installing pip.................done. 10:00:41 INFO - Return code: 0 10:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:00:41 INFO - Reading from file tmpfile_stdout 10:00:41 INFO - Output received: 10:00:41 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) 10:00:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:00:41 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')]} 10:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:41 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')]} 10:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:41 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 0x7f8e073adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79f60>, '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 0x2a7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', '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 10:00:41 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 10:00:41 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 10:00:41 INFO - Using env: {'DISPLAY': ':0', 10:00:41 INFO - 'HOME': '/home/cltbld', 10:00:41 INFO - 'LANG': 'en_US.UTF-8', 10:00:41 INFO - 'LANGUAGE': 'en_US:en', 10:00:41 INFO - 'LOGNAME': 'cltbld', 10:00:41 INFO - 'MAIL': '/var/mail/cltbld', 10:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:41 INFO - 'MOZ_NO_REMOTE': '1', 10:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:41 INFO - 'NO_EM_RESTART': '1', 10:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:41 INFO - 'PWD': '/builds/slave/test', 10:00:41 INFO - 'SHELL': '/bin/bash', 10:00:41 INFO - 'SHLVL': '1', 10:00:41 INFO - 'TERM': 'linux', 10:00:41 INFO - 'TMOUT': '86400', 10:00:41 INFO - 'USER': 'cltbld', 10:00:41 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', 10:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:41 INFO - '_': '/tools/buildbot/bin/python'} 10:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:41 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 10:00:41 INFO - Cleaning up... 10:00:41 INFO - Return code: 0 10:00:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:00:41 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')]} 10:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:41 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')]} 10:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:41 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 0x7f8e073adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79f60>, '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 0x2a7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', '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 10:00:41 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 10:00:41 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 10:00:41 INFO - Using env: {'DISPLAY': ':0', 10:00:41 INFO - 'HOME': '/home/cltbld', 10:00:41 INFO - 'LANG': 'en_US.UTF-8', 10:00:41 INFO - 'LANGUAGE': 'en_US:en', 10:00:41 INFO - 'LOGNAME': 'cltbld', 10:00:41 INFO - 'MAIL': '/var/mail/cltbld', 10:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:41 INFO - 'MOZ_NO_REMOTE': '1', 10:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:41 INFO - 'NO_EM_RESTART': '1', 10:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:41 INFO - 'PWD': '/builds/slave/test', 10:00:41 INFO - 'SHELL': '/bin/bash', 10:00:41 INFO - 'SHLVL': '1', 10:00:41 INFO - 'TERM': 'linux', 10:00:41 INFO - 'TMOUT': '86400', 10:00:41 INFO - 'USER': 'cltbld', 10:00:41 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', 10:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:41 INFO - '_': '/tools/buildbot/bin/python'} 10:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:42 INFO - Downloading/unpacking psutil>=3.1.1 10:00:42 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 10:00:42 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 10:00:42 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 10:00:42 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 10:00:42 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 10:00:42 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 10:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:00:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:44 INFO - Installing collected packages: psutil 10:00:44 INFO - Running setup.py install for psutil 10:00:44 INFO - building 'psutil._psutil_linux' extension 10:00:44 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 10:00:44 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 10:00:44 INFO - building 'psutil._psutil_posix' extension 10:00:44 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 10:00:44 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 10:00:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:44 INFO - Successfully installed psutil 10:00:44 INFO - Cleaning up... 10:00:44 INFO - Return code: 0 10:00:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:00:44 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')]} 10:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:44 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')]} 10:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:44 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 0x7f8e073adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79f60>, '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 0x2a7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', '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 10:00:44 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 10:00:44 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 10:00:44 INFO - Using env: {'DISPLAY': ':0', 10:00:44 INFO - 'HOME': '/home/cltbld', 10:00:44 INFO - 'LANG': 'en_US.UTF-8', 10:00:44 INFO - 'LANGUAGE': 'en_US:en', 10:00:44 INFO - 'LOGNAME': 'cltbld', 10:00:44 INFO - 'MAIL': '/var/mail/cltbld', 10:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:44 INFO - 'MOZ_NO_REMOTE': '1', 10:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:44 INFO - 'NO_EM_RESTART': '1', 10:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:44 INFO - 'PWD': '/builds/slave/test', 10:00:44 INFO - 'SHELL': '/bin/bash', 10:00:44 INFO - 'SHLVL': '1', 10:00:44 INFO - 'TERM': 'linux', 10:00:44 INFO - 'TMOUT': '86400', 10:00:44 INFO - 'USER': 'cltbld', 10:00:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', 10:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:44 INFO - '_': '/tools/buildbot/bin/python'} 10:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:00:44 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 10:00:44 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 10:00:44 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 10:00:44 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 10:00:44 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 10:00:44 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 10:00:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:00:46 INFO - Installing collected packages: mozsystemmonitor 10:00:46 INFO - Running setup.py install for mozsystemmonitor 10:00:46 INFO - Successfully installed mozsystemmonitor 10:00:46 INFO - Cleaning up... 10:00:46 INFO - Return code: 0 10:00:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:00:46 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')]} 10:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:46 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')]} 10:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:46 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 0x7f8e073adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79f60>, '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 0x2a7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', '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 10:00:46 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 10:00:46 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 10:00:46 INFO - Using env: {'DISPLAY': ':0', 10:00:46 INFO - 'HOME': '/home/cltbld', 10:00:46 INFO - 'LANG': 'en_US.UTF-8', 10:00:46 INFO - 'LANGUAGE': 'en_US:en', 10:00:46 INFO - 'LOGNAME': 'cltbld', 10:00:46 INFO - 'MAIL': '/var/mail/cltbld', 10:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:46 INFO - 'MOZ_NO_REMOTE': '1', 10:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:46 INFO - 'NO_EM_RESTART': '1', 10:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:46 INFO - 'PWD': '/builds/slave/test', 10:00:46 INFO - 'SHELL': '/bin/bash', 10:00:46 INFO - 'SHLVL': '1', 10:00:47 INFO - 'TERM': 'linux', 10:00:47 INFO - 'TMOUT': '86400', 10:00:47 INFO - 'USER': 'cltbld', 10:00:47 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', 10:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:47 INFO - '_': '/tools/buildbot/bin/python'} 10:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:47 INFO - Downloading/unpacking jsonschema==2.5.1 10:00:47 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 10:00:47 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 10:00:47 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 10:00:47 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 10:00:47 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 10:00:47 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 10:00:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:00:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:00:49 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 10:00:49 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 10:00:49 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 10:00:49 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 10:00:49 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 10:00:49 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 10:00:49 INFO - Downloading functools32-3.2.3-2.tar.gz 10:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:00:49 INFO - warning: no files found matching '*.txt' 10:00:49 INFO - no previously-included directories found matching 'build' 10:00:49 INFO - no previously-included directories found matching 'dist' 10:00:49 INFO - no previously-included directories found matching '.git*' 10:00:49 INFO - Installing collected packages: jsonschema, functools32 10:00:49 INFO - Running setup.py install for functools32 10:00:49 INFO - warning: no files found matching '*.txt' 10:00:49 INFO - no previously-included directories found matching 'build' 10:00:49 INFO - no previously-included directories found matching 'dist' 10:00:49 INFO - no previously-included directories found matching '.git*' 10:00:49 INFO - Successfully installed jsonschema functools32 10:00:49 INFO - Cleaning up... 10:00:49 INFO - Return code: 0 10:00:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:00:49 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')]} 10:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:49 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')]} 10:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:49 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 0x7f8e073adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79f60>, '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 0x2a7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', '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 10:00:49 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 10:00:49 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 10:00:49 INFO - Using env: {'DISPLAY': ':0', 10:00:49 INFO - 'HOME': '/home/cltbld', 10:00:49 INFO - 'LANG': 'en_US.UTF-8', 10:00:49 INFO - 'LANGUAGE': 'en_US:en', 10:00:49 INFO - 'LOGNAME': 'cltbld', 10:00:49 INFO - 'MAIL': '/var/mail/cltbld', 10:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:49 INFO - 'MOZ_NO_REMOTE': '1', 10:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:49 INFO - 'NO_EM_RESTART': '1', 10:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:49 INFO - 'PWD': '/builds/slave/test', 10:00:49 INFO - 'SHELL': '/bin/bash', 10:00:49 INFO - 'SHLVL': '1', 10:00:49 INFO - 'TERM': 'linux', 10:00:49 INFO - 'TMOUT': '86400', 10:00:49 INFO - 'USER': 'cltbld', 10:00:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', 10:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:49 INFO - '_': '/tools/buildbot/bin/python'} 10:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:00:49 INFO - Cleaning up... 10:00:49 INFO - Return code: 0 10:00:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:00:49 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')]} 10:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:49 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')]} 10:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:49 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 0x7f8e073adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79f60>, '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 0x2a7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', '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 10:00:49 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 10:00:49 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 10:00:49 INFO - Using env: {'DISPLAY': ':0', 10:00:49 INFO - 'HOME': '/home/cltbld', 10:00:49 INFO - 'LANG': 'en_US.UTF-8', 10:00:49 INFO - 'LANGUAGE': 'en_US:en', 10:00:49 INFO - 'LOGNAME': 'cltbld', 10:00:49 INFO - 'MAIL': '/var/mail/cltbld', 10:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:49 INFO - 'MOZ_NO_REMOTE': '1', 10:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:49 INFO - 'NO_EM_RESTART': '1', 10:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:49 INFO - 'PWD': '/builds/slave/test', 10:00:49 INFO - 'SHELL': '/bin/bash', 10:00:49 INFO - 'SHLVL': '1', 10:00:49 INFO - 'TERM': 'linux', 10:00:49 INFO - 'TMOUT': '86400', 10:00:49 INFO - 'USER': 'cltbld', 10:00:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', 10:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:49 INFO - '_': '/tools/buildbot/bin/python'} 10:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:50 INFO - Downloading/unpacking blobuploader==1.2.4 10:00:50 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 10:00:50 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 10:00:50 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 10:00:50 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 10:00:50 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 10:00:50 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 10:00:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:00:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:00:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:00:52 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 10:00:52 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 10:00:52 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 10:00:52 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 10:00:52 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 10:00:52 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 10:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:00:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:00:52 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 10:00:52 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 10:00:52 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 10:00:52 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 10:00:52 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 10:00:52 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 10:00:52 INFO - Downloading docopt-0.6.1.tar.gz 10:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:00:52 INFO - Installing collected packages: blobuploader, requests, docopt 10:00:52 INFO - Running setup.py install for blobuploader 10:00:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:00:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:00:52 INFO - Running setup.py install for requests 10:00:53 INFO - Running setup.py install for docopt 10:00:53 INFO - Successfully installed blobuploader requests docopt 10:00:53 INFO - Cleaning up... 10:00:53 INFO - Return code: 0 10:00:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:53 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 0x7f8e073adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79f60>, '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 0x2a7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', '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 10:00:53 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 10:00:53 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 10:00:53 INFO - Using env: {'DISPLAY': ':0', 10:00:53 INFO - 'HOME': '/home/cltbld', 10:00:53 INFO - 'LANG': 'en_US.UTF-8', 10:00:53 INFO - 'LANGUAGE': 'en_US:en', 10:00:53 INFO - 'LOGNAME': 'cltbld', 10:00:53 INFO - 'MAIL': '/var/mail/cltbld', 10:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:53 INFO - 'MOZ_NO_REMOTE': '1', 10:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:53 INFO - 'NO_EM_RESTART': '1', 10:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:53 INFO - 'PWD': '/builds/slave/test', 10:00:53 INFO - 'SHELL': '/bin/bash', 10:00:53 INFO - 'SHLVL': '1', 10:00:53 INFO - 'TERM': 'linux', 10:00:53 INFO - 'TMOUT': '86400', 10:00:53 INFO - 'USER': 'cltbld', 10:00:53 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', 10:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:53 INFO - '_': '/tools/buildbot/bin/python'} 10:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:53 INFO - Running setup.py (path:/tmp/pip-u4KdG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:53 INFO - Running setup.py (path:/tmp/pip-GAfGZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:53 INFO - Running setup.py (path:/tmp/pip-tVpL3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:53 INFO - Running setup.py (path:/tmp/pip-BvdIf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:53 INFO - Running setup.py (path:/tmp/pip-eRXXGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:53 INFO - Running setup.py (path:/tmp/pip-Yvhwk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:54 INFO - Running setup.py (path:/tmp/pip-oGiROm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:54 INFO - Running setup.py (path:/tmp/pip-iuVEyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:54 INFO - Running setup.py (path:/tmp/pip-UrDpqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:54 INFO - Running setup.py (path:/tmp/pip-Oh9bvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:54 INFO - Running setup.py (path:/tmp/pip-hLq6gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:54 INFO - Running setup.py (path:/tmp/pip-BVSpKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:54 INFO - Running setup.py (path:/tmp/pip-vV6XF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:54 INFO - Running setup.py (path:/tmp/pip-8Ob47L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:54 INFO - Running setup.py (path:/tmp/pip-ynD1fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:54 INFO - Running setup.py (path:/tmp/pip-8eq0zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:54 INFO - Running setup.py (path:/tmp/pip-VySCd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:00:54 INFO - Running setup.py install for manifestparser 10:00:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:00:54 INFO - Running setup.py install for mozcrash 10:00:55 INFO - Running setup.py install for mozdebug 10:00:55 INFO - Running setup.py install for mozdevice 10:00:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:00:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:00:55 INFO - Running setup.py install for mozfile 10:00:55 INFO - Running setup.py install for mozhttpd 10:00:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:00:55 INFO - Running setup.py install for mozinfo 10:00:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:00:55 INFO - Running setup.py install for mozInstall 10:00:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:00:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:00:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:00:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:00:55 INFO - Running setup.py install for mozleak 10:00:55 INFO - Running setup.py install for mozlog 10:00:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:00:55 INFO - Running setup.py install for moznetwork 10:00:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:00:55 INFO - Running setup.py install for mozprocess 10:00:56 INFO - Running setup.py install for mozprofile 10:00:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:00:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:00:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:00:56 INFO - Running setup.py install for mozrunner 10:00:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:00:56 INFO - Running setup.py install for mozscreenshot 10:00:56 INFO - Running setup.py install for moztest 10:00:56 INFO - Running setup.py install for mozversion 10:00:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:00:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:00:56 INFO - Cleaning up... 10:00:56 INFO - Return code: 0 10:00:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:56 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 0x7f8e073adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79f60>, '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 0x2a7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', '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 10:00:56 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 10:00:56 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 10:00:56 INFO - Using env: {'DISPLAY': ':0', 10:00:56 INFO - 'HOME': '/home/cltbld', 10:00:56 INFO - 'LANG': 'en_US.UTF-8', 10:00:56 INFO - 'LANGUAGE': 'en_US:en', 10:00:56 INFO - 'LOGNAME': 'cltbld', 10:00:56 INFO - 'MAIL': '/var/mail/cltbld', 10:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:56 INFO - 'MOZ_NO_REMOTE': '1', 10:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:56 INFO - 'NO_EM_RESTART': '1', 10:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:56 INFO - 'PWD': '/builds/slave/test', 10:00:56 INFO - 'SHELL': '/bin/bash', 10:00:56 INFO - 'SHLVL': '1', 10:00:56 INFO - 'TERM': 'linux', 10:00:56 INFO - 'TMOUT': '86400', 10:00:56 INFO - 'USER': 'cltbld', 10:00:56 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', 10:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:56 INFO - '_': '/tools/buildbot/bin/python'} 10:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:56 INFO - Running setup.py (path:/tmp/pip-7BZJxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:56 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)) 10:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:56 INFO - Running setup.py (path:/tmp/pip-l16jWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:56 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)) 10:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:56 INFO - Running setup.py (path:/tmp/pip-a5_wJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:57 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)) 10:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:57 INFO - Running setup.py (path:/tmp/pip-ukB1qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:57 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)) 10:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:57 INFO - Running setup.py (path:/tmp/pip-RPutKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:57 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)) 10:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:57 INFO - Running setup.py (path:/tmp/pip-lgX9Ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:57 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)) 10:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:57 INFO - Running setup.py (path:/tmp/pip-ERkVNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:57 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)) 10:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:57 INFO - Running setup.py (path:/tmp/pip-bMxjdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:57 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)) 10:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:57 INFO - Running setup.py (path:/tmp/pip-Wcjg2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:57 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)) 10:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:57 INFO - Running setup.py (path:/tmp/pip-HjqNoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:57 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)) 10:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:57 INFO - Running setup.py (path:/tmp/pip-yHckVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:57 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)) 10:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:57 INFO - Running setup.py (path:/tmp/pip-y9qdch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:57 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)) 10:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:57 INFO - Running setup.py (path:/tmp/pip-tSlhgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:57 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)) 10:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:57 INFO - Running setup.py (path:/tmp/pip-VmM_5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:57 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)) 10:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:57 INFO - Running setup.py (path:/tmp/pip-41S5uP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:57 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)) 10:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:57 INFO - Running setup.py (path:/tmp/pip-JL3uTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:58 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)) 10:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:58 INFO - Running setup.py (path:/tmp/pip-EAD_Wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:58 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)) 10:00:58 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)) 10:00:58 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)) 10:00:58 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)) 10:00:58 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)) 10:00:58 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)) 10:00:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:58 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 10:00:58 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 10:00:58 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 10:00:58 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 10:00:58 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 10:00:58 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 10:01:00 INFO - Downloading blessings-1.6.tar.gz 10:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:01:00 INFO - Installing collected packages: blessings 10:01:00 INFO - Running setup.py install for blessings 10:01:00 INFO - Successfully installed blessings 10:01:00 INFO - Cleaning up... 10:01:00 INFO - Return code: 0 10:01:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:01:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:01:00 INFO - Reading from file tmpfile_stdout 10:01:00 INFO - Current package versions: 10:01:00 INFO - argparse == 1.2.1 10:01:00 INFO - blessings == 1.6 10:01:00 INFO - blobuploader == 1.2.4 10:01:00 INFO - docopt == 0.6.1 10:01:00 INFO - functools32 == 3.2.3-2 10:01:00 INFO - jsonschema == 2.5.1 10:01:00 INFO - manifestparser == 1.1 10:01:00 INFO - mozInstall == 1.12 10:01:00 INFO - mozcrash == 1.0 10:01:00 INFO - mozdebug == 0.1 10:01:00 INFO - mozdevice == 0.48 10:01:00 INFO - mozfile == 1.2 10:01:00 INFO - mozhttpd == 0.7 10:01:00 INFO - mozinfo == 0.9 10:01:00 INFO - mozleak == 0.1 10:01:00 INFO - mozlog == 3.4 10:01:00 INFO - moznetwork == 0.27 10:01:00 INFO - mozprocess == 0.23 10:01:00 INFO - mozprofile == 0.28 10:01:00 INFO - mozrunner == 6.13 10:01:00 INFO - mozscreenshot == 0.1 10:01:00 INFO - mozsystemmonitor == 0.3 10:01:00 INFO - moztest == 0.7 10:01:00 INFO - mozversion == 1.4 10:01:00 INFO - psutil == 3.1.1 10:01:00 INFO - requests == 1.2.3 10:01:00 INFO - wsgiref == 0.1.2 10:01:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:00 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 0x7f8e073adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79f60>, '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 0x2a7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', '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 10:01:00 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 10:01:00 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 10:01:00 INFO - Using env: {'DISPLAY': ':0', 10:01:00 INFO - 'HOME': '/home/cltbld', 10:01:00 INFO - 'LANG': 'en_US.UTF-8', 10:01:00 INFO - 'LANGUAGE': 'en_US:en', 10:01:00 INFO - 'LOGNAME': 'cltbld', 10:01:00 INFO - 'MAIL': '/var/mail/cltbld', 10:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:00 INFO - 'MOZ_NO_REMOTE': '1', 10:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:00 INFO - 'NO_EM_RESTART': '1', 10:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:00 INFO - 'PWD': '/builds/slave/test', 10:01:00 INFO - 'SHELL': '/bin/bash', 10:01:00 INFO - 'SHLVL': '1', 10:01:00 INFO - 'TERM': 'linux', 10:01:00 INFO - 'TMOUT': '86400', 10:01:00 INFO - 'USER': 'cltbld', 10:01:00 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', 10:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:00 INFO - '_': '/tools/buildbot/bin/python'} 10:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:00 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)) 10:01:00 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)) 10:01:00 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)) 10:01:00 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)) 10:01:00 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)) 10:01:00 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)) 10:01:00 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)) 10:01:00 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)) 10:01:00 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)) 10:01:00 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)) 10:01:00 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)) 10:01:00 INFO - Cleaning up... 10:01:00 INFO - Return code: 0 10:01:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e073adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a79f60>, '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 0x2a7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', '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 10:01:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:01:00 INFO - Using env: {'DISPLAY': ':0', 10:01:00 INFO - 'HOME': '/home/cltbld', 10:01:00 INFO - 'LANG': 'en_US.UTF-8', 10:01:00 INFO - 'LANGUAGE': 'en_US:en', 10:01:00 INFO - 'LOGNAME': 'cltbld', 10:01:00 INFO - 'MAIL': '/var/mail/cltbld', 10:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:00 INFO - 'MOZ_NO_REMOTE': '1', 10:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:00 INFO - 'NO_EM_RESTART': '1', 10:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:00 INFO - 'PWD': '/builds/slave/test', 10:01:00 INFO - 'SHELL': '/bin/bash', 10:01:00 INFO - 'SHLVL': '1', 10:01:00 INFO - 'TERM': 'linux', 10:01:00 INFO - 'TMOUT': '86400', 10:01:00 INFO - 'USER': 'cltbld', 10:01:00 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', 10:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:00 INFO - '_': '/tools/buildbot/bin/python'} 10:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:01:00 INFO - Cleaning up... 10:01:00 INFO - Return code: 0 10:01:00 INFO - Running post-action listener: _resource_record_post_action 10:01:00 INFO - Running post-action listener: _start_resource_monitoring 10:01:00 INFO - Starting resource monitoring. 10:01:00 INFO - [mozharness: 2016-11-24 18:01:00.994931Z] Finished create-virtualenv step (success) 10:01:00 INFO - [mozharness: 2016-11-24 18:01:00.995382Z] Running install step. 10:01:00 INFO - Running pre-action listener: _resource_record_pre_action 10:01:00 INFO - Running main action method: install 10:01:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:01:01 INFO - Reading from file tmpfile_stdout 10:01:01 INFO - Detecting whether we're running mozinstall >=1.0... 10:01:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:01:01 INFO - Reading from file tmpfile_stdout 10:01:01 INFO - Output received: 10:01:01 INFO - Usage: mozinstall [options] installer 10:01:01 INFO - Options: 10:01:01 INFO - -h, --help show this help message and exit 10:01:01 INFO - -d DEST, --destination=DEST 10:01:01 INFO - Directory to install application into. [default: 10:01:01 INFO - "/builds/slave/test"] 10:01:01 INFO - --app=APP Application being installed. [default: firefox] 10:01:01 INFO - mkdir: /builds/slave/test/build/application 10:01:01 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'] 10:01:01 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 10:01:17 INFO - Reading from file tmpfile_stdout 10:01:17 INFO - Output received: 10:01:17 INFO - /builds/slave/test/build/application/firefox/firefox 10:01:17 INFO - Running post-action listener: _resource_record_post_action 10:01:17 INFO - [mozharness: 2016-11-24 18:01:17.202239Z] Finished install step (success) 10:01:17 INFO - [mozharness: 2016-11-24 18:01:17.202483Z] Running run-tests step. 10:01:17 INFO - Running pre-action listener: _resource_record_pre_action 10:01:17 INFO - Running main action method: run_tests 10:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:01:17 INFO - Python 2.7.3 10:01:17 INFO - Return code: 0 10:01:17 INFO - grabbing minidump binary from tooltool 10:01: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')]} 10:01:17 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 0x2a79f60>, '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 0x2a7ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:01:17 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 10:01:17 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 10:01:17 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 10:01:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:01:17 INFO - Return code: 0 10:01:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:01:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:01:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:01:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:01:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:01:17 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:01:17 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:01:17 INFO - Using env: {'DISPLAY': ':0', 10:01:17 INFO - 'HOME': '/home/cltbld', 10:01:17 INFO - 'LANG': 'en_US.UTF-8', 10:01:17 INFO - 'LANGUAGE': 'en_US:en', 10:01:17 INFO - 'LOGNAME': 'cltbld', 10:01:17 INFO - 'MAIL': '/var/mail/cltbld', 10:01:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:01:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:17 INFO - 'MOZ_NO_REMOTE': '1', 10:01:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:17 INFO - 'NO_EM_RESTART': '1', 10:01:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:17 INFO - 'PWD': '/builds/slave/test', 10:01:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:01:17 INFO - 'SHELL': '/bin/bash', 10:01:17 INFO - 'SHLVL': '1', 10:01:17 INFO - 'TERM': 'linux', 10:01:17 INFO - 'TMOUT': '86400', 10:01:17 INFO - 'USER': 'cltbld', 10:01:17 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686', 10:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:17 INFO - '_': '/tools/buildbot/bin/python'} 10:01:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:01:17 INFO - mozversion application_buildid: 20161124071419 10:01:17 INFO - mozversion application_changeset: 12a7e9d627b5ef91b8c1a9061012cd48ae1a6df0 10:01:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:01:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:01:17 INFO - mozversion application_name: Firefox 10:01:17 INFO - mozversion application_remotingname: firefox-dev 10:01:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:01:17 INFO - mozversion application_vendor: Mozilla 10:01:17 INFO - mozversion application_version: 52.0a2 10:01:17 INFO - mozversion platform_buildid: 20161124071419 10:01:17 INFO - mozversion platform_changeset: 12a7e9d627b5ef91b8c1a9061012cd48ae1a6df0 10:01:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:01:17 INFO - mozversion platform_version: 52.0a2 10:01:17 INFO - using testdate: 1480010477 10:01:17 INFO - actual date: 1480010477 10:01:17 INFO - starting webserver on 'localhost:43038' 10:01:17 INFO - SUITE-START | Running 2 tests 10:01:17 INFO - TEST-START | dromaeo_css 10:01:17 INFO - operating with platform_type : linux_ 10:01:17 INFO - Initialising browser for dromaeo_css test... 10:01:17 INFO - TEST-INFO | started process 12928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwiuIye/profile http://localhost:43038/getInfo.html) 10:01:22 INFO - PROCESS | 12928 | __metrics Screen width/height:1600/1200 10:01:22 INFO - PROCESS | 12928 | colorDepth:24 10:01:22 INFO - PROCESS | 12928 | Browser inner width/height: 1024/697 10:01:22 INFO - PROCESS | 12928 | __metrics 10:01:22 ERROR - PROCESS | 12928 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:01:23 INFO - TEST-INFO | 12928: exit 0 10:01:23 INFO - Browser initialized. 10:01:23 INFO - Running cycle 1/1 for dromaeo_css test... 10:01:23 INFO - TEST-INFO | started process 13059 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwiuIye/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:35 INFO - PROCESS | 13059 | RSS: Main: 152170496 10:01:35 INFO - PROCESS | 13059 | 10:02:24 INFO - PROCESS | 13059 | 1480010544815 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] 10:04:35 INFO - PROCESS | 13059 | Cycle 1(1): loaded http://localhost:43038/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43038/tests/dromaeo/cssquery-ext.html) 10:04:36 INFO - PROCESS | 13059 | RSS: Main: 157220864 10:04:36 INFO - PROCESS | 13059 | 10:07:38 INFO - PROCESS | 13059 | Cycle 1(1): loaded http://localhost:43038/tests/dromaeo/cssquery-ext.html (next: http://localhost:43038/tests/dromaeo/cssquery-jquery.html) 10:07:39 INFO - PROCESS | 13059 | RSS: Main: 153280512 10:07:39 INFO - PROCESS | 13059 | 10:10:41 INFO - PROCESS | 13059 | Cycle 1(1): loaded http://localhost:43038/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43038/tests/dromaeo/cssquery-mootools.html) 10:10:41 INFO - PROCESS | 13059 | RSS: Main: 153640960 10:10:41 INFO - PROCESS | 13059 | 10:13:43 INFO - PROCESS | 13059 | Cycle 1(1): loaded http://localhost:43038/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43038/tests/dromaeo/cssquery-prototype.html) 10:13:43 INFO - PROCESS | 13059 | RSS: Main: 152137728 10:13:43 INFO - PROCESS | 13059 | 10:16:46 INFO - PROCESS | 13059 | Cycle 1(1): loaded http://localhost:43038/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43038/tests/dromaeo/cssquery-yui.html) 10:16:47 INFO - PROCESS | 13059 | RSS: Main: 154996736 10:16:47 INFO - PROCESS | 13059 | 10:19:49 INFO - PROCESS | 13059 | Cycle 1(1): loaded http://localhost:43038/tests/dromaeo/cssquery-yui.html (next: http://localhost:43038/tests/dromaeo/cssquery-dojo.html) 10:19:49 INFO - PROCESS | 13059 | RSS: Main: 155480064 10:19:49 INFO - PROCESS | 13059 | 10:19:49 INFO - PROCESS | 13059 | __start_tp_report 10:19:49 INFO - PROCESS | 13059 | _x_x_mozilla_page_load 10:19:49 INFO - PROCESS | 13059 | _x_x_mozilla_page_load_details 10:19:49 INFO - PROCESS | 13059 | |i|pagename|runs| 10:19:49 INFO - PROCESS | 13059 | |0;dojo.html;3249.756268279879;3254.4792833146703;3255.5442238086657;3298.224917144469;3302.537644729738;5633.408492108326;5675.659460432372;5690.943090569093;5691.4877661010505;5703.201551782754;5685.260916080903;5792.478676919077;5822.825315240539;5830.533557315404;5864.413558644133;5248.921266181001;5263.973680131594;5287.788488460457;5298.12580924149;5324.307839980797;5314.9468505315035;5328.17413300939;5342.118550439173;5349.491798279158;5367.677939323634;5172.482751724835;5209.426963034063;5330.040592693314;5334.386545547273;5344.946550534503;5150.536451719345;5179.766910489037;5187.247849061865;5189.532942035235;5214.191800270964;5167.715775632339;5169.353830771153;5180.870478238036;5230.973845130788;5303.337082864642;5598;5727.312722473288;5744.281964754406;5805.158252053428;5813.563982701315;6031.336552979169;6127.9031502109065;6140.258857967814;6145.293291271516;6145.494353883282;6118.893302669174;6187.969060154671;6210.4100110489435;6210.9068363974575;6213.906791398133;5482.698451585201;5524.171374293888;5727.026405511073;5768.50967667753;5778.5377169826315;6113.689152827286;6127.080937859268;6136.519078024463;6216.502679785606;6221.688915554204;5970.283565972111;5972.223610930551;5974.163617093611;5985.221921150222;5997.880042399128;5956.225690660186;6076.210092687922;6081.179040829431;6091.208142941389;6092.025275955826;5914.378990206053;6071.2714474263375;6084.087386892002;6101.420365065312;6131.233595800525;6154.046122850876;6160.630362178284;6161;6164.137020817089;6171.814845554641;4729.739864307496;4729.929051064237;4734.147853386355;4735.810567577328;4768.713877167381;4021.075152714892;4044.2518134145275;4148.087420767487;4198.64311533517;4219.683523735732;5896.439838215363;5934.347221805598;5939.287285525678;5956.076808094752;5989.460948514655;5951.226340575698;6009.759609615567;6175.073738939195;6191;6247.468965137923;5858;5903.852403689856;5912.645241285537;5946.8810623787285;5972.790952316735;5371.75827087782;5375.408705042442;5381.273528073738;5384.596155288369;5385.353757549119;6193.6903154841175;6459.418652321219;6467.320931302145;6470.611763294218;6473.126127972758;5955.553333499918;5960.403959604005;5978.730957107027;6027.336992930686;6064.605800622945;6049.848753781014;6201.976673848764;6204.5967012144065;6214.005759078525;6215;5864.120381942743;5908.556858235564;5921.644701317935;5931.851703707442;5933.940660593512;5943.673097979479;5984;6046.334903160737;6070.878582428415;6099.054646529795;6029.035354343284;6029.336772955059;6031.69841507914;6040.275166979991;6054.3340232575265;5983.222181116427;5991.9813631681845;6000;6000.759969601167;6000.759969601167;5678.119891416672;5784.739686714024;5825.0679891217205;5915.40845915405;5926.940730592812;6112.755489780359;6112.969435152796;6116.633002019893;6124.112003759519;6136.140940268277;5938.61399009063;5944.554158438221;5965.164876917322;5975.581709280309;5980.162777211281 10:19:49 INFO - PROCESS | 13059 | |1;ext.html;569.2144840120633;614.8555089553954;631.2771876201748;649.3863299182275;677.7729460630688;43588.12823743523;45081.09837803246;45095;48718.75640621801;48769;46023;46369.30446043312;46496.53503464964;46497.7675111624;46544;8903.154200350957;9050.27597792175;9050.592723327467;9060.954695226515;9067.138621830916;8811.427257228292;8924.330675199353;8928.687495937644;8966.64133434665;8995.055519170492;8938.821223575525;8997.595108220146;9009.504477253748;9010;9034.638614455414;8975.640974361018;8988.910110898905;8999.100089991014;9034.45793252407;9044.457332560067;8786.560671966376;8870.645174193025;8877.245434138105;8904.51025193614;8915.465072095694;43297.134057318995;43330.13339733219;43864;44166;44192;3457.2566898117025;3510.104923244556;3528.1356067763304;3573.857045718168;4127.814248358831;33929.32141357159;34052.6594734052;34294.48558271628;34744.65255347439;35489.11277218064;4377.562243775629;4406.317020861739;4445.022095139064;4485.618722408599;4542.182407166709;351426.99999999744;353829;354153;357430;357639;61153;61708;61737.07394389088;61842.690786545776;62029.68985155135;57656;57877.71061144667;57882.710586446796;58137;58303;17523.82476175222;17801.910990444965;17854.37509687181;17889;17895.10524473797;13937.233452160228;14020.789688154686;14037.298135093204;14039.78940315896;14084.084534505224;17831.73252401215;18011.369602063864;18026.549336266697;18140.9092954537;18147.54631134232;6200.054973887458;6201.410865967726;6271.216097987752;6377.617342959345;6429.678516074177;1060.877999030106;1062.442217835627;1111.727626731456;1148.9597864074885;1170.9648710538697;32655;32882.671173288436;33100.503492447635;33140.668593313756;33194.170145746066;1145.6391236760394;1146.157574182975;1194.474431250247;1194.5580135349803;1232.6610182199968;17426.302947882195;17511.299548018193;17781.022043787456;18007;18120.637587248446;502867;506003;506171;511361;512291;61359;61440;61504.384956149865;61598;61624.38375616276;1435.8923080768984;1442.8124343835234;1461.3496993837853;1472;1485.5543336998858;32332.83833580817;34007.659923400446;34076.11379656187;34138.14654633654;34297.48553771745;54118;54157.18764218461;54226.186607200136;54336.45663543472;54579;427370;428924;429959;430237;430404;30145.849270753504;30247.092587222418;30452.543211851396;30570.235744106576;30605.846970765004;48880.26679599738;49070;49232.75383623059;49549.256761149336;50423.74788126036;41552.79223603863;45998.310025348976;46311;46798;47557.52442475531;41540.79229603833;41890;41970;42757.78621106874;43300;38490.80754596209;38831;42861;43807.34288985604;44671.55328446804;36810.63189368179;37069.44395834119;37650.246995059395;37873.24253514969;37973.81013094917;29200;29369.265768355963;29575;29809;29954.25114372071 10:19:49 INFO - PROCESS | 13059 | |2;jquery.html;427.685651046481;434.66965106519035;439.26338908599405;442.6503062580561;446.997765011175;19103;20192;20754.169833206674;20756.27353042644;20907.895460522694;19949.401517954484;19965.500862478446;20226.19095236189;20254.08856601453;20477.180912763473;5656.321241451032;5982.581219314649;5988.580799344048;5995.1906492623375;5999.490043346299;5685.687287199203;5825.097109947965;5845.970770146143;5868;5878.617889837147;5810.883782324372;5826.592138550303;5837.124431335291;5837.445442682938;5844.678542680151;5632.295963004624;5747.166660834177;5764.481196692318;5785.710714464302;5818.650880947157;5066.189409694432;5189.532942035235;5248.317718696583;5259.658122222043;5284.154535274376;23980.52038959211;24003.27990160298;24203.636945445833;24296.028158873625;24521.754782452124;2581.8709064546697;2866.269101379135;2934.4864648686607;3227.887023954174;3231.2083539532728;14756.483523076748;15413;15502.767458488132;15649.374025039098;15789.131597762118;1933.6519426503223;1952.3947576251408;2060.9532903636496;2085.572457646179;2108.2937216032647;81284.59357703173;82395.5880220595;83965;95264.04735952622;96611.51694241483;11615.76768464643;12168.148229623841;12200.450979705935;12307.015438764878;12485.87514124847;17265.91367043182;17270.13649317529;17287.827121728875;17289.82710172907;17316.567085822957;8826.338024648177;8896.199342059246;8942.061083586259;9065.365424420359;9135.862962055575;8129.105798362176;8129.1464396238725;8279.50322980623;8419.031811341652;8438.831223375499;5096.796128154906;5143.8456846294675;5186.455422180692;5230.241614965808;5320.388155362183;1944.5041514413733;2007.4078146946686;2168.6638571021517;2171;2177.553601511718;896.3501461440403;994.4232345239743;1020.433659319085;1030.283952652914;1056.27645063132;20595.07322170506;20748.89625551893;20886.58226835455;21155.25956591512;21185.894070529856;1050.3435352904435;1067.066316972649;1071.8285074388061;1089.84742136101;1091;10951.233413661126;11569.19015668912;11689.76620467586;11830.290182589073;11831;477980;492394;500504;516407;523866;97064.51467742617;97365.51317243368;97814.5109274449;98911.50544247232;104629.47685261525;969.7187815533557;989.8911119776819;1016.3139880580726;1025.9333143345807;1044.8537204791182;18403;18441.631167376847;18684.34604788826;18747.812521874606;19014.61970760605;44110.13794722952;44597.77701111474;45129.548704512534;45392.54607453883;46041.53958460373;62696.373036269055;62716.05925911024;63149;63427;63564;8727.869081963649;9182.67860624875;9336.39313444624;9347.766305842408;11974.700632484257;12960.092793504364;13379.665508362368;13440.663983400493;14023.368948397143;14153.787693184404;11684.649460516199;11865.5847045353;11956.820647690118;12141.271523708605;12564.497420103458;12111.878881211074;12585.811212831632;12608.243505389706;12624.55814046504;12763.680907977376;11832.76334473323;12001.099917506397;12116.697082573006;12338.50645974151;12420.62738117858;12824.935875320563;12832.615021549369;13097.607071787861;13234.470621175045;13266.137701049402;10894.510854116586;10962.725931851768;10999.780004400027;11036.895674300076;11202.663920082085 10:19:49 INFO - PROCESS | 13059 | |3;mootools.html;1496.5136330692521;1508.2986411318734;1692.4837924433043;1778.9822101778977;1818.3181307009872;7664.11862635797;7913;8215.630296636651;8791.472511649306;8829.558522073903;8396.244338009594;8670.566471676422;8688.522131282776;8936.061713520085;8984.326175536828;2501.8999240030375;2540.593505039194;2545.2237067694346;2556.169244995375;2561.078011915709;2425.333033415807;2505.924822255326;2515.8238923275376;2523.684539432571;2524.835885667435;2448.2532827487607;2469.6295555666616;2476.368526025861;2479.801615870726;2485.8135639826996;2423.684920960273;2433.8052955763583;2447.9143229986953;2491.6636254105824;2515.987420062888;2485.42835147917;2491.9003239870563;2520.3825062859532;2521.9747802521924;2530.544501989641;8863.423877447945;8897.73306800797;8914.955425222897;8966.237869781076;8993.955030224872;5324.41431442541;5425.755840987165;5439.993601183754;5446.455354464561;5452.263944367539;3255.5930508686415;3436.27838153988;3506.8597256109724;3607.4408466687705;3694.7783133011835;1078.2129045796535;1130.8586426696663;1133.620237220532;1138.937358445285;1184.200664551433;12216.877831221664;12291.201071930296;12311.75376492474;12343.567975120828;12366.690832729164;4743.715377077387;4868.9756551217015;4885.2427873679635;4899.559039686445;4975.4527002029745;9969.252306077073;9978.700638980843;9997.400155990665;9998.450085245382;10011.349262297927;5449.482299181572;5477.917831232535;5486.31421072366;5489.3687225969525;5497.900419916033;4492.932606010912;4709.952900470951;5054.570361519239;5100.0819852426175;5150.665206761549;4252.4897012358715;4268.551802060801;4326.567343265649;4375.16871794358;4392.846250381285;1407.2049292149902;1424.444466658004;1426.5149849051165;1439.4889814115838;1459.8759105476154;826.4173757500947;831.4429332347341;927.332320729074;973.5618971462728;997.9251556133319;5684.403137670568;5690.5447564194765;5767.192593036978;5863.384344643836;5896.823095307148;467.1684401764864;471.1166562694947;473.9099571081484;476.72826488900995;481.1675800864524;3770.340190466712;3866.0721426857913;3899.0447340401784;3912;3938.7439816411843;10653.467326633638;10880.455977201109;10962.287451315638;11085.556577736961;11088.611898583511;10614.416207108683;10667.413292269;10903.29128606638;10918.617848375268;10928.180386471047;8289.295409890226;8383.790405239917;8409.663613455516;8465.619047142893;8485.703000394957;5676.375598684059;5739.2252045973255;5819.5635327351465;5833.591648584728;5982.282126144891;9568.4737339447;9640.807183856425;9941.552630131806;10003.049710277512;10076.294659374067;10031.849522257318;10074.496275186359;10142.442165680959;10191.490425478549;10245.590176392861;7120.750773722895;7491.438142139253;7847.9215207849475;7923.881141782993;8128.796780080545;8708.390412671306;8710.738677839676;8725.345599079967;8733.868991965253;8795.076516965626;7587.468877178544;7608.80977975555;7637.350825179922;7685.884711729441;7740.7677769667;7603.847923041398;7676.53940763556;7690.2694244046725;7787.727429539939;7898.84202315939;6999.51003429755;7079.2566780487305;7080.610566418896;7089.468289878177;7205.423566114803;4681.882952926067;4883.413990321184;4894.730789806453;4924.482929292372;5044.167712327571;4932.556069953722;4959.578435832995;5072.365954255718;5142.6914385137015;5170.1727723564045 10:19:49 INFO - PROCESS | 13059 | |4;prototype.html;358.77217966591223;361.13688284998847;363.34960420846687;374.2701731623333;375.1315704144906;5535.778568857241;5614.466625670565;5755.136729490573;5823.65058096514;5825.067989121736;5492;5601.551875849932;5684.261046064016;5725.885482290351;5731.340895796985;4505.301678239878;4512.916899944023;4517.390152329443;4528.592426681598;4529.592336689697;4415.668824838134;4454.287314029756;4485.1254005468945;4504.909901801962;4513.7517436540975;4446.577575130357;4454.309582014793;4465.866024019285;4473.150101480708;4488.573585509388;4423.712458690191;4475.820967161326;4505.662075344329;4505.752183629899;4518.502964673883;3776.9433458498142;3894.240623078501;4005.719599628027;4032.4152997815154;4041.6362527372676;5527.723613819293;5529.225908372831;5565.332160140769;5596.2165296858475;5605.411431799684;5100.413452452978;5101.770420331094;5116.334876466073;5142.691438513663;5144.402076951115;5638.774449022034;5914.792982245601;5928.40715928408;5987.64074155552;6000.159977603139;4301.5698430156735;4302.397664326997;4303.827846886121;4311.9784401077795;4338.457692788402;6172.691365431666;6219.1915051043525;6220.315765265817;6239.719212635442;6242.563020588561;4333.393324934512;4372.453443319585;4393.934090988638;4408.611287444444;4413.470383553929;4420.8673739787855;4435.1351486459835;4440.7335559866515;4444.311131774515;4462.174497717932;5068.923966140511;5099.439061703284;5105;5125.461826508163;5162.993216322781;5785.739641716133;5805;5896.469317761422;5926.940730592725;6037.758489660365;1480;1486.4500134949922;1490.2474250503426;1490.8136482939633;1490.9627259318386;1003.4967405728461;1026.6919924022764;1030.4281123976266;1039.7660526381503;1047.5076713944434;5610.298712660918;5632.648164440587;5687.236956543485;5694.886102277931;5788.305403351625;5936.198613187251;5977.641341519523;5985.503624093976;5990.460858522667;6058.030715085565;5360.127357578234;5491.670499769947;5607.7476513556985;5624.775008999594;5659.547236221092;3092.4433601951864;3153.290509635314;3169.952450713241;3190.7925984810913;3196.6164060312913;5956.101982890517;6188;6203.286622038433;6211.81364559064;6233.532485063638;5874.706264686749;5956.851078723066;5961.791337303173;6004.819855404257;6013.368596297413;6046.153538504613;6124.816255512342;6157.568970172135;6188.783392581238;6227.906581401283;5763.740631671669;5862.618929769551;5881.617694849821;5888.705564721832;5928.525717942641;5791.449812267828;5805.883882322414;5813.593048486566;5867.20792692998;5901.881962360814;6012.278526576664;6111.572189946661;6154.230721159855;6161.260648722182;6226.719797609209;4236.555161707976;4270.10327831159;4275.957240427556;4292.82828686849;4333.414988976448;5885.499732522783;6008.339082700987;6060.818175454743;6072.423119803611;6082.36135205797;5802.013657678121;5907.881842363215;5926.407359264039;5948.401217263493;5967.8209653710455;5978.461938425563;5981.312149102735;6009.188759517584;6022.66875321844;6062.878367502026;5664.830055098354;5860.267466566679;5898.233229680286;5961.225040744675;5967.403259673998;6006.939930600638;6057.18228039209;6062.636241825505;6073.939260607337;6075.848103797441;5632.901584191043;5746.655200687805;5851.444112809277;5888.057910734262;5896.380880007709 10:19:49 INFO - PROCESS | 13059 | |5;yui.html;775.4145620056856;778.8442311537692;783.9882401763971;804.0271271761169;866.588370524001;13399.263040532778;13927.234002129879;13959.302034898252;13972.860271397283;14689.706205875877;14708.117512949231;14902.254887255622;14982.400703971854;15004;15007.624809379771;834.3116928533954;848.9575521223945;854.679495189304;855.3926712034463;857.9227869491745;837.0833936839151;850.6044689219511;851.1403482482706;851.2849206666399;851.6550796927223;885.8671199320089;890.4835195586544;892.3530440430668;894.369469523984;898.3442087276293;881.8633111867671;884.9336299777542;886.2776836877924;887.201518633232;888.0675290944547;656.0716586030761;659.7196191618591;660.5211221864158;660.5277226782873;662.4700239808134;13151.736965260641;13899.652508687364;13933.024688271826;13941.930290348484;13962.162270263716;12822.935885320607;12964.740705185937;12989.805152922714;13181.406836692371;13258;10585.206109541738;10635.627753028684;10694.839577406345;10725.51735171919;10783.784324313548;3830.690249829789;3846.230753849213;3914.5889681583308;3929.2337994091163;4052.169305292408;62966.37033629651;63898.68050659717;65238.67380663114;65287.67356163284;65707.67146164239;9799.902000980042;9859.556319965619;9910.80178396428;9979.750506237402;10176.440295783803;19516.31692890742;19536.70694939577;19537.80462195388;19545;19635.312764053477;8429;8432.114627964098;8461.873071903927;8481;8846.424982376126;4607.838725644587;4696.521756384074;4773.594244489188;4831.299461578052;4904.583110435581;3522.489239060322;3611.8374673139247;3612.0608641753333;3629.0201645555553;3629.8729544466346;560.2129008742723;570.0537108400036;577.9364269930304;584.6053913608297;587.9676617785977;633.4742164003866;686.5228666077128;725.9237780033126;732.5092188233896;748.8876668499769;9779.804403912025;10080.69757907264;10252.897471025344;10441.947790261;10458.738531536772;782.6399856066159;783.8353945671473;789.5302295134386;794.8370584030375;806.3106044332129;4651.4418269807165;5014.573761230264;5027.974860125676;5049.368828896388;5064.41759197697;91827;94777.526112369;96711.51644241734;96974.51512742392;97779;85812.57093714492;86262.56868715616;87721;88016;89648;60089.39910600925;61685.69157154275;75218.62390688012;76893.61553192198;76933;9959.601615935571;10233.48832558384;10644.84032739494;10782.568697252022;10788.083012943987;46211.30683039824;46621.30068048914;46991;47019.76490117527;48392.51607484021;59178.408215919015;59779.70110149596;63813.680931595045;64550;65359.346406535326;12770.808437873253;13061.738765224833;13173.27546984925;13279.867201327863;13300.600981970556;13610.319484025957;13901.58295251144;13923.58229253124;14012.859871401155;14063.789043164155;13335.399907004403;13445.731085378433;13605.455781768618;14195.787063193853;14237.21695306768;13587.79618305746;13672;14103.506377276746;14323.427062917783;14378.424863005363;12462.272514468385;12820.358982051046;12992.480300787862;13187.868121319048;13460.528881489101;10827.729306767395;10984.065803067479;10990.725231869268;11048.558057677603;11099.112071034137;11058;11280.548778048786;11493.195476316578;11729.35488548138;11927.880721192678 10:19:49 INFO - PROCESS | 13059 | __end_tp_report 10:19:49 INFO - PROCESS | 13059 | __start_cc_report 10:19:49 INFO - PROCESS | 13059 | _x_x_mozilla_cycle_collect,306 10:19:49 INFO - PROCESS | 13059 | __end_cc_report 10:19:49 INFO - PROCESS | 13059 | __startTimestamp1480011589491__endTimestamp 10:19:49 INFO - PROCESS | 13059 | 10:19:49 INFO - PROCESS | 13059 | ------- Summary: start ------- 10:19:49 INFO - PROCESS | 13059 | Number of tests: 6 10:19:49 INFO - PROCESS | 13059 | 10:19:49 INFO - PROCESS | 13059 | [#0] dojo.html Cycles:165 Average:5692.85 Median:5939.29 stddev:639.00 (10.8%) stddev-sans-first:611.54 10:19:49 INFO - PROCESS | 13059 | Values: 3249.8 3254.5 3255.5 3298.2 3302.5 5633.4 5675.7 5690.9 5691.5 5703.2 5685.3 5792.5 5822.8 5830.5 5864.4 5248.9 5264.0 5287.8 5298.1 5324.3 5314.9 5328.2 5342.1 5349.5 5367.7 5172.5 5209.4 5330.0 5334.4 5344.9 5150.5 5179.8 5187.2 5189.5 5214.2 5167.7 5169.4 5180.9 5231.0 5303.3 5598.0 5727.3 5744.3 5805.2 5813.6 6031.3 6127.9 6140.3 6145.3 6145.5 6118.9 6188.0 6210.4 6210.9 6213.9 5482.7 5524.2 5727.0 5768.5 5778.5 6113.7 6127.1 6136.5 6216.5 6221.7 5970.3 5972.2 5974.2 5985.2 5997.9 5956.2 6076.2 6081.2 6091.2 6092.0 5914.4 6071.3 6084.1 6101.4 6131.2 6154.0 6160.6 6161.0 6164.1 6171.8 4729.7 4729.9 4734.1 4735.8 4768.7 4021.1 4044.3 4148.1 4198.6 4219.7 5896.4 5934.3 5939.3 5956.1 5989.5 5951.2 6009.8 6175.1 6191.0 6247.5 5858.0 5903.9 5912.6 5946.9 5972.8 5371.8 5375.4 5381.3 5384.6 5385.4 6193.7 6459.4 6467.3 6470.6 6473.1 5955.6 5960.4 5978.7 6027.3 6064.6 6049.8 6202.0 6204.6 6214.0 6215.0 5864.1 5908.6 5921.6 5931.9 5933.9 5943.7 5984.0 6046.3 6070.9 6099.1 6029.0 6029.3 6031.7 6040.3 6054.3 5983.2 5992.0 6000.0 6000.8 6000.8 5678.1 5784.7 5825.1 5915.4 5926.9 6112.8 6113.0 6116.6 6124.1 6136.1 5938.6 5944.6 5965.2 5975.6 5980.2 10:19:49 INFO - PROCESS | 13059 | 10:19:49 INFO - PROCESS | 13059 | [#1] ext.html Cycles:180 Average:60358.77 Median:43459.13 stddev:114995.22 (264.6%) stddev-sans-first:115230.20 10:19:49 INFO - PROCESS | 13059 | Values: 569.2 614.9 631.3 649.4 677.8 43588.1 45081.1 45095.0 48718.8 48769.0 46023.0 46369.3 46496.5 46497.8 46544.0 8903.2 9050.3 9050.6 9061.0 9067.1 8811.4 8924.3 8928.7 8966.6 8995.1 8938.8 8997.6 9009.5 9010.0 9034.6 8975.6 8988.9 8999.1 9034.5 9044.5 8786.6 8870.6 8877.2 8904.5 8915.5 43297.1 43330.1 43864.0 44166.0 44192.0 3457.3 3510.1 3528.1 3573.9 4127.8 33929.3 34052.7 34294.5 34744.7 35489.1 4377.6 4406.3 4445.0 4485.6 4542.2 351427.0 353829.0 354153.0 357430.0 357639.0 61153.0 61708.0 61737.1 61842.7 62029.7 57656.0 57877.7 57882.7 58137.0 58303.0 17523.8 17801.9 17854.4 17889.0 17895.1 13937.2 14020.8 14037.3 14039.8 14084.1 17831.7 18011.4 18026.5 18140.9 18147.5 6200.1 6201.4 6271.2 6377.6 6429.7 1060.9 1062.4 1111.7 1149.0 1171.0 32655.0 32882.7 33100.5 33140.7 33194.2 1145.6 1146.2 1194.5 1194.6 1232.7 17426.3 17511.3 17781.0 18007.0 18120.6 502867.0 506003.0 506171.0 511361.0 512291.0 61359.0 61440.0 61504.4 61598.0 61624.4 1435.9 1442.8 1461.3 1472.0 1485.6 32332.8 34007.7 34076.1 34138.1 34297.5 54118.0 54157.2 54226.2 54336.5 54579.0 427370.0 428924.0 429959.0 430237.0 430404.0 30145.8 30247.1 30452.5 30570.2 30605.8 48880.3 49070.0 49232.8 49549.3 50423.7 41552.8 45998.3 46311.0 46798.0 47557.5 41540.8 41890.0 41970.0 42757.8 43300.0 38490.8 38831.0 42861.0 43807.3 44671.6 36810.6 37069.4 37650.2 37873.2 37973.8 29200.0 29369.3 29575.0 29809.0 29954.3 10:19:49 INFO - PROCESS | 13059 | 10:19:49 INFO - PROCESS | 13059 | [#2] jquery.html Cycles:180 Average:30663.31 Median:2169.83 stddev:83008.40 (3825.6%) stddev-sans-first:83210.22 10:19:49 INFO - PROCESS | 13059 | Values: 427.7 434.7 439.3 442.7 447.0 19103.0 20192.0 20754.2 20756.3 20907.9 19949.4 19965.5 20226.2 20254.1 20477.2 5656.3 5982.6 5988.6 5995.2 5999.5 5685.7 5825.1 5846.0 5868.0 5878.6 5810.9 5826.6 5837.1 5837.4 5844.7 5632.3 5747.2 5764.5 5785.7 5818.7 5066.2 5189.5 5248.3 5259.7 5284.2 23980.5 24003.3 24203.6 24296.0 24521.8 2581.9 2866.3 2934.5 3227.9 3231.2 14756.5 15413.0 15502.8 15649.4 15789.1 1933.7 1952.4 2061.0 2085.6 2108.3 81284.6 82395.6 83965.0 95264.0 96611.5 11615.8 12168.1 12200.5 12307.0 12485.9 17265.9 17270.1 17287.8 17289.8 17316.6 8826.3 8896.2 8942.1 9065.4 9135.9 8129.1 8129.1 8279.5 8419.0 8438.8 5096.8 5143.8 5186.5 5230.2 5320.4 1944.5 2007.4 2168.7 2171.0 2177.6 896.4 994.4 1020.4 1030.3 1056.3 20595.1 20748.9 20886.6 21155.3 21185.9 1050.3 1067.1 1071.8 1089.8 1091.0 10951.2 11569.2 11689.8 11830.3 11831.0 477980.0 492394.0 500504.0 516407.0 523866.0 97064.5 97365.5 97814.5 98911.5 104629.5 969.7 989.9 1016.3 1025.9 1044.9 18403.0 18441.6 18684.3 18747.8 19014.6 44110.1 44597.8 45129.5 45392.5 46041.5 62696.4 62716.1 63149.0 63427.0 63564.0 8727.9 9182.7 9336.4 9347.8 11974.7 12960.1 13379.7 13440.7 14023.4 14153.8 11684.6 11865.6 11956.8 12141.3 12564.5 12111.9 12585.8 12608.2 12624.6 12763.7 11832.8 12001.1 12116.7 12338.5 12420.6 12824.9 12832.6 13097.6 13234.5 13266.1 10894.5 10962.7 10999.8 11036.9 11202.7 10:19:49 INFO - PROCESS | 13059 | 10:19:49 INFO - PROCESS | 13059 | [#3] mootools.html Cycles:180 Average:5813.46 Median:4897.14 stddev:3253.21 (66.4%) stddev-sans-first:3246.16 10:19:49 INFO - PROCESS | 13059 | Values: 1496.5 1508.3 1692.5 1779.0 1818.3 7664.1 7913.0 8215.6 8791.5 8829.6 8396.2 8670.6 8688.5 8936.1 8984.3 2501.9 2540.6 2545.2 2556.2 2561.1 2425.3 2505.9 2515.8 2523.7 2524.8 2448.3 2469.6 2476.4 2479.8 2485.8 2423.7 2433.8 2447.9 2491.7 2516.0 2485.4 2491.9 2520.4 2522.0 2530.5 8863.4 8897.7 8915.0 8966.2 8994.0 5324.4 5425.8 5440.0 5446.5 5452.3 3255.6 3436.3 3506.9 3607.4 3694.8 1078.2 1130.9 1133.6 1138.9 1184.2 12216.9 12291.2 12311.8 12343.6 12366.7 4743.7 4869.0 4885.2 4899.6 4975.5 9969.3 9978.7 9997.4 9998.5 10011.3 5449.5 5477.9 5486.3 5489.4 5497.9 4492.9 4710.0 5054.6 5100.1 5150.7 4252.5 4268.6 4326.6 4375.2 4392.8 1407.2 1424.4 1426.5 1439.5 1459.9 826.4 831.4 927.3 973.6 997.9 5684.4 5690.5 5767.2 5863.4 5896.8 467.2 471.1 473.9 476.7 481.2 3770.3 3866.1 3899.0 3912.0 3938.7 10653.5 10880.5 10962.3 11085.6 11088.6 10614.4 10667.4 10903.3 10918.6 10928.2 8289.3 8383.8 8409.7 8465.6 8485.7 5676.4 5739.2 5819.6 5833.6 5982.3 9568.5 9640.8 9941.6 10003.0 10076.3 10031.8 10074.5 10142.4 10191.5 10245.6 7120.8 7491.4 7847.9 7923.9 8128.8 8708.4 8710.7 8725.3 8733.9 8795.1 7587.5 7608.8 7637.4 7685.9 7740.8 7603.8 7676.5 7690.3 7787.7 7898.8 6999.5 7079.3 7080.6 7089.5 7205.4 4681.9 4883.4 4894.7 4924.5 5044.2 4932.6 4959.6 5072.4 5142.7 5170.2 10:19:49 INFO - PROCESS | 13059 | 10:19:49 INFO - PROCESS | 13059 | [#4] prototype.html Cycles:180 Average:4986.52 Median:5635.84 stddev:1445.05 (25.6%) stddev-sans-first:1406.74 10:19:49 INFO - PROCESS | 13059 | Values: 358.8 361.1 363.3 374.3 375.1 5535.8 5614.5 5755.1 5823.7 5825.1 5492.0 5601.6 5684.3 5725.9 5731.3 4505.3 4512.9 4517.4 4528.6 4529.6 4415.7 4454.3 4485.1 4504.9 4513.8 4446.6 4454.3 4465.9 4473.2 4488.6 4423.7 4475.8 4505.7 4505.8 4518.5 3776.9 3894.2 4005.7 4032.4 4041.6 5527.7 5529.2 5565.3 5596.2 5605.4 5100.4 5101.8 5116.3 5142.7 5144.4 5638.8 5914.8 5928.4 5987.6 6000.2 4301.6 4302.4 4303.8 4312.0 4338.5 6172.7 6219.2 6220.3 6239.7 6242.6 4333.4 4372.5 4393.9 4408.6 4413.5 4420.9 4435.1 4440.7 4444.3 4462.2 5068.9 5099.4 5105.0 5125.5 5163.0 5785.7 5805.0 5896.5 5926.9 6037.8 1480.0 1486.5 1490.2 1490.8 1491.0 1003.5 1026.7 1030.4 1039.8 1047.5 5610.3 5632.6 5687.2 5694.9 5788.3 5936.2 5977.6 5985.5 5990.5 6058.0 5360.1 5491.7 5607.7 5624.8 5659.5 3092.4 3153.3 3170.0 3190.8 3196.6 5956.1 6188.0 6203.3 6211.8 6233.5 5874.7 5956.9 5961.8 6004.8 6013.4 6046.2 6124.8 6157.6 6188.8 6227.9 5763.7 5862.6 5881.6 5888.7 5928.5 5791.4 5805.9 5813.6 5867.2 5901.9 6012.3 6111.6 6154.2 6161.3 6226.7 4236.6 4270.1 4276.0 4292.8 4333.4 5885.5 6008.3 6060.8 6072.4 6082.4 5802.0 5907.9 5926.4 5948.4 5967.8 5978.5 5981.3 6009.2 6022.7 6062.9 5664.8 5860.3 5898.2 5961.2 5967.4 6006.9 6057.2 6062.6 6073.9 6075.8 5632.9 5746.7 5851.4 5888.1 5896.4 10:19:49 INFO - PROCESS | 13059 | 10:19:49 INFO - PROCESS | 13059 | [#5] yui.html Cycles:180 Average:18531.23 Median:25896.68 stddev:25150.47 (97.1%) stddev-sans-first:25185.68 10:19:49 INFO - PROCESS | 13059 | Values: 775.4 778.8 784.0 804.0 866.6 13399.3 13927.2 13959.3 13972.9 14689.7 14708.1 14902.3 14982.4 15004.0 15007.6 834.3 849.0 854.7 855.4 857.9 837.1 850.6 851.1 851.3 851.7 885.9 890.5 892.4 894.4 898.3 881.9 884.9 886.3 887.2 888.1 656.1 659.7 660.5 660.5 662.5 13151.7 13899.7 13933.0 13941.9 13962.2 12822.9 12964.7 12989.8 13181.4 13258.0 10585.2 10635.6 10694.8 10725.5 10783.8 3830.7 3846.2 3914.6 3929.2 4052.2 62966.4 63898.7 65238.7 65287.7 65707.7 9799.9 9859.6 9910.8 9979.8 10176.4 19516.3 19536.7 19537.8 19545.0 19635.3 8429.0 8432.1 8461.9 8481.0 8846.4 4607.8 4696.5 4773.6 4831.3 4904.6 3522.5 3611.8 3612.1 3629.0 3629.9 560.2 570.1 577.9 584.6 588.0 633.5 686.5 725.9 732.5 748.9 9779.8 10080.7 10252.9 10441.9 10458.7 782.6 783.8 789.5 794.8 806.3 4651.4 5014.6 5028.0 5049.4 5064.4 91827.0 94777.5 96711.5 96974.5 97779.0 85812.6 86262.6 87721.0 88016.0 89648.0 60089.4 61685.7 75218.6 76893.6 76933.0 9959.6 10233.5 10644.8 10782.6 10788.1 46211.3 46621.3 46991.0 47019.8 48392.5 59178.4 59779.7 63813.7 64550.0 65359.3 12770.8 13061.7 13173.3 13279.9 13300.6 13610.3 13901.6 13923.6 14012.9 14063.8 13335.4 13445.7 13605.5 14195.8 14237.2 13587.8 13672.0 14103.5 14323.4 14378.4 12462.3 12820.4 12992.5 13187.9 13460.5 10827.7 10984.1 10990.7 11048.6 11099.1 11058.0 11280.5 11493.2 11729.4 11927.9 10:19:49 INFO - PROCESS | 13059 | -------- Summary: end -------- 10:19:49 INFO - PROCESS | 13059 | 10:19:50 INFO - TEST-INFO | 13059: exit 0 10:19:50 INFO - TEST-OK | dromaeo_css | took 1112791ms 10:19:50 INFO - TEST-START | kraken 10:19:50 INFO - operating with platform_type : linux_ 10:19:50 INFO - Initialising browser for kraken test... 10:19:50 INFO - TEST-INFO | started process 13434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcRxb0H/profile http://localhost:43038/getInfo.html) 10:19:54 INFO - PROCESS | 13434 | __metrics Screen width/height:1600/1200 10:19:54 INFO - PROCESS | 13434 | colorDepth:24 10:19:54 INFO - PROCESS | 13434 | Browser inner width/height: 1024/697 10:19:54 INFO - PROCESS | 13434 | __metrics 10:19:55 ERROR - PROCESS | 13434 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:19:55 INFO - TEST-INFO | 13434: exit 0 10:19:55 INFO - Browser initialized. 10:19:55 INFO - Running cycle 1/1 for kraken test... 10:19:55 INFO - TEST-INFO | started process 13563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcRxb0H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:07 INFO - PROCESS | 13563 | RSS: Main: 152559616 10:20:07 INFO - PROCESS | 13563 | 10:20:10 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43038/tests/kraken/driver.html?testName=audio-beat-detection) 10:20:11 INFO - PROCESS | 13563 | RSS: Main: 157401088 10:20:11 INFO - PROCESS | 13563 | 10:20:13 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43038/tests/kraken/driver.html?testName=audio-dft) 10:20:14 INFO - PROCESS | 13563 | RSS: Main: 155385856 10:20:14 INFO - PROCESS | 13563 | 10:20:17 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43038/tests/kraken/driver.html?testName=audio-fft) 10:20:17 INFO - PROCESS | 13563 | RSS: Main: 155766784 10:20:17 INFO - PROCESS | 13563 | 10:20:20 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43038/tests/kraken/driver.html?testName=audio-oscillator) 10:20:20 INFO - PROCESS | 13563 | RSS: Main: 155369472 10:20:20 INFO - PROCESS | 13563 | 10:20:22 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43038/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:20:23 INFO - PROCESS | 13563 | RSS: Main: 155070464 10:20:23 INFO - PROCESS | 13563 | 10:20:26 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43038/tests/kraken/driver.html?testName=imaging-darkroom) 10:20:26 INFO - PROCESS | 13563 | RSS: Main: 157896704 10:20:26 INFO - PROCESS | 13563 | 10:20:30 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43038/tests/kraken/driver.html?testName=imaging-desaturate) 10:20:30 INFO - PROCESS | 13563 | RSS: Main: 158621696 10:20:30 INFO - PROCESS | 13563 | 10:20:33 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43038/tests/kraken/driver.html?testName=json-parse-financial) 10:20:34 INFO - PROCESS | 13563 | RSS: Main: 157437952 10:20:34 INFO - PROCESS | 13563 | 10:20:35 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43038/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:20:36 INFO - PROCESS | 13563 | RSS: Main: 157241344 10:20:36 INFO - PROCESS | 13563 | 10:20:38 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:20:38 INFO - PROCESS | 13563 | RSS: Main: 157507584 10:20:38 INFO - PROCESS | 13563 | 10:20:40 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:20:41 INFO - PROCESS | 13563 | RSS: Main: 157978624 10:20:41 INFO - PROCESS | 13563 | 10:20:44 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:20:44 INFO - PROCESS | 13563 | RSS: Main: 158183424 10:20:44 INFO - PROCESS | 13563 | 10:20:47 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:20:48 INFO - PROCESS | 13563 | RSS: Main: 158339072 10:20:48 INFO - PROCESS | 13563 | 10:20:49 INFO - PROCESS | 13563 | Cycle 1(1): loaded http://localhost:43038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43038/tests/kraken/driver.html?testName=ai-astar) 10:20:50 INFO - PROCESS | 13563 | RSS: Main: 160010240 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | __start_tp_report 10:20:50 INFO - PROCESS | 13563 | _x_x_mozilla_page_load 10:20:50 INFO - PROCESS | 13563 | _x_x_mozilla_page_load_details 10:20:50 INFO - PROCESS | 13563 | |i|pagename|runs| 10:20:50 INFO - PROCESS | 13563 | |0;ai-astar;102;111;111;111;111;112;110;112;112;111 10:20:50 INFO - PROCESS | 13563 | |1;audio-beat-detection;147;123;121;155;122;123;123;126;161;121 10:20:50 INFO - PROCESS | 13563 | |2;audio-dft;163;163;162;161;163;161;161;163;159;162 10:20:50 INFO - PROCESS | 13563 | |3;audio-fft;74;75;74;110;76;75;85;75;100;76 10:20:50 INFO - PROCESS | 13563 | |4;audio-oscillator;81;80;114;81;81;81;95;80;82;115 10:20:50 INFO - PROCESS | 13563 | |5;imaging-gaussian-blur;117;118;117;118;117;118;117;118;118;118 10:20:50 INFO - PROCESS | 13563 | |6;imaging-darkroom;148;147;149;146;146;147;147;147;148;146 10:20:50 INFO - PROCESS | 13563 | |7;imaging-desaturate;85;85;88;85;84;85;85;85;85;85 10:20:50 INFO - PROCESS | 13563 | |8;json-parse-financial;59;52;52;51;51;52;51;53;53;57 10:20:50 INFO - PROCESS | 13563 | |9;json-stringify-tinderbox;59;58;59;60;60;59;59;59;62;59 10:20:50 INFO - PROCESS | 13563 | |10;stanford-crypto-aes;77;75;76;81;75;76;75;80;76;76 10:20:50 INFO - PROCESS | 13563 | |11;stanford-crypto-ccm;138;141;135;130;135;127;126;127;162;135 10:20:50 INFO - PROCESS | 13563 | |12;stanford-crypto-pbkdf2;153;167;157;156;160;155;156;160;154;169 10:20:50 INFO - PROCESS | 13563 | |13;stanford-crypto-sha256-iterative;65;64;62;64;62;63;61;61;62;61 10:20:50 INFO - PROCESS | 13563 | __end_tp_report 10:20:50 INFO - PROCESS | 13563 | __start_cc_report 10:20:50 INFO - PROCESS | 13563 | _x_x_mozilla_cycle_collect,839 10:20:50 INFO - PROCESS | 13563 | __end_cc_report 10:20:50 INFO - PROCESS | 13563 | __startTimestamp1480011650035__endTimestamp 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | ------- Summary: start ------- 10:20:50 INFO - PROCESS | 13563 | Number of tests: 14 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.98 (2.7%) stddev-sans-first:0.67 10:20:50 INFO - PROCESS | 13563 | Values: 102.0 111.0 111.0 111.0 111.0 112.0 110.0 112.0 112.0 111.0 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | [#1] audio-beat-detection Cycles:10 Average:132.20 Median:124.50 stddev:15.69 (12.6%) stddev-sans-first:15.70 10:20:50 INFO - PROCESS | 13563 | Values: 147.0 123.0 121.0 155.0 122.0 123.0 123.0 126.0 161.0 121.0 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.50 stddev:1.32 (0.8%) stddev-sans-first:1.32 10:20:50 INFO - PROCESS | 13563 | Values: 163.0 163.0 162.0 161.0 163.0 161.0 161.0 163.0 159.0 162.0 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.00 stddev:12.75 (17.0%) stddev-sans-first:13.20 10:20:50 INFO - PROCESS | 13563 | Values: 74.0 75.0 74.0 110.0 76.0 75.0 85.0 75.0 100.0 76.0 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:81.00 stddev:14.16 (17.5%) stddev-sans-first:14.72 10:20:50 INFO - PROCESS | 13563 | Values: 81.0 80.0 114.0 81.0 81.0 81.0 95.0 80.0 82.0 115.0 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:20:50 INFO - PROCESS | 13563 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 10:20:50 INFO - PROCESS | 13563 | Values: 148.0 147.0 149.0 146.0 146.0 147.0 147.0 147.0 148.0 146.0 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:1.03 (1.2%) stddev-sans-first:1.09 10:20:50 INFO - PROCESS | 13563 | Values: 85.0 85.0 88.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:52.50 stddev:2.73 (5.2%) stddev-sans-first:1.88 10:20:50 INFO - PROCESS | 13563 | Values: 59.0 52.0 52.0 51.0 51.0 52.0 51.0 53.0 53.0 57.0 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:1.07 (1.8%) stddev-sans-first:1.13 10:20:50 INFO - PROCESS | 13563 | Values: 59.0 58.0 59.0 60.0 60.0 59.0 59.0 59.0 62.0 59.0 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.00 stddev:2.11 (2.8%) stddev-sans-first:2.24 10:20:50 INFO - PROCESS | 13563 | Values: 77.0 75.0 76.0 81.0 75.0 76.0 75.0 80.0 76.0 76.0 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:135.00 stddev:10.56 (7.8%) stddev-sans-first:11.17 10:20:50 INFO - PROCESS | 13563 | Values: 138.0 141.0 135.0 130.0 135.0 127.0 126.0 127.0 162.0 135.0 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:158.50 stddev:5.42 (3.4%) stddev-sans-first:5.34 10:20:50 INFO - PROCESS | 13563 | Values: 153.0 167.0 157.0 156.0 160.0 155.0 156.0 160.0 154.0 169.0 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - PROCESS | 13563 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:1.43 (2.3%) stddev-sans-first:1.20 10:20:50 INFO - PROCESS | 13563 | Values: 65.0 64.0 62.0 64.0 62.0 63.0 61.0 61.0 62.0 61.0 10:20:50 INFO - PROCESS | 13563 | -------- Summary: end -------- 10:20:50 INFO - PROCESS | 13563 | 10:20:50 INFO - TEST-INFO | 13563: exit 0 10:20:51 INFO - TEST-OK | kraken | took 60766ms 10:20:51 INFO - SUITE-END | took 1173s 10:20:51 INFO - Completed test suite (00:19:33) 10:20:51 INFO - javascript benchmark 10:20:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7511.1958230221935, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3249.756268279879, 3254.4792833146703, 3255.5442238086657, 3298.224917144469, 3302.537644729738, 5633.408492108326, 5675.659460432372, 5690.943090569093, 5691.4877661010505, 5703.201551782754, 5685.260916080903, 5792.478676919077, 5822.825315240539, 5830.533557315404, 5864.413558644133, 5248.921266181001, 5263.973680131594, 5287.788488460457, 5298.12580924149, 5324.307839980797, 5314.9468505315035, 5328.17413300939, 5342.118550439173, 5349.491798279158, 5367.677939323634, 5172.482751724835, 5209.426963034063, 5330.040592693314, 5334.386545547273, 5344.946550534503, 5150.536451719345, 5179.766910489037, 5187.247849061865, 5189.532942035235, 5214.191800270964, 5167.715775632339, 5169.353830771153, 5180.870478238036, 5230.973845130788, 5303.337082864642, 5598.0, 5727.312722473288, 5744.281964754406, 5805.158252053428, 5813.563982701315, 6031.336552979169, 6127.9031502109065, 6140.258857967814, 6145.293291271516, 6145.494353883282, 6118.893302669174, 6187.969060154671, 6210.4100110489435, 6210.9068363974575, 6213.906791398133, 5482.698451585201, 5524.171374293888, 5727.026405511073, 5768.50967667753, 5778.5377169826315, 6113.689152827286, 6127.080937859268, 6136.519078024463, 6216.502679785606, 6221.688915554204, 5970.283565972111, 5972.223610930551, 5974.163617093611, 5985.221921150222, 5997.880042399128, 5956.225690660186, 6076.210092687922, 6081.179040829431, 6091.208142941389, 6092.025275955826, 5914.378990206053, 6071.2714474263375, 6084.087386892002, 6101.420365065312, 6131.233595800525, 6154.046122850876, 6160.630362178284, 6161.0, 6164.137020817089, 6171.814845554641, 4729.739864307496, 4729.929051064237, 4734.147853386355, 4735.810567577328, 4768.713877167381, 4021.075152714892, 4044.2518134145275, 4148.087420767487, 4198.64311533517, 4219.683523735732, 5896.439838215363, 5934.347221805598, 5939.287285525678, 5956.076808094752, 5989.460948514655, 5951.226340575698, 6009.759609615567, 6175.073738939195, 6191.0, 6247.468965137923, 5858.0, 5903.852403689856, 5912.645241285537, 5946.8810623787285, 5972.790952316735, 5371.75827087782, 5375.408705042442, 5381.273528073738, 5384.596155288369, 5385.353757549119, 6193.6903154841175, 6459.418652321219, 6467.320931302145, 6470.611763294218, 6473.126127972758, 5955.553333499918, 5960.403959604005, 5978.730957107027, 6027.336992930686, 6064.605800622945, 6049.848753781014, 6201.976673848764, 6204.5967012144065, 6214.005759078525, 6215.0, 5864.120381942743, 5908.556858235564, 5921.644701317935, 5931.851703707442, 5933.940660593512, 5943.673097979479, 5984.0, 6046.334903160737, 6070.878582428415, 6099.054646529795, 6029.035354343284, 6029.336772955059, 6031.69841507914, 6040.275166979991, 6054.3340232575265, 5983.222181116427, 5991.9813631681845, 6000.0, 6000.759969601167, 6000.759969601167, 5678.119891416672, 5784.739686714024, 5825.0679891217205, 5915.40845915405, 5926.940730592812, 6112.755489780359, 6112.969435152796, 6116.633002019893, 6124.112003759519, 6136.140940268277, 5938.61399009063, 5944.554158438221, 5965.164876917322, 5975.581709280309, 5980.162777211281], "value": 5649.496806303735, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.2144840120633, 614.8555089553954, 631.2771876201748, 649.3863299182275, 677.7729460630688, 43588.12823743523, 45081.09837803246, 45095.0, 48718.75640621801, 48769.0, 46023.0, 46369.30446043312, 46496.53503464964, 46497.7675111624, 46544.0, 8903.154200350957, 9050.27597792175, 9050.592723327467, 9060.954695226515, 9067.138621830916, 8811.427257228292, 8924.330675199353, 8928.687495937644, 8966.64133434665, 8995.055519170492, 8938.821223575525, 8997.595108220146, 9009.504477253748, 9010.0, 9034.638614455414, 8975.640974361018, 8988.910110898905, 8999.100089991014, 9034.45793252407, 9044.457332560067, 8786.560671966376, 8870.645174193025, 8877.245434138105, 8904.51025193614, 8915.465072095694, 43297.134057318995, 43330.13339733219, 43864.0, 44166.0, 44192.0, 3457.2566898117025, 3510.104923244556, 3528.1356067763304, 3573.857045718168, 4127.814248358831, 33929.32141357159, 34052.6594734052, 34294.48558271628, 34744.65255347439, 35489.11277218064, 4377.562243775629, 4406.317020861739, 4445.022095139064, 4485.618722408599, 4542.182407166709, 351426.99999999744, 353829.0, 354153.0, 357430.0, 357639.0, 61153.0, 61708.0, 61737.07394389088, 61842.690786545776, 62029.68985155135, 57656.0, 57877.71061144667, 57882.710586446796, 58137.0, 58303.0, 17523.82476175222, 17801.910990444965, 17854.37509687181, 17889.0, 17895.10524473797, 13937.233452160228, 14020.789688154686, 14037.298135093204, 14039.78940315896, 14084.084534505224, 17831.73252401215, 18011.369602063864, 18026.549336266697, 18140.9092954537, 18147.54631134232, 6200.054973887458, 6201.410865967726, 6271.216097987752, 6377.617342959345, 6429.678516074177, 1060.877999030106, 1062.442217835627, 1111.727626731456, 1148.9597864074885, 1170.9648710538697, 32655.0, 32882.671173288436, 33100.503492447635, 33140.668593313756, 33194.170145746066, 1145.6391236760394, 1146.157574182975, 1194.474431250247, 1194.5580135349803, 1232.6610182199968, 17426.302947882195, 17511.299548018193, 17781.022043787456, 18007.0, 18120.637587248446, 502867.0, 506003.0, 506171.0, 511361.0, 512291.0, 61359.0, 61440.0, 61504.384956149865, 61598.0, 61624.38375616276, 1435.8923080768984, 1442.8124343835234, 1461.3496993837853, 1472.0, 1485.5543336998858, 32332.83833580817, 34007.659923400446, 34076.11379656187, 34138.14654633654, 34297.48553771745, 54118.0, 54157.18764218461, 54226.186607200136, 54336.45663543472, 54579.0, 427370.0, 428924.0, 429959.0, 430237.0, 430404.0, 30145.849270753504, 30247.092587222418, 30452.543211851396, 30570.235744106576, 30605.846970765004, 48880.26679599738, 49070.0, 49232.75383623059, 49549.256761149336, 50423.74788126036, 41552.79223603863, 45998.310025348976, 46311.0, 46798.0, 47557.52442475531, 41540.79229603833, 41890.0, 41970.0, 42757.78621106874, 43300.0, 38490.80754596209, 38831.0, 42861.0, 43807.34288985604, 44671.55328446804, 36810.63189368179, 37069.44395834119, 37650.246995059395, 37873.24253514969, 37973.81013094917, 29200.0, 29369.265768355963, 29575.0, 29809.0, 29954.25114372071], "value": 20744.023869141973, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.685651046481, 434.66965106519035, 439.26338908599405, 442.6503062580561, 446.997765011175, 19103.0, 20192.0, 20754.169833206674, 20756.27353042644, 20907.895460522694, 19949.401517954484, 19965.500862478446, 20226.19095236189, 20254.08856601453, 20477.180912763473, 5656.321241451032, 5982.581219314649, 5988.580799344048, 5995.1906492623375, 5999.490043346299, 5685.687287199203, 5825.097109947965, 5845.970770146143, 5868.0, 5878.617889837147, 5810.883782324372, 5826.592138550303, 5837.124431335291, 5837.445442682938, 5844.678542680151, 5632.295963004624, 5747.166660834177, 5764.481196692318, 5785.710714464302, 5818.650880947157, 5066.189409694432, 5189.532942035235, 5248.317718696583, 5259.658122222043, 5284.154535274376, 23980.52038959211, 24003.27990160298, 24203.636945445833, 24296.028158873625, 24521.754782452124, 2581.8709064546697, 2866.269101379135, 2934.4864648686607, 3227.887023954174, 3231.2083539532728, 14756.483523076748, 15413.0, 15502.767458488132, 15649.374025039098, 15789.131597762118, 1933.6519426503223, 1952.3947576251408, 2060.9532903636496, 2085.572457646179, 2108.2937216032647, 81284.59357703173, 82395.5880220595, 83965.0, 95264.04735952622, 96611.51694241483, 11615.76768464643, 12168.148229623841, 12200.450979705935, 12307.015438764878, 12485.87514124847, 17265.91367043182, 17270.13649317529, 17287.827121728875, 17289.82710172907, 17316.567085822957, 8826.338024648177, 8896.199342059246, 8942.061083586259, 9065.365424420359, 9135.862962055575, 8129.105798362176, 8129.1464396238725, 8279.50322980623, 8419.031811341652, 8438.831223375499, 5096.796128154906, 5143.8456846294675, 5186.455422180692, 5230.241614965808, 5320.388155362183, 1944.5041514413733, 2007.4078146946686, 2168.6638571021517, 2171.0, 2177.553601511718, 896.3501461440403, 994.4232345239743, 1020.433659319085, 1030.283952652914, 1056.27645063132, 20595.07322170506, 20748.89625551893, 20886.58226835455, 21155.25956591512, 21185.894070529856, 1050.3435352904435, 1067.066316972649, 1071.8285074388061, 1089.84742136101, 1091.0, 10951.233413661126, 11569.19015668912, 11689.76620467586, 11830.290182589073, 11831.0, 477980.0, 492394.0, 500504.0, 516407.0, 523866.0, 97064.51467742617, 97365.51317243368, 97814.5109274449, 98911.50544247232, 104629.47685261525, 969.7187815533557, 989.8911119776819, 1016.3139880580726, 1025.9333143345807, 1044.8537204791182, 18403.0, 18441.631167376847, 18684.34604788826, 18747.812521874606, 19014.61970760605, 44110.13794722952, 44597.77701111474, 45129.548704512534, 45392.54607453883, 46041.53958460373, 62696.373036269055, 62716.05925911024, 63149.0, 63427.0, 63564.0, 8727.869081963649, 9182.67860624875, 9336.39313444624, 9347.766305842408, 11974.700632484257, 12960.092793504364, 13379.665508362368, 13440.663983400493, 14023.368948397143, 14153.787693184404, 11684.649460516199, 11865.5847045353, 11956.820647690118, 12141.271523708605, 12564.497420103458, 12111.878881211074, 12585.811212831632, 12608.243505389706, 12624.55814046504, 12763.680907977376, 11832.76334473323, 12001.099917506397, 12116.697082573006, 12338.50645974151, 12420.62738117858, 12824.935875320563, 12832.615021549369, 13097.607071787861, 13234.470621175045, 13266.137701049402, 10894.510854116586, 10962.725931851768, 10999.780004400027, 11036.895674300076, 11202.663920082085], "value": 9964.973063630514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1496.5136330692521, 1508.2986411318734, 1692.4837924433043, 1778.9822101778977, 1818.3181307009872, 7664.11862635797, 7913.0, 8215.630296636651, 8791.472511649306, 8829.558522073903, 8396.244338009594, 8670.566471676422, 8688.522131282776, 8936.061713520085, 8984.326175536828, 2501.8999240030375, 2540.593505039194, 2545.2237067694346, 2556.169244995375, 2561.078011915709, 2425.333033415807, 2505.924822255326, 2515.8238923275376, 2523.684539432571, 2524.835885667435, 2448.2532827487607, 2469.6295555666616, 2476.368526025861, 2479.801615870726, 2485.8135639826996, 2423.684920960273, 2433.8052955763583, 2447.9143229986953, 2491.6636254105824, 2515.987420062888, 2485.42835147917, 2491.9003239870563, 2520.3825062859532, 2521.9747802521924, 2530.544501989641, 8863.423877447945, 8897.73306800797, 8914.955425222897, 8966.237869781076, 8993.955030224872, 5324.41431442541, 5425.755840987165, 5439.993601183754, 5446.455354464561, 5452.263944367539, 3255.5930508686415, 3436.27838153988, 3506.8597256109724, 3607.4408466687705, 3694.7783133011835, 1078.2129045796535, 1130.8586426696663, 1133.620237220532, 1138.937358445285, 1184.200664551433, 12216.877831221664, 12291.201071930296, 12311.75376492474, 12343.567975120828, 12366.690832729164, 4743.715377077387, 4868.9756551217015, 4885.2427873679635, 4899.559039686445, 4975.4527002029745, 9969.252306077073, 9978.700638980843, 9997.400155990665, 9998.450085245382, 10011.349262297927, 5449.482299181572, 5477.917831232535, 5486.31421072366, 5489.3687225969525, 5497.900419916033, 4492.932606010912, 4709.952900470951, 5054.570361519239, 5100.0819852426175, 5150.665206761549, 4252.4897012358715, 4268.551802060801, 4326.567343265649, 4375.16871794358, 4392.846250381285, 1407.2049292149902, 1424.444466658004, 1426.5149849051165, 1439.4889814115838, 1459.8759105476154, 826.4173757500947, 831.4429332347341, 927.332320729074, 973.5618971462728, 997.9251556133319, 5684.403137670568, 5690.5447564194765, 5767.192593036978, 5863.384344643836, 5896.823095307148, 467.1684401764864, 471.1166562694947, 473.9099571081484, 476.72826488900995, 481.1675800864524, 3770.340190466712, 3866.0721426857913, 3899.0447340401784, 3912.0, 3938.7439816411843, 10653.467326633638, 10880.455977201109, 10962.287451315638, 11085.556577736961, 11088.611898583511, 10614.416207108683, 10667.413292269, 10903.29128606638, 10918.617848375268, 10928.180386471047, 8289.295409890226, 8383.790405239917, 8409.663613455516, 8465.619047142893, 8485.703000394957, 5676.375598684059, 5739.2252045973255, 5819.5635327351465, 5833.591648584728, 5982.282126144891, 9568.4737339447, 9640.807183856425, 9941.552630131806, 10003.049710277512, 10076.294659374067, 10031.849522257318, 10074.496275186359, 10142.442165680959, 10191.490425478549, 10245.590176392861, 7120.750773722895, 7491.438142139253, 7847.9215207849475, 7923.881141782993, 8128.796780080545, 8708.390412671306, 8710.738677839676, 8725.345599079967, 8733.868991965253, 8795.076516965626, 7587.468877178544, 7608.80977975555, 7637.350825179922, 7685.884711729441, 7740.7677769667, 7603.847923041398, 7676.53940763556, 7690.2694244046725, 7787.727429539939, 7898.84202315939, 6999.51003429755, 7079.2566780487305, 7080.610566418896, 7089.468289878177, 7205.423566114803, 4681.882952926067, 4883.413990321184, 4894.730789806453, 4924.482929292372, 5044.167712327571, 4932.556069953722, 4959.578435832995, 5072.365954255718, 5142.6914385137015, 5170.1727723564045], "value": 4623.452369355555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.77217966591223, 361.13688284998847, 363.34960420846687, 374.2701731623333, 375.1315704144906, 5535.778568857241, 5614.466625670565, 5755.136729490573, 5823.65058096514, 5825.067989121736, 5492.0, 5601.551875849932, 5684.261046064016, 5725.885482290351, 5731.340895796985, 4505.301678239878, 4512.916899944023, 4517.390152329443, 4528.592426681598, 4529.592336689697, 4415.668824838134, 4454.287314029756, 4485.1254005468945, 4504.909901801962, 4513.7517436540975, 4446.577575130357, 4454.309582014793, 4465.866024019285, 4473.150101480708, 4488.573585509388, 4423.712458690191, 4475.820967161326, 4505.662075344329, 4505.752183629899, 4518.502964673883, 3776.9433458498142, 3894.240623078501, 4005.719599628027, 4032.4152997815154, 4041.6362527372676, 5527.723613819293, 5529.225908372831, 5565.332160140769, 5596.2165296858475, 5605.411431799684, 5100.413452452978, 5101.770420331094, 5116.334876466073, 5142.691438513663, 5144.402076951115, 5638.774449022034, 5914.792982245601, 5928.40715928408, 5987.64074155552, 6000.159977603139, 4301.5698430156735, 4302.397664326997, 4303.827846886121, 4311.9784401077795, 4338.457692788402, 6172.691365431666, 6219.1915051043525, 6220.315765265817, 6239.719212635442, 6242.563020588561, 4333.393324934512, 4372.453443319585, 4393.934090988638, 4408.611287444444, 4413.470383553929, 4420.8673739787855, 4435.1351486459835, 4440.7335559866515, 4444.311131774515, 4462.174497717932, 5068.923966140511, 5099.439061703284, 5105.0, 5125.461826508163, 5162.993216322781, 5785.739641716133, 5805.0, 5896.469317761422, 5926.940730592725, 6037.758489660365, 1480.0, 1486.4500134949922, 1490.2474250503426, 1490.8136482939633, 1490.9627259318386, 1003.4967405728461, 1026.6919924022764, 1030.4281123976266, 1039.7660526381503, 1047.5076713944434, 5610.298712660918, 5632.648164440587, 5687.236956543485, 5694.886102277931, 5788.305403351625, 5936.198613187251, 5977.641341519523, 5985.503624093976, 5990.460858522667, 6058.030715085565, 5360.127357578234, 5491.670499769947, 5607.7476513556985, 5624.775008999594, 5659.547236221092, 3092.4433601951864, 3153.290509635314, 3169.952450713241, 3190.7925984810913, 3196.6164060312913, 5956.101982890517, 6188.0, 6203.286622038433, 6211.81364559064, 6233.532485063638, 5874.706264686749, 5956.851078723066, 5961.791337303173, 6004.819855404257, 6013.368596297413, 6046.153538504613, 6124.816255512342, 6157.568970172135, 6188.783392581238, 6227.906581401283, 5763.740631671669, 5862.618929769551, 5881.617694849821, 5888.705564721832, 5928.525717942641, 5791.449812267828, 5805.883882322414, 5813.593048486566, 5867.20792692998, 5901.881962360814, 6012.278526576664, 6111.572189946661, 6154.230721159855, 6161.260648722182, 6226.719797609209, 4236.555161707976, 4270.10327831159, 4275.957240427556, 4292.82828686849, 4333.414988976448, 5885.499732522783, 6008.339082700987, 6060.818175454743, 6072.423119803611, 6082.36135205797, 5802.013657678121, 5907.881842363215, 5926.407359264039, 5948.401217263493, 5967.8209653710455, 5978.461938425563, 5981.312149102735, 6009.188759517584, 6022.66875321844, 6062.878367502026, 5664.830055098354, 5860.267466566679, 5898.233229680286, 5961.225040744675, 5967.403259673998, 6006.939930600638, 6057.18228039209, 6062.636241825505, 6073.939260607337, 6075.848103797441, 5632.901584191043, 5746.655200687805, 5851.444112809277, 5888.057910734262, 5896.380880007709], "value": 4528.080971947989, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.4145620056856, 778.8442311537692, 783.9882401763971, 804.0271271761169, 866.588370524001, 13399.263040532778, 13927.234002129879, 13959.302034898252, 13972.860271397283, 14689.706205875877, 14708.117512949231, 14902.254887255622, 14982.400703971854, 15004.0, 15007.624809379771, 834.3116928533954, 848.9575521223945, 854.679495189304, 855.3926712034463, 857.9227869491745, 837.0833936839151, 850.6044689219511, 851.1403482482706, 851.2849206666399, 851.6550796927223, 885.8671199320089, 890.4835195586544, 892.3530440430668, 894.369469523984, 898.3442087276293, 881.8633111867671, 884.9336299777542, 886.2776836877924, 887.201518633232, 888.0675290944547, 656.0716586030761, 659.7196191618591, 660.5211221864158, 660.5277226782873, 662.4700239808134, 13151.736965260641, 13899.652508687364, 13933.024688271826, 13941.930290348484, 13962.162270263716, 12822.935885320607, 12964.740705185937, 12989.805152922714, 13181.406836692371, 13258.0, 10585.206109541738, 10635.627753028684, 10694.839577406345, 10725.51735171919, 10783.784324313548, 3830.690249829789, 3846.230753849213, 3914.5889681583308, 3929.2337994091163, 4052.169305292408, 62966.37033629651, 63898.68050659717, 65238.67380663114, 65287.67356163284, 65707.67146164239, 9799.902000980042, 9859.556319965619, 9910.80178396428, 9979.750506237402, 10176.440295783803, 19516.31692890742, 19536.70694939577, 19537.80462195388, 19545.0, 19635.312764053477, 8429.0, 8432.114627964098, 8461.873071903927, 8481.0, 8846.424982376126, 4607.838725644587, 4696.521756384074, 4773.594244489188, 4831.299461578052, 4904.583110435581, 3522.489239060322, 3611.8374673139247, 3612.0608641753333, 3629.0201645555553, 3629.8729544466346, 560.2129008742723, 570.0537108400036, 577.9364269930304, 584.6053913608297, 587.9676617785977, 633.4742164003866, 686.5228666077128, 725.9237780033126, 732.5092188233896, 748.8876668499769, 9779.804403912025, 10080.69757907264, 10252.897471025344, 10441.947790261, 10458.738531536772, 782.6399856066159, 783.8353945671473, 789.5302295134386, 794.8370584030375, 806.3106044332129, 4651.4418269807165, 5014.573761230264, 5027.974860125676, 5049.368828896388, 5064.41759197697, 91827.0, 94777.526112369, 96711.51644241734, 96974.51512742392, 97779.0, 85812.57093714492, 86262.56868715616, 87721.0, 88016.0, 89648.0, 60089.39910600925, 61685.69157154275, 75218.62390688012, 76893.61553192198, 76933.0, 9959.601615935571, 10233.48832558384, 10644.84032739494, 10782.568697252022, 10788.083012943987, 46211.30683039824, 46621.30068048914, 46991.0, 47019.76490117527, 48392.51607484021, 59178.408215919015, 59779.70110149596, 63813.680931595045, 64550.0, 65359.346406535326, 12770.808437873253, 13061.738765224833, 13173.27546984925, 13279.867201327863, 13300.600981970556, 13610.319484025957, 13901.58295251144, 13923.58229253124, 14012.859871401155, 14063.789043164155, 13335.399907004403, 13445.731085378433, 13605.455781768618, 14195.787063193853, 14237.21695306768, 13587.79618305746, 13672.0, 14103.506377276746, 14323.427062917783, 14378.424863005363, 12462.272514468385, 12820.358982051046, 12992.480300787862, 13187.868121319048, 13460.528881489101, 10827.729306767395, 10984.065803067479, 10990.725231869268, 11048.558057677603, 11099.112071034137, 11058.0, 11280.548778048786, 11493.195476316578, 11729.35488548138, 11927.880721192678], "value": 7344.320062575185, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1471.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 111.0, 111.0, 112.0, 110.0, 112.0, 112.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 121.0, 155.0, 122.0, 123.0, 123.0, 126.0, 161.0, 121.0], "value": 132.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 161.0, 163.0, 161.0, 161.0, 163.0, 159.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 110.0, 76.0, 75.0, 85.0, 75.0, 100.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 114.0, 81.0, 81.0, 81.0, 95.0, 80.0, 82.0, 115.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 146.0, 146.0, 147.0, 147.0, 147.0, 148.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 88.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 52.0, 52.0, 51.0, 51.0, 52.0, 51.0, 53.0, 53.0, 57.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 60.0, 60.0, 59.0, 59.0, 59.0, 62.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 81.0, 75.0, 76.0, 75.0, 80.0, 76.0, 76.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 135.0, 130.0, 135.0, 127.0, 126.0, 127.0, 162.0, 135.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 167.0, 157.0, 156.0, 160.0, 155.0, 156.0, 160.0, 154.0, 169.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 62.0, 64.0, 62.0, 63.0, 61.0, 61.0, 62.0, 61.0], "value": 62.5, "unit": "score"}]}]} 10:20:51 INFO - Return code: 0 10:20:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:20:51 ERROR - # TBPL SUCCESS # 10:20:51 INFO - Running post-action listener: _resource_record_post_action 10:20:51 INFO - [mozharness: 2016-11-24 18:20:51.333539Z] Finished run-tests step (success) 10:20:51 INFO - Running post-run listener: _resource_record_post_run 10:20:51 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 503808; Write bytes: 355831808; Read time: 160; Write time: 217992 10:20:51 INFO - TinderboxPrint: CPU usage
13.3% 10:20:51 INFO - TinderboxPrint: I/O read bytes / time
503,808 / 160 10:20:51 INFO - TinderboxPrint: I/O write bytes / time
355,831,808 / 217,992 10:20:51 INFO - TinderboxPrint: CPU idle
8,227.0 (86.7%) 10:20:51 INFO - TinderboxPrint: CPU user
1,208.8 (12.7%) 10:20:51 INFO - TinderboxPrint: Swap in / out
0 / 0 10:20:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108105728; Read time: 0; Write time: 99680 10:20:51 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 499712; Write bytes: 247386112; Read time: 152; Write time: 118308 10:20:51 INFO - Running post-run listener: _upload_blobber_files 10:20:51 INFO - Blob upload gear active. 10:20:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:20:51 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 10:20:51 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'] 10:20:51 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 10:20:52 INFO - (blobuploader) - INFO - Open directory for files ... 10:20:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:20:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:20:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:53 INFO - (blobuploader) - INFO - Done attempting. 10:20:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:20:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:20:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:57 INFO - (blobuploader) - INFO - Done attempting. 10:20:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:20:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:20:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:57 INFO - (blobuploader) - INFO - Done attempting. 10:20:57 INFO - (blobuploader) - INFO - Iteration through files over. 10:20:57 INFO - Return code: 0 10:20:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:20:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:20:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/291df4d4040e2697be71ec303da722a25b53c76241111e098f079148d07b8af3726c3f0175b0d0960d78778a6cf2dfa63dc6b01ef838e7e85827a9f770232d01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f6089fe98f2a38827a0569f014612b0f25571c8071968b13474870f5f5f5d136623cbdff433243f401e10d9b9a0ae143831b5c1722edb73496b8ec233265701", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c5ae8c00ea2bf300a3afc9e46f2ac238dcbc6040330c27c5124f3bde94796b187f8d7f8a312fa7609c0e44a2ae2277fb449736d966d760f4f55ce3605554e1c"} 10:20:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:20:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:20:57 INFO - Contents: 10:20:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/291df4d4040e2697be71ec303da722a25b53c76241111e098f079148d07b8af3726c3f0175b0d0960d78778a6cf2dfa63dc6b01ef838e7e85827a9f770232d01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f6089fe98f2a38827a0569f014612b0f25571c8071968b13474870f5f5f5d136623cbdff433243f401e10d9b9a0ae143831b5c1722edb73496b8ec233265701", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c5ae8c00ea2bf300a3afc9e46f2ac238dcbc6040330c27c5124f3bde94796b187f8d7f8a312fa7609c0e44a2ae2277fb449736d966d760f4f55ce3605554e1c"} 10:20:57 INFO - Running post-run listener: copy_logs_to_upload_dir 10:20:57 INFO - Copying logs to upload dir... 10:20:57 INFO - mkdir: /builds/slave/test/build/upload/logs 10:20:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.883208 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-24 10:20:57.694151) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 10:20:57.697999) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/291df4d4040e2697be71ec303da722a25b53c76241111e098f079148d07b8af3726c3f0175b0d0960d78778a6cf2dfa63dc6b01ef838e7e85827a9f770232d01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f6089fe98f2a38827a0569f014612b0f25571c8071968b13474870f5f5f5d136623cbdff433243f401e10d9b9a0ae143831b5c1722edb73496b8ec233265701", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c5ae8c00ea2bf300a3afc9e46f2ac238dcbc6040330c27c5124f3bde94796b187f8d7f8a312fa7609c0e44a2ae2277fb449736d966d760f4f55ce3605554e1c"} build_url:https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011867 build_url: 'https://queue.taskcluster.net/v1/task/DdajU2gxSo-iwX3P8t_IaA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/291df4d4040e2697be71ec303da722a25b53c76241111e098f079148d07b8af3726c3f0175b0d0960d78778a6cf2dfa63dc6b01ef838e7e85827a9f770232d01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3f6089fe98f2a38827a0569f014612b0f25571c8071968b13474870f5f5f5d136623cbdff433243f401e10d9b9a0ae143831b5c1722edb73496b8ec233265701", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c5ae8c00ea2bf300a3afc9e46f2ac238dcbc6040330c27c5124f3bde94796b187f8d7f8a312fa7609c0e44a2ae2277fb449736d966d760f4f55ce3605554e1c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 10:20:57.723713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:20:57.724044) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1480010422.988264-2117591686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 10:20:57.807322) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 10:20:57.807641) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 10:20:57.807913) ========= ========= Total master_lag: 0.17 =========