builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1482387842.81 results: success (0) buildid: 20161221205053 builduid: fc07050e8ba848b18d7a2c2b22945a63 revision: 913f99c5f60ba918e3c33c6d711212f5178481e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 22:24:02.810152) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 22:24:02.810597) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 22:24:02.810873) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 22:24:02.847323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 22:24:02.847642) ========= 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=a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-21 22:24:02-- 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% 226M=0s 2016-12-21 22:24:03 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143160 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 22:24:03.017208) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 22:24:03.017487) ========= 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=a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017930 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 22:24:03.066485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 22:24:03.066787) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 913f99c5f60ba918e3c33c6d711212f5178481e2 --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 913f99c5f60ba918e3c33c6d711212f5178481e2 --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=a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-21 22:24:03,127 truncating revision to first 12 chars 2016-12-21 22:24:03,127 Setting DEBUG logging. 2016-12-21 22:24:03,127 attempt 1/10 2016-12-21 22:24:03,127 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/913f99c5f60b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 22:24:03,478 unpacking tar archive at: mozilla-aurora-913f99c5f60b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.714184 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 22:24:03.793664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 22:24:03.793972) ========= script_repo_revision: 913f99c5f60ba918e3c33c6d711212f5178481e2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 22:24:03.794380) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 22:24:03.794659) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 22:24:03.802717) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-21 22:24:03.802984) ========= /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=a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:24:04 INFO - MultiFileLogger online at 20161221 22:24:04 in /builds/slave/test 22:24:04 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 22:24:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:24:04 INFO - {'append_to_log': False, 22:24:04 INFO - 'base_work_dir': '/builds/slave/test', 22:24:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:24:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:24:04 INFO - 'branch': 'Mozilla-Aurora', 22:24:04 INFO - 'buildbot_json_path': 'buildprops.json', 22:24:04 INFO - 'config_files': ('talos/linux_config.py',), 22:24:04 INFO - 'default_actions': ('clobber', 22:24:04 INFO - 'read-buildbot-config', 22:24:04 INFO - 'download-and-extract', 22:24:04 INFO - 'populate-webroot', 22:24:04 INFO - 'create-virtualenv', 22:24:04 INFO - 'install', 22:24:04 INFO - 'run-tests'), 22:24:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:24:04 INFO - 'download_minidump_stackwalk': True, 22:24:04 INFO - 'download_symbols': 'ondemand', 22:24:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:24:04 INFO - 'tooltool.py': '/tools/tooltool.py', 22:24:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:24:04 INFO - '/tools/misc-python/virtualenv.py')}, 22:24:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:24:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:24:04 INFO - 'installer_path': 'installer.exe', 22:24:04 INFO - 'log_level': 'info', 22:24:04 INFO - 'log_name': 'talos', 22:24:04 INFO - 'log_to_console': True, 22:24:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:24:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:24:04 INFO - 'opt_config_files': (), 22:24:04 INFO - 'pip_index': False, 22:24:04 INFO - 'sps_profile': False, 22:24:04 INFO - 'sps_profile_interval': 0, 22:24:04 INFO - 'suite': 'dromaeojs-e10s', 22:24:04 INFO - 'system_bits': '32', 22:24:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:24:04 INFO - 'title': 'talos-linux64-ix-002', 22:24:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:24:04 INFO - 'use_talos_json': True, 22:24:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:24:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:24:04 INFO - 'work_dir': 'build'} 22:24:04 INFO - [mozharness: 2016-12-22 06:24:04.043176Z] Running clobber step. 22:24:04 INFO - Running pre-action listener: _resource_record_pre_action 22:24:04 INFO - Running main action method: clobber 22:24:04 INFO - rmtree: /builds/slave/test/build 22:24:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:24:04 INFO - Running post-action listener: _resource_record_post_action 22:24:04 INFO - [mozharness: 2016-12-22 06:24:04.470455Z] Finished clobber step (success) 22:24:04 INFO - [mozharness: 2016-12-22 06:24:04.470554Z] Running read-buildbot-config step. 22:24:04 INFO - Running pre-action listener: _resource_record_pre_action 22:24:04 INFO - Running main action method: read_buildbot_config 22:24:04 INFO - Using buildbot properties: 22:24:04 INFO - { 22:24:04 INFO - "project": "", 22:24:04 INFO - "product": "firefox", 22:24:04 INFO - "script_repo_revision": "production", 22:24:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 22:24:04 INFO - "repository": "", 22:24:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 22:24:04 INFO - "buildid": "20161221205053", 22:24:04 INFO - "pgo_build": "True", 22:24:04 INFO - "basedir": "/builds/slave/test", 22:24:04 INFO - "buildnumber": 694, 22:24:04 INFO - "slavename": "talos-linux64-ix-002", 22:24:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:24:04 INFO - "platform": "ubuntu64_hw", 22:24:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 22:24:04 INFO - "branch": "mozilla-aurora", 22:24:04 INFO - "repo_path": "releases/mozilla-aurora", 22:24:04 INFO - "revision": "913f99c5f60ba918e3c33c6d711212f5178481e2", 22:24:04 INFO - "stage_platform": "linux64-pgo", 22:24:04 INFO - "builduid": "fc07050e8ba848b18d7a2c2b22945a63", 22:24:04 INFO - "slavebuilddir": "test" 22:24:04 INFO - } 22:24:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 22:24:04 INFO - Running post-action listener: _resource_record_post_action 22:24:04 INFO - [mozharness: 2016-12-22 06:24:04.472968Z] Finished read-buildbot-config step (success) 22:24:04 INFO - [mozharness: 2016-12-22 06:24:04.473056Z] Running download-and-extract step. 22:24:04 INFO - Running pre-action listener: _resource_record_pre_action 22:24:04 INFO - Running main action method: download_and_extract 22:24:04 INFO - mkdir: /builds/slave/test/build/tests 22:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:04 INFO - trying https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 22:24:04 INFO - Downloading https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/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 22:24:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/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 22:24:05 INFO - Downloaded 1361 bytes. 22:24:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 22:24:05 INFO - Using the following test package requirements: 22:24:05 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 22:24:05 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 22:24:05 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 22:24:05 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:05 INFO - u'jsshell-linux-x86_64.zip'], 22:24:05 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 22:24:05 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 22:24:05 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 22:24:05 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 22:24:05 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 22:24:05 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 22:24:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 22:24:05 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:24:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 22:24:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:24:05 INFO - Fetch https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 22:24:05 INFO - Http code: 200 22:24:05 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 22:24:05 INFO - x-amz-cf-id: 5bHX3EP26PSLyxKwK35XzPAyfxKRqOSmZbecOke6-Gkq65n9kOeiHA== 22:24:05 INFO - x-amz-version-id: iUAHvYGW1tgokxV4c.mMAaEswQzVn6a0 22:24:06 INFO - Expected file size: 21942915 22:24:06 INFO - Obtained file size: 21942915 22:24:10 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 22:24:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 22:24:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:24:10 INFO - Fetch https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 22:24:10 INFO - Http code: 200 22:24:10 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 22:24:10 INFO - x-amz-cf-id: 9hmUssCVJ06U2K3e71_UIlYy5csda7jjgh6nt8hXwSigHlSZ7K3GMQ== 22:24:10 INFO - x-amz-version-id: iUAHvYGW1tgokxV4c.mMAaEswQzVn6a0 22:24:11 INFO - Expected file size: 21942915 22:24:11 INFO - Obtained file size: 21942915 22:24:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 22:24:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:24:15 INFO - Fetch https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 22:24:16 INFO - Http code: 200 22:24:16 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 22:24:16 INFO - x-amz-cf-id: 6m51DUG9MdS7g9hDV5cWHIS3CLPR-GiLKVPFuVXuZq_Juefi_47FVQ== 22:24:16 INFO - x-amz-version-id: gJ0.yP0H2ky005BZHhjbtG.FsFjLMp4D 22:24:16 INFO - Expected file size: 14409038 22:24:16 INFO - Obtained file size: 14409038 22:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:16 INFO - trying https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 22:24:16 INFO - Downloading https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/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 22:24:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/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 22:24:17 INFO - Downloaded 63962967 bytes. 22:24:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 22:24:17 INFO - mkdir: /builds/slave/test/properties 22:24:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:24:17 INFO - Writing to file /builds/slave/test/properties/build_url 22:24:17 INFO - Contents: 22:24:17 INFO - build_url:https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 22:24:18 INFO - Running post-action listener: _resource_record_post_action 22:24:18 INFO - Running post-action listener: set_extra_try_arguments 22:24:18 INFO - [mozharness: 2016-12-22 06:24:18.669027Z] Finished download-and-extract step (success) 22:24:18 INFO - [mozharness: 2016-12-22 06:24:18.669257Z] Running populate-webroot step. 22:24:18 INFO - Running pre-action listener: _resource_record_pre_action 22:24:18 INFO - Running main action method: populate_webroot 22:24:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:24:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:24:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:24:18 INFO - '--tppagecycles', 22:24:18 INFO - '7'], 22:24:18 INFO - 'tests': ['tsvgm']}}, 22:24:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:24:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:24:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:24:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:24:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:24:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:24:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:18 INFO - 'talos_options': ['--disable-e10s'], 22:24:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:24:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:24:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:18 INFO - 'talos_options': ['--disable-e10s'], 22:24:18 INFO - 'tests': ['damp', 'tps']}, 22:24:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:18 INFO - 'tests': ['damp', 'tps']}, 22:24:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:24:18 INFO - 'tests': ['dromaeo_dom']}, 22:24:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:24:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:24:18 INFO - 'tests': ['basic_compositor_video']}, 22:24:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:24:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:24:18 INFO - 'tests': ['a11yr', 22:24:18 INFO - 'ts_paint', 22:24:18 INFO - 'tpaint', 22:24:18 INFO - 'sessionrestore', 22:24:18 INFO - 'sessionrestore_no_auto_restore', 22:24:18 INFO - 'tabpaint']}, 22:24:18 INFO - 'other-e10s': {'tests': ['a11yr', 22:24:18 INFO - 'ts_paint', 22:24:18 INFO - 'tpaint', 22:24:18 INFO - 'sessionrestore', 22:24:18 INFO - 'sessionrestore_no_auto_restore', 22:24:18 INFO - 'tabpaint']}, 22:24:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:24:18 INFO - 'ts_paint', 22:24:18 INFO - 'tpaint', 22:24:18 INFO - 'sessionrestore', 22:24:18 INFO - 'sessionrestore_no_auto_restore', 22:24:18 INFO - 'tabpaint']}, 22:24:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:24:18 INFO - 'ts_paint', 22:24:18 INFO - 'tpaint', 22:24:18 INFO - 'sessionrestore', 22:24:18 INFO - 'sessionrestore_no_auto_restore', 22:24:18 INFO - 'tabpaint']}, 22:24:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:24:18 INFO - 'tests': ['a11yr', 22:24:18 INFO - 'ts_paint', 22:24:18 INFO - 'tpaint', 22:24:18 INFO - 'sessionrestore', 22:24:18 INFO - 'sessionrestore_no_auto_restore', 22:24:18 INFO - 'tabpaint']}, 22:24:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:24:18 INFO - 'tests': ['a11yr', 22:24:18 INFO - 'ts_paint', 22:24:18 INFO - 'tpaint', 22:24:18 INFO - 'sessionrestore', 22:24:18 INFO - 'sessionrestore_no_auto_restore', 22:24:18 INFO - 'tabpaint']}, 22:24:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:24:18 INFO - 'tests': ['tsvgx', 22:24:18 INFO - 'tsvgr_opacity', 22:24:18 INFO - 'tart', 22:24:18 INFO - 'tscrollx', 22:24:18 INFO - 'cart']}, 22:24:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:24:18 INFO - 'tsvgr_opacity', 22:24:18 INFO - 'tart', 22:24:18 INFO - 'tscrollx', 22:24:18 INFO - 'cart']}, 22:24:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:18 INFO - 'talos_options': ['--disable-e10s'], 22:24:18 INFO - 'tests': ['tp5o']}, 22:24:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:18 INFO - 'tests': ['tp5o']}, 22:24:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:18 INFO - 'talos_options': ['--disable-e10s', 22:24:18 INFO - '--xperf_path', 22:24:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:24:18 INFO - 'tests': ['tp5n']}, 22:24:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:18 INFO - 'talos_options': ['--xperf_path', 22:24:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:24:18 INFO - 'tests': ['tp5n']}}, 22:24:18 INFO - 'talos.zip': {'path': '', 22:24:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:24:18 INFO - Running post-action listener: _resource_record_post_action 22:24:18 INFO - [mozharness: 2016-12-22 06:24:18.689179Z] Finished populate-webroot step (success) 22:24:18 INFO - [mozharness: 2016-12-22 06:24:18.689267Z] Running create-virtualenv step. 22:24:18 INFO - Running pre-action listener: _resource_record_pre_action 22:24:18 INFO - Running main action method: create_virtualenv 22:24:18 INFO - Creating virtualenv /builds/slave/test/build/venv 22:24:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:24:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:24:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:24:18 INFO - Using real prefix '/usr' 22:24:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:24:19 INFO - Installing distribute.............................................................................................................................................................................................done. 22:24:21 INFO - Installing pip.................done. 22:24:21 INFO - Return code: 0 22:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:24:21 INFO - Reading from file tmpfile_stdout 22:24:21 INFO - Output received: 22:24:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 22:24:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:21 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 0x7f7ad8485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560f60>, '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 0x2561d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25621d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:24:21 INFO - Using env: {'DISPLAY': ':0', 22:24:21 INFO - 'HOME': '/home/cltbld', 22:24:21 INFO - 'LANG': 'en_US.UTF-8', 22:24:21 INFO - 'LANGUAGE': 'en_US:en', 22:24:21 INFO - 'LOGNAME': 'cltbld', 22:24:21 INFO - 'MAIL': '/var/mail/cltbld', 22:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:21 INFO - 'MOZ_NO_REMOTE': '1', 22:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:21 INFO - 'NO_EM_RESTART': '1', 22:24:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:21 INFO - 'PWD': '/builds/slave/test', 22:24:21 INFO - 'SHELL': '/bin/bash', 22:24:21 INFO - 'SHLVL': '1', 22:24:21 INFO - 'TERM': 'linux', 22:24:21 INFO - 'TMOUT': '86400', 22:24:21 INFO - 'USER': 'cltbld', 22:24:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 22:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:21 INFO - '_': '/tools/buildbot/bin/python'} 22:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:24:22 INFO - Cleaning up... 22:24:22 INFO - Return code: 0 22:24:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7ad8485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560f60>, '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 0x2561d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25621d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:24:22 INFO - Using env: {'DISPLAY': ':0', 22:24:22 INFO - 'HOME': '/home/cltbld', 22:24:22 INFO - 'LANG': 'en_US.UTF-8', 22:24:22 INFO - 'LANGUAGE': 'en_US:en', 22:24:22 INFO - 'LOGNAME': 'cltbld', 22:24:22 INFO - 'MAIL': '/var/mail/cltbld', 22:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:22 INFO - 'MOZ_NO_REMOTE': '1', 22:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:22 INFO - 'NO_EM_RESTART': '1', 22:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:22 INFO - 'PWD': '/builds/slave/test', 22:24:22 INFO - 'SHELL': '/bin/bash', 22:24:22 INFO - 'SHLVL': '1', 22:24:22 INFO - 'TERM': 'linux', 22:24:22 INFO - 'TMOUT': '86400', 22:24:22 INFO - 'USER': 'cltbld', 22:24:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 22:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:22 INFO - '_': '/tools/buildbot/bin/python'} 22:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:22 INFO - Downloading/unpacking psutil>=3.1.1 22:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:24:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:24:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:24:24 INFO - Installing collected packages: psutil 22:24:24 INFO - Running setup.py install for psutil 22:24:24 INFO - building 'psutil._psutil_linux' extension 22:24:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:24:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:24:25 INFO - building 'psutil._psutil_posix' extension 22:24:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:24:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:24:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:24:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:24:25 INFO - Successfully installed psutil 22:24:25 INFO - Cleaning up... 22:24:25 INFO - Return code: 0 22:24:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:24: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')]} 22:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24: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')]} 22:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ad8485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560f60>, '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 0x2561d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25621d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:24:25 INFO - Using env: {'DISPLAY': ':0', 22:24:25 INFO - 'HOME': '/home/cltbld', 22:24:25 INFO - 'LANG': 'en_US.UTF-8', 22:24:25 INFO - 'LANGUAGE': 'en_US:en', 22:24:25 INFO - 'LOGNAME': 'cltbld', 22:24:25 INFO - 'MAIL': '/var/mail/cltbld', 22:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:25 INFO - 'MOZ_NO_REMOTE': '1', 22:24:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:25 INFO - 'NO_EM_RESTART': '1', 22:24:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:25 INFO - 'PWD': '/builds/slave/test', 22:24:25 INFO - 'SHELL': '/bin/bash', 22:24:25 INFO - 'SHLVL': '1', 22:24:25 INFO - 'TERM': 'linux', 22:24:25 INFO - 'TMOUT': '86400', 22:24:25 INFO - 'USER': 'cltbld', 22:24:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 22:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:25 INFO - '_': '/tools/buildbot/bin/python'} 22:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:24:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:24:28 INFO - Installing collected packages: mozsystemmonitor 22:24:28 INFO - Running setup.py install for mozsystemmonitor 22:24:28 INFO - Successfully installed mozsystemmonitor 22:24:28 INFO - Cleaning up... 22:24:28 INFO - Return code: 0 22:24:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:28 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 0x7f7ad8485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560f60>, '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 0x2561d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25621d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:24:28 INFO - Using env: {'DISPLAY': ':0', 22:24:28 INFO - 'HOME': '/home/cltbld', 22:24:28 INFO - 'LANG': 'en_US.UTF-8', 22:24:28 INFO - 'LANGUAGE': 'en_US:en', 22:24:28 INFO - 'LOGNAME': 'cltbld', 22:24:28 INFO - 'MAIL': '/var/mail/cltbld', 22:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:28 INFO - 'MOZ_NO_REMOTE': '1', 22:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:28 INFO - 'NO_EM_RESTART': '1', 22:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:28 INFO - 'PWD': '/builds/slave/test', 22:24:28 INFO - 'SHELL': '/bin/bash', 22:24:28 INFO - 'SHLVL': '1', 22:24:28 INFO - 'TERM': 'linux', 22:24:28 INFO - 'TMOUT': '86400', 22:24:28 INFO - 'USER': 'cltbld', 22:24:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 22:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:28 INFO - '_': '/tools/buildbot/bin/python'} 22:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:28 INFO - Downloading/unpacking jsonschema==2.5.1 22:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:24:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:30 INFO - Downloading functools32-3.2.3-2.tar.gz 22:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:24:30 INFO - warning: no files found matching '*.txt' 22:24:30 INFO - no previously-included directories found matching 'build' 22:24:30 INFO - no previously-included directories found matching 'dist' 22:24:30 INFO - no previously-included directories found matching '.git*' 22:24:30 INFO - Installing collected packages: jsonschema, functools32 22:24:30 INFO - Running setup.py install for functools32 22:24:30 INFO - warning: no files found matching '*.txt' 22:24:30 INFO - no previously-included directories found matching 'build' 22:24:30 INFO - no previously-included directories found matching 'dist' 22:24:30 INFO - no previously-included directories found matching '.git*' 22:24:30 INFO - Successfully installed jsonschema functools32 22:24:30 INFO - Cleaning up... 22:24:31 INFO - Return code: 0 22:24:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:31 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 0x7f7ad8485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560f60>, '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 0x2561d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25621d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:24:31 INFO - Using env: {'DISPLAY': ':0', 22:24:31 INFO - 'HOME': '/home/cltbld', 22:24:31 INFO - 'LANG': 'en_US.UTF-8', 22:24:31 INFO - 'LANGUAGE': 'en_US:en', 22:24:31 INFO - 'LOGNAME': 'cltbld', 22:24:31 INFO - 'MAIL': '/var/mail/cltbld', 22:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:31 INFO - 'MOZ_NO_REMOTE': '1', 22:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:31 INFO - 'NO_EM_RESTART': '1', 22:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:31 INFO - 'PWD': '/builds/slave/test', 22:24:31 INFO - 'SHELL': '/bin/bash', 22:24:31 INFO - 'SHLVL': '1', 22:24:31 INFO - 'TERM': 'linux', 22:24:31 INFO - 'TMOUT': '86400', 22:24:31 INFO - 'USER': 'cltbld', 22:24:31 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 22:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:31 INFO - '_': '/tools/buildbot/bin/python'} 22:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:24:31 INFO - Cleaning up... 22:24:31 INFO - Return code: 0 22:24:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:31 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 0x7f7ad8485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560f60>, '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 0x2561d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25621d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:24:31 INFO - Using env: {'DISPLAY': ':0', 22:24:31 INFO - 'HOME': '/home/cltbld', 22:24:31 INFO - 'LANG': 'en_US.UTF-8', 22:24:31 INFO - 'LANGUAGE': 'en_US:en', 22:24:31 INFO - 'LOGNAME': 'cltbld', 22:24:31 INFO - 'MAIL': '/var/mail/cltbld', 22:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:31 INFO - 'MOZ_NO_REMOTE': '1', 22:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:31 INFO - 'NO_EM_RESTART': '1', 22:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:31 INFO - 'PWD': '/builds/slave/test', 22:24:31 INFO - 'SHELL': '/bin/bash', 22:24:31 INFO - 'SHLVL': '1', 22:24:31 INFO - 'TERM': 'linux', 22:24:31 INFO - 'TMOUT': '86400', 22:24:31 INFO - 'USER': 'cltbld', 22:24:31 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 22:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:31 INFO - '_': '/tools/buildbot/bin/python'} 22:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:31 INFO - Downloading/unpacking blobuploader==1.2.4 22:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:33 INFO - Downloading blobuploader-1.2.4.tar.gz 22:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:24:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:24:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:34 INFO - Downloading docopt-0.6.1.tar.gz 22:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:24:34 INFO - Installing collected packages: blobuploader, requests, docopt 22:24:34 INFO - Running setup.py install for blobuploader 22:24:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:24:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:24:34 INFO - Running setup.py install for requests 22:24:34 INFO - Running setup.py install for docopt 22:24:34 INFO - Successfully installed blobuploader requests docopt 22:24:34 INFO - Cleaning up... 22:24:34 INFO - Return code: 0 22:24:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:34 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 0x7f7ad8485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560f60>, '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 0x2561d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25621d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:24:34 INFO - Using env: {'DISPLAY': ':0', 22:24:34 INFO - 'HOME': '/home/cltbld', 22:24:34 INFO - 'LANG': 'en_US.UTF-8', 22:24:34 INFO - 'LANGUAGE': 'en_US:en', 22:24:34 INFO - 'LOGNAME': 'cltbld', 22:24:34 INFO - 'MAIL': '/var/mail/cltbld', 22:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:34 INFO - 'MOZ_NO_REMOTE': '1', 22:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:34 INFO - 'NO_EM_RESTART': '1', 22:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:34 INFO - 'PWD': '/builds/slave/test', 22:24:34 INFO - 'SHELL': '/bin/bash', 22:24:34 INFO - 'SHLVL': '1', 22:24:34 INFO - 'TERM': 'linux', 22:24:34 INFO - 'TMOUT': '86400', 22:24:34 INFO - 'USER': 'cltbld', 22:24:34 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 22:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:34 INFO - '_': '/tools/buildbot/bin/python'} 22:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:24:35 INFO - Running setup.py (path:/tmp/pip-HOBe02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:24:35 INFO - Running setup.py (path:/tmp/pip-nvnZyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:24:35 INFO - Running setup.py (path:/tmp/pip-OYAJUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:24:35 INFO - Running setup.py (path:/tmp/pip-Dnny3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:24:35 INFO - Running setup.py (path:/tmp/pip-M_gP0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:24:35 INFO - Running setup.py (path:/tmp/pip-ozqaWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:24:35 INFO - Running setup.py (path:/tmp/pip-dB6Ntk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:24:35 INFO - Running setup.py (path:/tmp/pip-ak80KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:24:35 INFO - Running setup.py (path:/tmp/pip-i9tbTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:24:35 INFO - Running setup.py (path:/tmp/pip-qaqDlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:24:35 INFO - Running setup.py (path:/tmp/pip-2XfhKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:24:35 INFO - Running setup.py (path:/tmp/pip-SdJO8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:24:35 INFO - Running setup.py (path:/tmp/pip-1uWayw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:24:35 INFO - Running setup.py (path:/tmp/pip-LnDsw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:36 INFO - Running setup.py (path:/tmp/pip-eiSiAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:24:36 INFO - Running setup.py (path:/tmp/pip-gU82k1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:24:36 INFO - Running setup.py (path:/tmp/pip-SLJhCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:24:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:24:36 INFO - Running setup.py install for manifestparser 22:24:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:24:36 INFO - Running setup.py install for mozcrash 22:24:36 INFO - Running setup.py install for mozdebug 22:24:36 INFO - Running setup.py install for mozdevice 22:24:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:24:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:24:36 INFO - Running setup.py install for mozfile 22:24:36 INFO - Running setup.py install for mozhttpd 22:24:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:24:36 INFO - Running setup.py install for mozinfo 22:24:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:24:36 INFO - Running setup.py install for mozInstall 22:24:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:24:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:24:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:24:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:24:37 INFO - Running setup.py install for mozleak 22:24:37 INFO - Running setup.py install for mozlog 22:24:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:24:37 INFO - Running setup.py install for moznetwork 22:24:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:24:37 INFO - Running setup.py install for mozprocess 22:24:37 INFO - Running setup.py install for mozprofile 22:24:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:24:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:24:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:24:37 INFO - Running setup.py install for mozrunner 22:24:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:24:37 INFO - Running setup.py install for mozscreenshot 22:24:37 INFO - Running setup.py install for moztest 22:24:37 INFO - Running setup.py install for mozversion 22:24:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:24:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:24:38 INFO - Cleaning up... 22:24:38 INFO - Return code: 0 22:24:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:38 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 0x7f7ad8485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560f60>, '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 0x2561d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25621d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:24:38 INFO - Using env: {'DISPLAY': ':0', 22:24:38 INFO - 'HOME': '/home/cltbld', 22:24:38 INFO - 'LANG': 'en_US.UTF-8', 22:24:38 INFO - 'LANGUAGE': 'en_US:en', 22:24:38 INFO - 'LOGNAME': 'cltbld', 22:24:38 INFO - 'MAIL': '/var/mail/cltbld', 22:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:38 INFO - 'MOZ_NO_REMOTE': '1', 22:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:38 INFO - 'NO_EM_RESTART': '1', 22:24:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:38 INFO - 'PWD': '/builds/slave/test', 22:24:38 INFO - 'SHELL': '/bin/bash', 22:24:38 INFO - 'SHLVL': '1', 22:24:38 INFO - 'TERM': 'linux', 22:24:38 INFO - 'TMOUT': '86400', 22:24:38 INFO - 'USER': 'cltbld', 22:24:38 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 22:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:38 INFO - '_': '/tools/buildbot/bin/python'} 22:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:24:38 INFO - Running setup.py (path:/tmp/pip-1Gagpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:24:38 INFO - Running setup.py (path:/tmp/pip-yWwXL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:24:38 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)) 22:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:24:38 INFO - Running setup.py (path:/tmp/pip-benYS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:24:38 INFO - Running setup.py (path:/tmp/pip-FW3M66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:24:38 INFO - Running setup.py (path:/tmp/pip-v97IGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:24:38 INFO - Running setup.py (path:/tmp/pip-IeTOTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:24:38 INFO - Running setup.py (path:/tmp/pip-omKm47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:24:38 INFO - Running setup.py (path:/tmp/pip-gXxQNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:24:38 INFO - Running setup.py (path:/tmp/pip-Jm4Pct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:24:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:24:38 INFO - Running setup.py (path:/tmp/pip-e0GjYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:24:39 INFO - Running setup.py (path:/tmp/pip-g0U3wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:24:39 INFO - Running setup.py (path:/tmp/pip-f6LI0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:24:39 INFO - Running setup.py (path:/tmp/pip-b8yAex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:24:39 INFO - Running setup.py (path:/tmp/pip-FKkF4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:24:39 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)) 22:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:39 INFO - Running setup.py (path:/tmp/pip-Pv8rFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:24:39 INFO - Running setup.py (path:/tmp/pip-kPETPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:24:39 INFO - Running setup.py (path:/tmp/pip-iAuIGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:24:39 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)) 22:24:39 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)) 22:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:24:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:41 INFO - Downloading blessings-1.6.tar.gz 22:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:24:41 INFO - Installing collected packages: blessings 22:24:41 INFO - Running setup.py install for blessings 22:24:41 INFO - Successfully installed blessings 22:24:41 INFO - Cleaning up... 22:24:41 INFO - Return code: 0 22:24:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:24:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:24:42 INFO - Reading from file tmpfile_stdout 22:24:42 INFO - Current package versions: 22:24:42 INFO - argparse == 1.2.1 22:24:42 INFO - blessings == 1.6 22:24:42 INFO - blobuploader == 1.2.4 22:24:42 INFO - docopt == 0.6.1 22:24:42 INFO - functools32 == 3.2.3-2 22:24:42 INFO - jsonschema == 2.5.1 22:24:42 INFO - manifestparser == 1.1 22:24:42 INFO - mozInstall == 1.12 22:24:42 INFO - mozcrash == 1.0 22:24:42 INFO - mozdebug == 0.1 22:24:42 INFO - mozdevice == 0.48 22:24:42 INFO - mozfile == 1.2 22:24:42 INFO - mozhttpd == 0.7 22:24:42 INFO - mozinfo == 0.9 22:24:42 INFO - mozleak == 0.1 22:24:42 INFO - mozlog == 3.4 22:24:42 INFO - moznetwork == 0.27 22:24:42 INFO - mozprocess == 0.23 22:24:42 INFO - mozprofile == 0.28 22:24:42 INFO - mozrunner == 6.13 22:24:42 INFO - mozscreenshot == 0.1 22:24:42 INFO - mozsystemmonitor == 0.3 22:24:42 INFO - moztest == 0.7 22:24:42 INFO - mozversion == 1.4 22:24:42 INFO - psutil == 3.1.1 22:24:42 INFO - requests == 1.2.3 22:24:42 INFO - wsgiref == 0.1.2 22:24:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:42 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 0x7f7ad8485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560f60>, '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 0x2561d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25621d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:24:42 INFO - Using env: {'DISPLAY': ':0', 22:24:42 INFO - 'HOME': '/home/cltbld', 22:24:42 INFO - 'LANG': 'en_US.UTF-8', 22:24:42 INFO - 'LANGUAGE': 'en_US:en', 22:24:42 INFO - 'LOGNAME': 'cltbld', 22:24:42 INFO - 'MAIL': '/var/mail/cltbld', 22:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:42 INFO - 'MOZ_NO_REMOTE': '1', 22:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:42 INFO - 'NO_EM_RESTART': '1', 22:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:42 INFO - 'PWD': '/builds/slave/test', 22:24:42 INFO - 'SHELL': '/bin/bash', 22:24:42 INFO - 'SHLVL': '1', 22:24:42 INFO - 'TERM': 'linux', 22:24:42 INFO - 'TMOUT': '86400', 22:24:42 INFO - 'USER': 'cltbld', 22:24:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 22:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:42 INFO - '_': '/tools/buildbot/bin/python'} 22:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:24:42 INFO - Cleaning up... 22:24:42 INFO - Return code: 0 22:24:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:42 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 0x7f7ad8485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2563ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2560f60>, '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 0x2561d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25621d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:24:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:24:42 INFO - Using env: {'DISPLAY': ':0', 22:24:42 INFO - 'HOME': '/home/cltbld', 22:24:42 INFO - 'LANG': 'en_US.UTF-8', 22:24:42 INFO - 'LANGUAGE': 'en_US:en', 22:24:42 INFO - 'LOGNAME': 'cltbld', 22:24:42 INFO - 'MAIL': '/var/mail/cltbld', 22:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:42 INFO - 'MOZ_NO_REMOTE': '1', 22:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:42 INFO - 'NO_EM_RESTART': '1', 22:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:42 INFO - 'PWD': '/builds/slave/test', 22:24:42 INFO - 'SHELL': '/bin/bash', 22:24:42 INFO - 'SHLVL': '1', 22:24:42 INFO - 'TERM': 'linux', 22:24:42 INFO - 'TMOUT': '86400', 22:24:42 INFO - 'USER': 'cltbld', 22:24:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 22:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:42 INFO - '_': '/tools/buildbot/bin/python'} 22:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:24:42 INFO - Cleaning up... 22:24:42 INFO - Return code: 0 22:24:42 INFO - Running post-action listener: _resource_record_post_action 22:24:42 INFO - Running post-action listener: _start_resource_monitoring 22:24:42 INFO - Starting resource monitoring. 22:24:42 INFO - [mozharness: 2016-12-22 06:24:42.540592Z] Finished create-virtualenv step (success) 22:24:42 INFO - [mozharness: 2016-12-22 06:24:42.541505Z] Running install step. 22:24:42 INFO - Running pre-action listener: _resource_record_pre_action 22:24:42 INFO - Running main action method: install 22:24:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:24:42 INFO - Reading from file tmpfile_stdout 22:24:42 INFO - Detecting whether we're running mozinstall >=1.0... 22:24:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:24:42 INFO - Reading from file tmpfile_stdout 22:24:42 INFO - Output received: 22:24:42 INFO - Usage: mozinstall [options] installer 22:24:42 INFO - Options: 22:24:42 INFO - -h, --help show this help message and exit 22:24:42 INFO - -d DEST, --destination=DEST 22:24:42 INFO - Directory to install application into. [default: 22:24:42 INFO - "/builds/slave/test"] 22:24:42 INFO - --app=APP Application being installed. [default: firefox] 22:24:42 INFO - mkdir: /builds/slave/test/build/application 22:24:42 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'] 22:24:42 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 22:24:58 INFO - Reading from file tmpfile_stdout 22:24:58 INFO - Output received: 22:24:58 INFO - /builds/slave/test/build/application/firefox/firefox 22:24:58 INFO - Running post-action listener: _resource_record_post_action 22:24:58 INFO - [mozharness: 2016-12-22 06:24:58.739659Z] Finished install step (success) 22:24:58 INFO - [mozharness: 2016-12-22 06:24:58.739910Z] Running run-tests step. 22:24:58 INFO - Running pre-action listener: _resource_record_pre_action 22:24:58 INFO - Running main action method: run_tests 22:24:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:24:58 INFO - Python 2.7.3 22:24:58 INFO - Return code: 0 22:24:58 INFO - grabbing minidump binary from tooltool 22:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:58 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 0x2560f60>, '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 0x2561d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25621d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:24:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:24:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:24:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:24:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:24:58 INFO - Return code: 0 22:24:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:24:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:24:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:24:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:24:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:24:58 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/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 22:24:58 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/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 22:24:58 INFO - Using env: {'DISPLAY': ':0', 22:24:58 INFO - 'HOME': '/home/cltbld', 22:24:58 INFO - 'LANG': 'en_US.UTF-8', 22:24:58 INFO - 'LANGUAGE': 'en_US:en', 22:24:58 INFO - 'LOGNAME': 'cltbld', 22:24:58 INFO - 'MAIL': '/var/mail/cltbld', 22:24:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:24:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:58 INFO - 'MOZ_NO_REMOTE': '1', 22:24:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:58 INFO - 'NO_EM_RESTART': '1', 22:24:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:58 INFO - 'PWD': '/builds/slave/test', 22:24:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:24:58 INFO - 'SHELL': '/bin/bash', 22:24:58 INFO - 'SHLVL': '1', 22:24:58 INFO - 'TERM': 'linux', 22:24:58 INFO - 'TMOUT': '86400', 22:24:58 INFO - 'USER': 'cltbld', 22:24:58 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189', 22:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:58 INFO - '_': '/tools/buildbot/bin/python'} 22:24:58 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/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 22:24:59 INFO - mozversion application_buildid: 20161221205053 22:24:59 INFO - mozversion application_changeset: 913f99c5f60ba918e3c33c6d711212f5178481e2 22:24:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:24:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:24:59 INFO - mozversion application_name: Firefox 22:24:59 INFO - mozversion application_remotingname: firefox-dev 22:24:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:24:59 INFO - mozversion application_vendor: Mozilla 22:24:59 INFO - mozversion application_version: 52.0a2 22:24:59 INFO - mozversion platform_buildid: 20161221205053 22:24:59 INFO - mozversion platform_changeset: 913f99c5f60ba918e3c33c6d711212f5178481e2 22:24:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:24:59 INFO - mozversion platform_version: 52.0a2 22:24:59 INFO - using testdate: 1482387899 22:24:59 INFO - actual date: 1482387899 22:24:59 INFO - starting webserver on 'localhost:50703' 22:24:59 INFO - SUITE-START | Running 2 tests 22:24:59 INFO - TEST-START | dromaeo_css 22:24:59 INFO - operating with platform_type : linux_ 22:24:59 INFO - Initialising browser for dromaeo_css test... 22:24:59 INFO - TEST-INFO | started process 3311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAza8hX/profile http://localhost:50703/getInfo.html) 22:25:04 INFO - PROCESS | 3311 | __metrics Screen width/height:1600/1200 22:25:04 INFO - PROCESS | 3311 | colorDepth:24 22:25:04 INFO - PROCESS | 3311 | Browser inner width/height: 1024/697 22:25:04 INFO - PROCESS | 3311 | __metrics 22:25:05 ERROR - PROCESS | 3311 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 22:25:06 INFO - TEST-INFO | 3311: exit 0 22:25:06 INFO - Browser initialized. 22:25:06 INFO - Running cycle 1/1 for dromaeo_css test... 22:25:06 INFO - TEST-INFO | started process 3440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAza8hX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:25:18 INFO - PROCESS | 3440 | RSS: Main: 151371776 22:25:18 INFO - PROCESS | 3440 | 22:26:07 INFO - PROCESS | 3440 | 1482387967683 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:28:18 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:50703/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50703/tests/dromaeo/cssquery-ext.html) 22:28:19 INFO - PROCESS | 3440 | RSS: Main: 155545600 22:28:19 INFO - PROCESS | 3440 | 22:31:21 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:50703/tests/dromaeo/cssquery-ext.html (next: http://localhost:50703/tests/dromaeo/cssquery-jquery.html) 22:31:22 INFO - PROCESS | 3440 | RSS: Main: 153178112 22:31:22 INFO - PROCESS | 3440 | 22:34:24 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:50703/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50703/tests/dromaeo/cssquery-mootools.html) 22:34:24 INFO - PROCESS | 3440 | RSS: Main: 153202688 22:34:24 INFO - PROCESS | 3440 | 22:37:26 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:50703/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50703/tests/dromaeo/cssquery-prototype.html) 22:37:27 INFO - PROCESS | 3440 | RSS: Main: 151629824 22:37:27 INFO - PROCESS | 3440 | 22:40:29 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:50703/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50703/tests/dromaeo/cssquery-yui.html) 22:40:30 INFO - PROCESS | 3440 | RSS: Main: 154304512 22:40:30 INFO - PROCESS | 3440 | 22:43:32 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:50703/tests/dromaeo/cssquery-yui.html (next: http://localhost:50703/tests/dromaeo/cssquery-dojo.html) 22:43:33 INFO - PROCESS | 3440 | RSS: Main: 155615232 22:43:33 INFO - PROCESS | 3440 | 22:43:33 INFO - PROCESS | 3440 | __start_tp_report 22:43:33 INFO - PROCESS | 3440 | _x_x_mozilla_page_load 22:43:33 INFO - PROCESS | 3440 | _x_x_mozilla_page_load_details 22:43:33 INFO - PROCESS | 3440 | |i|pagename|runs| 22:43:33 INFO - PROCESS | 3440 | |0;dojo.html;3327.4010678077952;3327.633960264371;3343.0639420962125;3345.7992520448774;3362.22668786179;5670.546356291497;5702.885942281152;5710.172025056364;5712.114622233556;5720.141978703186;5717.228174196493;5782.45066718661;5783.363829978699;5788.5369170466365;5816.214811000514;5201.271821944931;5249.527542521172;5306.469353064701;5306.787728490855;5330.813421530247;5292.947070529284;5304.416514183436;5307.150855863063;5329.786808527654;5347.438518955492;5173.042987047389;5214.817481388152;5319;5330.093884039723;5344.812931547397;5217.765200565984;5239.869003274911;5241.397239317489;5272.551833094172;5310.256564081032;5221.086309895753;5262.605304602132;5265.710385928773;5289.074411977888;5330.813421530228;5584.274044374205;5695.857603559903;5707.229524014247;5774.133879918004;5794.188813566104;6059.909101363483;6106.755729770804;6115.388461153893;6129.540284478682;6140.925338065821;6127.6017058891475;6162.752463606377;6174.320824709278;6184.257889053298;6203.658798766066;5659.8585035374035;5706.058500347479;5709.628874123168;5735.1970724098655;5781.739821707991;6210.254769427697;6321.683915804191;6328.6202827830475;6332.303446620868;6335.303116657164;6054.334023257438;6061.666608336495;6068.726907289182;6093.482054025458;6096.116063170904;6003.0695242237525;6020.337762846083;6144.477719393813;6174.8147555573405;6174.845628859224;6096.786612468542;6097.420745029215;6104.881809607925;6116.990696535111;6174.536909731698;6112.655464441461;6128.686460748404;6129.603311142676;6138.3577446079025;6143.818944274718;4507.233770259064;4600.125976064537;4601.780498260391;4607.9308810367875;4612.630989520897;4039.7778122203563;4079.8164082616354;4084.244414783275;4109.691773117028;4162.729422587522;5929.703514824328;5932.911006334908;5935.881282374415;5945.137954996501;5950.077737950624;6041;6101.267847858197;6196.256449226122;6212;6261.154744109578;5805.274340707411;5808.244928159397;5853.88292234153;5880.647161170344;5932.911006334908;5219.817306394334;5231.136862417735;5245.3705555332845;5248.396434410015;5248.737563121828;6224.315325314303;6443.387878151568;6453.096566480696;6456.51576131792;6475.287718350977;6028.608140470856;6120.751898419022;6137.355577664281;6143.419763699347;6206.534509911865;6453.419192272718;6453.548251622341;6459.515536334699;6475.676216189077;6475.870482590228;6040.244969378828;6077.6961151943115;6086.239220097488;6099.908501372572;6116.877662446637;6017.578769486094;6092;6111;6136.938630613815;6139.662318572343;6027.75888964454;6030.1256317832795;6040.124181993674;6042.335343112166;6064.06007068905;6034.125051867542;6034.366391529002;6036.094585811988;6038.245219347582;6047.123167140828;5762.049261871744;5777.740001700017;5805.187273781589;5913;5998;5971.193888825127;5973.671448070224;6032.1856549365275;6060.787872424444;6070.998285282879;5844.12338149264;5878.265216847894;5885.764569417347;5901.940980590139;5905.822825315247 22:43:33 INFO - PROCESS | 3440 | |1;ext.html;618.3538202578306;620.3827191944016;659.7361055577768;669.8057563306638;688.6040526697151;42575;43184;43363.34954975678;43496.13007739843;43504;43779;43861.7806910965;43892;43987;44086;8618.353623478233;8728.956355218215;8802.207801297882;8820.514871682055;8820.911790882104;8700.086490918457;8705.825883482326;8735.082816304292;8773.868391974125;8794.560271986407;8827.602757875911;8829.735107946772;8857.335699822539;8869.778255543599;8886.73339799807;8750;8766.649334026632;8784.692535761218;8786.16531429513;8805.42764720291;8670.566471676391;8700.521471319074;8748.518831464267;8748.606312715943;8762.123787621187;40280.59719402827;40950;40951.7952410239;40964.38553421701;41010.58989410097;3450.189205536697;3580.2481478889463;3650.6349365063547;3702.8889133326043;3781;31793.841030794698;32385;32520.512192317135;32831.88229061502;32997;3986.521617405901;4151.813168407429;4161.854335098257;4176.1230141670285;4216.85241016566;381459;384567;385281;385328.9999999972;386011;64615.353846461876;64615.67692161603;64773.676131619985;65075;65130;68814;69102.65448672825;69516.30483695098;69534;69799;15275;15375.923120384326;15416.768748468781;15524.14617196065;15528.456504022304;13253.403596838165;13341.66645833862;13358.265295408652;13396.665083372995;13422.194668319931;19657;19755.604887902162;19785.703214451794;19958.60082798336;20026.399208023784;7383.187849336568;7506.624668766649;7507.737229196952;7724.6523906424345;7778.377729781604;959.8896126945491;1007.9294449388619;1048.8898665640152;1109.9400072930493;1133.0991861469986;32750.344993100003;33024.50463243053;33314;33449;33974;1063.5798859450474;1096.2107282756403;1146.5070019891527;1148.3167515328532;1196.300164403816;16750.83249167517;17146.91426542884;17478;17685.20416581257;18766.155523001496;423911;429094;559301;559426;560586;63510.682446587474;64294.678526607066;64378.35621643817;64525.354746452875;64562;1424.8717615414662;1428.9356978935973;1473.528470889305;1474;1478.6968671422333;32760.83619581887;34243;34612.134696632784;34619.82690086534;34717;55774.163387548404;56479;56515.71742141263;56587.71706141443;56589.15116273342;527771;530830;533009;533610;534062;45030.77484612556;46832.297515537975;48082.75958620184;48159.75920120377;48640.75679621579;51290.23064653959;51694;51831.222531661304;51879.2218116721;52688.47311526836;42841.14317713566;44159.33760993523;44941;45329.773351134354;45726.314105289115;42735.7863210682;44050.118997620506;44366;44645;44856.32715509205;43761;44379.11241775211;45135;45186.77406612946;45312.32031519596;36636.81681591575;38722.41916371313;39047.80476097601;39306.31239807431;39318.41022384609;29758.702412975592;30127.548086779156;30134.246643834078;30269.545956810223;30787.53818692766 22:43:33 INFO - PROCESS | 3440 | |2;jquery.html;417.7347384410898;419.6663652396343;424.74303046656763;433.8199647146434;441.97348159110436;18186.181621827018;19063;19815.900920495376;20227.494312642193;20272;19312.227510899545;19594.608107837834;20028.29900953467;20084.196632134695;20252.39242822714;5720.628159169651;5945.256842894638;5968.955432799265;5983.730732117044;6011.729472173763;5746.281714785652;5867.55993300502;5967.955607768645;5974.641521508724;6046.96976515119;6114.1745864308195;6177.691115444232;6188.81433556994;6191.442770150686;6200.162977997958;6148.415900489446;6180.783672571461;6590.505712071614;6621.93378066218;6626.072349871022;5743.339515955677;5901.262342207224;5933.3473317934995;5950.137230101611;5961.731722072517;14740.70518589633;14971.92514037423;15130.319135638923;15147;15147.54557363281;2188.2122435923056;2347.33101066197;2382.332946774906;2578.046122934526;2898.145047211078;10768.138548916146;10834.241603087787;10960.780784384267;11256.943715281372;11443.656690299304;1876.3995521433146;1937.4865660599953;2020.9794054002634;2085.6141613801497;2104.400245929918;85009.72485412662;85262.5736871318;86861.56569217113;88131;88694;11633.243839150597;11802.232854864405;11913.404329783476;11915.404229788475;12067.198832367776;16880.831191688172;16960.236789344508;17007.659846803243;17034;17048.744268835977;8172.910205982206;8347.874781878276;8428.283595894294;8614.913850861536;8718.43330183536;7986.600669966479;8033.3974951878845;8080;8089.676412943534;8237.217464340878;5117.769700363493;5130.1535246684625;5134.332536770271;5152.871178220575;5192.350956130484;1996.161612122912;2035.9185632574827;2072.202202152182;2106.3680895731527;2125.4048866317457;888.3825741109866;971.5967873332629;992.2607657295362;1025.8666373371414;1045.9592705258317;20375.28686495995;20452.795472045385;20563.177472900916;20615;20703.896480517804;1019.622739586343;1029.5264178477985;1036.1555332404066;1058.1640504001907;1065.5151905882806;10675.199360047873;11402.372869492257;11418.771624567462;11583.24708893936;11591.942040289914;364211;365018;366889;484717;501350;90354.54822725845;91745;95528;101487.49256253672;104377.47811260895;1049.1134990932649;1083.268793564341;1089.2647462962468;1090.111559079348;1096.8793432722393;16685.08232047249;17246;17573.736393953845;17879.642407151525;17904.552386189927;34644.653553464144;41532.1693566133;42480.78759606182;43529;43546.78226608847;60429.697851510464;62738.37261627326;64218.67890660517;64567;66118;8618.956905215433;8740.125987401208;8961.417507861968;9188.310876684409;9427.717168484956;13097.41061652209;14008;14078.929605351908;14284.500042498463;14406.927965360526;12559.372031398576;12582.30797306157;12599.559015434783;12624.747505049663;12667.80998285008;11728.354940478015;11776.70558236051;11815.113866460222;11973.221740586834;12045.879541204476;12336.50653973831;12410.5656302029;12518.186317889307;12784.872151278369;12928.741425171633;7738.92261077382;7921.485103468256;7996.200379961957;8005.239502247277;8311.503929292785;10444.791104178026;12061.939690301493;12145.332006739714;12466.065045121471;12697.682557935756 22:43:33 INFO - PROCESS | 3440 | |3;mootools.html;1367.8563750806165;1445.833729121151;1496.7380708376031;1729.3428497171074;1757.4376199616113;8204.671813127468;8373.874391884126;8790.824183516326;9285.721428357143;9384.81230375392;8680.348973826956;8964.596593153308;8978.50618215998;9235;9263.490508022056;2480.441900572375;2495.987520062397;2509.1092662104966;2509.5608268553024;2513.0450428837016;2477.417806815397;2557.0283292348972;2569.2292312306326;2575.613657951313;2576.497582971321;2447.4982628561193;2483.0936708101503;2500.58740307849;2503.4367267364787;2513.40934880303;2351.1065794997876;2371.2293504610984;2381.3332266965276;2419.9637005444933;2422.2975337152207;2410.4817464245098;2412.3848418653133;2441.5727247731575;2453.858955585661;2459.0409740201335;8597.398182127254;9154.954225228832;9245.722628321093;9285.535723213812;9305.53472326381;5646.322441307069;5772.134179873011;5774.653520788766;5775.682337471438;5788.04497257952;3488.8953331399844;3546.148924258185;3612.747107702462;3643.0710168906758;3666.7616604920595;1140.589387820384;1147.822087576427;1175.7354595216093;1198.101423932051;1202.2966564559742;12196.451159697746;12197.939010304892;12246.387680616022;12302.753944921142;12305.26168429897;4697.061313338977;4762.14281429346;4882.7558622068755;5106.055379754757;5227;10739;10745.570177192982;10759.515821788038;10828.350298982086;10853.51159197838;5798.188253644493;5833.50415214703;5833.766649334064;5834.649921004753;5840.59115861894;5208.817691380784;5343.091674415358;5364.3830959440165;5410.161424979135;5489.560835133179;4117.958820411817;4177.937330940038;4194.8112334945;4246.766427846436;4251.87244382669;1300.4213125159401;1301.7006088599676;1301.7526669932683;1304.6673098359859;1306.5688322853625;941.9433936874885;951.9286053546011;991.0634450444261;1018.2414101494434;1032.8605638238892;6292.590981586274;6371.362863713592;6452.9677351612945;6457.225132984072;6727.360900714424;933.570557543524;981.0434826044692;998.9800203995879;1008.4151192308443;1049.6536143072767;4269.4449721536;4406.140802543473;4414.448193975753;4419.779011049434;4433.800478978454;11288.661340159808;11630.360330181922;11652.650420487398;11654.242474239147;11664.591739289084;11513.88486115145;11523.654290371302;11546.711332216593;11559.711007224718;11560.075193984461;7715.4599178058115;8067.273945344947;8122.715704950417;8224.259816616533;8577.914220857836;5862.208601838868;6159.19930409044;6311.65285909261;6393.520485963664;6491.675416229075;10569.149963119518;10584.84122738175;10623.468826558486;10725.570977160825;10733.409662468326;10557.260991730505;10583.4708264588;10660.680179594625;10666.83999739989;10742.462876855969;8140.430169888051;8199;8322.833543329221;8328.250457458858;8376.53929033909;8830.514321712368;8855.158759917798;8880.777980550538;8901.465912045298;8922.286217102746;7826.882596761167;7836.216378362118;7888.802779930547;7913;7918.881216781638;7577.280158384945;7710.228977102245;7798.922010779819;7807.648655810389;7864.5281283123195;7281.235470275545;7304.598247096461;7307.342339189286;7338.412926965937;7455.6644950978425;5221.947780522146;5281;5442.891142177214;5479.780808767605;5523.364813046551;5074.188129899198;5295.523402893758;5330.173823057432;5397;5559.471850174227 22:43:33 INFO - PROCESS | 3440 | |4;prototype.html;341.73686261578587;346.4629823773151;346.8629891192979;357.78354095772056;358.07080625776103;5596.776128954842;5714.257146570951;5721.199032135499;5751.942480575193;5764.25064741583;5615.438456154383;5626.470691093668;5634.605577609559;5637.436256374361;5652.5195358394585;3951.920961580781;4291.46356705411;4335.479742430913;4408.625266852321;4429.1584598926265;4418.955810441903;4422.11557688462;4428.512863585019;4436.245838207513;4448.199324121657;4402.361657559652;4404.66964977628;4411.2941929291155;4416.82332706693;4425.7565833879125;4214.452121224222;4357.738535687838;4383.49589797171;4423.557644235567;4459.933101003504;3846.173072789336;3862.671672907806;3870.974191839165;3877.2827027000094;3881.8835434936714;5512.33851937766;5533.750981205815;5541.750621222014;5561.58288128392;5568.331800183963;4868.342773725537;4893.412790465131;4928.482509336504;5076.720780357079;5126.53861152498;5851.8537036574;5895.322037965646;5897.3218079920925;5907.527397808208;5924.377940316248;4231.1749208904275;4232.851850185229;4252.064545799919;4259.680523960716;4268.87193384199;6055.091736239555;6115.9694201529155;6170.814875553696;6195.504359651262;6211.503079753609;4289.027047558096;4290.806913688892;4296.818374946914;4297.806598703066;4305.440292761921;4368;4373.453318335208;4383.145286669069;4404.801783919731;4410;4838.5968069260225;5013.473585273567;5015.3730783652045;5053.343065401475;5130.615203859726;5926.525877929756;5929.37741537141;5934.6142500737315;5967.9701601491715;5977.1333156692035;1509.2680050175657;1518.468536012409;1527.3737767515265;1531.958268377514;1532.9846701532842;1057.8201705710048;1073.5330131392868;1074.355386767933;1083.6261489786168;1120.8374785656035;5592.608517403743;5618.2415373924;5642.7178641067785;5672.858178545487;5676.347220069745;5856.297244330707;5873.4435374625755;5890.263717035371;5900.4984576310635;5982.670953097534;5374.892502149935;5509.228707980886;5592.440755924375;5598.86002849932;5608.691521966331;3109.626844778596;3131.2954585218145;3139.100843989399;3143.8742450301734;3156.936861262762;5954.541137421273;6071;6099.725512351954;6123.479504242189;6164.506839452833;5972.104184372379;5975.103734439869;5987.670678112659;6006.429389208019;6044.637321760709;6210.875782484325;6221.786751583489;6365.2361716594305;6372.2671892732005;6392.360763923663;6028.547858910687;6115.480184184395;6118.174046503665;6121.724522396414;6138.324784273816;5864.120381942743;5986.6707331097205;6003.519718422428;6003.5797494174985;6061.666608336407;6345.650989195638;6346.936530634634;6354.745810167541;6380.202474690664;6386.265579458236;4171.749695018309;4327.593532102016;4469.865904022885;4487.955120448884;4498.212812757689;6085.391460853879;6098.481629061402;6111.716539526571;6118.847028824137;6123.326434092157;5964.8807023860145;5976.521878249817;5992.550558708027;6011.128386384037;6022.548308876764;5833.562482813721;5858.47273745365;5888.705564721661;5910.143029260819;5966.880662386641;5864.853378665567;5885.761672111738;5891.527118220445;5919.6152250103605;5920.79277225295;5810.448007439287;5969.492593129633;5985.40145985398;5994.381516990301;6050.97292407031;5794.7102644866745;5832.270966129234;5860.736266868086;5862.824115276549;5877.647341159544 22:43:33 INFO - PROCESS | 3440 | |5;yui.html;694.3889377347933;735.3712575747736;746.8319628083678;771.9732755435272;827.7227128911816;13689.383977721001;14146.363413646384;14234.715305693893;14244.501442449517;14284.999999999975;13439.462421503153;13488.797668034988;13769.311534423265;13783.65540861479;13794.241316727575;682.9009793579941;698.6925752668809;781.9335356494705;804.569555287921;819.4264015189391;822.9753107406757;823.6622984576325;825.038829763325;829.3945419843518;831.3930830493713;855.4781583234222;868.439856292694;869.3132425383939;870.2298465857698;872.3762509805488;859.8452278589851;861.6854847980474;862.8619420892627;864.8745931839879;865.2688478235881;627.2817623820699;631.204682100552;633.1926793338484;633.9366063393624;636.7389370358131;13422.395992180278;13501.59495215145;13539.932300338436;13565.118267312593;14720.190389528572;14101.506447274398;14974;15437.922810385877;15512.767308490382;15529.145896975662;11923.224990375598;12044.21712588679;12077.396130193543;12114.81827772584;12352.505899763999;3851.5378154621626;3869.8452061917487;3880.4567360569545;3901.43429202764;3991.600839916014;65758.3424165757;66359.33640663628;66476;67312.99030514596;68549;11602.256545619626;11661.766764664659;11905.226160299553;12034.217775844718;12156.878431215751;21729.348119556438;21946.45133871666;22130.336089917328;22230.333090007003;22518.66222006671;8293.677092728385;8598.914010859811;8599.484030958163;8608.65565377378;8654.22112009922;4656.4877863434995;4735.928961065587;4738.549837765407;4771.403574553181;4785.3300537924715;3605.4591811228;3729.8881033568496;3739.495168152265;3745;3750.268697603941;665.9433948114367;674.639068098565;694.5728377048079;704.8766465868453;706.8727629026722;686.543448606681;699.5907394174363;711.8576284743073;751.1474476469247;783.6982761636697;9196.402233854911;9573.952130239444;9716.02839716037;9761.219102471785;9766.560504777302;621.3351713666424;695.8900553616973;698.5878331784272;711.0898050495374;730.1129128109372;4200.7479551227025;4315.352697095461;4428.645708343325;4437.400950871655;4504.819807207675;58127.70936145292;58368.4163158363;58394.12408813871;76964.23035769683;90174.54912725394;75026.62486687531;77353.61323193349;78115;79276.60361698155;80052.5997370021;72095.63952180206;72177.27822721706;73743.63128184433;74637.25362746412;74691;8526.275266602408;8597.957010214908;8605.139486051345;8700.260477859452;8732.34507411934;47997.622703183755;48673.0265394683;48978.26532602085;49519;50491.49508505015;52287.73856130695;63949;64817.67591162014;66454.33545664481;66665;11511.424428778695;11686.94156529212;11772;12015.339156346485;12099.75800484003;12359.707076335528;13116.475340986253;13375.665608359868;13399.53101641438;13876.167429954236;12856.42146103409;12872.22766634005;12907.612771616867;12959.157654752411;12985.48058077704;11944.283342999448;12028.757315587925;12270.4478298475;12403.875961240272;12656.493740250287;12398.876011239772;12435;12630.936845316082;12923.676908077374;13142.60572182836;10463.843042354218;10513.106385956973;10954.014138727553;11139.220254582102;11216.83174752363;10815.837762433726;11112.555497779998;11158.776824463628;11278.774424511628;11339.659810205707 22:43:33 INFO - PROCESS | 3440 | __end_tp_report 22:43:33 INFO - PROCESS | 3440 | __start_cc_report 22:43:33 INFO - PROCESS | 3440 | _x_x_mozilla_cycle_collect,321 22:43:33 INFO - PROCESS | 3440 | __end_cc_report 22:43:33 INFO - PROCESS | 3440 | __startTimestamp1482389013096__endTimestamp 22:43:33 INFO - PROCESS | 3440 | 22:43:33 INFO - PROCESS | 3440 | ------- Summary: start ------- 22:43:33 INFO - PROCESS | 3440 | Number of tests: 6 22:43:33 INFO - PROCESS | 3440 | 22:43:33 INFO - PROCESS | 3440 | [#0] dojo.html Cycles:165 Average:5714.08 Median:5945.14 stddev:658.56 (11.1%) stddev-sans-first:633.40 22:43:33 INFO - PROCESS | 3440 | Values: 3327.4 3327.6 3343.1 3345.8 3362.2 5670.5 5702.9 5710.2 5712.1 5720.1 5717.2 5782.5 5783.4 5788.5 5816.2 5201.3 5249.5 5306.5 5306.8 5330.8 5292.9 5304.4 5307.2 5329.8 5347.4 5173.0 5214.8 5319.0 5330.1 5344.8 5217.8 5239.9 5241.4 5272.6 5310.3 5221.1 5262.6 5265.7 5289.1 5330.8 5584.3 5695.9 5707.2 5774.1 5794.2 6059.9 6106.8 6115.4 6129.5 6140.9 6127.6 6162.8 6174.3 6184.3 6203.7 5659.9 5706.1 5709.6 5735.2 5781.7 6210.3 6321.7 6328.6 6332.3 6335.3 6054.3 6061.7 6068.7 6093.5 6096.1 6003.1 6020.3 6144.5 6174.8 6174.8 6096.8 6097.4 6104.9 6117.0 6174.5 6112.7 6128.7 6129.6 6138.4 6143.8 4507.2 4600.1 4601.8 4607.9 4612.6 4039.8 4079.8 4084.2 4109.7 4162.7 5929.7 5932.9 5935.9 5945.1 5950.1 6041.0 6101.3 6196.3 6212.0 6261.2 5805.3 5808.2 5853.9 5880.6 5932.9 5219.8 5231.1 5245.4 5248.4 5248.7 6224.3 6443.4 6453.1 6456.5 6475.3 6028.6 6120.8 6137.4 6143.4 6206.5 6453.4 6453.5 6459.5 6475.7 6475.9 6040.2 6077.7 6086.2 6099.9 6116.9 6017.6 6092.0 6111.0 6136.9 6139.7 6027.8 6030.1 6040.1 6042.3 6064.1 6034.1 6034.4 6036.1 6038.2 6047.1 5762.0 5777.7 5805.2 5913.0 5998.0 5971.2 5973.7 6032.2 6060.8 6071.0 5844.1 5878.3 5885.8 5901.9 5905.8 22:43:33 INFO - PROCESS | 3440 | 22:43:33 INFO - PROCESS | 3440 | [#1] ext.html Cycles:180 Average:64913.25 Median:43876.89 stddev:127263.80 (290.0%) stddev-sans-first:127529.25 22:43:33 INFO - PROCESS | 3440 | Values: 618.4 620.4 659.7 669.8 688.6 42575.0 43184.0 43363.3 43496.1 43504.0 43779.0 43861.8 43892.0 43987.0 44086.0 8618.4 8729.0 8802.2 8820.5 8820.9 8700.1 8705.8 8735.1 8773.9 8794.6 8827.6 8829.7 8857.3 8869.8 8886.7 8750.0 8766.6 8784.7 8786.2 8805.4 8670.6 8700.5 8748.5 8748.6 8762.1 40280.6 40950.0 40951.8 40964.4 41010.6 3450.2 3580.2 3650.6 3702.9 3781.0 31793.8 32385.0 32520.5 32831.9 32997.0 3986.5 4151.8 4161.9 4176.1 4216.9 381459.0 384567.0 385281.0 385329.0 386011.0 64615.4 64615.7 64773.7 65075.0 65130.0 68814.0 69102.7 69516.3 69534.0 69799.0 15275.0 15375.9 15416.8 15524.1 15528.5 13253.4 13341.7 13358.3 13396.7 13422.2 19657.0 19755.6 19785.7 19958.6 20026.4 7383.2 7506.6 7507.7 7724.7 7778.4 959.9 1007.9 1048.9 1109.9 1133.1 32750.3 33024.5 33314.0 33449.0 33974.0 1063.6 1096.2 1146.5 1148.3 1196.3 16750.8 17146.9 17478.0 17685.2 18766.2 423911.0 429094.0 559301.0 559426.0 560586.0 63510.7 64294.7 64378.4 64525.4 64562.0 1424.9 1428.9 1473.5 1474.0 1478.7 32760.8 34243.0 34612.1 34619.8 34717.0 55774.2 56479.0 56515.7 56587.7 56589.2 527771.0 530830.0 533009.0 533610.0 534062.0 45030.8 46832.3 48082.8 48159.8 48640.8 51290.2 51694.0 51831.2 51879.2 52688.5 42841.1 44159.3 44941.0 45329.8 45726.3 42735.8 44050.1 44366.0 44645.0 44856.3 43761.0 44379.1 45135.0 45186.8 45312.3 36636.8 38722.4 39047.8 39306.3 39318.4 29758.7 30127.5 30134.2 30269.5 30787.5 22:43:33 INFO - PROCESS | 3440 | 22:43:33 INFO - PROCESS | 3440 | [#2] jquery.html Cycles:180 Average:27512.23 Median:2095.01 stddev:70214.62 (3351.5%) stddev-sans-first:70382.12 22:43:33 INFO - PROCESS | 3440 | Values: 417.7 419.7 424.7 433.8 442.0 18186.2 19063.0 19815.9 20227.5 20272.0 19312.2 19594.6 20028.3 20084.2 20252.4 5720.6 5945.3 5969.0 5983.7 6011.7 5746.3 5867.6 5968.0 5974.6 6047.0 6114.2 6177.7 6188.8 6191.4 6200.2 6148.4 6180.8 6590.5 6621.9 6626.1 5743.3 5901.3 5933.3 5950.1 5961.7 14740.7 14971.9 15130.3 15147.0 15147.5 2188.2 2347.3 2382.3 2578.0 2898.1 10768.1 10834.2 10960.8 11256.9 11443.7 1876.4 1937.5 2021.0 2085.6 2104.4 85009.7 85262.6 86861.6 88131.0 88694.0 11633.2 11802.2 11913.4 11915.4 12067.2 16880.8 16960.2 17007.7 17034.0 17048.7 8172.9 8347.9 8428.3 8614.9 8718.4 7986.6 8033.4 8080.0 8089.7 8237.2 5117.8 5130.2 5134.3 5152.9 5192.4 1996.2 2035.9 2072.2 2106.4 2125.4 888.4 971.6 992.3 1025.9 1046.0 20375.3 20452.8 20563.2 20615.0 20703.9 1019.6 1029.5 1036.2 1058.2 1065.5 10675.2 11402.4 11418.8 11583.2 11591.9 364211.0 365018.0 366889.0 484717.0 501350.0 90354.5 91745.0 95528.0 101487.5 104377.5 1049.1 1083.3 1089.3 1090.1 1096.9 16685.1 17246.0 17573.7 17879.6 17904.6 34644.7 41532.2 42480.8 43529.0 43546.8 60429.7 62738.4 64218.7 64567.0 66118.0 8619.0 8740.1 8961.4 9188.3 9427.7 13097.4 14008.0 14078.9 14284.5 14406.9 12559.4 12582.3 12599.6 12624.7 12667.8 11728.4 11776.7 11815.1 11973.2 12045.9 12336.5 12410.6 12518.2 12784.9 12928.7 7738.9 7921.5 7996.2 8005.2 8311.5 10444.8 12061.9 12145.3 12466.1 12697.7 22:43:33 INFO - PROCESS | 3440 | 22:43:33 INFO - PROCESS | 3440 | [#3] mootools.html Cycles:180 Average:6069.92 Median:4822.45 stddev:3394.14 (70.4%) stddev-sans-first:3385.26 22:43:33 INFO - PROCESS | 3440 | Values: 1367.9 1445.8 1496.7 1729.3 1757.4 8204.7 8373.9 8790.8 9285.7 9384.8 8680.3 8964.6 8978.5 9235.0 9263.5 2480.4 2496.0 2509.1 2509.6 2513.0 2477.4 2557.0 2569.2 2575.6 2576.5 2447.5 2483.1 2500.6 2503.4 2513.4 2351.1 2371.2 2381.3 2420.0 2422.3 2410.5 2412.4 2441.6 2453.9 2459.0 8597.4 9155.0 9245.7 9285.5 9305.5 5646.3 5772.1 5774.7 5775.7 5788.0 3488.9 3546.1 3612.7 3643.1 3666.8 1140.6 1147.8 1175.7 1198.1 1202.3 12196.5 12197.9 12246.4 12302.8 12305.3 4697.1 4762.1 4882.8 5106.1 5227.0 10739.0 10745.6 10759.5 10828.4 10853.5 5798.2 5833.5 5833.8 5834.6 5840.6 5208.8 5343.1 5364.4 5410.2 5489.6 4118.0 4177.9 4194.8 4246.8 4251.9 1300.4 1301.7 1301.8 1304.7 1306.6 941.9 951.9 991.1 1018.2 1032.9 6292.6 6371.4 6453.0 6457.2 6727.4 933.6 981.0 999.0 1008.4 1049.7 4269.4 4406.1 4414.4 4419.8 4433.8 11288.7 11630.4 11652.7 11654.2 11664.6 11513.9 11523.7 11546.7 11559.7 11560.1 7715.5 8067.3 8122.7 8224.3 8577.9 5862.2 6159.2 6311.7 6393.5 6491.7 10569.1 10584.8 10623.5 10725.6 10733.4 10557.3 10583.5 10660.7 10666.8 10742.5 8140.4 8199.0 8322.8 8328.3 8376.5 8830.5 8855.2 8880.8 8901.5 8922.3 7826.9 7836.2 7888.8 7913.0 7918.9 7577.3 7710.2 7798.9 7807.6 7864.5 7281.2 7304.6 7307.3 7338.4 7455.7 5221.9 5281.0 5442.9 5479.8 5523.4 5074.2 5295.5 5330.2 5397.0 5559.5 22:43:33 INFO - PROCESS | 3440 | 22:43:33 INFO - PROCESS | 3440 | [#4] prototype.html Cycles:180 Average:4979.56 Median:5636.02 stddev:1461.07 (25.9%) stddev-sans-first:1423.09 22:43:33 INFO - PROCESS | 3440 | Values: 341.7 346.5 346.9 357.8 358.1 5596.8 5714.3 5721.2 5751.9 5764.3 5615.4 5626.5 5634.6 5637.4 5652.5 3951.9 4291.5 4335.5 4408.6 4429.2 4419.0 4422.1 4428.5 4436.2 4448.2 4402.4 4404.7 4411.3 4416.8 4425.8 4214.5 4357.7 4383.5 4423.6 4459.9 3846.2 3862.7 3871.0 3877.3 3881.9 5512.3 5533.8 5541.8 5561.6 5568.3 4868.3 4893.4 4928.5 5076.7 5126.5 5851.9 5895.3 5897.3 5907.5 5924.4 4231.2 4232.9 4252.1 4259.7 4268.9 6055.1 6116.0 6170.8 6195.5 6211.5 4289.0 4290.8 4296.8 4297.8 4305.4 4368.0 4373.5 4383.1 4404.8 4410.0 4838.6 5013.5 5015.4 5053.3 5130.6 5926.5 5929.4 5934.6 5968.0 5977.1 1509.3 1518.5 1527.4 1532.0 1533.0 1057.8 1073.5 1074.4 1083.6 1120.8 5592.6 5618.2 5642.7 5672.9 5676.3 5856.3 5873.4 5890.3 5900.5 5982.7 5374.9 5509.2 5592.4 5598.9 5608.7 3109.6 3131.3 3139.1 3143.9 3156.9 5954.5 6071.0 6099.7 6123.5 6164.5 5972.1 5975.1 5987.7 6006.4 6044.6 6210.9 6221.8 6365.2 6372.3 6392.4 6028.5 6115.5 6118.2 6121.7 6138.3 5864.1 5986.7 6003.5 6003.6 6061.7 6345.7 6346.9 6354.7 6380.2 6386.3 4171.7 4327.6 4469.9 4488.0 4498.2 6085.4 6098.5 6111.7 6118.8 6123.3 5964.9 5976.5 5992.6 6011.1 6022.5 5833.6 5858.5 5888.7 5910.1 5966.9 5864.9 5885.8 5891.5 5919.6 5920.8 5810.4 5969.5 5985.4 5994.4 6051.0 5794.7 5832.3 5860.7 5862.8 5877.6 22:43:33 INFO - PROCESS | 3440 | 22:43:33 INFO - PROCESS | 3440 | [#5] yui.html Cycles:180 Average:17685.18 Median:48335.32 stddev:22958.49 (47.5%) stddev-sans-first:22987.45 22:43:33 INFO - PROCESS | 3440 | Values: 694.4 735.4 746.8 772.0 827.7 13689.4 14146.4 14234.7 14244.5 14285.0 13439.5 13488.8 13769.3 13783.7 13794.2 682.9 698.7 781.9 804.6 819.4 823.0 823.7 825.0 829.4 831.4 855.5 868.4 869.3 870.2 872.4 859.8 861.7 862.9 864.9 865.3 627.3 631.2 633.2 633.9 636.7 13422.4 13501.6 13539.9 13565.1 14720.2 14101.5 14974.0 15437.9 15512.8 15529.1 11923.2 12044.2 12077.4 12114.8 12352.5 3851.5 3869.8 3880.5 3901.4 3991.6 65758.3 66359.3 66476.0 67313.0 68549.0 11602.3 11661.8 11905.2 12034.2 12156.9 21729.3 21946.5 22130.3 22230.3 22518.7 8293.7 8598.9 8599.5 8608.7 8654.2 4656.5 4735.9 4738.5 4771.4 4785.3 3605.5 3729.9 3739.5 3745.0 3750.3 665.9 674.6 694.6 704.9 706.9 686.5 699.6 711.9 751.1 783.7 9196.4 9574.0 9716.0 9761.2 9766.6 621.3 695.9 698.6 711.1 730.1 4200.7 4315.4 4428.6 4437.4 4504.8 58127.7 58368.4 58394.1 76964.2 90174.5 75026.6 77353.6 78115.0 79276.6 80052.6 72095.6 72177.3 73743.6 74637.3 74691.0 8526.3 8598.0 8605.1 8700.3 8732.3 47997.6 48673.0 48978.3 49519.0 50491.5 52287.7 63949.0 64817.7 66454.3 66665.0 11511.4 11686.9 11772.0 12015.3 12099.8 12359.7 13116.5 13375.7 13399.5 13876.2 12856.4 12872.2 12907.6 12959.2 12985.5 11944.3 12028.8 12270.4 12403.9 12656.5 12398.9 12435.0 12630.9 12923.7 13142.6 10463.8 10513.1 10954.0 11139.2 11216.8 10815.8 11112.6 11158.8 11278.8 11339.7 22:43:33 INFO - PROCESS | 3440 | -------- Summary: end -------- 22:43:33 INFO - PROCESS | 3440 | 22:43:33 INFO - TEST-INFO | 3440: exit 0 22:43:33 INFO - TEST-OK | dromaeo_css | took 1114455ms 22:43:33 INFO - TEST-START | kraken 22:43:33 INFO - operating with platform_type : linux_ 22:43:33 INFO - Initialising browser for kraken test... 22:43:33 INFO - TEST-INFO | started process 3809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt__na1/profile http://localhost:50703/getInfo.html) 22:43:38 INFO - PROCESS | 3809 | __metrics Screen width/height:1600/1200 22:43:38 INFO - PROCESS | 3809 | colorDepth:24 22:43:38 INFO - PROCESS | 3809 | Browser inner width/height: 1024/697 22:43:38 INFO - PROCESS | 3809 | __metrics 22:43:38 ERROR - PROCESS | 3809 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 22:43:39 INFO - TEST-INFO | 3809: exit 0 22:43:39 INFO - Browser initialized. 22:43:39 INFO - Running cycle 1/1 for kraken test... 22:43:39 INFO - TEST-INFO | started process 3941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt__na1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:43:51 INFO - PROCESS | 3941 | RSS: Main: 151740416 22:43:51 INFO - PROCESS | 3941 | 22:43:54 INFO - PROCESS | 3941 | Cycle 1(1): loaded http://localhost:50703/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50703/tests/kraken/driver.html?testName=audio-beat-detection) 22:43:55 INFO - PROCESS | 3941 | RSS: Main: 156766208 22:43:55 INFO - PROCESS | 3941 | 22:43:57 INFO - PROCESS | 3941 | Cycle 1(1): loaded http://localhost:50703/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50703/tests/kraken/driver.html?testName=audio-dft) 22:43:58 INFO - PROCESS | 3941 | RSS: Main: 154894336 22:43:58 INFO - PROCESS | 3941 | 22:44:01 INFO - PROCESS | 3941 | Cycle 1(1): loaded http://localhost:50703/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50703/tests/kraken/driver.html?testName=audio-fft) 22:44:01 INFO - PROCESS | 3941 | RSS: Main: 155172864 22:44:01 INFO - PROCESS | 3941 | 22:44:03 INFO - PROCESS | 3941 | Cycle 1(1): loaded http://localhost:50703/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50703/tests/kraken/driver.html?testName=audio-oscillator) 22:44:04 INFO - PROCESS | 3941 | RSS: Main: 154988544 22:44:04 INFO - PROCESS | 3941 | 22:44:06 INFO - PROCESS | 3941 | Cycle 1(1): loaded http://localhost:50703/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50703/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:44:07 INFO - PROCESS | 3941 | RSS: Main: 154673152 22:44:07 INFO - PROCESS | 3941 | 22:44:10 INFO - PROCESS | 3941 | Cycle 1(1): loaded http://localhost:50703/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50703/tests/kraken/driver.html?testName=imaging-darkroom) 22:44:10 INFO - PROCESS | 3941 | RSS: Main: 158322688 22:44:10 INFO - PROCESS | 3941 | 22:44:14 INFO - PROCESS | 3941 | Cycle 1(1): loaded http://localhost:50703/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50703/tests/kraken/driver.html?testName=imaging-desaturate) 22:44:14 INFO - PROCESS | 3941 | RSS: Main: 158347264 22:44:14 INFO - PROCESS | 3941 | 22:44:17 INFO - PROCESS | 3941 | Cycle 1(1): loaded http://localhost:50703/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50703/tests/kraken/driver.html?testName=json-parse-financial) 22:44:18 INFO - PROCESS | 3941 | RSS: Main: 157696000 22:44:18 INFO - PROCESS | 3941 | 22:44:19 INFO - PROCESS | 3941 | Cycle 1(1): loaded http://localhost:50703/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50703/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:44:20 INFO - PROCESS | 3941 | RSS: Main: 157134848 22:44:20 INFO - PROCESS | 3941 | 22:44:21 INFO - PROCESS | 3941 | Cycle 1(1): loaded http://localhost:50703/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50703/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:44:22 INFO - PROCESS | 3941 | RSS: Main: 157274112 22:44:22 INFO - PROCESS | 3941 | 22:44:24 INFO - PROCESS | 3941 | Cycle 1(1): loaded http://localhost:50703/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50703/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:44:25 INFO - PROCESS | 3941 | RSS: Main: 157687808 22:44:25 INFO - PROCESS | 3941 | 22:44:28 INFO - PROCESS | 3941 | Cycle 1(1): loaded http://localhost:50703/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:44:28 INFO - PROCESS | 3941 | RSS: Main: 157495296 22:44:28 INFO - PROCESS | 3941 | 22:44:31 INFO - PROCESS | 3941 | Cycle 1(1): loaded http://localhost:50703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:44:32 INFO - PROCESS | 3941 | RSS: Main: 157986816 22:44:32 INFO - PROCESS | 3941 | 22:44:33 INFO - PROCESS | 3941 | Cycle 1(1): loaded http://localhost:50703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50703/tests/kraken/driver.html?testName=ai-astar) 22:44:34 INFO - PROCESS | 3941 | RSS: Main: 159817728 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | __start_tp_report 22:44:34 INFO - PROCESS | 3941 | _x_x_mozilla_page_load 22:44:34 INFO - PROCESS | 3941 | _x_x_mozilla_page_load_details 22:44:34 INFO - PROCESS | 3941 | |i|pagename|runs| 22:44:34 INFO - PROCESS | 3941 | |0;ai-astar;103;112;111;113;113;112;111;112;110;111 22:44:34 INFO - PROCESS | 3941 | |1;audio-beat-detection;139;120;119;153;119;119;118;123;158;122 22:44:34 INFO - PROCESS | 3941 | |2;audio-dft;162;162;164;161;164;162;161;161;162;160 22:44:34 INFO - PROCESS | 3941 | |3;audio-fft;75;76;75;112;76;77;76;76;98;77 22:44:34 INFO - PROCESS | 3941 | |4;audio-oscillator;81;82;121;83;82;81;102;82;81;110 22:44:34 INFO - PROCESS | 3941 | |5;imaging-gaussian-blur;118;117;117;117;118;117;117;118;117;117 22:44:34 INFO - PROCESS | 3941 | |6;imaging-darkroom;146;149;147;164;146;151;149;146;147;146 22:44:34 INFO - PROCESS | 3941 | |7;imaging-desaturate;85;86;85;86;85;85;85;84;86;85 22:44:34 INFO - PROCESS | 3941 | |8;json-parse-financial;57;55;52;51;51;50;50;51;51;53 22:44:34 INFO - PROCESS | 3941 | |9;json-stringify-tinderbox;60;60;59;60;60;60;60;60;60;59 22:44:34 INFO - PROCESS | 3941 | |10;stanford-crypto-aes;75;76;78;75;77;79;75;81;76;82 22:44:34 INFO - PROCESS | 3941 | |11;stanford-crypto-ccm;135;127;131;124;120;121;131;124;171;134 22:44:34 INFO - PROCESS | 3941 | |12;stanford-crypto-pbkdf2;160;155;155;157;160;160;159;159;166;159 22:44:34 INFO - PROCESS | 3941 | |13;stanford-crypto-sha256-iterative;65;66;65;63;64;62;62;63;61;65 22:44:34 INFO - PROCESS | 3941 | __end_tp_report 22:44:34 INFO - PROCESS | 3941 | __start_cc_report 22:44:34 INFO - PROCESS | 3941 | _x_x_mozilla_cycle_collect,808 22:44:34 INFO - PROCESS | 3941 | __end_cc_report 22:44:34 INFO - PROCESS | 3941 | __startTimestamp1482389074178__endTimestamp 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | ------- Summary: start ------- 22:44:34 INFO - PROCESS | 3941 | Number of tests: 14 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:2.90 (2.6%) stddev-sans-first:1.00 22:44:34 INFO - PROCESS | 3941 | Values: 103.0 112.0 111.0 113.0 113.0 112.0 111.0 112.0 110.0 111.0 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:122.50 stddev:15.29 (12.5%) stddev-sans-first:15.78 22:44:34 INFO - PROCESS | 3941 | Values: 139.0 120.0 119.0 153.0 119.0 119.0 118.0 123.0 158.0 122.0 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 22:44:34 INFO - PROCESS | 3941 | Values: 162.0 162.0 164.0 161.0 164.0 162.0 161.0 161.0 162.0 160.0 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:12.68 (16.7%) stddev-sans-first:13.21 22:44:34 INFO - PROCESS | 3941 | Values: 75.0 76.0 75.0 112.0 76.0 77.0 76.0 76.0 98.0 77.0 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:81.50 stddev:14.86 (18.2%) stddev-sans-first:15.36 22:44:34 INFO - PROCESS | 3941 | Values: 81.0 82.0 121.0 83.0 82.0 81.0 102.0 82.0 81.0 110.0 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 22:44:34 INFO - PROCESS | 3941 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:148.00 stddev:5.51 (3.7%) stddev-sans-first:5.73 22:44:34 INFO - PROCESS | 3941 | Values: 146.0 149.0 147.0 164.0 146.0 151.0 149.0 146.0 147.0 146.0 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 22:44:34 INFO - PROCESS | 3941 | Values: 85.0 86.0 85.0 86.0 85.0 85.0 85.0 84.0 86.0 85.0 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:51.50 stddev:2.28 (4.4%) stddev-sans-first:1.59 22:44:34 INFO - PROCESS | 3941 | Values: 57.0 55.0 52.0 51.0 51.0 50.0 50.0 51.0 51.0 53.0 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 22:44:34 INFO - PROCESS | 3941 | Values: 60.0 60.0 59.0 60.0 60.0 60.0 60.0 60.0 60.0 59.0 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:77.50 stddev:2.55 (3.3%) stddev-sans-first:2.55 22:44:34 INFO - PROCESS | 3941 | Values: 75.0 76.0 78.0 75.0 77.0 79.0 75.0 81.0 76.0 82.0 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:131.00 stddev:14.73 (11.2%) stddev-sans-first:15.58 22:44:34 INFO - PROCESS | 3941 | Values: 135.0 127.0 131.0 124.0 120.0 121.0 131.0 124.0 171.0 134.0 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.00 Median:159.50 stddev:3.13 (2.0%) stddev-sans-first:3.30 22:44:34 INFO - PROCESS | 3941 | Values: 160.0 155.0 155.0 157.0 160.0 160.0 159.0 159.0 166.0 159.0 22:44:34 INFO - PROCESS | 3941 | 22:44:34 INFO - PROCESS | 3941 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.50 stddev:1.65 (2.6%) stddev-sans-first:1.67 22:44:34 INFO - PROCESS | 3941 | Values: 65.0 66.0 65.0 63.0 64.0 62.0 62.0 63.0 61.0 65.0 22:44:34 INFO - PROCESS | 3941 | -------- Summary: end -------- 22:44:34 INFO - PROCESS | 3941 | 22:44:35 INFO - TEST-INFO | 3941: exit 0 22:44:35 INFO - TEST-OK | kraken | took 61340ms 22:44:35 INFO - SUITE-END | took 1175s 22:44:35 INFO - Completed test suite (00:19:35) 22:44:35 INFO - javascript benchmark 22:44:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7517.933087661006, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3327.4010678077952, 3327.633960264371, 3343.0639420962125, 3345.7992520448774, 3362.22668786179, 5670.546356291497, 5702.885942281152, 5710.172025056364, 5712.114622233556, 5720.141978703186, 5717.228174196493, 5782.45066718661, 5783.363829978699, 5788.5369170466365, 5816.214811000514, 5201.271821944931, 5249.527542521172, 5306.469353064701, 5306.787728490855, 5330.813421530247, 5292.947070529284, 5304.416514183436, 5307.150855863063, 5329.786808527654, 5347.438518955492, 5173.042987047389, 5214.817481388152, 5319.0, 5330.093884039723, 5344.812931547397, 5217.765200565984, 5239.869003274911, 5241.397239317489, 5272.551833094172, 5310.256564081032, 5221.086309895753, 5262.605304602132, 5265.710385928773, 5289.074411977888, 5330.813421530228, 5584.274044374205, 5695.857603559903, 5707.229524014247, 5774.133879918004, 5794.188813566104, 6059.909101363483, 6106.755729770804, 6115.388461153893, 6129.540284478682, 6140.925338065821, 6127.6017058891475, 6162.752463606377, 6174.320824709278, 6184.257889053298, 6203.658798766066, 5659.8585035374035, 5706.058500347479, 5709.628874123168, 5735.1970724098655, 5781.739821707991, 6210.254769427697, 6321.683915804191, 6328.6202827830475, 6332.303446620868, 6335.303116657164, 6054.334023257438, 6061.666608336495, 6068.726907289182, 6093.482054025458, 6096.116063170904, 6003.0695242237525, 6020.337762846083, 6144.477719393813, 6174.8147555573405, 6174.845628859224, 6096.786612468542, 6097.420745029215, 6104.881809607925, 6116.990696535111, 6174.536909731698, 6112.655464441461, 6128.686460748404, 6129.603311142676, 6138.3577446079025, 6143.818944274718, 4507.233770259064, 4600.125976064537, 4601.780498260391, 4607.9308810367875, 4612.630989520897, 4039.7778122203563, 4079.8164082616354, 4084.244414783275, 4109.691773117028, 4162.729422587522, 5929.703514824328, 5932.911006334908, 5935.881282374415, 5945.137954996501, 5950.077737950624, 6041.0, 6101.267847858197, 6196.256449226122, 6212.0, 6261.154744109578, 5805.274340707411, 5808.244928159397, 5853.88292234153, 5880.647161170344, 5932.911006334908, 5219.817306394334, 5231.136862417735, 5245.3705555332845, 5248.396434410015, 5248.737563121828, 6224.315325314303, 6443.387878151568, 6453.096566480696, 6456.51576131792, 6475.287718350977, 6028.608140470856, 6120.751898419022, 6137.355577664281, 6143.419763699347, 6206.534509911865, 6453.419192272718, 6453.548251622341, 6459.515536334699, 6475.676216189077, 6475.870482590228, 6040.244969378828, 6077.6961151943115, 6086.239220097488, 6099.908501372572, 6116.877662446637, 6017.578769486094, 6092.0, 6111.0, 6136.938630613815, 6139.662318572343, 6027.75888964454, 6030.1256317832795, 6040.124181993674, 6042.335343112166, 6064.06007068905, 6034.125051867542, 6034.366391529002, 6036.094585811988, 6038.245219347582, 6047.123167140828, 5762.049261871744, 5777.740001700017, 5805.187273781589, 5913.0, 5998.0, 5971.193888825127, 5973.671448070224, 6032.1856549365275, 6060.787872424444, 6070.998285282879, 5844.12338149264, 5878.265216847894, 5885.764569417347, 5901.940980590139, 5905.822825315247], "value": 5668.783834630532, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.3538202578306, 620.3827191944016, 659.7361055577768, 669.8057563306638, 688.6040526697151, 42575.0, 43184.0, 43363.34954975678, 43496.13007739843, 43504.0, 43779.0, 43861.7806910965, 43892.0, 43987.0, 44086.0, 8618.353623478233, 8728.956355218215, 8802.207801297882, 8820.514871682055, 8820.911790882104, 8700.086490918457, 8705.825883482326, 8735.082816304292, 8773.868391974125, 8794.560271986407, 8827.602757875911, 8829.735107946772, 8857.335699822539, 8869.778255543599, 8886.73339799807, 8750.0, 8766.649334026632, 8784.692535761218, 8786.16531429513, 8805.42764720291, 8670.566471676391, 8700.521471319074, 8748.518831464267, 8748.606312715943, 8762.123787621187, 40280.59719402827, 40950.0, 40951.7952410239, 40964.38553421701, 41010.58989410097, 3450.189205536697, 3580.2481478889463, 3650.6349365063547, 3702.8889133326043, 3781.0, 31793.841030794698, 32385.0, 32520.512192317135, 32831.88229061502, 32997.0, 3986.521617405901, 4151.813168407429, 4161.854335098257, 4176.1230141670285, 4216.85241016566, 381459.0, 384567.0, 385281.0, 385328.9999999972, 386011.0, 64615.353846461876, 64615.67692161603, 64773.676131619985, 65075.0, 65130.0, 68814.0, 69102.65448672825, 69516.30483695098, 69534.0, 69799.0, 15275.0, 15375.923120384326, 15416.768748468781, 15524.14617196065, 15528.456504022304, 13253.403596838165, 13341.66645833862, 13358.265295408652, 13396.665083372995, 13422.194668319931, 19657.0, 19755.604887902162, 19785.703214451794, 19958.60082798336, 20026.399208023784, 7383.187849336568, 7506.624668766649, 7507.737229196952, 7724.6523906424345, 7778.377729781604, 959.8896126945491, 1007.9294449388619, 1048.8898665640152, 1109.9400072930493, 1133.0991861469986, 32750.344993100003, 33024.50463243053, 33314.0, 33449.0, 33974.0, 1063.5798859450474, 1096.2107282756403, 1146.5070019891527, 1148.3167515328532, 1196.300164403816, 16750.83249167517, 17146.91426542884, 17478.0, 17685.20416581257, 18766.155523001496, 423911.0, 429094.0, 559301.0, 559426.0, 560586.0, 63510.682446587474, 64294.678526607066, 64378.35621643817, 64525.354746452875, 64562.0, 1424.8717615414662, 1428.9356978935973, 1473.528470889305, 1474.0, 1478.6968671422333, 32760.83619581887, 34243.0, 34612.134696632784, 34619.82690086534, 34717.0, 55774.163387548404, 56479.0, 56515.71742141263, 56587.71706141443, 56589.15116273342, 527771.0, 530830.0, 533009.0, 533610.0, 534062.0, 45030.77484612556, 46832.297515537975, 48082.75958620184, 48159.75920120377, 48640.75679621579, 51290.23064653959, 51694.0, 51831.222531661304, 51879.2218116721, 52688.47311526836, 42841.14317713566, 44159.33760993523, 44941.0, 45329.773351134354, 45726.314105289115, 42735.7863210682, 44050.118997620506, 44366.0, 44645.0, 44856.32715509205, 43761.0, 44379.11241775211, 45135.0, 45186.77406612946, 45312.32031519596, 36636.81681591575, 38722.41916371313, 39047.80476097601, 39306.31239807431, 39318.41022384609, 29758.702412975592, 30127.548086779156, 30134.246643834078, 30269.545956810223, 30787.53818692766], "value": 21228.710463105686, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.7347384410898, 419.6663652396343, 424.74303046656763, 433.8199647146434, 441.97348159110436, 18186.181621827018, 19063.0, 19815.900920495376, 20227.494312642193, 20272.0, 19312.227510899545, 19594.608107837834, 20028.29900953467, 20084.196632134695, 20252.39242822714, 5720.628159169651, 5945.256842894638, 5968.955432799265, 5983.730732117044, 6011.729472173763, 5746.281714785652, 5867.55993300502, 5967.955607768645, 5974.641521508724, 6046.96976515119, 6114.1745864308195, 6177.691115444232, 6188.81433556994, 6191.442770150686, 6200.162977997958, 6148.415900489446, 6180.783672571461, 6590.505712071614, 6621.93378066218, 6626.072349871022, 5743.339515955677, 5901.262342207224, 5933.3473317934995, 5950.137230101611, 5961.731722072517, 14740.70518589633, 14971.92514037423, 15130.319135638923, 15147.0, 15147.54557363281, 2188.2122435923056, 2347.33101066197, 2382.332946774906, 2578.046122934526, 2898.145047211078, 10768.138548916146, 10834.241603087787, 10960.780784384267, 11256.943715281372, 11443.656690299304, 1876.3995521433146, 1937.4865660599953, 2020.9794054002634, 2085.6141613801497, 2104.400245929918, 85009.72485412662, 85262.5736871318, 86861.56569217113, 88131.0, 88694.0, 11633.243839150597, 11802.232854864405, 11913.404329783476, 11915.404229788475, 12067.198832367776, 16880.831191688172, 16960.236789344508, 17007.659846803243, 17034.0, 17048.744268835977, 8172.910205982206, 8347.874781878276, 8428.283595894294, 8614.913850861536, 8718.43330183536, 7986.600669966479, 8033.3974951878845, 8080.0, 8089.676412943534, 8237.217464340878, 5117.769700363493, 5130.1535246684625, 5134.332536770271, 5152.871178220575, 5192.350956130484, 1996.161612122912, 2035.9185632574827, 2072.202202152182, 2106.3680895731527, 2125.4048866317457, 888.3825741109866, 971.5967873332629, 992.2607657295362, 1025.8666373371414, 1045.9592705258317, 20375.28686495995, 20452.795472045385, 20563.177472900916, 20615.0, 20703.896480517804, 1019.622739586343, 1029.5264178477985, 1036.1555332404066, 1058.1640504001907, 1065.5151905882806, 10675.199360047873, 11402.372869492257, 11418.771624567462, 11583.24708893936, 11591.942040289914, 364211.0, 365018.0, 366889.0, 484717.0, 501350.0, 90354.54822725845, 91745.0, 95528.0, 101487.49256253672, 104377.47811260895, 1049.1134990932649, 1083.268793564341, 1089.2647462962468, 1090.111559079348, 1096.8793432722393, 16685.08232047249, 17246.0, 17573.736393953845, 17879.642407151525, 17904.552386189927, 34644.653553464144, 41532.1693566133, 42480.78759606182, 43529.0, 43546.78226608847, 60429.697851510464, 62738.37261627326, 64218.67890660517, 64567.0, 66118.0, 8618.956905215433, 8740.125987401208, 8961.417507861968, 9188.310876684409, 9427.717168484956, 13097.41061652209, 14008.0, 14078.929605351908, 14284.500042498463, 14406.927965360526, 12559.372031398576, 12582.30797306157, 12599.559015434783, 12624.747505049663, 12667.80998285008, 11728.354940478015, 11776.70558236051, 11815.113866460222, 11973.221740586834, 12045.879541204476, 12336.50653973831, 12410.5656302029, 12518.186317889307, 12784.872151278369, 12928.741425171633, 7738.92261077382, 7921.485103468256, 7996.200379961957, 8005.239502247277, 8311.503929292785, 10444.791104178026, 12061.939690301493, 12145.332006739714, 12466.065045121471, 12697.682557935756], "value": 9494.933522568012, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.8563750806165, 1445.833729121151, 1496.7380708376031, 1729.3428497171074, 1757.4376199616113, 8204.671813127468, 8373.874391884126, 8790.824183516326, 9285.721428357143, 9384.81230375392, 8680.348973826956, 8964.596593153308, 8978.50618215998, 9235.0, 9263.490508022056, 2480.441900572375, 2495.987520062397, 2509.1092662104966, 2509.5608268553024, 2513.0450428837016, 2477.417806815397, 2557.0283292348972, 2569.2292312306326, 2575.613657951313, 2576.497582971321, 2447.4982628561193, 2483.0936708101503, 2500.58740307849, 2503.4367267364787, 2513.40934880303, 2351.1065794997876, 2371.2293504610984, 2381.3332266965276, 2419.9637005444933, 2422.2975337152207, 2410.4817464245098, 2412.3848418653133, 2441.5727247731575, 2453.858955585661, 2459.0409740201335, 8597.398182127254, 9154.954225228832, 9245.722628321093, 9285.535723213812, 9305.53472326381, 5646.322441307069, 5772.134179873011, 5774.653520788766, 5775.682337471438, 5788.04497257952, 3488.8953331399844, 3546.148924258185, 3612.747107702462, 3643.0710168906758, 3666.7616604920595, 1140.589387820384, 1147.822087576427, 1175.7354595216093, 1198.101423932051, 1202.2966564559742, 12196.451159697746, 12197.939010304892, 12246.387680616022, 12302.753944921142, 12305.26168429897, 4697.061313338977, 4762.14281429346, 4882.7558622068755, 5106.055379754757, 5227.0, 10739.0, 10745.570177192982, 10759.515821788038, 10828.350298982086, 10853.51159197838, 5798.188253644493, 5833.50415214703, 5833.766649334064, 5834.649921004753, 5840.59115861894, 5208.817691380784, 5343.091674415358, 5364.3830959440165, 5410.161424979135, 5489.560835133179, 4117.958820411817, 4177.937330940038, 4194.8112334945, 4246.766427846436, 4251.87244382669, 1300.4213125159401, 1301.7006088599676, 1301.7526669932683, 1304.6673098359859, 1306.5688322853625, 941.9433936874885, 951.9286053546011, 991.0634450444261, 1018.2414101494434, 1032.8605638238892, 6292.590981586274, 6371.362863713592, 6452.9677351612945, 6457.225132984072, 6727.360900714424, 933.570557543524, 981.0434826044692, 998.9800203995879, 1008.4151192308443, 1049.6536143072767, 4269.4449721536, 4406.140802543473, 4414.448193975753, 4419.779011049434, 4433.800478978454, 11288.661340159808, 11630.360330181922, 11652.650420487398, 11654.242474239147, 11664.591739289084, 11513.88486115145, 11523.654290371302, 11546.711332216593, 11559.711007224718, 11560.075193984461, 7715.4599178058115, 8067.273945344947, 8122.715704950417, 8224.259816616533, 8577.914220857836, 5862.208601838868, 6159.19930409044, 6311.65285909261, 6393.520485963664, 6491.675416229075, 10569.149963119518, 10584.84122738175, 10623.468826558486, 10725.570977160825, 10733.409662468326, 10557.260991730505, 10583.4708264588, 10660.680179594625, 10666.83999739989, 10742.462876855969, 8140.430169888051, 8199.0, 8322.833543329221, 8328.250457458858, 8376.53929033909, 8830.514321712368, 8855.158759917798, 8880.777980550538, 8901.465912045298, 8922.286217102746, 7826.882596761167, 7836.216378362118, 7888.802779930547, 7913.0, 7918.881216781638, 7577.280158384945, 7710.228977102245, 7798.922010779819, 7807.648655810389, 7864.5281283123195, 7281.235470275545, 7304.598247096461, 7307.342339189286, 7338.412926965937, 7455.6644950978425, 5221.947780522146, 5281.0, 5442.891142177214, 5479.780808767605, 5523.364813046551, 5074.188129899198, 5295.523402893758, 5330.173823057432, 5397.0, 5559.471850174227], "value": 4872.246670623441, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.73686261578587, 346.4629823773151, 346.8629891192979, 357.78354095772056, 358.07080625776103, 5596.776128954842, 5714.257146570951, 5721.199032135499, 5751.942480575193, 5764.25064741583, 5615.438456154383, 5626.470691093668, 5634.605577609559, 5637.436256374361, 5652.5195358394585, 3951.920961580781, 4291.46356705411, 4335.479742430913, 4408.625266852321, 4429.1584598926265, 4418.955810441903, 4422.11557688462, 4428.512863585019, 4436.245838207513, 4448.199324121657, 4402.361657559652, 4404.66964977628, 4411.2941929291155, 4416.82332706693, 4425.7565833879125, 4214.452121224222, 4357.738535687838, 4383.49589797171, 4423.557644235567, 4459.933101003504, 3846.173072789336, 3862.671672907806, 3870.974191839165, 3877.2827027000094, 3881.8835434936714, 5512.33851937766, 5533.750981205815, 5541.750621222014, 5561.58288128392, 5568.331800183963, 4868.342773725537, 4893.412790465131, 4928.482509336504, 5076.720780357079, 5126.53861152498, 5851.8537036574, 5895.322037965646, 5897.3218079920925, 5907.527397808208, 5924.377940316248, 4231.1749208904275, 4232.851850185229, 4252.064545799919, 4259.680523960716, 4268.87193384199, 6055.091736239555, 6115.9694201529155, 6170.814875553696, 6195.504359651262, 6211.503079753609, 4289.027047558096, 4290.806913688892, 4296.818374946914, 4297.806598703066, 4305.440292761921, 4368.0, 4373.453318335208, 4383.145286669069, 4404.801783919731, 4410.0, 4838.5968069260225, 5013.473585273567, 5015.3730783652045, 5053.343065401475, 5130.615203859726, 5926.525877929756, 5929.37741537141, 5934.6142500737315, 5967.9701601491715, 5977.1333156692035, 1509.2680050175657, 1518.468536012409, 1527.3737767515265, 1531.958268377514, 1532.9846701532842, 1057.8201705710048, 1073.5330131392868, 1074.355386767933, 1083.6261489786168, 1120.8374785656035, 5592.608517403743, 5618.2415373924, 5642.7178641067785, 5672.858178545487, 5676.347220069745, 5856.297244330707, 5873.4435374625755, 5890.263717035371, 5900.4984576310635, 5982.670953097534, 5374.892502149935, 5509.228707980886, 5592.440755924375, 5598.86002849932, 5608.691521966331, 3109.626844778596, 3131.2954585218145, 3139.100843989399, 3143.8742450301734, 3156.936861262762, 5954.541137421273, 6071.0, 6099.725512351954, 6123.479504242189, 6164.506839452833, 5972.104184372379, 5975.103734439869, 5987.670678112659, 6006.429389208019, 6044.637321760709, 6210.875782484325, 6221.786751583489, 6365.2361716594305, 6372.2671892732005, 6392.360763923663, 6028.547858910687, 6115.480184184395, 6118.174046503665, 6121.724522396414, 6138.324784273816, 5864.120381942743, 5986.6707331097205, 6003.519718422428, 6003.5797494174985, 6061.666608336407, 6345.650989195638, 6346.936530634634, 6354.745810167541, 6380.202474690664, 6386.265579458236, 4171.749695018309, 4327.593532102016, 4469.865904022885, 4487.955120448884, 4498.212812757689, 6085.391460853879, 6098.481629061402, 6111.716539526571, 6118.847028824137, 6123.326434092157, 5964.8807023860145, 5976.521878249817, 5992.550558708027, 6011.128386384037, 6022.548308876764, 5833.562482813721, 5858.47273745365, 5888.705564721661, 5910.143029260819, 5966.880662386641, 5864.853378665567, 5885.761672111738, 5891.527118220445, 5919.6152250103605, 5920.79277225295, 5810.448007439287, 5969.492593129633, 5985.40145985398, 5994.381516990301, 6050.97292407031, 5794.7102644866745, 5832.270966129234, 5860.736266868086, 5862.824115276549, 5877.647341159544], "value": 4518.093329061792, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.3889377347933, 735.3712575747736, 746.8319628083678, 771.9732755435272, 827.7227128911816, 13689.383977721001, 14146.363413646384, 14234.715305693893, 14244.501442449517, 14284.999999999975, 13439.462421503153, 13488.797668034988, 13769.311534423265, 13783.65540861479, 13794.241316727575, 682.9009793579941, 698.6925752668809, 781.9335356494705, 804.569555287921, 819.4264015189391, 822.9753107406757, 823.6622984576325, 825.038829763325, 829.3945419843518, 831.3930830493713, 855.4781583234222, 868.439856292694, 869.3132425383939, 870.2298465857698, 872.3762509805488, 859.8452278589851, 861.6854847980474, 862.8619420892627, 864.8745931839879, 865.2688478235881, 627.2817623820699, 631.204682100552, 633.1926793338484, 633.9366063393624, 636.7389370358131, 13422.395992180278, 13501.59495215145, 13539.932300338436, 13565.118267312593, 14720.190389528572, 14101.506447274398, 14974.0, 15437.922810385877, 15512.767308490382, 15529.145896975662, 11923.224990375598, 12044.21712588679, 12077.396130193543, 12114.81827772584, 12352.505899763999, 3851.5378154621626, 3869.8452061917487, 3880.4567360569545, 3901.43429202764, 3991.600839916014, 65758.3424165757, 66359.33640663628, 66476.0, 67312.99030514596, 68549.0, 11602.256545619626, 11661.766764664659, 11905.226160299553, 12034.217775844718, 12156.878431215751, 21729.348119556438, 21946.45133871666, 22130.336089917328, 22230.333090007003, 22518.66222006671, 8293.677092728385, 8598.914010859811, 8599.484030958163, 8608.65565377378, 8654.22112009922, 4656.4877863434995, 4735.928961065587, 4738.549837765407, 4771.403574553181, 4785.3300537924715, 3605.4591811228, 3729.8881033568496, 3739.495168152265, 3745.0, 3750.268697603941, 665.9433948114367, 674.639068098565, 694.5728377048079, 704.8766465868453, 706.8727629026722, 686.543448606681, 699.5907394174363, 711.8576284743073, 751.1474476469247, 783.6982761636697, 9196.402233854911, 9573.952130239444, 9716.02839716037, 9761.219102471785, 9766.560504777302, 621.3351713666424, 695.8900553616973, 698.5878331784272, 711.0898050495374, 730.1129128109372, 4200.7479551227025, 4315.352697095461, 4428.645708343325, 4437.400950871655, 4504.819807207675, 58127.70936145292, 58368.4163158363, 58394.12408813871, 76964.23035769683, 90174.54912725394, 75026.62486687531, 77353.61323193349, 78115.0, 79276.60361698155, 80052.5997370021, 72095.63952180206, 72177.27822721706, 73743.63128184433, 74637.25362746412, 74691.0, 8526.275266602408, 8597.957010214908, 8605.139486051345, 8700.260477859452, 8732.34507411934, 47997.622703183755, 48673.0265394683, 48978.26532602085, 49519.0, 50491.49508505015, 52287.73856130695, 63949.0, 64817.67591162014, 66454.33545664481, 66665.0, 11511.424428778695, 11686.94156529212, 11772.0, 12015.339156346485, 12099.75800484003, 12359.707076335528, 13116.475340986253, 13375.665608359868, 13399.53101641438, 13876.167429954236, 12856.42146103409, 12872.22766634005, 12907.612771616867, 12959.157654752411, 12985.48058077704, 11944.283342999448, 12028.757315587925, 12270.4478298475, 12403.875961240272, 12656.493740250287, 12398.876011239772, 12435.0, 12630.936845316082, 12923.676908077374, 13142.60572182836, 10463.843042354218, 10513.106385956973, 10954.014138727553, 11139.220254582102, 11216.83174752363, 10815.837762433726, 11112.555497779998, 11158.776824463628, 11278.774424511628, 11339.659810205707], "value": 7177.2631697543, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1469.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 111.0, 113.0, 113.0, 112.0, 111.0, 112.0, 110.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 120.0, 119.0, 153.0, 119.0, 119.0, 118.0, 123.0, 158.0, 122.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 161.0, 164.0, 162.0, 161.0, 161.0, 162.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 112.0, 76.0, 77.0, 76.0, 76.0, 98.0, 77.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 121.0, 83.0, 82.0, 81.0, 102.0, 82.0, 81.0, 110.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 147.0, 164.0, 146.0, 151.0, 149.0, 146.0, 147.0, 146.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 86.0, 85.0, 85.0, 85.0, 84.0, 86.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 52.0, 51.0, 51.0, 50.0, 50.0, 51.0, 51.0, 53.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 75.0, 77.0, 79.0, 75.0, 81.0, 76.0, 82.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 127.0, 131.0, 124.0, 120.0, 121.0, 131.0, 124.0, 171.0, 134.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 155.0, 155.0, 157.0, 160.0, 160.0, 159.0, 159.0, 166.0, 159.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 63.0, 64.0, 62.0, 62.0, 63.0, 61.0, 65.0], "value": 63.6, "unit": "score"}]}]} 22:44:35 INFO - Return code: 0 22:44:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:44:35 ERROR - # TBPL SUCCESS # 22:44:35 INFO - Running post-action listener: _resource_record_post_action 22:44:35 INFO - [mozharness: 2016-12-22 06:44:35.473208Z] Finished run-tests step (success) 22:44:35 INFO - Running post-run listener: _resource_record_post_run 22:44:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8835072; Write bytes: 389857280; Read time: 1744; Write time: 323572 22:44:35 INFO - TinderboxPrint: CPU usage
13.3% 22:44:35 INFO - TinderboxPrint: I/O read bytes / time
8,835,072 / 1,744 22:44:35 INFO - TinderboxPrint: I/O write bytes / time
389,857,280 / 323,572 22:44:35 INFO - TinderboxPrint: CPU idle
8,242.0 (86.7%) 22:44:35 INFO - TinderboxPrint: CPU user
1,208.0 (12.7%) 22:44:35 INFO - TinderboxPrint: Swap in / out
0 / 0 22:44:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 22052864; Read time: 64; Write time: 8608 22:44:35 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 6643712; Write bytes: 268894208; Read time: 1148; Write time: 230916 22:44:36 INFO - Running post-run listener: _upload_blobber_files 22:44:36 INFO - Blob upload gear active. 22:44:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:44:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:44:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:44:36 INFO - (blobuploader) - INFO - Open directory for files ... 22:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:44:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:37 INFO - (blobuploader) - INFO - Done attempting. 22:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:44:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:40 INFO - (blobuploader) - INFO - Done attempting. 22:44:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:44:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:44:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:41 INFO - (blobuploader) - INFO - Done attempting. 22:44:41 INFO - (blobuploader) - INFO - Iteration through files over. 22:44:41 INFO - Return code: 0 22:44:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:44:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:44:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f303fc5e2c034b22c2c03f28dfdce899ed541a5a4e5a5383d5f07b8b56f57419b2a0a73e382e343f0ba92da61f34800d2e18f9515c86f9449dcf6c0a769f7226", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac44f6a7076eb5edcb3f52865083493587e08577a8ee82fc09957dfce51a7dca26d0aff67a04c7c161fee10e579db58b57597783dd9ab00f97328bf230b3a666", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/802570bd4a15ce4b54beef05c99254e98bc0dca005c794edc0ba9266439d20d43c551854859dd406de3e77f898ecd22f8a557742e2cd7ea09ac5e340b3c5f062"} 22:44:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:44:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:44:41 INFO - Contents: 22:44:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f303fc5e2c034b22c2c03f28dfdce899ed541a5a4e5a5383d5f07b8b56f57419b2a0a73e382e343f0ba92da61f34800d2e18f9515c86f9449dcf6c0a769f7226", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac44f6a7076eb5edcb3f52865083493587e08577a8ee82fc09957dfce51a7dca26d0aff67a04c7c161fee10e579db58b57597783dd9ab00f97328bf230b3a666", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/802570bd4a15ce4b54beef05c99254e98bc0dca005c794edc0ba9266439d20d43c551854859dd406de3e77f898ecd22f8a557742e2cd7ea09ac5e340b3c5f062"} 22:44:41 INFO - Running post-run listener: copy_logs_to_upload_dir 22:44:41 INFO - Copying logs to upload dir... 22:44:41 INFO - mkdir: /builds/slave/test/build/upload/logs 22:44:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.670030 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-21 22:44:41.489233) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 22:44:41.493928) ========= 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=a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189 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/f303fc5e2c034b22c2c03f28dfdce899ed541a5a4e5a5383d5f07b8b56f57419b2a0a73e382e343f0ba92da61f34800d2e18f9515c86f9449dcf6c0a769f7226", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac44f6a7076eb5edcb3f52865083493587e08577a8ee82fc09957dfce51a7dca26d0aff67a04c7c161fee10e579db58b57597783dd9ab00f97328bf230b3a666", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/802570bd4a15ce4b54beef05c99254e98bc0dca005c794edc0ba9266439d20d43c551854859dd406de3e77f898ecd22f8a557742e2cd7ea09ac5e340b3c5f062"} build_url:https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011670 build_url: 'https://queue.taskcluster.net/v1/task/a2ce1SH5QD6A73oj-YhIDA/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/f303fc5e2c034b22c2c03f28dfdce899ed541a5a4e5a5383d5f07b8b56f57419b2a0a73e382e343f0ba92da61f34800d2e18f9515c86f9449dcf6c0a769f7226", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac44f6a7076eb5edcb3f52865083493587e08577a8ee82fc09957dfce51a7dca26d0aff67a04c7c161fee10e579db58b57597783dd9ab00f97328bf230b3a666", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/802570bd4a15ce4b54beef05c99254e98bc0dca005c794edc0ba9266439d20d43c551854859dd406de3e77f898ecd22f8a557742e2cd7ea09ac5e340b3c5f062"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 22:44:41.519253) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 22:44:41.519546) ========= 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=a0d2d2de893abaa8702a9954000001a7-1482387267.596578-273821189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004370 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 22:44:41.605884) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 22:44:41.606255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 22:44:41.606575) ========= ========= Total master_lag: 0.18 =========