builder: cedar_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1479486783.34 results: success (0) buildid: 20161118070428 builduid: c123361a476643a3b4591fdbee8e2568 revision: 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 08:33:03.339263) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 08:33:03.339730) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 08:33:03.340004) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 08:33:03.354449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:33:03.354776) ========= 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=836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-18 08:33:04-- 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-11-18 08:33:04 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118619 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:33:03.487072) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:33:03.487381) ========= 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=836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019600 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:33:03.536384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:33:03.536742) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c --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=836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-18 08:33:04,313 truncating revision to first 12 chars 2016-11-18 08:33:04,314 Setting DEBUG logging. 2016-11-18 08:33:04,314 attempt 1/10 2016-11-18 08:33:04,314 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/26b31d10e8cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 08:33:04,619 unpacking tar archive at: cedar-26b31d10e8cc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602656 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:33:04.152705) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 08:33:04.153005) ========= script_repo_revision: 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 08:33:04.153397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 08:33:04.153674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 08:33:04.164410) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-18 08:33:04.164696) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:33:05 INFO - MultiFileLogger online at 20161118 08:33:05 in /builds/slave/test 08:33:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 08:33:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:33:05 INFO - {'append_to_log': False, 08:33:05 INFO - 'base_work_dir': '/builds/slave/test', 08:33:05 INFO - 'blob_upload_branch': 'Cedar', 08:33:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:33:05 INFO - 'branch': 'Cedar', 08:33:05 INFO - 'buildbot_json_path': 'buildprops.json', 08:33:05 INFO - 'config_files': ('talos/linux_config.py',), 08:33:05 INFO - 'default_actions': ('clobber', 08:33:05 INFO - 'read-buildbot-config', 08:33:05 INFO - 'download-and-extract', 08:33:05 INFO - 'populate-webroot', 08:33:05 INFO - 'create-virtualenv', 08:33:05 INFO - 'install', 08:33:05 INFO - 'run-tests'), 08:33:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:33:05 INFO - 'download_minidump_stackwalk': True, 08:33:05 INFO - 'download_symbols': 'ondemand', 08:33:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:33:05 INFO - 'tooltool.py': '/tools/tooltool.py', 08:33:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:33:05 INFO - '/tools/misc-python/virtualenv.py')}, 08:33:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:33:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:33:05 INFO - 'installer_path': 'installer.exe', 08:33:05 INFO - 'log_level': 'info', 08:33:05 INFO - 'log_name': 'talos', 08:33:05 INFO - 'log_to_console': True, 08:33:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:33:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:33:05 INFO - 'opt_config_files': (), 08:33:05 INFO - 'pip_index': False, 08:33:05 INFO - 'sps_profile': False, 08:33:05 INFO - 'sps_profile_interval': 0, 08:33:05 INFO - 'suite': 'dromaeojs', 08:33:05 INFO - 'system_bits': '32', 08:33:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:33:05 INFO - 'title': 'talos-linux64-ix-028', 08:33:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:33:05 INFO - 'use_talos_json': True, 08:33:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:33:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:33:05 INFO - 'work_dir': 'build'} 08:33:05 INFO - [mozharness: 2016-11-18 16:33:05.033370Z] Running clobber step. 08:33:05 INFO - Running pre-action listener: _resource_record_pre_action 08:33:05 INFO - Running main action method: clobber 08:33:05 INFO - rmtree: /builds/slave/test/build 08:33:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:33:05 INFO - Running post-action listener: _resource_record_post_action 08:33:05 INFO - [mozharness: 2016-11-18 16:33:05.480782Z] Finished clobber step (success) 08:33:05 INFO - [mozharness: 2016-11-18 16:33:05.480881Z] Running read-buildbot-config step. 08:33:05 INFO - Running pre-action listener: _resource_record_pre_action 08:33:05 INFO - Running main action method: read_buildbot_config 08:33:05 INFO - Using buildbot properties: 08:33:05 INFO - { 08:33:05 INFO - "project": "", 08:33:05 INFO - "product": "firefox", 08:33:05 INFO - "script_repo_revision": "default", 08:33:05 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs", 08:33:05 INFO - "repository": "", 08:33:05 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs", 08:33:05 INFO - "buildid": "20161118070428", 08:33:05 INFO - "pgo_build": "False", 08:33:05 INFO - "basedir": "/builds/slave/test", 08:33:05 INFO - "buildnumber": 5, 08:33:05 INFO - "slavename": "talos-linux64-ix-028", 08:33:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:33:05 INFO - "platform": "ubuntu64_hw", 08:33:05 INFO - "scheduler": "tests-cedar-linux64-talos", 08:33:05 INFO - "branch": "cedar", 08:33:05 INFO - "repo_path": "projects/cedar", 08:33:05 INFO - "revision": "26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c", 08:33:05 INFO - "stage_platform": "linux64", 08:33:05 INFO - "builduid": "c123361a476643a3b4591fdbee8e2568", 08:33:05 INFO - "slavebuilddir": "test" 08:33:05 INFO - } 08:33:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 08:33:05 INFO - Running post-action listener: _resource_record_post_action 08:33:05 INFO - [mozharness: 2016-11-18 16:33:05.483308Z] Finished read-buildbot-config step (success) 08:33:05 INFO - [mozharness: 2016-11-18 16:33:05.483396Z] Running download-and-extract step. 08:33:05 INFO - Running pre-action listener: _resource_record_pre_action 08:33:05 INFO - Running main action method: download_and_extract 08:33:05 INFO - mkdir: /builds/slave/test/build/tests 08:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:05 INFO - trying https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:33:05 INFO - Downloading https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:33:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:33:06 INFO - Downloaded 1361 bytes. 08:33:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:33:06 INFO - Using the following test package requirements: 08:33:06 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:33:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:33:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:33:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:06 INFO - u'jsshell-linux-x86_64.zip'], 08:33:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:33:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:33:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:33:06 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:33:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:33:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:33:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:33:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:33:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:33:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:33:06 INFO - Fetch https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:33:06 INFO - Http code: 200 08:33:06 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 08:33:06 INFO - x-amz-cf-id: FOj5meVXe0r-dzU3qyog4klt62laFwVw4FGg8Djx6TmKWCxPSh_pWw== 08:33:06 INFO - x-amz-version-id: HO.HLvZIASBBNtYcSD8e7Rbj3f7hC0Ee 08:33:07 INFO - Expected file size: 20309619 08:33:07 INFO - Obtained file size: 20309619 08:33:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:33:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:33:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:33:11 INFO - Fetch https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:33:11 INFO - Http code: 200 08:33:11 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 08:33:11 INFO - x-amz-cf-id: ezJViiZbXTjwO8z4GsmI_Bx28pAfu4-O-IhbSaRbic_cxY4mRY1wuw== 08:33:11 INFO - x-amz-version-id: HO.HLvZIASBBNtYcSD8e7Rbj3f7hC0Ee 08:33:11 INFO - Expected file size: 20309619 08:33:11 INFO - Obtained file size: 20309619 08:33:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 08:33:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:33:16 INFO - Fetch https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:33:16 INFO - Http code: 200 08:33:16 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 08:33:16 INFO - x-amz-cf-id: EPv1dqFJWI6viwhyYX9cCaw1wRYZ9vtMNJCdc6OQFP4iDTHhn8vmmw== 08:33:16 INFO - x-amz-version-id: Uk7xh6g.fzRoOMYdtRrrObGGEl3AmfrZ 08:33:17 INFO - Expected file size: 14409392 08:33:17 INFO - Obtained file size: 14409392 08:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:17 INFO - trying https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:33:17 INFO - Downloading https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:33:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:33:18 INFO - Downloaded 55681627 bytes. 08:33:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:33:18 INFO - mkdir: /builds/slave/test/properties 08:33:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:33:18 INFO - Writing to file /builds/slave/test/properties/build_url 08:33:18 INFO - Contents: 08:33:18 INFO - build_url:https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:33:19 INFO - Running post-action listener: _resource_record_post_action 08:33:19 INFO - Running post-action listener: set_extra_try_arguments 08:33:19 INFO - [mozharness: 2016-11-18 16:33:19.213114Z] Finished download-and-extract step (success) 08:33:19 INFO - [mozharness: 2016-11-18 16:33:19.213378Z] Running populate-webroot step. 08:33:19 INFO - Running pre-action listener: _resource_record_pre_action 08:33:19 INFO - Running main action method: populate_webroot 08:33:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:33:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:33:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:33:19 INFO - '--tppagecycles', 08:33:19 INFO - '7'], 08:33:19 INFO - 'tests': ['tsvgm']}}, 08:33:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:33:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:33:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:33:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:33:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:33:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:33:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:33:19 INFO - 'talos_options': ['--disable-e10s'], 08:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:33:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:33:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:33:19 INFO - 'talos_options': ['--disable-e10s'], 08:33:19 INFO - 'tests': ['damp', 'tps']}, 08:33:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:33:19 INFO - 'tests': ['damp', 'tps']}, 08:33:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:33:19 INFO - 'tests': ['dromaeo_dom']}, 08:33:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:33:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:33:19 INFO - 'tests': ['basic_compositor_video']}, 08:33:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:33:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:33:19 INFO - 'tests': ['a11yr', 08:33:19 INFO - 'ts_paint', 08:33:19 INFO - 'tpaint', 08:33:19 INFO - 'sessionrestore', 08:33:19 INFO - 'sessionrestore_no_auto_restore', 08:33:19 INFO - 'tabpaint']}, 08:33:19 INFO - 'other-e10s': {'tests': ['a11yr', 08:33:19 INFO - 'ts_paint', 08:33:19 INFO - 'tpaint', 08:33:19 INFO - 'sessionrestore', 08:33:19 INFO - 'sessionrestore_no_auto_restore', 08:33:19 INFO - 'tabpaint']}, 08:33:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:33:19 INFO - 'ts_paint', 08:33:19 INFO - 'tpaint', 08:33:19 INFO - 'sessionrestore', 08:33:19 INFO - 'sessionrestore_no_auto_restore', 08:33:19 INFO - 'tabpaint']}, 08:33:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:33:19 INFO - 'ts_paint', 08:33:19 INFO - 'tpaint', 08:33:19 INFO - 'sessionrestore', 08:33:19 INFO - 'sessionrestore_no_auto_restore', 08:33:19 INFO - 'tabpaint']}, 08:33:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:33:19 INFO - 'tests': ['a11yr', 08:33:19 INFO - 'ts_paint', 08:33:19 INFO - 'tpaint', 08:33:19 INFO - 'sessionrestore', 08:33:19 INFO - 'sessionrestore_no_auto_restore', 08:33:19 INFO - 'tabpaint']}, 08:33:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:33:19 INFO - 'tests': ['a11yr', 08:33:19 INFO - 'ts_paint', 08:33:19 INFO - 'tpaint', 08:33:19 INFO - 'sessionrestore', 08:33:19 INFO - 'sessionrestore_no_auto_restore', 08:33:19 INFO - 'tabpaint']}, 08:33:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:33:19 INFO - 'tests': ['tsvgx', 08:33:19 INFO - 'tsvgr_opacity', 08:33:19 INFO - 'tart', 08:33:19 INFO - 'tscrollx', 08:33:19 INFO - 'cart']}, 08:33:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:33:19 INFO - 'tsvgr_opacity', 08:33:19 INFO - 'tart', 08:33:19 INFO - 'tscrollx', 08:33:19 INFO - 'cart']}, 08:33:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:33:19 INFO - 'talos_options': ['--disable-e10s'], 08:33:19 INFO - 'tests': ['tp5o']}, 08:33:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:33:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:33:19 INFO - 'talos_options': ['--disable-e10s', 08:33:19 INFO - '--xperf_path', 08:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:33:19 INFO - 'tests': ['tp5n']}, 08:33:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:33:19 INFO - 'talos_options': ['--xperf_path', 08:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:33:19 INFO - 'tests': ['tp5n']}}, 08:33:19 INFO - 'talos.zip': {'path': '', 08:33:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:33:19 INFO - Running post-action listener: _resource_record_post_action 08:33:19 INFO - [mozharness: 2016-11-18 16:33:19.233701Z] Finished populate-webroot step (success) 08:33:19 INFO - [mozharness: 2016-11-18 16:33:19.233788Z] Running create-virtualenv step. 08:33:19 INFO - Running pre-action listener: _resource_record_pre_action 08:33:19 INFO - Running main action method: create_virtualenv 08:33:19 INFO - Creating virtualenv /builds/slave/test/build/venv 08:33:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:33:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:33:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:33:19 INFO - Using real prefix '/usr' 08:33:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:33:19 INFO - Installing distribute.............................................................................................................................................................................................done. 08:33:21 INFO - Installing pip.................done. 08:33:21 INFO - Return code: 0 08:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:33:22 INFO - Reading from file tmpfile_stdout 08:33:22 INFO - Output received: 08:33:22 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:33:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:33: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')]} 08:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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')]} 08:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca24301e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80fc0>, '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 0x1e81ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e82350>, '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': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33: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', 'pip>=1.5'] in /builds/slave/test/build 08:33: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 pip>=1.5 08:33:22 INFO - Using env: {'DISPLAY': ':0', 08:33:22 INFO - 'HOME': '/home/cltbld', 08:33:22 INFO - 'LANG': 'en_US.UTF-8', 08:33:22 INFO - 'LANGUAGE': 'en_US:en', 08:33:22 INFO - 'LOGNAME': 'cltbld', 08:33:22 INFO - 'MAIL': '/var/mail/cltbld', 08:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:22 INFO - 'MOZ_NO_REMOTE': '1', 08:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:22 INFO - 'NO_EM_RESTART': '1', 08:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:22 INFO - 'PWD': '/builds/slave/test', 08:33:22 INFO - 'SHELL': '/bin/bash', 08:33:22 INFO - 'SHLVL': '1', 08:33:22 INFO - 'TERM': 'linux', 08:33:22 INFO - 'TMOUT': '86400', 08:33:22 INFO - 'USER': 'cltbld', 08:33:22 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 08:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:22 INFO - '_': '/tools/buildbot/bin/python'} 08:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33: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 08:33:22 INFO - Cleaning up... 08:33:22 INFO - Return code: 0 08:33:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:33: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')]} 08:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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')]} 08:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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 0x7fca24301e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80fc0>, '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 0x1e81ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e82350>, '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': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33: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 08:33: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 08:33:22 INFO - Using env: {'DISPLAY': ':0', 08:33:22 INFO - 'HOME': '/home/cltbld', 08:33:22 INFO - 'LANG': 'en_US.UTF-8', 08:33:22 INFO - 'LANGUAGE': 'en_US:en', 08:33:22 INFO - 'LOGNAME': 'cltbld', 08:33:22 INFO - 'MAIL': '/var/mail/cltbld', 08:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:22 INFO - 'MOZ_NO_REMOTE': '1', 08:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:22 INFO - 'NO_EM_RESTART': '1', 08:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:22 INFO - 'PWD': '/builds/slave/test', 08:33:22 INFO - 'SHELL': '/bin/bash', 08:33:22 INFO - 'SHLVL': '1', 08:33:22 INFO - 'TERM': 'linux', 08:33:22 INFO - 'TMOUT': '86400', 08:33:22 INFO - 'USER': 'cltbld', 08:33:22 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 08:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:22 INFO - '_': '/tools/buildbot/bin/python'} 08:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:22 INFO - Downloading/unpacking psutil>=3.1.1 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:33:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:24 INFO - Installing collected packages: psutil 08:33:24 INFO - Running setup.py install for psutil 08:33:24 INFO - building 'psutil._psutil_linux' extension 08:33: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 08:33:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:33:24 INFO - building 'psutil._psutil_posix' extension 08:33:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:33:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:33:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:25 INFO - Successfully installed psutil 08:33:25 INFO - Cleaning up... 08:33:25 INFO - Return code: 0 08:33:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:33: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')]} 08:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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')]} 08:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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 0x7fca24301e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80fc0>, '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 0x1e81ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e82350>, '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': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33: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 08:33: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 08:33:25 INFO - Using env: {'DISPLAY': ':0', 08:33:25 INFO - 'HOME': '/home/cltbld', 08:33:25 INFO - 'LANG': 'en_US.UTF-8', 08:33:25 INFO - 'LANGUAGE': 'en_US:en', 08:33:25 INFO - 'LOGNAME': 'cltbld', 08:33:25 INFO - 'MAIL': '/var/mail/cltbld', 08:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:25 INFO - 'MOZ_NO_REMOTE': '1', 08:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:25 INFO - 'NO_EM_RESTART': '1', 08:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:25 INFO - 'PWD': '/builds/slave/test', 08:33:25 INFO - 'SHELL': '/bin/bash', 08:33:25 INFO - 'SHLVL': '1', 08:33:25 INFO - 'TERM': 'linux', 08:33:25 INFO - 'TMOUT': '86400', 08:33:25 INFO - 'USER': 'cltbld', 08:33:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 08:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:25 INFO - '_': '/tools/buildbot/bin/python'} 08:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:33:27 INFO - Installing collected packages: mozsystemmonitor 08:33:27 INFO - Running setup.py install for mozsystemmonitor 08:33:27 INFO - Successfully installed mozsystemmonitor 08:33:27 INFO - Cleaning up... 08:33:27 INFO - Return code: 0 08:33:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fca24301e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80fc0>, '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 0x1e81ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e82350>, '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': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:33:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:33:27 INFO - Using env: {'DISPLAY': ':0', 08:33:27 INFO - 'HOME': '/home/cltbld', 08:33:27 INFO - 'LANG': 'en_US.UTF-8', 08:33:27 INFO - 'LANGUAGE': 'en_US:en', 08:33:27 INFO - 'LOGNAME': 'cltbld', 08:33:27 INFO - 'MAIL': '/var/mail/cltbld', 08:33:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:27 INFO - 'MOZ_NO_REMOTE': '1', 08:33:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:27 INFO - 'NO_EM_RESTART': '1', 08:33:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:27 INFO - 'PWD': '/builds/slave/test', 08:33:27 INFO - 'SHELL': '/bin/bash', 08:33:27 INFO - 'SHLVL': '1', 08:33:27 INFO - 'TERM': 'linux', 08:33:27 INFO - 'TMOUT': '86400', 08:33:27 INFO - 'USER': 'cltbld', 08:33:27 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 08:33:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:27 INFO - '_': '/tools/buildbot/bin/python'} 08:33:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:27 INFO - Downloading/unpacking jsonschema==2.5.1 08:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:33:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:29 INFO - Downloading functools32-3.2.3-2.tar.gz 08:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:33:29 INFO - warning: no files found matching '*.txt' 08:33:29 INFO - no previously-included directories found matching 'build' 08:33:29 INFO - no previously-included directories found matching 'dist' 08:33:29 INFO - no previously-included directories found matching '.git*' 08:33:29 INFO - Installing collected packages: jsonschema, functools32 08:33:29 INFO - Running setup.py install for functools32 08:33:29 INFO - warning: no files found matching '*.txt' 08:33:29 INFO - no previously-included directories found matching 'build' 08:33:29 INFO - no previously-included directories found matching 'dist' 08:33:29 INFO - no previously-included directories found matching '.git*' 08:33:29 INFO - Successfully installed jsonschema functools32 08:33:29 INFO - Cleaning up... 08:33:30 INFO - Return code: 0 08:33:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:30 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 0x7fca24301e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80fc0>, '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 0x1e81ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e82350>, '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': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:33:30 INFO - Using env: {'DISPLAY': ':0', 08:33:30 INFO - 'HOME': '/home/cltbld', 08:33:30 INFO - 'LANG': 'en_US.UTF-8', 08:33:30 INFO - 'LANGUAGE': 'en_US:en', 08:33:30 INFO - 'LOGNAME': 'cltbld', 08:33:30 INFO - 'MAIL': '/var/mail/cltbld', 08:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:30 INFO - 'MOZ_NO_REMOTE': '1', 08:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:30 INFO - 'NO_EM_RESTART': '1', 08:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:30 INFO - 'PWD': '/builds/slave/test', 08:33:30 INFO - 'SHELL': '/bin/bash', 08:33:30 INFO - 'SHLVL': '1', 08:33:30 INFO - 'TERM': 'linux', 08:33:30 INFO - 'TMOUT': '86400', 08:33:30 INFO - 'USER': 'cltbld', 08:33:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 08:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:30 INFO - '_': '/tools/buildbot/bin/python'} 08:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:33:30 INFO - Cleaning up... 08:33:30 INFO - Return code: 0 08:33:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:30 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 0x7fca24301e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80fc0>, '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 0x1e81ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e82350>, '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': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:33:30 INFO - Using env: {'DISPLAY': ':0', 08:33:30 INFO - 'HOME': '/home/cltbld', 08:33:30 INFO - 'LANG': 'en_US.UTF-8', 08:33:30 INFO - 'LANGUAGE': 'en_US:en', 08:33:30 INFO - 'LOGNAME': 'cltbld', 08:33:30 INFO - 'MAIL': '/var/mail/cltbld', 08:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:30 INFO - 'MOZ_NO_REMOTE': '1', 08:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:30 INFO - 'NO_EM_RESTART': '1', 08:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:30 INFO - 'PWD': '/builds/slave/test', 08:33:30 INFO - 'SHELL': '/bin/bash', 08:33:30 INFO - 'SHLVL': '1', 08:33:30 INFO - 'TERM': 'linux', 08:33:30 INFO - 'TMOUT': '86400', 08:33:30 INFO - 'USER': 'cltbld', 08:33:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 08:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:30 INFO - '_': '/tools/buildbot/bin/python'} 08:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:30 INFO - Downloading/unpacking blobuploader==1.2.4 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33:32 INFO - Downloading blobuploader-1.2.4.tar.gz 08:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:33:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:33:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:33 INFO - Downloading docopt-0.6.1.tar.gz 08:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:33:33 INFO - Installing collected packages: blobuploader, requests, docopt 08:33:33 INFO - Running setup.py install for blobuploader 08:33:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:33:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:33:33 INFO - Running setup.py install for requests 08:33:33 INFO - Running setup.py install for docopt 08:33:33 INFO - Successfully installed blobuploader requests docopt 08:33:33 INFO - Cleaning up... 08:33:33 INFO - Return code: 0 08:33:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:33 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 0x7fca24301e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80fc0>, '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 0x1e81ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e82350>, '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': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:33 INFO - Using env: {'DISPLAY': ':0', 08:33:33 INFO - 'HOME': '/home/cltbld', 08:33:33 INFO - 'LANG': 'en_US.UTF-8', 08:33:33 INFO - 'LANGUAGE': 'en_US:en', 08:33:33 INFO - 'LOGNAME': 'cltbld', 08:33:33 INFO - 'MAIL': '/var/mail/cltbld', 08:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:33 INFO - 'MOZ_NO_REMOTE': '1', 08:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:33 INFO - 'NO_EM_RESTART': '1', 08:33:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:33 INFO - 'PWD': '/builds/slave/test', 08:33:33 INFO - 'SHELL': '/bin/bash', 08:33:33 INFO - 'SHLVL': '1', 08:33:33 INFO - 'TERM': 'linux', 08:33:33 INFO - 'TMOUT': '86400', 08:33:33 INFO - 'USER': 'cltbld', 08:33:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 08:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:33 INFO - '_': '/tools/buildbot/bin/python'} 08:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:34 INFO - Running setup.py (path:/tmp/pip-060Lon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:34 INFO - Running setup.py (path:/tmp/pip-3pc46L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:34 INFO - Running setup.py (path:/tmp/pip-qUjZjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:34 INFO - Running setup.py (path:/tmp/pip-VkfU8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:34 INFO - Running setup.py (path:/tmp/pip-ZiuPzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:34 INFO - Running setup.py (path:/tmp/pip-It0Z1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:34 INFO - Running setup.py (path:/tmp/pip-PyCUbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:34 INFO - Running setup.py (path:/tmp/pip-B3jFxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:34 INFO - Running setup.py (path:/tmp/pip-r9xr_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:34 INFO - Running setup.py (path:/tmp/pip-jDJSYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:34 INFO - Running setup.py (path:/tmp/pip-tqUrI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:34 INFO - Running setup.py (path:/tmp/pip-JHK0dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:35 INFO - Running setup.py (path:/tmp/pip-sPjEhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:35 INFO - Running setup.py (path:/tmp/pip-ednK7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:35 INFO - Running setup.py (path:/tmp/pip-NOpT_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:35 INFO - Running setup.py (path:/tmp/pip-5fh8e1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:35 INFO - Running setup.py (path:/tmp/pip-g_emLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:33:35 INFO - Running setup.py install for manifestparser 08:33:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:33:35 INFO - Running setup.py install for mozcrash 08:33:35 INFO - Running setup.py install for mozdebug 08:33:35 INFO - Running setup.py install for mozdevice 08:33:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:33:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:33:35 INFO - Running setup.py install for mozfile 08:33:36 INFO - Running setup.py install for mozhttpd 08:33:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:33:36 INFO - Running setup.py install for mozinfo 08:33:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:33:36 INFO - Running setup.py install for mozInstall 08:33:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:33:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:33:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:33:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:33:36 INFO - Running setup.py install for mozleak 08:33:36 INFO - Running setup.py install for mozlog 08:33:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:33:36 INFO - Running setup.py install for moznetwork 08:33:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:33:36 INFO - Running setup.py install for mozprocess 08:33:36 INFO - Running setup.py install for mozprofile 08:33:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:33:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:33:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:33:36 INFO - Running setup.py install for mozrunner 08:33:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:33:37 INFO - Running setup.py install for mozscreenshot 08:33:37 INFO - Running setup.py install for moztest 08:33:37 INFO - Running setup.py install for mozversion 08:33:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:33:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:33:37 INFO - Cleaning up... 08:33:37 INFO - Return code: 0 08:33:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:37 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 0x7fca24301e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80fc0>, '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 0x1e81ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e82350>, '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': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:37 INFO - Using env: {'DISPLAY': ':0', 08:33:37 INFO - 'HOME': '/home/cltbld', 08:33:37 INFO - 'LANG': 'en_US.UTF-8', 08:33:37 INFO - 'LANGUAGE': 'en_US:en', 08:33:37 INFO - 'LOGNAME': 'cltbld', 08:33:37 INFO - 'MAIL': '/var/mail/cltbld', 08:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:37 INFO - 'MOZ_NO_REMOTE': '1', 08:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:37 INFO - 'NO_EM_RESTART': '1', 08:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:37 INFO - 'PWD': '/builds/slave/test', 08:33:37 INFO - 'SHELL': '/bin/bash', 08:33:37 INFO - 'SHLVL': '1', 08:33:37 INFO - 'TERM': 'linux', 08:33:37 INFO - 'TMOUT': '86400', 08:33:37 INFO - 'USER': 'cltbld', 08:33:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 08:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:37 INFO - '_': '/tools/buildbot/bin/python'} 08:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:37 INFO - Running setup.py (path:/tmp/pip-dJvOGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:37 INFO - Running setup.py (path:/tmp/pip-ItjACP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:37 INFO - Running setup.py (path:/tmp/pip-MNJ9JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:37 INFO - Running setup.py (path:/tmp/pip-BBsO_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:37 INFO - Running setup.py (path:/tmp/pip-UvhaIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:37 INFO - Running setup.py (path:/tmp/pip-orFg1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:37 INFO - Running setup.py (path:/tmp/pip-HPCpoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33: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)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:38 INFO - Running setup.py (path:/tmp/pip-T3GAkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33: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)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:38 INFO - Running setup.py (path:/tmp/pip-MWcot_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33: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)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:38 INFO - Running setup.py (path:/tmp/pip-P3thTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:38 INFO - Running setup.py (path:/tmp/pip-dKA6dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:38 INFO - Running setup.py (path:/tmp/pip-0QNI1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:38 INFO - Running setup.py (path:/tmp/pip-a0VL9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:38 INFO - Running setup.py (path:/tmp/pip-mLcYzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:38 INFO - Running setup.py (path:/tmp/pip-qEfrzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:38 INFO - Running setup.py (path:/tmp/pip-dv3s70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:38 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)) 08:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:38 INFO - Running setup.py (path:/tmp/pip-ggOza1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:40 INFO - Downloading blessings-1.6.tar.gz 08:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:33:40 INFO - Installing collected packages: blessings 08:33:40 INFO - Running setup.py install for blessings 08:33:40 INFO - Successfully installed blessings 08:33:40 INFO - Cleaning up... 08:33:41 INFO - Return code: 0 08:33:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:41 INFO - Reading from file tmpfile_stdout 08:33:41 INFO - Current package versions: 08:33:41 INFO - argparse == 1.2.1 08:33:41 INFO - blessings == 1.6 08:33:41 INFO - blobuploader == 1.2.4 08:33:41 INFO - docopt == 0.6.1 08:33:41 INFO - functools32 == 3.2.3-2 08:33:41 INFO - jsonschema == 2.5.1 08:33:41 INFO - manifestparser == 1.1 08:33:41 INFO - mozInstall == 1.12 08:33:41 INFO - mozcrash == 1.0 08:33:41 INFO - mozdebug == 0.1 08:33:41 INFO - mozdevice == 0.48 08:33:41 INFO - mozfile == 1.2 08:33:41 INFO - mozhttpd == 0.7 08:33:41 INFO - mozinfo == 0.9 08:33:41 INFO - mozleak == 0.1 08:33:41 INFO - mozlog == 3.4 08:33:41 INFO - moznetwork == 0.27 08:33:41 INFO - mozprocess == 0.23 08:33:41 INFO - mozprofile == 0.28 08:33:41 INFO - mozrunner == 6.13 08:33:41 INFO - mozscreenshot == 0.1 08:33:41 INFO - mozsystemmonitor == 0.3 08:33:41 INFO - moztest == 0.7 08:33:41 INFO - mozversion == 1.4 08:33:41 INFO - psutil == 3.1.1 08:33:41 INFO - requests == 1.2.3 08:33:41 INFO - wsgiref == 0.1.2 08:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:41 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 0x7fca24301e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80fc0>, '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 0x1e81ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e82350>, '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': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:41 INFO - Using env: {'DISPLAY': ':0', 08:33:41 INFO - 'HOME': '/home/cltbld', 08:33:41 INFO - 'LANG': 'en_US.UTF-8', 08:33:41 INFO - 'LANGUAGE': 'en_US:en', 08:33:41 INFO - 'LOGNAME': 'cltbld', 08:33:41 INFO - 'MAIL': '/var/mail/cltbld', 08:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:41 INFO - 'MOZ_NO_REMOTE': '1', 08:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:41 INFO - 'NO_EM_RESTART': '1', 08:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:41 INFO - 'PWD': '/builds/slave/test', 08:33:41 INFO - 'SHELL': '/bin/bash', 08:33:41 INFO - 'SHLVL': '1', 08:33:41 INFO - 'TERM': 'linux', 08:33:41 INFO - 'TMOUT': '86400', 08:33:41 INFO - 'USER': 'cltbld', 08:33:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 08:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:41 INFO - '_': '/tools/buildbot/bin/python'} 08:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:33:41 INFO - Cleaning up... 08:33:41 INFO - Return code: 0 08:33:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca24301e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c56b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df2130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e80fc0>, '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 0x1e81ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e82350>, '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': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:33:41 INFO - Using env: {'DISPLAY': ':0', 08:33:41 INFO - 'HOME': '/home/cltbld', 08:33:41 INFO - 'LANG': 'en_US.UTF-8', 08:33:41 INFO - 'LANGUAGE': 'en_US:en', 08:33:41 INFO - 'LOGNAME': 'cltbld', 08:33:41 INFO - 'MAIL': '/var/mail/cltbld', 08:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:41 INFO - 'MOZ_NO_REMOTE': '1', 08:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:41 INFO - 'NO_EM_RESTART': '1', 08:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:41 INFO - 'PWD': '/builds/slave/test', 08:33:41 INFO - 'SHELL': '/bin/bash', 08:33:41 INFO - 'SHLVL': '1', 08:33:41 INFO - 'TERM': 'linux', 08:33:41 INFO - 'TMOUT': '86400', 08:33:41 INFO - 'USER': 'cltbld', 08:33:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 08:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:41 INFO - '_': '/tools/buildbot/bin/python'} 08:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:33:41 INFO - Cleaning up... 08:33:41 INFO - Return code: 0 08:33:41 INFO - Running post-action listener: _resource_record_post_action 08:33:41 INFO - Running post-action listener: _start_resource_monitoring 08:33:41 INFO - Starting resource monitoring. 08:33:41 INFO - [mozharness: 2016-11-18 16:33:41.719315Z] Finished create-virtualenv step (success) 08:33:41 INFO - [mozharness: 2016-11-18 16:33:41.719833Z] Running install step. 08:33:41 INFO - Running pre-action listener: _resource_record_pre_action 08:33:41 INFO - Running main action method: install 08:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:41 INFO - Reading from file tmpfile_stdout 08:33:41 INFO - Detecting whether we're running mozinstall >=1.0... 08:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:33:42 INFO - Reading from file tmpfile_stdout 08:33:42 INFO - Output received: 08:33:42 INFO - Usage: mozinstall [options] installer 08:33:42 INFO - Options: 08:33:42 INFO - -h, --help show this help message and exit 08:33:42 INFO - -d DEST, --destination=DEST 08:33:42 INFO - Directory to install application into. [default: 08:33:42 INFO - "/builds/slave/test"] 08:33:42 INFO - --app=APP Application being installed. [default: firefox] 08:33:42 INFO - mkdir: /builds/slave/test/build/application 08:33:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:33:58 INFO - Reading from file tmpfile_stdout 08:33:58 INFO - Output received: 08:33:58 INFO - /builds/slave/test/build/application/firefox/firefox 08:33:58 INFO - Running post-action listener: _resource_record_post_action 08:33:58 INFO - [mozharness: 2016-11-18 16:33:58.087890Z] Finished install step (success) 08:33:58 INFO - [mozharness: 2016-11-18 16:33:58.088233Z] Running run-tests step. 08:33:58 INFO - Running pre-action listener: _resource_record_pre_action 08:33:58 INFO - Running main action method: run_tests 08:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:33:58 INFO - Python 2.7.3 08:33:58 INFO - Return code: 0 08:33:58 INFO - grabbing minidump binary from tooltool 08:33: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')]} 08:33: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 0x1e80fc0>, '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 0x1e81ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e82350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:33: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 08:33: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 08:33: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 08:33:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:33:58 INFO - Return code: 0 08:33:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:33:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:33:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:33:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:33:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:33:58 INFO - Using env: {'DISPLAY': ':0', 08:33:58 INFO - 'HOME': '/home/cltbld', 08:33:58 INFO - 'LANG': 'en_US.UTF-8', 08:33:58 INFO - 'LANGUAGE': 'en_US:en', 08:33:58 INFO - 'LOGNAME': 'cltbld', 08:33:58 INFO - 'MAIL': '/var/mail/cltbld', 08:33:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:33:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:58 INFO - 'MOZ_NO_REMOTE': '1', 08:33:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:58 INFO - 'NO_EM_RESTART': '1', 08:33:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:58 INFO - 'PWD': '/builds/slave/test', 08:33:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:33:58 INFO - 'SHELL': '/bin/bash', 08:33:58 INFO - 'SHLVL': '1', 08:33:58 INFO - 'TERM': 'linux', 08:33:58 INFO - 'TMOUT': '86400', 08:33:58 INFO - 'USER': 'cltbld', 08:33:58 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046', 08:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:58 INFO - '_': '/tools/buildbot/bin/python'} 08:33:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:33:58 INFO - mozversion application_buildid: 20161118070428 08:33:58 INFO - mozversion application_changeset: 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c 08:33:58 INFO - mozversion application_display_name: Nightly 08:33:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:33:58 INFO - mozversion application_name: Firefox 08:33:58 INFO - mozversion application_remotingname: firefox 08:33:58 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 08:33:58 INFO - mozversion application_vendor: Mozilla 08:33:58 INFO - mozversion application_version: 53.0a1 08:33:58 INFO - mozversion platform_buildid: 20161118070428 08:33:58 INFO - mozversion platform_changeset: 26b31d10e8ccc0f257b6f2b3c20ef7fbe1f6819c 08:33:58 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 08:33:58 INFO - mozversion platform_version: 53.0a1 08:33:58 INFO - using testdate: 1479486838 08:33:58 INFO - actual date: 1479486838 08:33:58 INFO - starting webserver on 'localhost:53908' 08:33:58 INFO - SUITE-START | Running 2 tests 08:33:58 INFO - TEST-START | dromaeo_css 08:33:58 INFO - operating with platform_type : linux_ 08:33:58 INFO - Initialising browser for dromaeo_css test... 08:33:58 INFO - TEST-INFO | started process 19836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDxdaqb/profile http://localhost:53908/getInfo.html) 08:34:02 INFO - PROCESS | 19836 | __metrics Screen width/height:1600/1200 08:34:02 INFO - PROCESS | 19836 | colorDepth:24 08:34:02 INFO - PROCESS | 19836 | Browser inner width/height: 1024/697 08:34:02 INFO - PROCESS | 19836 | __metrics 08:34:03 INFO - PROCESS | 19836 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:34:03 INFO - PROCESS | 19836 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:34:04 INFO - PROCESS | 19836 | console.error: PushService: 08:34:04 INFO - PROCESS | 19836 | stateChangeProcessEnqueue: Error transitioning state 08:34:04 INFO - PROCESS | 19836 | UnknownError 08:34:04 INFO - TEST-INFO | 19836: exit 0 08:34:04 INFO - Browser initialized. 08:34:04 INFO - Running cycle 1/1 for dromaeo_css test... 08:34:04 INFO - TEST-INFO | started process 19921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDxdaqb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:17 INFO - PROCESS | 19921 | RSS: Main: 174170112 08:34:17 INFO - PROCESS | 19921 | 08:35:08 INFO - PROCESS | 19921 | 1479486908075 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] 08:37:22 INFO - PROCESS | 19921 | Cycle 1(1): loaded http://localhost:53908/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53908/tests/dromaeo/cssquery-ext.html) 08:37:23 INFO - PROCESS | 19921 | RSS: Main: 286384128 08:37:23 INFO - PROCESS | 19921 | 08:40:26 INFO - PROCESS | 19921 | Cycle 1(1): loaded http://localhost:53908/tests/dromaeo/cssquery-ext.html (next: http://localhost:53908/tests/dromaeo/cssquery-jquery.html) 08:40:27 INFO - PROCESS | 19921 | RSS: Main: 284651520 08:40:27 INFO - PROCESS | 19921 | 08:43:29 INFO - PROCESS | 19921 | Cycle 1(1): loaded http://localhost:53908/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53908/tests/dromaeo/cssquery-mootools.html) 08:43:30 INFO - PROCESS | 19921 | RSS: Main: 258179072 08:43:30 INFO - PROCESS | 19921 | 08:46:32 INFO - PROCESS | 19921 | Cycle 1(1): loaded http://localhost:53908/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53908/tests/dromaeo/cssquery-prototype.html) 08:46:33 INFO - PROCESS | 19921 | RSS: Main: 219578368 08:46:33 INFO - PROCESS | 19921 | 08:49:36 INFO - PROCESS | 19921 | Cycle 1(1): loaded http://localhost:53908/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53908/tests/dromaeo/cssquery-yui.html) 08:49:37 INFO - PROCESS | 19921 | RSS: Main: 221089792 08:49:37 INFO - PROCESS | 19921 | 08:52:39 INFO - PROCESS | 19921 | Cycle 1(1): loaded http://localhost:53908/tests/dromaeo/cssquery-yui.html (next: http://localhost:53908/tests/dromaeo/cssquery-dojo.html) 08:52:40 INFO - PROCESS | 19921 | RSS: Main: 301281280 08:52:40 INFO - PROCESS | 19921 | 08:52:40 INFO - PROCESS | 19921 | __start_tp_report 08:52:40 INFO - PROCESS | 19921 | _x_x_mozilla_page_load 08:52:40 INFO - PROCESS | 19921 | _x_x_mozilla_page_load_details 08:52:40 INFO - PROCESS | 19921 | |i|pagename|runs| 08:52:40 INFO - PROCESS | 19921 | |0;dojo.html;2518.5592521308768;2540.7459254074606;2564.5127425789105;2573.369524466505;2586.935326616834;4352.956470435302;4457.331400289954;4477.037436951063;4488.932666010012;4495.460544734632;4489.730616163032;4501.594856462926;4521.773911304438;4526.366308716782;4580.977095114528;4111.342185250361;4137.27597670408;4180.331147016478;4195.930037840361;4215.620594146526;3886.125621735101;4264.083222107246;4274.871753847389;4310.094880075188;4346;4118.299889018874;4212;4214.494260688706;4288.078063216408;4304.31131019037;4155.97922010391;4207.64235040022;4221.197972385237;4223.598758117974;4226.091390351058;4102.364133559303;4198.85304014358;4202.747835129871;4212.220739163234;4214.726042807208;4456.866294011184;4462.799174037176;4467;4523.36672865799;4529.365888775574;4785.114753770529;4785.928211076836;4791.736454495001;4793.400824896888;4820.927686084711;4723.433188017426;4783.569478746929;4808.735519546423;4819.662623616348;4859.052484765472;4506.864794056183;4514;4519.728816271035;4520.59314661682;4521.11838191556;4867.488913664014;4904.852854414374;4914.778834952435;4915.311856340115;4915.5330243626795;4731.69243999139;4733.053389322149;4733.692309999908;4741.0754902794315;4742;4766.094442055998;4816.892114813612;4818.445878723922;4818.68678535894;4831.202851529459;4799.088173247142;4868.464468908417;4898.92651610219;4906.484819094015;4906.730129842893;4830.782614782343;4834.299026641117;4841.225403935424;4843.07981483517;4886.29148773433;4104.0970986382945;4104.630583247522;4108.712390132722;4137.648299894482;4150.107726838744;3515.8242087896015;3536.5756109267054;3558.430651095812;3625.782453052825;3631.727620428426;4162.396452514368;4175.331946888483;4177.8328866845595;4198.3702444633545;4201.474815648044;4894.510548945077;4907.9263811042865;4936.580390666833;4943.060818444484;4957.876053098629;4188.099558594917;4194.035371864488;4194.622483976456;4235.25882970479;4235.618794308465;4255.29787585045;4309.569043095666;4351.477822661301;4357.455318085239;4399.956000440018;4511.187986162391;4530.728156310632;4549.749763762892;4615.907681846412;4617.792199351037;4832.734199618914;4835.95164048355;4839.854804355875;4840.29815676732;4885.804567817389;4566.1552612766745;4569.451665800125;4576.908461830678;4581.129585378767;4616.838410655611;4690.9765451172525;4746.715197088186;4747.382840230748;4750.216214324736;4756.16767065769;4844.563989240985;4910.680805747615;4914.238293064581;4946.604271658187;4964.230544265644;4737.881552961204;4764.880877978078;4773.498782627913;4774.283857421415;4824.614030877591;4608.055348653585;4675.13510000651;4722.173619616485;4763.476017637988;4825.059113472839;4571.291449825282;4610.561996610317;4627.074585083064;4634.768261586974;4675.99466114787;4762.857114286577;4763.69036012658;4765.547273009059;4777.0684716479955;4805.231163013901;4653.1856925038655;4661.044485880454;4668.229742092517;4709.222978208557;4709.529047095263 08:52:40 INFO - PROCESS | 19921 | |1;ext.html;549.618015479242;550.5430492691066;563.1721369586709;567.8921005009046;568.1619611073667;27744.167674969733;30498.39003219937;37159.81420092899;38506.8074659627;38637.227255454876;38556.80721596388;38858.61141388593;39042.60957390425;39098.80450597743;39202.41196382057;7537.773866783991;7692.4999875008225;7699.461037727361;7699.6920123195005;7699.923000770004;7400.666969986337;7442.218567050463;7560.054993125859;9690.903090969106;9961.103500684936;9970.551325190347;10020.89979100207;10033.097021268084;10035.69892903214;10042.297039207258;9808.558614862313;9860.359076660066;9869.259805514615;9870.309078364517;9876.358036727626;9774.16919561838;9837.311388202828;9837.409755414697;9847.90152098477;9855.113039826378;36919.815400922824;37177.25645487102;37188;37217;37233.81383093094;2885.841278729669;2929.3848291858735;2950.6606740224934;2952.1733914503975;2966.42154779818;27166.5925011123;27838;27863.582046269323;28263.57604635932;28693;3249.431349513826;3284.687954644305;3355.2450698592866;3396.371671240828;3447.0865220716532;232506;234017;234138;234360;234577;52136.47863521392;52284.47715522872;52662.21006684903;52662.47337526652;52670.47329526656;29950.850245748632;30533.38933221323;30768.230794230323;55182.17226741602;55203.82350294436;13916.373763180682;14131.293435328193;14140.434382624786;14142.64643383903;14144.36350364236;9534.90465095354;10054.49727513636;10087.747806304755;10131.493425328705;10143.847842282372;14814.851851481562;17091.48725538236;17500.82499174992;17593.824061759475;18100.45698629043;6570.277269500351;6600.174978127734;6669.066330713704;6718.428933540606;6752.257251702309;763.3244578548025;832.9625166867385;883.3066043156092;937.6718148647918;945.1729736480579;25654.230373088838;26527.734722652527;26847;27003.459930801666;27371.45257094847;886.1183122792734;889.1863944490848;902.3412908576645;905.6694306578052;923.0907556057278;13979.580612581638;14331.283435828167;14446.638834029234;14579.416823326948;14739.852601474062;354284;356409;357475;357813;358315;42840.357394639104;43125.13749724988;43143;43169.35245971313;43266.56733432625;1117.8602674665667;1147.1339138950207;1156.1964434717959;1163.3717792392013;1170.9648710538697;25663;25945.351366215997;26506.602400964388;26632.467350652492;26910;40474;40775.388369173896;40795.38806917839;40804.38793418161;40809.38785918273;302143;302307;303419;303549;303625;20770.1691932321;22822.20122295778;23040.539189216455;23155.494892831914;23378;34753.65246347605;37055;37272.44091338578;37477;37845;31279;31327.653090188312;31484.685153148177;31798;32179.356412871144;31513.21216969594;32380.145097355027;32535.674643253264;32712.34575308433;32774;32271.67728322687;32713;32927;33038.33923321568;33045.50431743574;26897.596536052366;30209.848950755106;31070.844645776626;31394.064768872388;34370.48444273288;24419;24439.511209775348;24505.142320018713;24722.752772472046;24909.875450623356 08:52:40 INFO - PROCESS | 19921 | |2;jquery.html;316.9160172554275;332.2109988776655;335.46158415742747;335.63918787303646;366.05192551292146;12433.378331083444;13601;15503.922480387582;16339.91830040848;17487.038212898286;13902.08056308174;13987.300634968262;14139.151650900953;15725.370985160609;16207.35170593175;4785.234362502;5005.6496045276845;5013.248012798092;5016.548510634042;5017.37282839645;3994.640482356587;5725.6278341907855;5755.769769209227;5844.473997340238;5854.443827836349;5560.193771903072;5814.09881468371;5817.476427121558;5821.039528477796;5823.330317013534;5750.942490575104;5757;5775.3935836736955;5775.942240577582;5785.334686511063;4844.15227335215;4987.226979818134;5038.319826823368;5040.34475518184;5044.772985215674;20077;20231;20391.796082039138;20440.897795510926;20793.58412831735;1782.803891571926;1885.1139964216795;1917.7411049508278;1919.1651631540324;1963.3128405058258;12732.427040783094;13175.604731857964;13598.796018059737;13633.863661363359;13805.378757955916;1636.1410259613679;1681.7477378393216;1717.3216579451048;1769.9469015929542;1914.2247389807012;65255;67544.66227668879;68409.65795171043;68413;70361;9625.422474651543;9745.817341544915;9797.608095676092;9940.105390514744;9965.701028969142;13378.598642040753;13387.196768193939;13407.195568265935;13413.463461461628;13422.731545369037;6871.793846184622;6974.511784175161;7028.543144695578;7087.681054352566;7098.432125429953;6716.858134117212;6756.527043107034;6902.137232845895;6906.447484201251;6908;4120.2583534964;4127.112670775738;4140.337545992687;4167.9583204168175;4268.530461649216;1701.3109690575336;1725.1805392438491;1740.8420334221807;1765.9911700441417;1795.4075155198752;749.1871319618166;785.654312102673;831.538496134639;876.0319846569577;961.9807603848024;16383;16758.58103547421;17323;17375.913120434318;17706.291748329924;799.94400391972;816.2979837339883;816.603947085663;827.3629305434781;878.3061381508537;9161.175494205554;9197.264218862474;9783.36408133469;9818;9963.651272205438;371919;372962;373946;383738;385120;65683.34316656868;80452.59773701095;82729.58635206906;83056.58471707723;84229.57885210535;386.37021654702653;407.5435512226266;408.76700280839634;411.2412598755292;412.4534991136756;8611.440256383315;8914.33142514327;9649.614015439303;9651.662191823252;9841;35442.8227858859;36368.454473183454;36437.27125457529;36543.63456365402;37030.8148459256;51297.487025129274;53801.73099134479;54103.72948135234;54279.72860135674;54871;6558.770443034471;6868.416184624163;7016.859662806817;7061.82345441368;7351.558906465629;9491.66779162726;10282.228832837418;10519.26365154432;10886;11051.778964420828;9238.84357603095;9640.517974101407;9773.169280611228;9782.706518804447;10152;9449.338546301693;9778.559964801743;9965.25260605443;10055.39667619945;10111.03945125212;9305.767355815888;9490.145886870216;9550.85673714881;9684.32209745311;9735.853962190431;6858.2455929848675;7081.964590177016;7165.7850264492145;7252.927470725225;7293.744718934812;7887.921120788948;9393.295502837178;9529.190018848198;9791.6010577409;9802.65690700822 08:52:40 INFO - PROCESS | 19921 | |3;mootools.html;1209.0690168570206;1315.0334504139455;1339.7789364754813;1387.3756809435756;1617.5470868156913;5965.433283838034;6458.386453286936;6625.900611490825;6695.062691223233;6860.279670634573;6721.932780672192;6725.865482690356;6741.157355330583;6746.257911629717;6759.864802703943;1997.9300724474647;2015.858889877709;2015.959680806383;2018.0817727933754;2020.7878172791866;1969.1532640964451;2025.7062725904734;2029.3303209940757;2042.366866271453;2047.8976051197455;1954.0913475234013;1965.557749506364;1983.8908860012693;1985.930492432765;1992.1931617694784;1970.3793305108845;1980.7722111957094;1985.037256930402;1987.5826076523947;1989.433011591704;1926.9036548172535;1949.0547084663926;1954.8729332593336;2024.6861736430876;2027.5742094160244;6639.269680335159;6769.898451523231;6904.827379315507;6913.308669133096;6920.653967301615;4014.578469260744;4169.937450938239;4175.185838761443;4175.832966681329;4181.372794080882;2589.469158822437;2764.861756912146;2809.339805145789;2817.281593193743;2831.8300901945745;924.2513564013103;932.6316105138433;946.1201082992814;963.3016063354082;969.0261287406182;8545.316374690072;8592.226699597066;8603.096674849114;8604.26863716585;8616.353773466952;3482.7213822894614;3506.50908872758;3588.6949609282983;3594.388953877847;3620.6560376764164;6896.448284137257;6897.068895699117;6900.585964842126;6901.689423975933;6902;3964.6035396460125;4017.6785857131945;4019.8593049243136;4036.3138266494766;4038.434619153321;3257.657945915692;3354.144693103292;3648.6533779290926;3774.207416442523;3774.7168962327937;2906.0384240637486;2939.412117576493;3029.106413607991;3044.9238769030508;3048.0551029180583;896.9596368163449;898.128815049401;904.0462312260497;906.2976193450129;906.582971832951;648.3937518420292;712.1987763765763;797.1152021256516;813.6338647608482;846.0524212881489;4495.865124046284;4616.861494155113;4807.543283388072;4876.658633895664;4910.729909854921;390.62695126154455;398.47003485364394;402.3582386094175;870.1689886158704;913.7578541686458;3258.4949332853444;3292.111129994888;3326.3846188455213;3331.733461323137;3439.8624055038017;7763.689452421952;8185.427020108655;8198.180181981874;8206.384521160937;8211.917880821235;7987.520748755093;8019.959900200462;8021.2379823916635;8042.672958961823;8065.798355041171;6274.6548939808745;6427.517936154807;6431.485481161496;6432.807015789627;6439;4471.530489298577;4561.087782443458;4639.628829693549;4734.857954261378;4840.104580652591;7099.645017748989;7425.851482970418;7458.142313634002;7480.4389670776;7485.363744081814;7600.8479830401975;7605.733799316998;7650.158482567024;7653.846923061619;7677;5398.217258497574;5921.85195370102;6011.248593925759;6056;6056.727447264796;5888.3228428729535;6038.456538911519;6238.812835614939;6241.282252540835;6358.93641063602;5854.707264636666;5912.113183022581;5915.201447804491;5995.460408563075;6127.172831667668;5797.594168408171;5857.384974577779;5882.411758824083;5886.970565147147;6007.939920600738;5158.948410515847;5304.522592966651;5348.171033489815;5433.619646624698;5498.917516237339;4098.7950602470355;4117.732347397409;4214.536400995827;4291.120320334261;4317.633001194934;4021.93967090488;4071.16541109066;4124.628783409507;4260.936085958651;4368.279233926367 08:52:40 INFO - PROCESS | 19921 | |4;prototype.html;273.94521095780846;280.28667042377145;282.1774527253057;285.4405365483652;286.3171336362774;4545.318202269661;4679.344891715163;4738.90522189556;4768.332433459318;4795;4575.702579332341;4686.367340409044;4698.85903422897;4702.506236845134;4717.976410117944;3521;3688.336099502102;3692;3712.8490168047992;3715.777053376806;3582.5521809773777;3625.492431059654;3697.576433073259;3698.167912219756;3706.4255040468634;3628.38317486028;3640.071781695664;3655.3968595181764;3658.396364599851;3664.6335366463272;3655.6527129922615;3660.981695091521;3665.8839986011944;3674.9816250918843;3692.6861216796606;3024.3346463777934;3189.7926634768664;3217.517372394136;3230.789998650104;3231.818522497305;4599.517050709661;4613.331066995301;4625.144348295543;4632.930506042412;4633.953660463386;4143.274926887812;4147.792610369469;4153.8961525961795;4157.397177409289;4159;4805.6155507559315;4887.242477416006;4907.362042934431;4950.78705717098;4958.355413796219;3502.124468882779;3502.807345595991;3540.973117795836;3542.8937131886087;3543.4684797280356;5157.200633901752;5195.558377537876;5196.350456192976;5203.687778733288;5211.661242019257;3437.553118094632;3577.58857731359;3653.707703383723;3657.305112028706;3668.1563240454843;3614.8915532534065;3640.508531348234;3645.70834333258;3669.5779985301497;3678.3378991781738;4112.732672376345;4132.214879172948;4146;4155.231282212801;4158.397032430281;4614.723116612947;4786.210275304606;4791.305260737243;4878.756062196876;4891.926621100686;1198.9220700654605;1213.4539457244275;1217.7807994561065;1226.8282440458343;1233.216907263894;810.4691427115249;842.1199846160777;849.755108765649;854.3976496569903;859.9785005374915;4192.014876504019;4193.622573968358;4209.852974982719;4232.915341693149;4240.6395456385935;4882.2432522959;4896.387951506062;4922.138625740481;4938.703677779345;4952.232403977389;4145.730527515701;4227.7040607157205;4238.131183107455;4260.957390426118;4263.722858014219;2498.263012411343;2547.312225699051;2574.3435423967144;2581.9741802581734;2593.6757905261843;4591.79336929839;4594.793234304464;4603.723776573416;4606.262997920317;4611.608013318838;4958.545519967639;4969.577585905238;4980.252962055721;4980.726060066659;4992.950070499249;4439.66702497314;4533.682642215079;4577.198990176772;4580.770961451914;4628.560286772751;4846.491118432514;4852.56326930578;4880.31675565414;4888.582311129875;4906.092372911023;4775.904481910273;4835.516448355277;4839.9430242146245;4854.247591623304;4867.342908707279;4481.395011673513;4588.4952655207235;4615.192341340185;4640.234361330343;4641.907161856811;3502.7898326100517;3502.9299414012085;3506.8421921013105;3515.1739341255297;3517.683408493248;4827;4897.461279259207;4907.386576677915;4916.975415122902;4928.728919909439;4781.378420805412;4833.912369716926;4956.281339205867;4956.628252880976;4961.156603377507;4942.75286235694;4943.961768028755;4944.703317800943;4961.776720047678;4968.677035992649;4734.96961944349;4863.124637565272;4866.513348665105;4870;4874.2444921037295;4947.579455746158;4975.601951843916;4993.575546078624;5002.474740152377;5005.324281222134;4836.443808962014;4836.709797412166;4841.958978819571;4851.611871050378;4882.36529251195 08:52:40 INFO - PROCESS | 19921 | |5;yui.html;618.5113760129498;628.9088082228077;645.093643430979;723.9819004524886;728.5300980867344;11781.116416268782;12661.493540258378;13054.804177937338;13060.999999999987;13443.26062066586;12416.317102559378;12694.174878632883;12696.746065078692;12708.428120734567;12715.173513721626;632.5161251642497;766.4787944197943;783.1933108897845;785.1834092543776;785.352084530262;643.9130717353167;766.877299632059;781.527176058485;786.9173736757643;793.3573805217792;819.315871247509;820.335528222142;822.2969361196151;822.5558198572763;822.6997146041682;662.0863208771912;808.1635507250027;810.5096416667949;810.6271115286975;811.2252798577374;492.308306828906;579.7188363643629;594.2631137389606;596.2070446306402;601.3114983344046;11343.602973895957;11346.149038822039;11373.203875728703;11374.431278436128;11379.374134422604;11837;11985.041196704242;12240.755184896252;12328.75342493145;12522;10910.781784364348;10983.340999540053;11001.724956876062;11066.557337706483;11116.777664446747;3914.8825535233987;3940.783256920868;3946.4869566956113;3950.1309711863346;3993.7204395692315;46688.53311466876;47940.7602961983;48240;48314.51685483135;48778.268325975136;9726.4074352628;9901.207903367713;9907.603695852229;9949.900500995042;9983.900160998443;17736.20187091584;17745.645087098186;17787.110644467724;17901.820981790017;17946.730799038025;6449.097126402307;6489.70796314167;6505.414512693786;6536.379043990813;6656.167979002625;3460.567429071366;3534.540509733718;3562.87529936451;3586.946195807065;3623.61951995042;2585.7414258574368;2663.2010396881246;2668.546347120994;2670.7863370930277;2672.3452754075374;466.52880590603735;470.3978906999047;480.24121887418494;482.8092903303246;485.07350959666866;406.5385787131627;417.1469345189096;423.8686007337735;466.9813207471663;527.0250037430799;6549.345065493508;6628.933710662928;6649.501287403464;6672.099266599044;7057.576545407292;476.1120510248362;487.70250147410053;495.7397366382606;531.8457647282322;545.0733752620561;3129.4679904416303;3138.905832825019;3140.560321554984;3207.1020114368016;3217.436948533997;64940.675296623216;66724.33275667278;67629;71348.64325678338;71432.64283678548;38079.80960095237;42581;59678.701606492556;61150.38849611536;61649;53483.19775203375;54248.728756355966;55138.9999999992;55413;55764.72117639386;6343.5876668016435;6374.203224596926;6409.903851442139;6412.839679008062;6728;37203.44194837025;38324.61675383322;38397;39142.21715565616;40323;46611.76694116508;48036.43653852878;50164.749176253885;51766.22350664818;54294.185587215434;8451.408401412087;8665.080965126082;8668.219860212612;8714.651413943371;8763.07987661312;9128.589213485277;9162.450252984841;9212.585433655635;9451.480168590519;9484.430934143973;8350.123237060265;8358.331333493428;8431.662733490837;8481.57592120404;8665.740027799176;8533.104024077631;8545.681629322296;8798.824023519366;8821.623346194703;9116.4074335168;8334.333253339597;8424.452410593292;8448.83102337962;8637.093105223861;8867.467951922905;7345.081864766904;7433.888491672521;7508.43686723487;7537.283958023979;7630.389568834591;7029.0862187915245;7073.823154420975;7114.50198486101;7366.447516436396;7371.631418429164 08:52:40 INFO - PROCESS | 19921 | __end_tp_report 08:52:40 INFO - PROCESS | 19921 | __start_cc_report 08:52:40 INFO - PROCESS | 19921 | _x_x_mozilla_cycle_collect,1229 08:52:40 INFO - PROCESS | 19921 | __end_cc_report 08:52:40 INFO - PROCESS | 19921 | __startTimestamp1479487960223__endTimestamp 08:52:40 INFO - PROCESS | 19921 | 08:52:40 INFO - PROCESS | 19921 | ------- Summary: start ------- 08:52:40 INFO - PROCESS | 19921 | Number of tests: 6 08:52:40 INFO - PROCESS | 19921 | 08:52:40 INFO - PROCESS | 19921 | [#0] dojo.html Cycles:165 Average:4481.31 Median:4581.13 stddev:463.34 (10.1%) stddev-sans-first:438.43 08:52:40 INFO - PROCESS | 19921 | Values: 2518.6 2540.7 2564.5 2573.4 2586.9 4353.0 4457.3 4477.0 4488.9 4495.5 4489.7 4501.6 4521.8 4526.4 4581.0 4111.3 4137.3 4180.3 4195.9 4215.6 3886.1 4264.1 4274.9 4310.1 4346.0 4118.3 4212.0 4214.5 4288.1 4304.3 4156.0 4207.6 4221.2 4223.6 4226.1 4102.4 4198.9 4202.7 4212.2 4214.7 4456.9 4462.8 4467.0 4523.4 4529.4 4785.1 4785.9 4791.7 4793.4 4820.9 4723.4 4783.6 4808.7 4819.7 4859.1 4506.9 4514.0 4519.7 4520.6 4521.1 4867.5 4904.9 4914.8 4915.3 4915.5 4731.7 4733.1 4733.7 4741.1 4742.0 4766.1 4816.9 4818.4 4818.7 4831.2 4799.1 4868.5 4898.9 4906.5 4906.7 4830.8 4834.3 4841.2 4843.1 4886.3 4104.1 4104.6 4108.7 4137.6 4150.1 3515.8 3536.6 3558.4 3625.8 3631.7 4162.4 4175.3 4177.8 4198.4 4201.5 4894.5 4907.9 4936.6 4943.1 4957.9 4188.1 4194.0 4194.6 4235.3 4235.6 4255.3 4309.6 4351.5 4357.5 4400.0 4511.2 4530.7 4549.7 4615.9 4617.8 4832.7 4836.0 4839.9 4840.3 4885.8 4566.2 4569.5 4576.9 4581.1 4616.8 4691.0 4746.7 4747.4 4750.2 4756.2 4844.6 4910.7 4914.2 4946.6 4964.2 4737.9 4764.9 4773.5 4774.3 4824.6 4608.1 4675.1 4722.2 4763.5 4825.1 4571.3 4610.6 4627.1 4634.8 4676.0 4762.9 4763.7 4765.5 4777.1 4805.2 4653.2 4661.0 4668.2 4709.2 4709.5 08:52:40 INFO - PROCESS | 19921 | 08:52:40 INFO - PROCESS | 19921 | [#1] ext.html Cycles:180 Average:44207.17 Median:18105.84 stddev:79404.22 (438.6%) stddev-sans-first:79559.31 08:52:40 INFO - PROCESS | 19921 | Values: 549.6 550.5 563.2 567.9 568.2 27744.2 30498.4 37159.8 38506.8 38637.2 38556.8 38858.6 39042.6 39098.8 39202.4 7537.8 7692.5 7699.5 7699.7 7699.9 7400.7 7442.2 7560.1 9690.9 9961.1 9970.6 10020.9 10033.1 10035.7 10042.3 9808.6 9860.4 9869.3 9870.3 9876.4 9774.2 9837.3 9837.4 9847.9 9855.1 36919.8 37177.3 37188.0 37217.0 37233.8 2885.8 2929.4 2950.7 2952.2 2966.4 27166.6 27838.0 27863.6 28263.6 28693.0 3249.4 3284.7 3355.2 3396.4 3447.1 232506.0 234017.0 234138.0 234360.0 234577.0 52136.5 52284.5 52662.2 52662.5 52670.5 29950.9 30533.4 30768.2 55182.2 55203.8 13916.4 14131.3 14140.4 14142.6 14144.4 9534.9 10054.5 10087.7 10131.5 10143.8 14814.9 17091.5 17500.8 17593.8 18100.5 6570.3 6600.2 6669.1 6718.4 6752.3 763.3 833.0 883.3 937.7 945.2 25654.2 26527.7 26847.0 27003.5 27371.5 886.1 889.2 902.3 905.7 923.1 13979.6 14331.3 14446.6 14579.4 14739.9 354284.0 356409.0 357475.0 357813.0 358315.0 42840.4 43125.1 43143.0 43169.4 43266.6 1117.9 1147.1 1156.2 1163.4 1171.0 25663.0 25945.4 26506.6 26632.5 26910.0 40474.0 40775.4 40795.4 40804.4 40809.4 302143.0 302307.0 303419.0 303549.0 303625.0 20770.2 22822.2 23040.5 23155.5 23378.0 34753.7 37055.0 37272.4 37477.0 37845.0 31279.0 31327.7 31484.7 31798.0 32179.4 31513.2 32380.1 32535.7 32712.3 32774.0 32271.7 32713.0 32927.0 33038.3 33045.5 26897.6 30209.8 31070.8 31394.1 34370.5 24419.0 24439.5 24505.1 24722.8 24909.9 08:52:40 INFO - PROCESS | 19921 | 08:52:40 INFO - PROCESS | 19921 | [#2] jquery.html Cycles:180 Average:23705.45 Median:54191.73 stddev:62565.18 (115.5%) stddev-sans-first:62716.05 08:52:40 INFO - PROCESS | 19921 | Values: 316.9 332.2 335.5 335.6 366.1 12433.4 13601.0 15503.9 16339.9 17487.0 13902.1 13987.3 14139.2 15725.4 16207.4 4785.2 5005.6 5013.2 5016.5 5017.4 3994.6 5725.6 5755.8 5844.5 5854.4 5560.2 5814.1 5817.5 5821.0 5823.3 5750.9 5757.0 5775.4 5775.9 5785.3 4844.2 4987.2 5038.3 5040.3 5044.8 20077.0 20231.0 20391.8 20440.9 20793.6 1782.8 1885.1 1917.7 1919.2 1963.3 12732.4 13175.6 13598.8 13633.9 13805.4 1636.1 1681.7 1717.3 1769.9 1914.2 65255.0 67544.7 68409.7 68413.0 70361.0 9625.4 9745.8 9797.6 9940.1 9965.7 13378.6 13387.2 13407.2 13413.5 13422.7 6871.8 6974.5 7028.5 7087.7 7098.4 6716.9 6756.5 6902.1 6906.4 6908.0 4120.3 4127.1 4140.3 4168.0 4268.5 1701.3 1725.2 1740.8 1766.0 1795.4 749.2 785.7 831.5 876.0 962.0 16383.0 16758.6 17323.0 17375.9 17706.3 799.9 816.3 816.6 827.4 878.3 9161.2 9197.3 9783.4 9818.0 9963.7 371919.0 372962.0 373946.0 383738.0 385120.0 65683.3 80452.6 82729.6 83056.6 84229.6 386.4 407.5 408.8 411.2 412.5 8611.4 8914.3 9649.6 9651.7 9841.0 35442.8 36368.5 36437.3 36543.6 37030.8 51297.5 53801.7 54103.7 54279.7 54871.0 6558.8 6868.4 7016.9 7061.8 7351.6 9491.7 10282.2 10519.3 10886.0 11051.8 9238.8 9640.5 9773.2 9782.7 10152.0 9449.3 9778.6 9965.3 10055.4 10111.0 9305.8 9490.1 9550.9 9684.3 9735.9 6858.2 7082.0 7165.8 7252.9 7293.7 7887.9 9393.3 9529.2 9791.6 9802.7 08:52:40 INFO - PROCESS | 19921 | 08:52:40 INFO - PROCESS | 19921 | [#3] mootools.html Cycles:180 Average:4418.78 Median:5373.19 stddev:2357.94 (43.9%) stddev-sans-first:2352.21 08:52:40 INFO - PROCESS | 19921 | Values: 1209.1 1315.0 1339.8 1387.4 1617.5 5965.4 6458.4 6625.9 6695.1 6860.3 6721.9 6725.9 6741.2 6746.3 6759.9 1997.9 2015.9 2016.0 2018.1 2020.8 1969.2 2025.7 2029.3 2042.4 2047.9 1954.1 1965.6 1983.9 1985.9 1992.2 1970.4 1980.8 1985.0 1987.6 1989.4 1926.9 1949.1 1954.9 2024.7 2027.6 6639.3 6769.9 6904.8 6913.3 6920.7 4014.6 4169.9 4175.2 4175.8 4181.4 2589.5 2764.9 2809.3 2817.3 2831.8 924.3 932.6 946.1 963.3 969.0 8545.3 8592.2 8603.1 8604.3 8616.4 3482.7 3506.5 3588.7 3594.4 3620.7 6896.4 6897.1 6900.6 6901.7 6902.0 3964.6 4017.7 4019.9 4036.3 4038.4 3257.7 3354.1 3648.7 3774.2 3774.7 2906.0 2939.4 3029.1 3044.9 3048.1 897.0 898.1 904.0 906.3 906.6 648.4 712.2 797.1 813.6 846.1 4495.9 4616.9 4807.5 4876.7 4910.7 390.6 398.5 402.4 870.2 913.8 3258.5 3292.1 3326.4 3331.7 3439.9 7763.7 8185.4 8198.2 8206.4 8211.9 7987.5 8020.0 8021.2 8042.7 8065.8 6274.7 6427.5 6431.5 6432.8 6439.0 4471.5 4561.1 4639.6 4734.9 4840.1 7099.6 7425.9 7458.1 7480.4 7485.4 7600.8 7605.7 7650.2 7653.8 7677.0 5398.2 5921.9 6011.2 6056.0 6056.7 5888.3 6038.5 6238.8 6241.3 6358.9 5854.7 5912.1 5915.2 5995.5 6127.2 5797.6 5857.4 5882.4 5887.0 6007.9 5158.9 5304.5 5348.2 5433.6 5498.9 4098.8 4117.7 4214.5 4291.1 4317.6 4021.9 4071.2 4124.6 4260.9 4368.3 08:52:40 INFO - PROCESS | 19921 | 08:52:40 INFO - PROCESS | 19921 | [#4] prototype.html Cycles:180 Average:4039.18 Median:4601.62 stddev:1170.42 (25.4%) stddev-sans-first:1139.07 08:52:40 INFO - PROCESS | 19921 | Values: 273.9 280.3 282.2 285.4 286.3 4545.3 4679.3 4738.9 4768.3 4795.0 4575.7 4686.4 4698.9 4702.5 4718.0 3521.0 3688.3 3692.0 3712.8 3715.8 3582.6 3625.5 3697.6 3698.2 3706.4 3628.4 3640.1 3655.4 3658.4 3664.6 3655.7 3661.0 3665.9 3675.0 3692.7 3024.3 3189.8 3217.5 3230.8 3231.8 4599.5 4613.3 4625.1 4632.9 4634.0 4143.3 4147.8 4153.9 4157.4 4159.0 4805.6 4887.2 4907.4 4950.8 4958.4 3502.1 3502.8 3541.0 3542.9 3543.5 5157.2 5195.6 5196.4 5203.7 5211.7 3437.6 3577.6 3653.7 3657.3 3668.2 3614.9 3640.5 3645.7 3669.6 3678.3 4112.7 4132.2 4146.0 4155.2 4158.4 4614.7 4786.2 4791.3 4878.8 4891.9 1198.9 1213.5 1217.8 1226.8 1233.2 810.5 842.1 849.8 854.4 860.0 4192.0 4193.6 4209.9 4232.9 4240.6 4882.2 4896.4 4922.1 4938.7 4952.2 4145.7 4227.7 4238.1 4261.0 4263.7 2498.3 2547.3 2574.3 2582.0 2593.7 4591.8 4594.8 4603.7 4606.3 4611.6 4958.5 4969.6 4980.3 4980.7 4993.0 4439.7 4533.7 4577.2 4580.8 4628.6 4846.5 4852.6 4880.3 4888.6 4906.1 4775.9 4835.5 4839.9 4854.2 4867.3 4481.4 4588.5 4615.2 4640.2 4641.9 3502.8 3502.9 3506.8 3515.2 3517.7 4827.0 4897.5 4907.4 4917.0 4928.7 4781.4 4833.9 4956.3 4956.6 4961.2 4942.8 4944.0 4944.7 4961.8 4968.7 4735.0 4863.1 4866.5 4870.0 4874.2 4947.6 4975.6 4993.6 5002.5 5005.3 4836.4 4836.7 4842.0 4851.6 4882.4 08:52:40 INFO - PROCESS | 19921 | 08:52:40 INFO - PROCESS | 19921 | [#5] yui.html Cycles:180 Average:13822.35 Median:30137.45 stddev:18170.69 (60.3%) stddev-sans-first:18194.61 08:52:40 INFO - PROCESS | 19921 | Values: 618.5 628.9 645.1 724.0 728.5 11781.1 12661.5 13054.8 13061.0 13443.3 12416.3 12694.2 12696.7 12708.4 12715.2 632.5 766.5 783.2 785.2 785.4 643.9 766.9 781.5 786.9 793.4 819.3 820.3 822.3 822.6 822.7 662.1 808.2 810.5 810.6 811.2 492.3 579.7 594.3 596.2 601.3 11343.6 11346.1 11373.2 11374.4 11379.4 11837.0 11985.0 12240.8 12328.8 12522.0 10910.8 10983.3 11001.7 11066.6 11116.8 3914.9 3940.8 3946.5 3950.1 3993.7 46688.5 47940.8 48240.0 48314.5 48778.3 9726.4 9901.2 9907.6 9949.9 9983.9 17736.2 17745.6 17787.1 17901.8 17946.7 6449.1 6489.7 6505.4 6536.4 6656.2 3460.6 3534.5 3562.9 3586.9 3623.6 2585.7 2663.2 2668.5 2670.8 2672.3 466.5 470.4 480.2 482.8 485.1 406.5 417.1 423.9 467.0 527.0 6549.3 6628.9 6649.5 6672.1 7057.6 476.1 487.7 495.7 531.8 545.1 3129.5 3138.9 3140.6 3207.1 3217.4 64940.7 66724.3 67629.0 71348.6 71432.6 38079.8 42581.0 59678.7 61150.4 61649.0 53483.2 54248.7 55139.0 55413.0 55764.7 6343.6 6374.2 6409.9 6412.8 6728.0 37203.4 38324.6 38397.0 39142.2 40323.0 46611.8 48036.4 50164.7 51766.2 54294.2 8451.4 8665.1 8668.2 8714.7 8763.1 9128.6 9162.5 9212.6 9451.5 9484.4 8350.1 8358.3 8431.7 8481.6 8665.7 8533.1 8545.7 8798.8 8821.6 9116.4 8334.3 8424.5 8448.8 8637.1 8867.5 7345.1 7433.9 7508.4 7537.3 7630.4 7029.1 7073.8 7114.5 7366.4 7371.6 08:52:40 INFO - PROCESS | 19921 | -------- Summary: end -------- 08:52:40 INFO - PROCESS | 19921 | 08:52:41 INFO - TEST-INFO | 19921: exit 0 08:52:41 INFO - TEST-OK | dromaeo_css | took 1122795ms 08:52:41 INFO - TEST-START | kraken 08:52:41 INFO - operating with platform_type : linux_ 08:52:41 INFO - Initialising browser for kraken test... 08:52:41 INFO - TEST-INFO | started process 20223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy0MjKv/profile http://localhost:53908/getInfo.html) 08:52:45 INFO - PROCESS | 20223 | __metrics Screen width/height:1600/1200 08:52:45 INFO - PROCESS | 20223 | colorDepth:24 08:52:45 INFO - PROCESS | 20223 | Browser inner width/height: 1024/697 08:52:45 INFO - PROCESS | 20223 | __metrics 08:52:46 INFO - PROCESS | 20223 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:52:46 INFO - PROCESS | 20223 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:46 INFO - PROCESS | 20223 | console.error: PushService: 08:52:46 INFO - PROCESS | 20223 | stateChangeProcessEnqueue: Error transitioning state 08:52:46 INFO - PROCESS | 20223 | UnknownError 08:52:47 INFO - TEST-INFO | 20223: exit 0 08:52:47 INFO - Browser initialized. 08:52:47 INFO - Running cycle 1/1 for kraken test... 08:52:47 INFO - TEST-INFO | started process 20305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy0MjKv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:59 INFO - PROCESS | 20305 | RSS: Main: 174960640 08:52:59 INFO - PROCESS | 20305 | 08:53:02 INFO - PROCESS | 20305 | Cycle 1(1): loaded http://localhost:53908/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53908/tests/kraken/driver.html?testName=audio-beat-detection) 08:53:03 INFO - PROCESS | 20305 | RSS: Main: 231321600 08:53:03 INFO - PROCESS | 20305 | 08:53:06 INFO - PROCESS | 20305 | Cycle 1(1): loaded http://localhost:53908/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53908/tests/kraken/driver.html?testName=audio-dft) 08:53:06 INFO - PROCESS | 20305 | RSS: Main: 218271744 08:53:06 INFO - PROCESS | 20305 | 08:53:10 INFO - PROCESS | 20305 | Cycle 1(1): loaded http://localhost:53908/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53908/tests/kraken/driver.html?testName=audio-fft) 08:53:10 INFO - PROCESS | 20305 | RSS: Main: 300765184 08:53:10 INFO - PROCESS | 20305 | 08:53:13 INFO - PROCESS | 20305 | Cycle 1(1): loaded http://localhost:53908/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53908/tests/kraken/driver.html?testName=audio-oscillator) 08:53:13 INFO - PROCESS | 20305 | RSS: Main: 211476480 08:53:13 INFO - PROCESS | 20305 | 08:53:15 INFO - PROCESS | 20305 | Cycle 1(1): loaded http://localhost:53908/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53908/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:53:16 INFO - PROCESS | 20305 | RSS: Main: 214667264 08:53:16 INFO - PROCESS | 20305 | 08:53:19 INFO - PROCESS | 20305 | Cycle 1(1): loaded http://localhost:53908/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53908/tests/kraken/driver.html?testName=imaging-darkroom) 08:53:20 INFO - PROCESS | 20305 | RSS: Main: 253681664 08:53:20 INFO - PROCESS | 20305 | 08:53:23 INFO - PROCESS | 20305 | Cycle 1(1): loaded http://localhost:53908/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53908/tests/kraken/driver.html?testName=imaging-desaturate) 08:53:24 INFO - PROCESS | 20305 | RSS: Main: 248422400 08:53:24 INFO - PROCESS | 20305 | 08:53:27 INFO - PROCESS | 20305 | Cycle 1(1): loaded http://localhost:53908/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53908/tests/kraken/driver.html?testName=json-parse-financial) 08:53:27 INFO - PROCESS | 20305 | RSS: Main: 250687488 08:53:27 INFO - PROCESS | 20305 | 08:53:29 INFO - PROCESS | 20305 | Cycle 1(1): loaded http://localhost:53908/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53908/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:53:30 INFO - PROCESS | 20305 | RSS: Main: 213606400 08:53:30 INFO - PROCESS | 20305 | 08:53:32 INFO - PROCESS | 20305 | Cycle 1(1): loaded http://localhost:53908/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53908/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:53:32 INFO - PROCESS | 20305 | RSS: Main: 220921856 08:53:32 INFO - PROCESS | 20305 | 08:53:35 INFO - PROCESS | 20305 | Cycle 1(1): loaded http://localhost:53908/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53908/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:53:35 INFO - PROCESS | 20305 | RSS: Main: 229494784 08:53:35 INFO - PROCESS | 20305 | 08:53:38 INFO - PROCESS | 20305 | Cycle 1(1): loaded http://localhost:53908/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:53:39 INFO - PROCESS | 20305 | RSS: Main: 238125056 08:53:39 INFO - PROCESS | 20305 | 08:53:42 INFO - PROCESS | 20305 | Cycle 1(1): loaded http://localhost:53908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:53:42 INFO - PROCESS | 20305 | RSS: Main: 234815488 08:53:42 INFO - PROCESS | 20305 | 08:53:44 INFO - PROCESS | 20305 | Cycle 1(1): loaded http://localhost:53908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53908/tests/kraken/driver.html?testName=ai-astar) 08:53:45 INFO - PROCESS | 20305 | RSS: Main: 285474816 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | __start_tp_report 08:53:45 INFO - PROCESS | 20305 | _x_x_mozilla_page_load 08:53:45 INFO - PROCESS | 20305 | _x_x_mozilla_page_load_details 08:53:45 INFO - PROCESS | 20305 | |i|pagename|runs| 08:53:45 INFO - PROCESS | 20305 | |0;ai-astar;111;116;120;117;116;116;115;116;117;118 08:53:45 INFO - PROCESS | 20305 | |1;audio-beat-detection;163;127;129;163;127;130;127;129;166;138 08:53:45 INFO - PROCESS | 20305 | |2;audio-dft;161;163;162;165;161;162;162;162;161;162 08:53:45 INFO - PROCESS | 20305 | |3;audio-fft;77;78;78;115;77;78;78;84;106;76 08:53:45 INFO - PROCESS | 20305 | |4;audio-oscillator;85;84;114;85;90;83;110;82;83;111 08:53:45 INFO - PROCESS | 20305 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;116;117 08:53:45 INFO - PROCESS | 20305 | |6;imaging-darkroom;147;147;147;146;147;147;146;146;147;147 08:53:45 INFO - PROCESS | 20305 | |7;imaging-desaturate;95;96;95;96;96;96;96;95;95;95 08:53:45 INFO - PROCESS | 20305 | |8;json-parse-financial;66;78;65;66;66;65;66;67;67;67 08:53:45 INFO - PROCESS | 20305 | |9;json-stringify-tinderbox;66;67;65;66;66;65;66;66;66;67 08:53:45 INFO - PROCESS | 20305 | |10;stanford-crypto-aes;87;85;86;85;95;85;84;86;85;95 08:53:45 INFO - PROCESS | 20305 | |11;stanford-crypto-ccm;148;145;151;147;144;152;143;140;188;141 08:53:45 INFO - PROCESS | 20305 | |12;stanford-crypto-pbkdf2;182;180;179;178;178;182;182;180;180;186 08:53:45 INFO - PROCESS | 20305 | |13;stanford-crypto-sha256-iterative;70;72;71;70;75;72;70;69;73;67 08:53:45 INFO - PROCESS | 20305 | __end_tp_report 08:53:45 INFO - PROCESS | 20305 | __start_cc_report 08:53:45 INFO - PROCESS | 20305 | _x_x_mozilla_cycle_collect,1988 08:53:45 INFO - PROCESS | 20305 | __end_cc_report 08:53:45 INFO - PROCESS | 20305 | __startTimestamp1479488025039__endTimestamp 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | ------- Summary: start ------- 08:53:45 INFO - PROCESS | 20305 | Number of tests: 14 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | [#0] ai-astar Cycles:10 Average:116.20 Median:116.50 stddev:2.30 (2.0%) stddev-sans-first:1.48 08:53:45 INFO - PROCESS | 20305 | Values: 111.0 116.0 120.0 117.0 116.0 116.0 115.0 116.0 117.0 118.0 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:134.00 stddev:16.95 (12.7%) stddev-sans-first:15.79 08:53:45 INFO - PROCESS | 20305 | Values: 163.0 127.0 129.0 163.0 127.0 130.0 127.0 129.0 166.0 138.0 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 08:53:45 INFO - PROCESS | 20305 | Values: 161.0 163.0 162.0 165.0 161.0 162.0 162.0 162.0 161.0 162.0 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | [#3] audio-fft Cycles:10 Average:84.70 Median:78.00 stddev:13.93 (17.9%) stddev-sans-first:14.49 08:53:45 INFO - PROCESS | 20305 | Values: 77.0 78.0 78.0 115.0 77.0 78.0 78.0 84.0 106.0 76.0 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:83.50 stddev:13.30 (15.9%) stddev-sans-first:13.81 08:53:45 INFO - PROCESS | 20305 | Values: 85.0 84.0 114.0 85.0 90.0 83.0 110.0 82.0 83.0 111.0 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:53:45 INFO - PROCESS | 20305 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 08:53:45 INFO - PROCESS | 20305 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:53:45 INFO - PROCESS | 20305 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:66.50 stddev:3.83 (5.8%) stddev-sans-first:4.03 08:53:45 INFO - PROCESS | 20305 | Values: 66.0 78.0 65.0 66.0 66.0 65.0 66.0 67.0 67.0 67.0 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 08:53:45 INFO - PROCESS | 20305 | Values: 66.0 67.0 65.0 66.0 66.0 65.0 66.0 66.0 66.0 67.0 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:86.00 stddev:4.14 (4.8%) stddev-sans-first:4.39 08:53:45 INFO - PROCESS | 20305 | Values: 87.0 85.0 86.0 85.0 95.0 85.0 84.0 86.0 85.0 95.0 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:147.50 stddev:13.96 (9.5%) stddev-sans-first:14.79 08:53:45 INFO - PROCESS | 20305 | Values: 148.0 145.0 151.0 147.0 144.0 152.0 143.0 140.0 188.0 141.0 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.70 Median:181.00 stddev:2.41 (1.3%) stddev-sans-first:2.51 08:53:45 INFO - PROCESS | 20305 | Values: 182.0 180.0 179.0 178.0 178.0 182.0 182.0 180.0 180.0 186.0 08:53:45 INFO - PROCESS | 20305 | 08:53:45 INFO - PROCESS | 20305 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.50 stddev:2.23 (3.1%) stddev-sans-first:2.35 08:53:45 INFO - PROCESS | 20305 | Values: 70.0 72.0 71.0 70.0 75.0 72.0 70.0 69.0 73.0 67.0 08:53:45 INFO - PROCESS | 20305 | -------- Summary: end -------- 08:53:45 INFO - PROCESS | 20305 | 08:53:46 INFO - TEST-INFO | 20305: exit 0 08:53:46 INFO - TEST-OK | kraken | took 65232ms 08:53:46 INFO - SUITE-END | took 1188s 08:53:46 INFO - Completed test suite (00:19:48) 08:53:46 INFO - javascript benchmark 08:53:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2518.5592521308768, 2540.7459254074606, 2564.5127425789105, 2573.369524466505, 2586.935326616834, 4352.956470435302, 4457.331400289954, 4477.037436951063, 4488.932666010012, 4495.460544734632, 4489.730616163032, 4501.594856462926, 4521.773911304438, 4526.366308716782, 4580.977095114528, 4111.342185250361, 4137.27597670408, 4180.331147016478, 4195.930037840361, 4215.620594146526, 3886.125621735101, 4264.083222107246, 4274.871753847389, 4310.094880075188, 4346.0, 4118.299889018874, 4212.0, 4214.494260688706, 4288.078063216408, 4304.31131019037, 4155.97922010391, 4207.64235040022, 4221.197972385237, 4223.598758117974, 4226.091390351058, 4102.364133559303, 4198.85304014358, 4202.747835129871, 4212.220739163234, 4214.726042807208, 4456.866294011184, 4462.799174037176, 4467.0, 4523.36672865799, 4529.365888775574, 4785.114753770529, 4785.928211076836, 4791.736454495001, 4793.400824896888, 4820.927686084711, 4723.433188017426, 4783.569478746929, 4808.735519546423, 4819.662623616348, 4859.052484765472, 4506.864794056183, 4514.0, 4519.728816271035, 4520.59314661682, 4521.11838191556, 4867.488913664014, 4904.852854414374, 4914.778834952435, 4915.311856340115, 4915.5330243626795, 4731.69243999139, 4733.053389322149, 4733.692309999908, 4741.0754902794315, 4742.0, 4766.094442055998, 4816.892114813612, 4818.445878723922, 4818.68678535894, 4831.202851529459, 4799.088173247142, 4868.464468908417, 4898.92651610219, 4906.484819094015, 4906.730129842893, 4830.782614782343, 4834.299026641117, 4841.225403935424, 4843.07981483517, 4886.29148773433, 4104.0970986382945, 4104.630583247522, 4108.712390132722, 4137.648299894482, 4150.107726838744, 3515.8242087896015, 3536.5756109267054, 3558.430651095812, 3625.782453052825, 3631.727620428426, 4162.396452514368, 4175.331946888483, 4177.8328866845595, 4198.3702444633545, 4201.474815648044, 4894.510548945077, 4907.9263811042865, 4936.580390666833, 4943.060818444484, 4957.876053098629, 4188.099558594917, 4194.035371864488, 4194.622483976456, 4235.25882970479, 4235.618794308465, 4255.29787585045, 4309.569043095666, 4351.477822661301, 4357.455318085239, 4399.956000440018, 4511.187986162391, 4530.728156310632, 4549.749763762892, 4615.907681846412, 4617.792199351037, 4832.734199618914, 4835.95164048355, 4839.854804355875, 4840.29815676732, 4885.804567817389, 4566.1552612766745, 4569.451665800125, 4576.908461830678, 4581.129585378767, 4616.838410655611, 4690.9765451172525, 4746.715197088186, 4747.382840230748, 4750.216214324736, 4756.16767065769, 4844.563989240985, 4910.680805747615, 4914.238293064581, 4946.604271658187, 4964.230544265644, 4737.881552961204, 4764.880877978078, 4773.498782627913, 4774.283857421415, 4824.614030877591, 4608.055348653585, 4675.13510000651, 4722.173619616485, 4763.476017637988, 4825.059113472839, 4571.291449825282, 4610.561996610317, 4627.074585083064, 4634.768261586974, 4675.99466114787, 4762.857114286577, 4763.69036012658, 4765.547273009059, 4777.0684716479955, 4805.231163013901, 4653.1856925038655, 4661.044485880454, 4668.229742092517, 4709.222978208557, 4709.529047095263], "value": 4452.20740425713, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.618015479242, 550.5430492691066, 563.1721369586709, 567.8921005009046, 568.1619611073667, 27744.167674969733, 30498.39003219937, 37159.81420092899, 38506.8074659627, 38637.227255454876, 38556.80721596388, 38858.61141388593, 39042.60957390425, 39098.80450597743, 39202.41196382057, 7537.773866783991, 7692.4999875008225, 7699.461037727361, 7699.6920123195005, 7699.923000770004, 7400.666969986337, 7442.218567050463, 7560.054993125859, 9690.903090969106, 9961.103500684936, 9970.551325190347, 10020.89979100207, 10033.097021268084, 10035.69892903214, 10042.297039207258, 9808.558614862313, 9860.359076660066, 9869.259805514615, 9870.309078364517, 9876.358036727626, 9774.16919561838, 9837.311388202828, 9837.409755414697, 9847.90152098477, 9855.113039826378, 36919.815400922824, 37177.25645487102, 37188.0, 37217.0, 37233.81383093094, 2885.841278729669, 2929.3848291858735, 2950.6606740224934, 2952.1733914503975, 2966.42154779818, 27166.5925011123, 27838.0, 27863.582046269323, 28263.57604635932, 28693.0, 3249.431349513826, 3284.687954644305, 3355.2450698592866, 3396.371671240828, 3447.0865220716532, 232506.0, 234017.0, 234138.0, 234360.0, 234577.0, 52136.47863521392, 52284.47715522872, 52662.21006684903, 52662.47337526652, 52670.47329526656, 29950.850245748632, 30533.38933221323, 30768.230794230323, 55182.17226741602, 55203.82350294436, 13916.373763180682, 14131.293435328193, 14140.434382624786, 14142.64643383903, 14144.36350364236, 9534.90465095354, 10054.49727513636, 10087.747806304755, 10131.493425328705, 10143.847842282372, 14814.851851481562, 17091.48725538236, 17500.82499174992, 17593.824061759475, 18100.45698629043, 6570.277269500351, 6600.174978127734, 6669.066330713704, 6718.428933540606, 6752.257251702309, 763.3244578548025, 832.9625166867385, 883.3066043156092, 937.6718148647918, 945.1729736480579, 25654.230373088838, 26527.734722652527, 26847.0, 27003.459930801666, 27371.45257094847, 886.1183122792734, 889.1863944490848, 902.3412908576645, 905.6694306578052, 923.0907556057278, 13979.580612581638, 14331.283435828167, 14446.638834029234, 14579.416823326948, 14739.852601474062, 354284.0, 356409.0, 357475.0, 357813.0, 358315.0, 42840.357394639104, 43125.13749724988, 43143.0, 43169.35245971313, 43266.56733432625, 1117.8602674665667, 1147.1339138950207, 1156.1964434717959, 1163.3717792392013, 1170.9648710538697, 25663.0, 25945.351366215997, 26506.602400964388, 26632.467350652492, 26910.0, 40474.0, 40775.388369173896, 40795.38806917839, 40804.38793418161, 40809.38785918273, 302143.0, 302307.0, 303419.0, 303549.0, 303625.0, 20770.1691932321, 22822.20122295778, 23040.539189216455, 23155.494892831914, 23378.0, 34753.65246347605, 37055.0, 37272.44091338578, 37477.0, 37845.0, 31279.0, 31327.653090188312, 31484.685153148177, 31798.0, 32179.356412871144, 31513.21216969594, 32380.145097355027, 32535.674643253264, 32712.34575308433, 32774.0, 32271.67728322687, 32713.0, 32927.0, 33038.33923321568, 33045.50431743574, 26897.596536052366, 30209.848950755106, 31070.844645776626, 31394.064768872388, 34370.48444273288, 24419.0, 24439.511209775348, 24505.142320018713, 24722.752772472046, 24909.875450623356], "value": 16841.663145634095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.9160172554275, 332.2109988776655, 335.46158415742747, 335.63918787303646, 366.05192551292146, 12433.378331083444, 13601.0, 15503.922480387582, 16339.91830040848, 17487.038212898286, 13902.08056308174, 13987.300634968262, 14139.151650900953, 15725.370985160609, 16207.35170593175, 4785.234362502, 5005.6496045276845, 5013.248012798092, 5016.548510634042, 5017.37282839645, 3994.640482356587, 5725.6278341907855, 5755.769769209227, 5844.473997340238, 5854.443827836349, 5560.193771903072, 5814.09881468371, 5817.476427121558, 5821.039528477796, 5823.330317013534, 5750.942490575104, 5757.0, 5775.3935836736955, 5775.942240577582, 5785.334686511063, 4844.15227335215, 4987.226979818134, 5038.319826823368, 5040.34475518184, 5044.772985215674, 20077.0, 20231.0, 20391.796082039138, 20440.897795510926, 20793.58412831735, 1782.803891571926, 1885.1139964216795, 1917.7411049508278, 1919.1651631540324, 1963.3128405058258, 12732.427040783094, 13175.604731857964, 13598.796018059737, 13633.863661363359, 13805.378757955916, 1636.1410259613679, 1681.7477378393216, 1717.3216579451048, 1769.9469015929542, 1914.2247389807012, 65255.0, 67544.66227668879, 68409.65795171043, 68413.0, 70361.0, 9625.422474651543, 9745.817341544915, 9797.608095676092, 9940.105390514744, 9965.701028969142, 13378.598642040753, 13387.196768193939, 13407.195568265935, 13413.463461461628, 13422.731545369037, 6871.793846184622, 6974.511784175161, 7028.543144695578, 7087.681054352566, 7098.432125429953, 6716.858134117212, 6756.527043107034, 6902.137232845895, 6906.447484201251, 6908.0, 4120.2583534964, 4127.112670775738, 4140.337545992687, 4167.9583204168175, 4268.530461649216, 1701.3109690575336, 1725.1805392438491, 1740.8420334221807, 1765.9911700441417, 1795.4075155198752, 749.1871319618166, 785.654312102673, 831.538496134639, 876.0319846569577, 961.9807603848024, 16383.0, 16758.58103547421, 17323.0, 17375.913120434318, 17706.291748329924, 799.94400391972, 816.2979837339883, 816.603947085663, 827.3629305434781, 878.3061381508537, 9161.175494205554, 9197.264218862474, 9783.36408133469, 9818.0, 9963.651272205438, 371919.0, 372962.0, 373946.0, 383738.0, 385120.0, 65683.34316656868, 80452.59773701095, 82729.58635206906, 83056.58471707723, 84229.57885210535, 386.37021654702653, 407.5435512226266, 408.76700280839634, 411.2412598755292, 412.4534991136756, 8611.440256383315, 8914.33142514327, 9649.614015439303, 9651.662191823252, 9841.0, 35442.8227858859, 36368.454473183454, 36437.27125457529, 36543.63456365402, 37030.8148459256, 51297.487025129274, 53801.73099134479, 54103.72948135234, 54279.72860135674, 54871.0, 6558.770443034471, 6868.416184624163, 7016.859662806817, 7061.82345441368, 7351.558906465629, 9491.66779162726, 10282.228832837418, 10519.26365154432, 10886.0, 11051.778964420828, 9238.84357603095, 9640.517974101407, 9773.169280611228, 9782.706518804447, 10152.0, 9449.338546301693, 9778.559964801743, 9965.25260605443, 10055.39667619945, 10111.03945125212, 9305.767355815888, 9490.145886870216, 9550.85673714881, 9684.32209745311, 9735.853962190431, 6858.2455929848675, 7081.964590177016, 7165.7850264492145, 7252.927470725225, 7293.744718934812, 7887.921120788948, 9393.295502837178, 9529.190018848198, 9791.6010577409, 9802.65690700822], "value": 7755.833890391666, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1209.0690168570206, 1315.0334504139455, 1339.7789364754813, 1387.3756809435756, 1617.5470868156913, 5965.433283838034, 6458.386453286936, 6625.900611490825, 6695.062691223233, 6860.279670634573, 6721.932780672192, 6725.865482690356, 6741.157355330583, 6746.257911629717, 6759.864802703943, 1997.9300724474647, 2015.858889877709, 2015.959680806383, 2018.0817727933754, 2020.7878172791866, 1969.1532640964451, 2025.7062725904734, 2029.3303209940757, 2042.366866271453, 2047.8976051197455, 1954.0913475234013, 1965.557749506364, 1983.8908860012693, 1985.930492432765, 1992.1931617694784, 1970.3793305108845, 1980.7722111957094, 1985.037256930402, 1987.5826076523947, 1989.433011591704, 1926.9036548172535, 1949.0547084663926, 1954.8729332593336, 2024.6861736430876, 2027.5742094160244, 6639.269680335159, 6769.898451523231, 6904.827379315507, 6913.308669133096, 6920.653967301615, 4014.578469260744, 4169.937450938239, 4175.185838761443, 4175.832966681329, 4181.372794080882, 2589.469158822437, 2764.861756912146, 2809.339805145789, 2817.281593193743, 2831.8300901945745, 924.2513564013103, 932.6316105138433, 946.1201082992814, 963.3016063354082, 969.0261287406182, 8545.316374690072, 8592.226699597066, 8603.096674849114, 8604.26863716585, 8616.353773466952, 3482.7213822894614, 3506.50908872758, 3588.6949609282983, 3594.388953877847, 3620.6560376764164, 6896.448284137257, 6897.068895699117, 6900.585964842126, 6901.689423975933, 6902.0, 3964.6035396460125, 4017.6785857131945, 4019.8593049243136, 4036.3138266494766, 4038.434619153321, 3257.657945915692, 3354.144693103292, 3648.6533779290926, 3774.207416442523, 3774.7168962327937, 2906.0384240637486, 2939.412117576493, 3029.106413607991, 3044.9238769030508, 3048.0551029180583, 896.9596368163449, 898.128815049401, 904.0462312260497, 906.2976193450129, 906.582971832951, 648.3937518420292, 712.1987763765763, 797.1152021256516, 813.6338647608482, 846.0524212881489, 4495.865124046284, 4616.861494155113, 4807.543283388072, 4876.658633895664, 4910.729909854921, 390.62695126154455, 398.47003485364394, 402.3582386094175, 870.1689886158704, 913.7578541686458, 3258.4949332853444, 3292.111129994888, 3326.3846188455213, 3331.733461323137, 3439.8624055038017, 7763.689452421952, 8185.427020108655, 8198.180181981874, 8206.384521160937, 8211.917880821235, 7987.520748755093, 8019.959900200462, 8021.2379823916635, 8042.672958961823, 8065.798355041171, 6274.6548939808745, 6427.517936154807, 6431.485481161496, 6432.807015789627, 6439.0, 4471.530489298577, 4561.087782443458, 4639.628829693549, 4734.857954261378, 4840.104580652591, 7099.645017748989, 7425.851482970418, 7458.142313634002, 7480.4389670776, 7485.363744081814, 7600.8479830401975, 7605.733799316998, 7650.158482567024, 7653.846923061619, 7677.0, 5398.217258497574, 5921.85195370102, 6011.248593925759, 6056.0, 6056.727447264796, 5888.3228428729535, 6038.456538911519, 6238.812835614939, 6241.282252540835, 6358.93641063602, 5854.707264636666, 5912.113183022581, 5915.201447804491, 5995.460408563075, 6127.172831667668, 5797.594168408171, 5857.384974577779, 5882.411758824083, 5886.970565147147, 6007.939920600738, 5158.948410515847, 5304.522592966651, 5348.171033489815, 5433.619646624698, 5498.917516237339, 4098.7950602470355, 4117.732347397409, 4214.536400995827, 4291.120320334261, 4317.633001194934, 4021.93967090488, 4071.16541109066, 4124.628783409507, 4260.936085958651, 4368.279233926367], "value": 3601.5024441061873, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.94521095780846, 280.28667042377145, 282.1774527253057, 285.4405365483652, 286.3171336362774, 4545.318202269661, 4679.344891715163, 4738.90522189556, 4768.332433459318, 4795.0, 4575.702579332341, 4686.367340409044, 4698.85903422897, 4702.506236845134, 4717.976410117944, 3521.0, 3688.336099502102, 3692.0, 3712.8490168047992, 3715.777053376806, 3582.5521809773777, 3625.492431059654, 3697.576433073259, 3698.167912219756, 3706.4255040468634, 3628.38317486028, 3640.071781695664, 3655.3968595181764, 3658.396364599851, 3664.6335366463272, 3655.6527129922615, 3660.981695091521, 3665.8839986011944, 3674.9816250918843, 3692.6861216796606, 3024.3346463777934, 3189.7926634768664, 3217.517372394136, 3230.789998650104, 3231.818522497305, 4599.517050709661, 4613.331066995301, 4625.144348295543, 4632.930506042412, 4633.953660463386, 4143.274926887812, 4147.792610369469, 4153.8961525961795, 4157.397177409289, 4159.0, 4805.6155507559315, 4887.242477416006, 4907.362042934431, 4950.78705717098, 4958.355413796219, 3502.124468882779, 3502.807345595991, 3540.973117795836, 3542.8937131886087, 3543.4684797280356, 5157.200633901752, 5195.558377537876, 5196.350456192976, 5203.687778733288, 5211.661242019257, 3437.553118094632, 3577.58857731359, 3653.707703383723, 3657.305112028706, 3668.1563240454843, 3614.8915532534065, 3640.508531348234, 3645.70834333258, 3669.5779985301497, 3678.3378991781738, 4112.732672376345, 4132.214879172948, 4146.0, 4155.231282212801, 4158.397032430281, 4614.723116612947, 4786.210275304606, 4791.305260737243, 4878.756062196876, 4891.926621100686, 1198.9220700654605, 1213.4539457244275, 1217.7807994561065, 1226.8282440458343, 1233.216907263894, 810.4691427115249, 842.1199846160777, 849.755108765649, 854.3976496569903, 859.9785005374915, 4192.014876504019, 4193.622573968358, 4209.852974982719, 4232.915341693149, 4240.6395456385935, 4882.2432522959, 4896.387951506062, 4922.138625740481, 4938.703677779345, 4952.232403977389, 4145.730527515701, 4227.7040607157205, 4238.131183107455, 4260.957390426118, 4263.722858014219, 2498.263012411343, 2547.312225699051, 2574.3435423967144, 2581.9741802581734, 2593.6757905261843, 4591.79336929839, 4594.793234304464, 4603.723776573416, 4606.262997920317, 4611.608013318838, 4958.545519967639, 4969.577585905238, 4980.252962055721, 4980.726060066659, 4992.950070499249, 4439.66702497314, 4533.682642215079, 4577.198990176772, 4580.770961451914, 4628.560286772751, 4846.491118432514, 4852.56326930578, 4880.31675565414, 4888.582311129875, 4906.092372911023, 4775.904481910273, 4835.516448355277, 4839.9430242146245, 4854.247591623304, 4867.342908707279, 4481.395011673513, 4588.4952655207235, 4615.192341340185, 4640.234361330343, 4641.907161856811, 3502.7898326100517, 3502.9299414012085, 3506.8421921013105, 3515.1739341255297, 3517.683408493248, 4827.0, 4897.461279259207, 4907.386576677915, 4916.975415122902, 4928.728919909439, 4781.378420805412, 4833.912369716926, 4956.281339205867, 4956.628252880976, 4961.156603377507, 4942.75286235694, 4943.961768028755, 4944.703317800943, 4961.776720047678, 4968.677035992649, 4734.96961944349, 4863.124637565272, 4866.513348665105, 4870.0, 4874.2444921037295, 4947.579455746158, 4975.601951843916, 4993.575546078624, 5002.474740152377, 5005.324281222134, 4836.443808962014, 4836.709797412166, 4841.958978819571, 4851.611871050378, 4882.36529251195], "value": 3664.847891468467, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.5113760129498, 628.9088082228077, 645.093643430979, 723.9819004524886, 728.5300980867344, 11781.116416268782, 12661.493540258378, 13054.804177937338, 13060.999999999987, 13443.26062066586, 12416.317102559378, 12694.174878632883, 12696.746065078692, 12708.428120734567, 12715.173513721626, 632.5161251642497, 766.4787944197943, 783.1933108897845, 785.1834092543776, 785.352084530262, 643.9130717353167, 766.877299632059, 781.527176058485, 786.9173736757643, 793.3573805217792, 819.315871247509, 820.335528222142, 822.2969361196151, 822.5558198572763, 822.6997146041682, 662.0863208771912, 808.1635507250027, 810.5096416667949, 810.6271115286975, 811.2252798577374, 492.308306828906, 579.7188363643629, 594.2631137389606, 596.2070446306402, 601.3114983344046, 11343.602973895957, 11346.149038822039, 11373.203875728703, 11374.431278436128, 11379.374134422604, 11837.0, 11985.041196704242, 12240.755184896252, 12328.75342493145, 12522.0, 10910.781784364348, 10983.340999540053, 11001.724956876062, 11066.557337706483, 11116.777664446747, 3914.8825535233987, 3940.783256920868, 3946.4869566956113, 3950.1309711863346, 3993.7204395692315, 46688.53311466876, 47940.7602961983, 48240.0, 48314.51685483135, 48778.268325975136, 9726.4074352628, 9901.207903367713, 9907.603695852229, 9949.900500995042, 9983.900160998443, 17736.20187091584, 17745.645087098186, 17787.110644467724, 17901.820981790017, 17946.730799038025, 6449.097126402307, 6489.70796314167, 6505.414512693786, 6536.379043990813, 6656.167979002625, 3460.567429071366, 3534.540509733718, 3562.87529936451, 3586.946195807065, 3623.61951995042, 2585.7414258574368, 2663.2010396881246, 2668.546347120994, 2670.7863370930277, 2672.3452754075374, 466.52880590603735, 470.3978906999047, 480.24121887418494, 482.8092903303246, 485.07350959666866, 406.5385787131627, 417.1469345189096, 423.8686007337735, 466.9813207471663, 527.0250037430799, 6549.345065493508, 6628.933710662928, 6649.501287403464, 6672.099266599044, 7057.576545407292, 476.1120510248362, 487.70250147410053, 495.7397366382606, 531.8457647282322, 545.0733752620561, 3129.4679904416303, 3138.905832825019, 3140.560321554984, 3207.1020114368016, 3217.436948533997, 64940.675296623216, 66724.33275667278, 67629.0, 71348.64325678338, 71432.64283678548, 38079.80960095237, 42581.0, 59678.701606492556, 61150.38849611536, 61649.0, 53483.19775203375, 54248.728756355966, 55138.9999999992, 55413.0, 55764.72117639386, 6343.5876668016435, 6374.203224596926, 6409.903851442139, 6412.839679008062, 6728.0, 37203.44194837025, 38324.61675383322, 38397.0, 39142.21715565616, 40323.0, 46611.76694116508, 48036.43653852878, 50164.749176253885, 51766.22350664818, 54294.185587215434, 8451.408401412087, 8665.080965126082, 8668.219860212612, 8714.651413943371, 8763.07987661312, 9128.589213485277, 9162.450252984841, 9212.585433655635, 9451.480168590519, 9484.430934143973, 8350.123237060265, 8358.331333493428, 8431.662733490837, 8481.57592120404, 8665.740027799176, 8533.104024077631, 8545.681629322296, 8798.824023519366, 8821.623346194703, 9116.4074335168, 8334.333253339597, 8424.452410593292, 8448.83102337962, 8637.093105223861, 8867.467951922905, 7345.081864766904, 7433.888491672521, 7508.43686723487, 7537.283958023979, 7630.389568834591, 7029.0862187915245, 7073.823154420975, 7114.50198486101, 7366.447516436396, 7371.631418429164], "value": 5640.54881571897, "unit": "score"}], "name": "dromaeo_css", "value": 5925.853720409179, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 120.0, 117.0, 116.0, 116.0, 115.0, 116.0, 117.0, 118.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 127.0, 129.0, 163.0, 127.0, 130.0, 127.0, 129.0, 166.0, 138.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 165.0, 161.0, 162.0, 162.0, 162.0, 161.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 115.0, 77.0, 78.0, 78.0, 84.0, 106.0, 76.0], "value": 84.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 114.0, 85.0, 90.0, 83.0, 110.0, 82.0, 83.0, 111.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 65.0, 66.0, 66.0, 65.0, 66.0, 67.0, 67.0, 67.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 85.0, 95.0, 85.0, 84.0, 86.0, 85.0, 95.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 151.0, 147.0, 144.0, 152.0, 143.0, 140.0, 188.0, 141.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 180.0, 179.0, 178.0, 178.0, 182.0, 182.0, 180.0, 180.0, 186.0], "value": 180.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 71.0, 70.0, 75.0, 72.0, 70.0, 69.0, 73.0, 67.0], "value": 70.9, "unit": "score"}], "name": "kraken", "value": 1576.7, "alertThreshold": 2.0}]} 08:53:46 INFO - Return code: 0 08:53:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:53:46 INFO - # TBPL SUCCESS # 08:53:46 INFO - Running post-action listener: _resource_record_post_action 08:53:46 INFO - [mozharness: 2016-11-18 16:53:46.833560Z] Finished run-tests step (success) 08:53:46 INFO - Running post-run listener: _resource_record_post_run 08:53:46 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391024640; Read time: 16; Write time: 345572 08:53:46 INFO - TinderboxPrint: CPU usage
13.1% 08:53:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:53:46 INFO - TinderboxPrint: I/O write bytes / time
391,024,640 / 345,572 08:53:46 INFO - TinderboxPrint: CPU idle
8,353.9 (86.9%) 08:53:46 INFO - TinderboxPrint: CPU user
1,211.2 (12.6%) 08:53:46 INFO - TinderboxPrint: Swap in / out
0 / 0 08:53:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99684352; Read time: 0; Write time: 100916 08:53:46 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 291340288; Read time: 0; Write time: 244656 08:53:47 INFO - Running post-run listener: _upload_blobber_files 08:53:47 INFO - Blob upload gear active. 08:53:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:53:47 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 08:53:47 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:53:47 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:53:47 INFO - (blobuploader) - INFO - Open directory for files ... 08:53:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:53:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:53:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:48 INFO - (blobuploader) - INFO - Done attempting. 08:53:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:53:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:53:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:51 INFO - (blobuploader) - INFO - Done attempting. 08:53:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:53:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:53:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:52 INFO - (blobuploader) - INFO - Done attempting. 08:53:52 INFO - (blobuploader) - INFO - Iteration through files over. 08:53:52 INFO - Return code: 0 08:53:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:53:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:53:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/4ff95fdcb7bfcec04c724241e1d7a5f282a00bf8fa56a5704fc20b6034999a3e00ade4a9043dc329e5f2e68497ef3e13ca7ccd3ace38a0d4e122f2197d5c75f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/940c55c072ce1c88f72c7efbbdc2171f5e3f3359910fd5abda2743c57a2a1b49957e8b87a0e45749bf8a4517c8bafb39b4467e4665c880a2cbef82a96a6df103", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d889fd030e6a44275e2ebee53204092e8994baed505dffca94539d32d862e97385cf3e81d668b7adb710f6020095b4d55637a5ea3735653bbe305ae3248c620e"} 08:53:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:53:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:53:52 INFO - Contents: 08:53:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/4ff95fdcb7bfcec04c724241e1d7a5f282a00bf8fa56a5704fc20b6034999a3e00ade4a9043dc329e5f2e68497ef3e13ca7ccd3ace38a0d4e122f2197d5c75f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/940c55c072ce1c88f72c7efbbdc2171f5e3f3359910fd5abda2743c57a2a1b49957e8b87a0e45749bf8a4517c8bafb39b4467e4665c880a2cbef82a96a6df103", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d889fd030e6a44275e2ebee53204092e8994baed505dffca94539d32d862e97385cf3e81d668b7adb710f6020095b4d55637a5ea3735653bbe305ae3248c620e"} 08:53:52 INFO - Running post-run listener: copy_logs_to_upload_dir 08:53:52 INFO - Copying logs to upload dir... 08:53:52 INFO - mkdir: /builds/slave/test/build/upload/logs 08:53:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.874027 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-18 08:53:52.048228) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 08:53:52.052342) ========= 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=836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/4ff95fdcb7bfcec04c724241e1d7a5f282a00bf8fa56a5704fc20b6034999a3e00ade4a9043dc329e5f2e68497ef3e13ca7ccd3ace38a0d4e122f2197d5c75f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/940c55c072ce1c88f72c7efbbdc2171f5e3f3359910fd5abda2743c57a2a1b49957e8b87a0e45749bf8a4517c8bafb39b4467e4665c880a2cbef82a96a6df103", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d889fd030e6a44275e2ebee53204092e8994baed505dffca94539d32d862e97385cf3e81d668b7adb710f6020095b4d55637a5ea3735653bbe305ae3248c620e"} build_url:https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011858 build_url: 'https://queue.taskcluster.net/v1/task/RfchONawSYOj_mYVL3tFdA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/4ff95fdcb7bfcec04c724241e1d7a5f282a00bf8fa56a5704fc20b6034999a3e00ade4a9043dc329e5f2e68497ef3e13ca7ccd3ace38a0d4e122f2197d5c75f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/940c55c072ce1c88f72c7efbbdc2171f5e3f3359910fd5abda2743c57a2a1b49957e8b87a0e45749bf8a4517c8bafb39b4467e4665c880a2cbef82a96a6df103", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/d889fd030e6a44275e2ebee53204092e8994baed505dffca94539d32d862e97385cf3e81d668b7adb710f6020095b4d55637a5ea3735653bbe305ae3248c620e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 08:53:52.078242) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:53:52.078562) ========= 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=836cfdc75598d54cb747368e000001a9-1479486783.111541-1995470046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:53:52.161562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 08:53:52.161897) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 08:53:52.162234) ========= ========= Total master_lag: 0.16 =========