builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1480142837.73 results: success (0) buildid: 20161125212619 builduid: 6dda5ec114504956b67d6e1531a80fba revision: 180c7af5922ee89f848c25c3847bd1fb22a71e37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 22:47:17.731697) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 22:47:17.732090) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 22:47:17.732362) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 22:47:17.819660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:47:17.820008) ========= 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=923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-25 22:47:18-- 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% 66.3M=0s 2016-11-25 22:47:19 (66.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163089 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:47:17.997089) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:47:17.997414) ========= 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=923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016977 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:47:18.056031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:47:18.056349) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 180c7af5922ee89f848c25c3847bd1fb22a71e37 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 180c7af5922ee89f848c25c3847bd1fb22a71e37 --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=923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-25 22:47:19,163 truncating revision to first 12 chars 2016-11-25 22:47:19,163 Setting DEBUG logging. 2016-11-25 22:47:19,163 attempt 1/10 2016-11-25 22:47:19,163 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/180c7af5922e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-25 22:47:19,578 unpacking tar archive at: mozilla-central-180c7af5922e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.735964 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 22:47:18.805714) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 22:47:18.806056) ========= script_repo_revision: 180c7af5922ee89f848c25c3847bd1fb22a71e37 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 22:47:18.806449) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 22:47:18.806722) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 22:47:18.818197) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-11-25 22:47:18.818569) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:47:20 INFO - MultiFileLogger online at 20161125 22:47:20 in /builds/slave/test 22:47:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 22:47:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:47:20 INFO - {'append_to_log': False, 22:47:20 INFO - 'base_work_dir': '/builds/slave/test', 22:47:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:47:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:47:20 INFO - 'branch': 'Firefox-Non-PGO', 22:47:20 INFO - 'buildbot_json_path': 'buildprops.json', 22:47:20 INFO - 'config_files': ('talos/linux_config.py',), 22:47:20 INFO - 'default_actions': ('clobber', 22:47:20 INFO - 'read-buildbot-config', 22:47:20 INFO - 'download-and-extract', 22:47:20 INFO - 'populate-webroot', 22:47:20 INFO - 'create-virtualenv', 22:47:20 INFO - 'install', 22:47:20 INFO - 'run-tests'), 22:47:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:47:20 INFO - 'download_minidump_stackwalk': True, 22:47:20 INFO - 'download_symbols': 'ondemand', 22:47:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:47:20 INFO - 'tooltool.py': '/tools/tooltool.py', 22:47:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:47:20 INFO - '/tools/misc-python/virtualenv.py')}, 22:47:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:47:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:47:20 INFO - 'installer_path': 'installer.exe', 22:47:20 INFO - 'log_level': 'info', 22:47:20 INFO - 'log_name': 'talos', 22:47:20 INFO - 'log_to_console': True, 22:47:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:47:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:47:20 INFO - 'opt_config_files': (), 22:47:20 INFO - 'pip_index': False, 22:47:20 INFO - 'sps_profile': False, 22:47:20 INFO - 'sps_profile_interval': 0, 22:47:20 INFO - 'suite': 'dromaeojs', 22:47:20 INFO - 'system_bits': '32', 22:47:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:47:20 INFO - 'title': 'talos-linux64-ix-007', 22:47:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:47:20 INFO - 'use_talos_json': True, 22:47:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:47:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:47:20 INFO - 'work_dir': 'build'} 22:47:20 INFO - [mozharness: 2016-11-26 06:47:20.021239Z] Running clobber step. 22:47:20 INFO - Running pre-action listener: _resource_record_pre_action 22:47:20 INFO - Running main action method: clobber 22:47:20 INFO - rmtree: /builds/slave/test/build 22:47:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:47:20 INFO - Running post-action listener: _resource_record_post_action 22:47:20 INFO - [mozharness: 2016-11-26 06:47:20.476814Z] Finished clobber step (success) 22:47:20 INFO - [mozharness: 2016-11-26 06:47:20.476912Z] Running read-buildbot-config step. 22:47:20 INFO - Running pre-action listener: _resource_record_pre_action 22:47:20 INFO - Running main action method: read_buildbot_config 22:47:20 INFO - Using buildbot properties: 22:47:20 INFO - { 22:47:20 INFO - "project": "", 22:47:20 INFO - "product": "firefox", 22:47:20 INFO - "script_repo_revision": "production", 22:47:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:47:20 INFO - "repository": "", 22:47:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 22:47:20 INFO - "buildid": "20161125212619", 22:47:20 INFO - "pgo_build": "False", 22:47:20 INFO - "basedir": "/builds/slave/test", 22:47:20 INFO - "buildnumber": 310, 22:47:20 INFO - "slavename": "talos-linux64-ix-007", 22:47:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:47:20 INFO - "platform": "ubuntu64_hw", 22:47:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 22:47:20 INFO - "branch": "mozilla-central", 22:47:20 INFO - "repo_path": "mozilla-central", 22:47:20 INFO - "revision": "180c7af5922ee89f848c25c3847bd1fb22a71e37", 22:47:20 INFO - "stage_platform": "linux64", 22:47:20 INFO - "builduid": "6dda5ec114504956b67d6e1531a80fba", 22:47:20 INFO - "slavebuilddir": "test" 22:47:20 INFO - } 22:47:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 22:47:20 INFO - Running post-action listener: _resource_record_post_action 22:47:20 INFO - [mozharness: 2016-11-26 06:47:20.479323Z] Finished read-buildbot-config step (success) 22:47:20 INFO - [mozharness: 2016-11-26 06:47:20.479411Z] Running download-and-extract step. 22:47:20 INFO - Running pre-action listener: _resource_record_pre_action 22:47:20 INFO - Running main action method: download_and_extract 22:47:20 INFO - mkdir: /builds/slave/test/build/tests 22:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:20 INFO - trying https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:47:20 INFO - Downloading https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/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 22:47:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/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 22:47:21 INFO - Downloaded 1361 bytes. 22:47:21 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 22:47:21 INFO - Using the following test package requirements: 22:47:21 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:21 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:47:21 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:47:21 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:21 INFO - u'jsshell-linux-x86_64.zip'], 22:47:21 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:47:21 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:21 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:47:21 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:47:21 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:47:21 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:21 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:47:21 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:47:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 22:47:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:47:21 INFO - Fetch https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:47:21 INFO - Http code: 200 22:47:21 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 22:47:21 INFO - x-amz-cf-id: ORl4hvkpOQ21hrKmjVUfEYQLmiD2dooYaJAhQGrKk2TWndwo24gF5A== 22:47:21 INFO - x-amz-version-id: 7SKMsQUnPTgtRBIaUFMgSgKErbH4hEl_ 22:47:24 INFO - Expected file size: 20207265 22:47:24 INFO - Obtained file size: 20207265 22:47:27 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 22:47:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 22:47:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:47:28 INFO - Fetch https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:47:28 INFO - Http code: 200 22:47:28 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 22:47:28 INFO - x-amz-cf-id: p4kAw80IsqXK0shMQsmaaDsznwgh852iYdtYj5ullhE5emzrBzk_ew== 22:47:28 INFO - x-amz-version-id: 7SKMsQUnPTgtRBIaUFMgSgKErbH4hEl_ 22:47:28 INFO - Expected file size: 20207265 22:47:28 INFO - Obtained file size: 20207265 22:47:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 22:47:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:47:33 INFO - Fetch https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:47:34 INFO - Http code: 200 22:47:34 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 22:47:34 INFO - x-amz-cf-id: ZxrRHMl55E6aCJfMnYbI23X7RySJNHUrfyK8oHbDctWfDgjL4rNfSw== 22:47:34 INFO - x-amz-version-id: I2Rbq19mmSihcQuSBIyYwgFCwT8RgC36 22:47:34 INFO - Expected file size: 14409702 22:47:34 INFO - Obtained file size: 14409702 22:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:35 INFO - trying https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:47:35 INFO - Downloading https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/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 22:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/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 22:47:37 INFO - Downloaded 55676916 bytes. 22:47:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:47:37 INFO - mkdir: /builds/slave/test/properties 22:47:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:47:37 INFO - Writing to file /builds/slave/test/properties/build_url 22:47:37 INFO - Contents: 22:47:37 INFO - build_url:https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 22:47:38 INFO - Running post-action listener: _resource_record_post_action 22:47:38 INFO - Running post-action listener: set_extra_try_arguments 22:47:38 INFO - [mozharness: 2016-11-26 06:47:38.195320Z] Finished download-and-extract step (success) 22:47:38 INFO - [mozharness: 2016-11-26 06:47:38.195545Z] Running populate-webroot step. 22:47:38 INFO - Running pre-action listener: _resource_record_pre_action 22:47:38 INFO - Running main action method: populate_webroot 22:47:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:47:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:47:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:47:38 INFO - '--tppagecycles', 22:47:38 INFO - '7'], 22:47:38 INFO - 'tests': ['tsvgm']}}, 22:47:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:47:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:47:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:47:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:47:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:47:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:47:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:47:38 INFO - 'talos_options': ['--disable-e10s'], 22:47:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:47:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:47:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:47:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:47:38 INFO - 'talos_options': ['--disable-e10s'], 22:47:38 INFO - 'tests': ['damp', 'tps']}, 22:47:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:47:38 INFO - 'tests': ['damp', 'tps']}, 22:47:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:47:38 INFO - 'tests': ['dromaeo_dom']}, 22:47:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:47:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:47:38 INFO - 'tests': ['basic_compositor_video']}, 22:47:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:47:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:47:38 INFO - 'tests': ['a11yr', 22:47:38 INFO - 'ts_paint', 22:47:38 INFO - 'tpaint', 22:47:38 INFO - 'sessionrestore', 22:47:38 INFO - 'sessionrestore_no_auto_restore', 22:47:38 INFO - 'tabpaint']}, 22:47:38 INFO - 'other-e10s': {'tests': ['a11yr', 22:47:38 INFO - 'ts_paint', 22:47:38 INFO - 'tpaint', 22:47:38 INFO - 'sessionrestore', 22:47:38 INFO - 'sessionrestore_no_auto_restore', 22:47:38 INFO - 'tabpaint']}, 22:47:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:47:38 INFO - 'ts_paint', 22:47:38 INFO - 'tpaint', 22:47:38 INFO - 'sessionrestore', 22:47:38 INFO - 'sessionrestore_no_auto_restore', 22:47:38 INFO - 'tabpaint']}, 22:47:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:47:38 INFO - 'ts_paint', 22:47:38 INFO - 'tpaint', 22:47:38 INFO - 'sessionrestore', 22:47:38 INFO - 'sessionrestore_no_auto_restore', 22:47:38 INFO - 'tabpaint']}, 22:47:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:47:38 INFO - 'tests': ['a11yr', 22:47:38 INFO - 'ts_paint', 22:47:38 INFO - 'tpaint', 22:47:38 INFO - 'sessionrestore', 22:47:38 INFO - 'sessionrestore_no_auto_restore', 22:47:38 INFO - 'tabpaint']}, 22:47:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:47:38 INFO - 'tests': ['a11yr', 22:47:38 INFO - 'ts_paint', 22:47:38 INFO - 'tpaint', 22:47:38 INFO - 'sessionrestore', 22:47:38 INFO - 'sessionrestore_no_auto_restore', 22:47:38 INFO - 'tabpaint']}, 22:47:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:47:38 INFO - 'tests': ['tsvgx', 22:47:38 INFO - 'tsvgr_opacity', 22:47:38 INFO - 'tart', 22:47:38 INFO - 'tscrollx', 22:47:38 INFO - 'cart', 22:47:38 INFO - 'tsvg_static']}, 22:47:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:47:38 INFO - 'tsvgr_opacity', 22:47:38 INFO - 'tart', 22:47:38 INFO - 'tscrollx', 22:47:38 INFO - 'cart', 22:47:38 INFO - 'tsvg_static']}, 22:47:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:47:38 INFO - 'talos_options': ['--disable-e10s'], 22:47:38 INFO - 'tests': ['tp5o']}, 22:47:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:47:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:47:38 INFO - 'talos_options': ['--disable-e10s', 22:47:38 INFO - '--xperf_path', 22:47:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:47:38 INFO - 'tests': ['tp5n']}, 22:47:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:47:38 INFO - 'talos_options': ['--xperf_path', 22:47:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:47:38 INFO - 'tests': ['tp5n']}}, 22:47:38 INFO - 'talos.zip': {'path': '', 22:47:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:47:38 INFO - Running post-action listener: _resource_record_post_action 22:47:38 INFO - [mozharness: 2016-11-26 06:47:38.217180Z] Finished populate-webroot step (success) 22:47:38 INFO - [mozharness: 2016-11-26 06:47:38.217268Z] Running create-virtualenv step. 22:47:38 INFO - Running pre-action listener: _resource_record_pre_action 22:47:38 INFO - Running main action method: create_virtualenv 22:47:38 INFO - Creating virtualenv /builds/slave/test/build/venv 22:47:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:47:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:47:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:47:38 INFO - Using real prefix '/usr' 22:47:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:47:38 INFO - Installing distribute.............................................................................................................................................................................................done. 22:47:40 INFO - Installing pip.................done. 22:47:40 INFO - Return code: 0 22:47:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:47:41 INFO - Reading from file tmpfile_stdout 22:47:41 INFO - Output received: 22:47:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 22:47:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:47: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')]} 22:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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')]} 22:47:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9d30f7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd0fc0>, '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 0x1bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2350>, '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': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:47:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:47:41 INFO - Using env: {'DISPLAY': ':0', 22:47:41 INFO - 'HOME': '/home/cltbld', 22:47:41 INFO - 'LANG': 'en_US.UTF-8', 22:47:41 INFO - 'LANGUAGE': 'en_US:en', 22:47:41 INFO - 'LOGNAME': 'cltbld', 22:47:41 INFO - 'MAIL': '/var/mail/cltbld', 22:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:41 INFO - 'MOZ_NO_REMOTE': '1', 22:47:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:41 INFO - 'NO_EM_RESTART': '1', 22:47:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:41 INFO - 'PWD': '/builds/slave/test', 22:47:41 INFO - 'SHELL': '/bin/bash', 22:47:41 INFO - 'SHLVL': '1', 22:47:41 INFO - 'TERM': 'linux', 22:47:41 INFO - 'TMOUT': '86400', 22:47:41 INFO - 'USER': 'cltbld', 22:47:41 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 22:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:41 INFO - '_': '/tools/buildbot/bin/python'} 22:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:47:41 INFO - Cleaning up... 22:47:41 INFO - Return code: 0 22:47:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:47: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')]} 22:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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')]} 22:47:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9d30f7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd0fc0>, '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 0x1bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2350>, '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': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:47:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:47:41 INFO - Using env: {'DISPLAY': ':0', 22:47:41 INFO - 'HOME': '/home/cltbld', 22:47:41 INFO - 'LANG': 'en_US.UTF-8', 22:47:41 INFO - 'LANGUAGE': 'en_US:en', 22:47:41 INFO - 'LOGNAME': 'cltbld', 22:47:41 INFO - 'MAIL': '/var/mail/cltbld', 22:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:41 INFO - 'MOZ_NO_REMOTE': '1', 22:47:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:41 INFO - 'NO_EM_RESTART': '1', 22:47:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:41 INFO - 'PWD': '/builds/slave/test', 22:47:41 INFO - 'SHELL': '/bin/bash', 22:47:41 INFO - 'SHLVL': '1', 22:47:41 INFO - 'TERM': 'linux', 22:47:41 INFO - 'TMOUT': '86400', 22:47:41 INFO - 'USER': 'cltbld', 22:47:41 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 22:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:41 INFO - '_': '/tools/buildbot/bin/python'} 22:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:41 INFO - Downloading/unpacking psutil>=3.1.1 22:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:47:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:47:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:47:43 INFO - Installing collected packages: psutil 22:47:43 INFO - Running setup.py install for psutil 22:47:43 INFO - building 'psutil._psutil_linux' extension 22:47:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:47:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:47:43 INFO - building 'psutil._psutil_posix' extension 22:47:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:47:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:47:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:47:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:47:44 INFO - Successfully installed psutil 22:47:44 INFO - Cleaning up... 22:47:44 INFO - Return code: 0 22:47:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9d30f7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd0fc0>, '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 0x1bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2350>, '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': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:47:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:47:44 INFO - Using env: {'DISPLAY': ':0', 22:47:44 INFO - 'HOME': '/home/cltbld', 22:47:44 INFO - 'LANG': 'en_US.UTF-8', 22:47:44 INFO - 'LANGUAGE': 'en_US:en', 22:47:44 INFO - 'LOGNAME': 'cltbld', 22:47:44 INFO - 'MAIL': '/var/mail/cltbld', 22:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:44 INFO - 'MOZ_NO_REMOTE': '1', 22:47:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:44 INFO - 'NO_EM_RESTART': '1', 22:47:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:44 INFO - 'PWD': '/builds/slave/test', 22:47:44 INFO - 'SHELL': '/bin/bash', 22:47:44 INFO - 'SHLVL': '1', 22:47:44 INFO - 'TERM': 'linux', 22:47:44 INFO - 'TMOUT': '86400', 22:47:44 INFO - 'USER': 'cltbld', 22:47:44 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 22:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:44 INFO - '_': '/tools/buildbot/bin/python'} 22:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:47:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:47:46 INFO - Installing collected packages: mozsystemmonitor 22:47:46 INFO - Running setup.py install for mozsystemmonitor 22:47:46 INFO - Successfully installed mozsystemmonitor 22:47:46 INFO - Cleaning up... 22:47:46 INFO - Return code: 0 22:47:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9d30f7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd0fc0>, '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 0x1bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2350>, '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': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:47:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:47:46 INFO - Using env: {'DISPLAY': ':0', 22:47:46 INFO - 'HOME': '/home/cltbld', 22:47:46 INFO - 'LANG': 'en_US.UTF-8', 22:47:46 INFO - 'LANGUAGE': 'en_US:en', 22:47:46 INFO - 'LOGNAME': 'cltbld', 22:47:46 INFO - 'MAIL': '/var/mail/cltbld', 22:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:46 INFO - 'MOZ_NO_REMOTE': '1', 22:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:46 INFO - 'NO_EM_RESTART': '1', 22:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:46 INFO - 'PWD': '/builds/slave/test', 22:47:46 INFO - 'SHELL': '/bin/bash', 22:47:46 INFO - 'SHLVL': '1', 22:47:46 INFO - 'TERM': 'linux', 22:47:46 INFO - 'TMOUT': '86400', 22:47:46 INFO - 'USER': 'cltbld', 22:47:46 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 22:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:46 INFO - '_': '/tools/buildbot/bin/python'} 22:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:46 INFO - Downloading/unpacking jsonschema==2.5.1 22:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:47:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:48 INFO - Downloading functools32-3.2.3-2.tar.gz 22:47:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:47:48 INFO - warning: no files found matching '*.txt' 22:47:48 INFO - no previously-included directories found matching 'build' 22:47:48 INFO - no previously-included directories found matching 'dist' 22:47:48 INFO - no previously-included directories found matching '.git*' 22:47:48 INFO - Installing collected packages: jsonschema, functools32 22:47:48 INFO - Running setup.py install for functools32 22:47:49 INFO - warning: no files found matching '*.txt' 22:47:49 INFO - no previously-included directories found matching 'build' 22:47:49 INFO - no previously-included directories found matching 'dist' 22:47:49 INFO - no previously-included directories found matching '.git*' 22:47:49 INFO - Successfully installed jsonschema functools32 22:47:49 INFO - Cleaning up... 22:47:49 INFO - Return code: 0 22:47:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9d30f7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd0fc0>, '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 0x1bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2350>, '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': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:47:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:47:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:47:49 INFO - Using env: {'DISPLAY': ':0', 22:47:49 INFO - 'HOME': '/home/cltbld', 22:47:49 INFO - 'LANG': 'en_US.UTF-8', 22:47:49 INFO - 'LANGUAGE': 'en_US:en', 22:47:49 INFO - 'LOGNAME': 'cltbld', 22:47:49 INFO - 'MAIL': '/var/mail/cltbld', 22:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:49 INFO - 'MOZ_NO_REMOTE': '1', 22:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:49 INFO - 'NO_EM_RESTART': '1', 22:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:49 INFO - 'PWD': '/builds/slave/test', 22:47:49 INFO - 'SHELL': '/bin/bash', 22:47:49 INFO - 'SHLVL': '1', 22:47:49 INFO - 'TERM': 'linux', 22:47:49 INFO - 'TMOUT': '86400', 22:47:49 INFO - 'USER': 'cltbld', 22:47:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 22:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:49 INFO - '_': '/tools/buildbot/bin/python'} 22:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:47:49 INFO - Cleaning up... 22:47:49 INFO - Return code: 0 22:47:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9d30f7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd0fc0>, '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 0x1bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2350>, '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': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:47:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:47:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:47:49 INFO - Using env: {'DISPLAY': ':0', 22:47:49 INFO - 'HOME': '/home/cltbld', 22:47:49 INFO - 'LANG': 'en_US.UTF-8', 22:47:49 INFO - 'LANGUAGE': 'en_US:en', 22:47:49 INFO - 'LOGNAME': 'cltbld', 22:47:49 INFO - 'MAIL': '/var/mail/cltbld', 22:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:49 INFO - 'MOZ_NO_REMOTE': '1', 22:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:49 INFO - 'NO_EM_RESTART': '1', 22:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:49 INFO - 'PWD': '/builds/slave/test', 22:47:49 INFO - 'SHELL': '/bin/bash', 22:47:49 INFO - 'SHLVL': '1', 22:47:49 INFO - 'TERM': 'linux', 22:47:49 INFO - 'TMOUT': '86400', 22:47:49 INFO - 'USER': 'cltbld', 22:47:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 22:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:49 INFO - '_': '/tools/buildbot/bin/python'} 22:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:49 INFO - Downloading/unpacking blobuploader==1.2.4 22:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:51 INFO - Downloading blobuploader-1.2.4.tar.gz 22:47:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:47:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:47:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:52 INFO - Downloading docopt-0.6.1.tar.gz 22:47:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:47:52 INFO - Installing collected packages: blobuploader, requests, docopt 22:47:52 INFO - Running setup.py install for blobuploader 22:47:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:47:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:47:52 INFO - Running setup.py install for requests 22:47:52 INFO - Running setup.py install for docopt 22:47:52 INFO - Successfully installed blobuploader requests docopt 22:47:52 INFO - Cleaning up... 22:47:52 INFO - Return code: 0 22:47:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:52 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 0x7fb9d30f7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd0fc0>, '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 0x1bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2350>, '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': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:47:52 INFO - Using env: {'DISPLAY': ':0', 22:47:52 INFO - 'HOME': '/home/cltbld', 22:47:52 INFO - 'LANG': 'en_US.UTF-8', 22:47:52 INFO - 'LANGUAGE': 'en_US:en', 22:47:52 INFO - 'LOGNAME': 'cltbld', 22:47:52 INFO - 'MAIL': '/var/mail/cltbld', 22:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:52 INFO - 'MOZ_NO_REMOTE': '1', 22:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:52 INFO - 'NO_EM_RESTART': '1', 22:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:52 INFO - 'PWD': '/builds/slave/test', 22:47:52 INFO - 'SHELL': '/bin/bash', 22:47:52 INFO - 'SHLVL': '1', 22:47:52 INFO - 'TERM': 'linux', 22:47:52 INFO - 'TMOUT': '86400', 22:47:52 INFO - 'USER': 'cltbld', 22:47:52 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 22:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:52 INFO - '_': '/tools/buildbot/bin/python'} 22:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:47:53 INFO - Running setup.py (path:/tmp/pip-bQ3iA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:47:53 INFO - Running setup.py (path:/tmp/pip-0bbxd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:47:53 INFO - Running setup.py (path:/tmp/pip-iQeyaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:47:53 INFO - Running setup.py (path:/tmp/pip-r5NDxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:47:53 INFO - Running setup.py (path:/tmp/pip-O30Bzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:47:53 INFO - Running setup.py (path:/tmp/pip-0YzpNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:47:53 INFO - Running setup.py (path:/tmp/pip-4qUM0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:47:53 INFO - Running setup.py (path:/tmp/pip-SAz4vY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:47:53 INFO - Running setup.py (path:/tmp/pip-4y0xjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:47:53 INFO - Running setup.py (path:/tmp/pip-MmsY4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:47:53 INFO - Running setup.py (path:/tmp/pip-iemNDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:47:53 INFO - Running setup.py (path:/tmp/pip-5ufi7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:47:53 INFO - Running setup.py (path:/tmp/pip-mWFCtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:47:54 INFO - Running setup.py (path:/tmp/pip-lJq6XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:47:54 INFO - Running setup.py (path:/tmp/pip-LCcdkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:47:54 INFO - Running setup.py (path:/tmp/pip-mQHFw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:47:54 INFO - Running setup.py (path:/tmp/pip-lea7xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:47:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:47:54 INFO - Running setup.py install for manifestparser 22:47:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:47:54 INFO - Running setup.py install for mozcrash 22:47:54 INFO - Running setup.py install for mozdebug 22:47:54 INFO - Running setup.py install for mozdevice 22:47:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:47:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:47:54 INFO - Running setup.py install for mozfile 22:47:54 INFO - Running setup.py install for mozhttpd 22:47:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:47:54 INFO - Running setup.py install for mozinfo 22:47:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:47:55 INFO - Running setup.py install for mozInstall 22:47:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:47:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:47:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:47:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:47:55 INFO - Running setup.py install for mozleak 22:47:55 INFO - Running setup.py install for mozlog 22:47:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:47:55 INFO - Running setup.py install for moznetwork 22:47:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:47:55 INFO - Running setup.py install for mozprocess 22:47:55 INFO - Running setup.py install for mozprofile 22:47:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:47:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:47:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:47:55 INFO - Running setup.py install for mozrunner 22:47:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:47:55 INFO - Running setup.py install for mozscreenshot 22:47:55 INFO - Running setup.py install for moztest 22:47:55 INFO - Running setup.py install for mozversion 22:47:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:47:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:47:56 INFO - Cleaning up... 22:47:56 INFO - Return code: 0 22:47:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9d30f7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd0fc0>, '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 0x1bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2350>, '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': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:47:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:47:56 INFO - Using env: {'DISPLAY': ':0', 22:47:56 INFO - 'HOME': '/home/cltbld', 22:47:56 INFO - 'LANG': 'en_US.UTF-8', 22:47:56 INFO - 'LANGUAGE': 'en_US:en', 22:47:56 INFO - 'LOGNAME': 'cltbld', 22:47:56 INFO - 'MAIL': '/var/mail/cltbld', 22:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:56 INFO - 'MOZ_NO_REMOTE': '1', 22:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:56 INFO - 'NO_EM_RESTART': '1', 22:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:56 INFO - 'PWD': '/builds/slave/test', 22:47:56 INFO - 'SHELL': '/bin/bash', 22:47:56 INFO - 'SHLVL': '1', 22:47:56 INFO - 'TERM': 'linux', 22:47:56 INFO - 'TMOUT': '86400', 22:47:56 INFO - 'USER': 'cltbld', 22:47:56 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 22:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:56 INFO - '_': '/tools/buildbot/bin/python'} 22:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:47:56 INFO - Running setup.py (path:/tmp/pip-CWMxM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:47:56 INFO - Running setup.py (path:/tmp/pip-MThELo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:47:56 INFO - Running setup.py (path:/tmp/pip-vccZ2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:47:56 INFO - Running setup.py (path:/tmp/pip-_GQ8Wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:47:56 INFO - Running setup.py (path:/tmp/pip-SOunY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:47:56 INFO - Running setup.py (path:/tmp/pip-Hqw65F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:47:56 INFO - Running setup.py (path:/tmp/pip-4Plu0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:47:56 INFO - Running setup.py (path:/tmp/pip-98zsx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:47:56 INFO - Running setup.py (path:/tmp/pip-lqC_yX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:47:56 INFO - Running setup.py (path:/tmp/pip-qeXJsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:47:57 INFO - Running setup.py (path:/tmp/pip-lzpRpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:47:57 INFO - Running setup.py (path:/tmp/pip-9hNMUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:47:57 INFO - Running setup.py (path:/tmp/pip-zftZRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:47:57 INFO - Running setup.py (path:/tmp/pip-k6L9x0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:47:57 INFO - Running setup.py (path:/tmp/pip-ArCuIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:47:57 INFO - Running setup.py (path:/tmp/pip-37ph_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:47:57 INFO - Running setup.py (path:/tmp/pip-3ecX_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:47:57 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:47:57 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:47:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:59 INFO - Downloading blessings-1.6.tar.gz 22:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:47:59 INFO - Installing collected packages: blessings 22:47:59 INFO - Running setup.py install for blessings 22:47:59 INFO - Successfully installed blessings 22:47:59 INFO - Cleaning up... 22:47:59 INFO - Return code: 0 22:47:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:47:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:47:59 INFO - Reading from file tmpfile_stdout 22:47:59 INFO - Current package versions: 22:47:59 INFO - argparse == 1.2.1 22:47:59 INFO - blessings == 1.6 22:47:59 INFO - blobuploader == 1.2.4 22:47:59 INFO - docopt == 0.6.1 22:47:59 INFO - functools32 == 3.2.3-2 22:47:59 INFO - jsonschema == 2.5.1 22:47:59 INFO - manifestparser == 1.1 22:47:59 INFO - mozInstall == 1.12 22:47:59 INFO - mozcrash == 1.0 22:47:59 INFO - mozdebug == 0.1 22:47:59 INFO - mozdevice == 0.49 22:47:59 INFO - mozfile == 1.2 22:47:59 INFO - mozhttpd == 0.7 22:47:59 INFO - mozinfo == 0.9 22:47:59 INFO - mozleak == 0.1 22:47:59 INFO - mozlog == 3.4 22:47:59 INFO - moznetwork == 0.27 22:47:59 INFO - mozprocess == 0.23 22:47:59 INFO - mozprofile == 0.28 22:47:59 INFO - mozrunner == 6.13 22:47:59 INFO - mozscreenshot == 0.1 22:47:59 INFO - mozsystemmonitor == 0.3 22:47:59 INFO - moztest == 0.7 22:47:59 INFO - mozversion == 1.4 22:47:59 INFO - psutil == 3.1.1 22:47:59 INFO - requests == 1.2.3 22:47:59 INFO - wsgiref == 0.1.2 22:47:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9d30f7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd0fc0>, '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 0x1bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2350>, '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': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:48:00 INFO - Using env: {'DISPLAY': ':0', 22:48:00 INFO - 'HOME': '/home/cltbld', 22:48:00 INFO - 'LANG': 'en_US.UTF-8', 22:48:00 INFO - 'LANGUAGE': 'en_US:en', 22:48:00 INFO - 'LOGNAME': 'cltbld', 22:48:00 INFO - 'MAIL': '/var/mail/cltbld', 22:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:00 INFO - 'MOZ_NO_REMOTE': '1', 22:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:00 INFO - 'NO_EM_RESTART': '1', 22:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:00 INFO - 'PWD': '/builds/slave/test', 22:48:00 INFO - 'SHELL': '/bin/bash', 22:48:00 INFO - 'SHLVL': '1', 22:48:00 INFO - 'TERM': 'linux', 22:48:00 INFO - 'TMOUT': '86400', 22:48:00 INFO - 'USER': 'cltbld', 22:48:00 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 22:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:00 INFO - '_': '/tools/buildbot/bin/python'} 22:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:48:00 INFO - Cleaning up... 22:48:00 INFO - Return code: 0 22:48:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9d30f7e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd0fc0>, '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 0x1bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2350>, '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': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:48:00 INFO - Using env: {'DISPLAY': ':0', 22:48:00 INFO - 'HOME': '/home/cltbld', 22:48:00 INFO - 'LANG': 'en_US.UTF-8', 22:48:00 INFO - 'LANGUAGE': 'en_US:en', 22:48:00 INFO - 'LOGNAME': 'cltbld', 22:48:00 INFO - 'MAIL': '/var/mail/cltbld', 22:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:00 INFO - 'MOZ_NO_REMOTE': '1', 22:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:00 INFO - 'NO_EM_RESTART': '1', 22:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:00 INFO - 'PWD': '/builds/slave/test', 22:48:00 INFO - 'SHELL': '/bin/bash', 22:48:00 INFO - 'SHLVL': '1', 22:48:00 INFO - 'TERM': 'linux', 22:48:00 INFO - 'TMOUT': '86400', 22:48:00 INFO - 'USER': 'cltbld', 22:48:00 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 22:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:00 INFO - '_': '/tools/buildbot/bin/python'} 22:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:48:00 INFO - Cleaning up... 22:48:00 INFO - Return code: 0 22:48:00 INFO - Running post-action listener: _resource_record_post_action 22:48:00 INFO - Running post-action listener: _start_resource_monitoring 22:48:00 INFO - Starting resource monitoring. 22:48:00 INFO - [mozharness: 2016-11-26 06:48:00.486495Z] Finished create-virtualenv step (success) 22:48:00 INFO - [mozharness: 2016-11-26 06:48:00.487022Z] Running install step. 22:48:00 INFO - Running pre-action listener: _resource_record_pre_action 22:48:00 INFO - Running main action method: install 22:48:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:48:00 INFO - Reading from file tmpfile_stdout 22:48:00 INFO - Detecting whether we're running mozinstall >=1.0... 22:48:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:48:00 INFO - Reading from file tmpfile_stdout 22:48:00 INFO - Output received: 22:48:00 INFO - Usage: mozinstall [options] installer 22:48:00 INFO - Options: 22:48:00 INFO - -h, --help show this help message and exit 22:48:00 INFO - -d DEST, --destination=DEST 22:48:00 INFO - Directory to install application into. [default: 22:48:00 INFO - "/builds/slave/test"] 22:48:00 INFO - --app=APP Application being installed. [default: firefox] 22:48:00 INFO - mkdir: /builds/slave/test/build/application 22:48:00 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'] 22:48:00 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 22:48:16 INFO - Reading from file tmpfile_stdout 22:48:16 INFO - Output received: 22:48:16 INFO - /builds/slave/test/build/application/firefox/firefox 22:48:16 INFO - Running post-action listener: _resource_record_post_action 22:48:16 INFO - [mozharness: 2016-11-26 06:48:16.839499Z] Finished install step (success) 22:48:16 INFO - [mozharness: 2016-11-26 06:48:16.839738Z] Running run-tests step. 22:48:16 INFO - Running pre-action listener: _resource_record_pre_action 22:48:16 INFO - Running main action method: run_tests 22:48:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:48:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:48:16 INFO - Python 2.7.3 22:48:16 INFO - Return code: 0 22:48:16 INFO - grabbing minidump binary from tooltool 22:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:48:16 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 0x1bd0fc0>, '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 0x1bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd2350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:48:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:48:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:48:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:48:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:48:16 INFO - Return code: 0 22:48:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:48:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:48:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:48:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:48:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:48:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:48:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:48:16 INFO - Using env: {'DISPLAY': ':0', 22:48:16 INFO - 'HOME': '/home/cltbld', 22:48:16 INFO - 'LANG': 'en_US.UTF-8', 22:48:16 INFO - 'LANGUAGE': 'en_US:en', 22:48:16 INFO - 'LOGNAME': 'cltbld', 22:48:16 INFO - 'MAIL': '/var/mail/cltbld', 22:48:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:48:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:16 INFO - 'MOZ_NO_REMOTE': '1', 22:48:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:16 INFO - 'NO_EM_RESTART': '1', 22:48:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:16 INFO - 'PWD': '/builds/slave/test', 22:48:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:48:16 INFO - 'SHELL': '/bin/bash', 22:48:16 INFO - 'SHLVL': '1', 22:48:16 INFO - 'TERM': 'linux', 22:48:16 INFO - 'TMOUT': '86400', 22:48:16 INFO - 'USER': 'cltbld', 22:48:16 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212', 22:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:16 INFO - '_': '/tools/buildbot/bin/python'} 22:48:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:48:17 INFO - mozversion application_buildid: 20161125212619 22:48:17 INFO - mozversion application_changeset: 180c7af5922ee89f848c25c3847bd1fb22a71e37 22:48:17 INFO - mozversion application_display_name: Nightly 22:48:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:48:17 INFO - mozversion application_name: Firefox 22:48:17 INFO - mozversion application_remotingname: firefox 22:48:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:48:17 INFO - mozversion application_vendor: Mozilla 22:48:17 INFO - mozversion application_version: 53.0a1 22:48:17 INFO - mozversion platform_buildid: 20161125212619 22:48:17 INFO - mozversion platform_changeset: 180c7af5922ee89f848c25c3847bd1fb22a71e37 22:48:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:48:17 INFO - mozversion platform_version: 53.0a1 22:48:17 INFO - using testdate: 1480142897 22:48:17 INFO - actual date: 1480142897 22:48:17 INFO - starting webserver on 'localhost:40122' 22:48:17 INFO - SUITE-START | Running 2 tests 22:48:17 INFO - TEST-START | dromaeo_css 22:48:17 INFO - operating with platform_type : linux_ 22:48:17 INFO - Initialising browser for dromaeo_css test... 22:48:17 INFO - TEST-INFO | started process 27942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPsMNPI/profile http://localhost:40122/getInfo.html) 22:48:21 INFO - PROCESS | 27942 | __metrics Screen width/height:1600/1200 22:48:21 INFO - PROCESS | 27942 | colorDepth:24 22:48:21 INFO - PROCESS | 27942 | Browser inner width/height: 1024/697 22:48:21 INFO - PROCESS | 27942 | __metrics 22:48:21 INFO - PROCESS | 27942 | 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" 22:48:21 INFO - PROCESS | 27942 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:48:22 INFO - TEST-INFO | 27942: exit 0 22:48:22 INFO - Browser initialized. 22:48:22 INFO - Running cycle 1/1 for dromaeo_css test... 22:48:22 INFO - TEST-INFO | started process 28022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPsMNPI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:48:34 INFO - PROCESS | 28022 | RSS: Main: 174768128 22:48:34 INFO - PROCESS | 28022 | 22:49:26 INFO - PROCESS | 28022 | 1480142966601 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:51:40 INFO - PROCESS | 28022 | Cycle 1(1): loaded http://localhost:40122/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40122/tests/dromaeo/cssquery-ext.html) 22:51:41 INFO - PROCESS | 28022 | RSS: Main: 310022144 22:51:41 INFO - PROCESS | 28022 | 22:54:44 INFO - PROCESS | 28022 | Cycle 1(1): loaded http://localhost:40122/tests/dromaeo/cssquery-ext.html (next: http://localhost:40122/tests/dromaeo/cssquery-jquery.html) 22:54:45 INFO - PROCESS | 28022 | RSS: Main: 284209152 22:54:45 INFO - PROCESS | 28022 | 22:57:47 INFO - PROCESS | 28022 | Cycle 1(1): loaded http://localhost:40122/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40122/tests/dromaeo/cssquery-mootools.html) 22:57:48 INFO - PROCESS | 28022 | RSS: Main: 225353728 22:57:48 INFO - PROCESS | 28022 | 23:00:50 INFO - PROCESS | 28022 | Cycle 1(1): loaded http://localhost:40122/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40122/tests/dromaeo/cssquery-prototype.html) 23:00:51 INFO - PROCESS | 28022 | RSS: Main: 228384768 23:00:51 INFO - PROCESS | 28022 | 23:03:54 INFO - PROCESS | 28022 | Cycle 1(1): loaded http://localhost:40122/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40122/tests/dromaeo/cssquery-yui.html) 23:03:54 INFO - PROCESS | 28022 | RSS: Main: 221540352 23:03:54 INFO - PROCESS | 28022 | 23:06:57 INFO - PROCESS | 28022 | Cycle 1(1): loaded http://localhost:40122/tests/dromaeo/cssquery-yui.html (next: http://localhost:40122/tests/dromaeo/cssquery-dojo.html) 23:06:57 INFO - PROCESS | 28022 | RSS: Main: 317464576 23:06:57 INFO - PROCESS | 28022 | 23:06:57 INFO - PROCESS | 28022 | __start_tp_report 23:06:57 INFO - PROCESS | 28022 | _x_x_mozilla_page_load 23:06:57 INFO - PROCESS | 28022 | _x_x_mozilla_page_load_details 23:06:57 INFO - PROCESS | 28022 | |i|pagename|runs| 23:06:57 INFO - PROCESS | 28022 | |0;dojo.html;2542.936426589335;2594.9610755838653;2601.2456387647585;2623.93440163996;2629.908587936007;4469.128519938613;4544.954550454503;4604.963883126299;4627.120847039065;4648.837290694826;4552.613027892633;4564.475085365184;4565.018521017989;4567.155076310884;4572.885677858055;4189.853355132571;4206.894827629303;4219.13507730916;4247.851325203618;4263.275243208662;4281.05816720321;4302.698811083225;4307.956920430787;4313.935290970638;4316.784160791964;4158.106007208449;4202.831886724527;4207.789610519477;4228.809703563347;4307.396964424983;4227.725197862129;4249.681273904439;4286.142771445692;4315.525292217853;4324.005478739876;4143;4189.539150693421;4190.664746820247;4226.894327641833;4229.36559516072;4584.689824079327;4588.082383523275;4591.816327346902;4640.303954406832;4648.1865673507;4867.561919427269;4885.633577481668;4891.755412229374;4896.877578060541;4915.852524424237;4811.374521312242;4872.8538143855385;4880.194767863299;4900.313956046157;4927.704337739747;4528.637708983273;4602.217623004098;4618.515055919147;4622.653301002439;4644.674872758875;5116.923246151311;5120.257562653394;5148.794048238028;5169.793208271627;5172.870678232999;4902.48523904992;4909;4909.803607855646;4915.115279249698;4960.553550180501;4764.30917516965;4826.396700412449;4997.375328083989;4999.47505511916;5046.419661738873;4758.78585463655;4828.203346447867;4885.8045678173185;4896.436909755424;4966.006798640286;4886.071646387175;4901.745854591817;4902.436219834764;4903.26451032348;4947.802087916443;4220.2192594370135;4261.552536983634;4264.680148988777;4272.6154646082;4306.74159550428;3646.9817650912105;3651.1054791576234;3651.8721844735305;3652.1782598915033;3688.1517251032415;4198.706090573692;4214.599613036757;4237.025484138665;4241.300185469425;4251.277282861921;4901.730404827697;4912.140375434285;4925.11347957364;4925.605951523869;4972.577330926912;4111.8972025699595;4168.3955826405;4170.311898536768;4207.957920420757;4214.810333534998;4449.933251001237;4458.487273963536;4465.620422264079;4467.463904331501;4468.50846406895;4582.747948862844;4613.1004454131125;4620.145273124483;4624.722516649012;4628.1669299525065;4916.8770780730765;4922.261660750916;4925.064237794808;4927.18701414277;4927.457979622167;4586.220342541843;4609.170349337018;4612.169809434334;4617.376654151646;4619.330197121331;4842.564169224786;4876.926846097241;4888.095702295087;4910.386201724785;4927.802887884588;4934.136526107988;4958.628102892226;4959.156943319572;4963.230699241623;5017.974910125426;4702.858914232578;4757.381540399864;4816.927746083882;4828.851767677985;4865.440474345495;4699.882502937454;4763.833265835818;4766.666333356632;4778.546038126373;4820.39745031871;4787.54518320759;4791.640626953063;4792.346640409053;4795.400574928134;4840.104580652591;4779.378680771617;4893.314935908905;4896.436909755424;4900.313956046085;4933.876653083702;4691.249400095969;4710.26990816424;4719.716816990992;4748.216544270157;4789.090072886141 23:06:57 INFO - PROCESS | 28022 | |1;ext.html;530.1358785180156;539.4605394605394;553.1067326268073;554.2130175151285;571.7912961768956;26771.196864094083;37218.62781372189;38233.80883095581;38255.808720956426;41482.37776433348;38583.80708096462;38896.22207555847;38926;38973;39009.07431942609;7298.379637730786;7436.925630743677;7441.441891858105;7445.255474452566;7449.329560339568;7220.169680486732;7476.962615186916;9444.102810233016;9650.469224192666;9665.226781857435;9736.951315243414;9790.21678265737;9809.117179453884;9820.82150141984;9825.901740982606;9615.471149086798;9666;9676.274279429072;9681.709548713514;9689;9568.952155239249;9630.518474076338;9688.41869487833;9690.370125941861;9696.36973596721;36058.27883442343;36173.63826361729;36256;36310;36315.81842090799;2978.195887110468;3028.6971302869756;3052.740517056053;3210.1653570071717;3233;27928.441431171264;27980.720192798217;28282.434351313063;28700.569491457645;29408.11775646734;3379.509971054208;3425.1950791563963;3477.426224672926;3604.2611264690936;3619.4027985382645;229352;231360;231382;231605;231962;48768.7561562197;49168.50831491711;49404.752976234886;49481;49532.50467495279;51670.74164629153;51684;51698;51757.7412112937;51851.74074129605;14229.715405691828;14529.418823247162;14542.563723088324;14551.199684017269;14556.344964476411;10342.793144137075;10606.946965265124;11266.098712103012;11439.714007149722;11448.084153267719;13913.721725565432;14481.565553033426;14522;14912.179830109231;14990.925045374703;5893.734781934738;5984.700764961822;5997.640141591519;6024.548158888101;6064.454199122012;763.3397111498625;925.4863550729275;961.7835986902891;969.3391639948387;992.528548939248;26250.474990500083;27026.324341891217;27087;27304.726952730616;27355.72644273532;925.7132585705874;935.5883411299143;967.9516024198903;995.4922989275522;1032.1484775060605;13810.792838107436;14181.290935453393;14491.565253042425;14622.195779232245;14655.159489672973;384610;389436;392279;556689;562827;47213.76393118081;47753.522464775604;47764.7611761939;47811.28283075687;47829.521704783205;1065.4672663668166;1096.9962484326752;1135.795556799784;1145.7593905279984;1172.1560476456937;23980.688568250516;27904.720952791024;27923.581146282417;27940.441191175654;28250.85874570614;39836.2032759349;40250.396244056945;40399.7980010098;40413.59586404098;40428;272861;273381;274305;274659;274944;23176.536469270857;23936.760632393452;23965.64051539263;25286.620700689873;25602;38497;38525.80737096409;38845;39997.40003900002;40302.39546406748;33524.1618959528;33772.493412599324;33947;34075.829620851735;34632.48051279182;33131.668683312855;33167.66832331646;33756.831215844744;34047.14882127867;34522.82738586291;32998.67001329956;33214.16964575905;33455.16362090967;33613.495797562566;33718.15704607405;29921.401571968872;30296.5455518163;31041.689583104784;31235.219119522193;31336.05991820249;24149.894517932345;24151.637725434484;24152.63771043471;24283.39291517726;24315.513689725754 23:06:57 INFO - PROCESS | 28022 | |2;jquery.html;329.94253417795966;339.35522507236266;353.05557633330835;356.413699464381;384.9499565056542;12273.693157671052;15184.848151518481;15444.536663900073;16306;17111.40110096147;16608.169591520436;16625.251863666133;16629.41797037104;16733.74899376507;16932.238049287782;4796.808127674897;4833;5007.073691367109;5023.0707319145895;5057.216131499624;3640.526731524898;4930.506949305059;5028;5032.672876263049;5035.647504674675;3816.9618303816883;5484.2596249506405;5719;5725.055365864628;5834.474897259246;5627.465390787868;5827;5827.941720582803;5830.912536311958;5852.707364631751;5160.329157209576;5198.558122559587;5203.531682148587;5204.791808327663;5206.609504287194;19206.327778527822;19567.315143970034;19591.41225763215;19645.705314420295;19674.213031478725;1859.20054376618;1885.3401309541687;1904.2043323377281;1952.6973319135557;2181.465540942479;8609.225169734755;8815.823683526358;9066.048064953151;9413.388129771543;12109.697257568543;1600.3758534171682;1634.5423281481085;1759.727242277449;1799.190364336054;1880.7743070831589;43282;58567.70716146434;59165.112523312186;62074;67233.99149012817;9458.763530911645;9873.210143188528;9907.356021858555;9956.701298961043;9987.600495980225;13569.86430135686;13575;13585.864141358657;13598.048136630341;13602.183868967893;6918.37734603878;6982.266861979419;7056.54132481387;7202;7411.592362420119;6574.868502629921;6580.21037475506;6605.174353205849;6728.091707619506;6766.830829229309;4263.680223983214;4309.806058727365;4334.718243314238;4347.347897815353;4428.778561071998;1598.1609654931021;1721.664275466297;1760;1774.2193434888607;1791.3013924569427;714.5069901767764;788.7239466186903;836.9455985360933;837.7486753973783;901.3735453859636;16294.42969496062;16314.34742610306;16481.093539855185;16507.09210993407;17135.172696505186;818.7543736878913;820.5774026376421;821.9342452603777;840.537704262653;922.8477301245354;8911.910880891108;9447.527623618791;9503.952480237554;9524.190443812215;9555.533359968065;327039;332324;334064;334399;334851;69500;72146.27853721501;76372.23627763762;79471.20528794754;81797;896.4576431259125;916.6425094213262;927.8144371125802;946.9621215151454;947.1333729637443;14506.927465363027;14525.139664804672;16333.428330008393;16463.423780168116;16758.58103547421;29406.264843379086;30731.846340768152;36452.63547364598;36821.81589092038;37300;43120.35319470148;44612;44989.100217994805;45540.31689524594;51102;7030.789076327718;7033.507654464343;7242.348188663045;7307.634618269171;7449.6275186241555;8102.87845682327;11142.164337674869;11354.318740875575;11404;11836.526538938346;10517.789644207227;10559.257722475706;10590.629327973484;10723.571057157938;10959.50682219318;6737.292584278776;9203.263738900738;10538.841917371092;10594.20543459259;10875.564977400816;10613.734656633645;10622;10704.785904282027;10774.784504310026;11263.887361126284;7448.106227252548;7501.099868015873;7588.165301816685;7704.92295077042;8087.83824323522;9795.216382689225;10049.296549241482;10432.68701938943;10475.738106547396;10920.890791091988 23:06:57 INFO - PROCESS | 28022 | |3;mootools.html;1311.4754098360659;1353.1542785758902;1368.4321006782186;1613.370785393696;1636.2882146266375;5978.07339862321;6210.254769427664;6487.902681459776;6906.067680863076;6912.205096413914;6428.614283143014;6691;6692.163479565054;6809.761658341959;6844.2813504582045;2017.082227586452;2040.1533363654066;2045.3761602711168;2045.9795402046013;2053.425040988518;1638.1645360865925;1757.6484703059375;2028.229272876305;2030.6953956906434;2039.3474088291678;1718.037898776689;1732.5322163015978;1736.3401907275218;1960.8529360298035;2021.7877122902105;1989.2838578111869;1993.4318719165042;1998.1208268361875;1998.6402447559433;1998.740163778714;1955.8533110016806;1981.7522809648794;2041.5202427429542;2046.1610739596842;2052.917883284667;6681.265060843352;6684.799456016327;6744.629045402501;6758.324167583251;6759.053732477408;4049.696272779524;4183.874483765492;4185.288500954845;4186.246475634384;4189.2040512302565;2526.595744680842;2628.158989123481;2686.240512464339;2701.9459610807676;2721.0612338743103;800.7877912353231;842.1199846160777;846.5354935960761;872.5462759365095;880.5949263338807;8879.955600222022;8904.8664270036;8926.152015558511;8968.282537396992;8974.506402147814;3607.098225443639;3677.7241706871555;3806.410006449005;3830.942535861964;3854.7494412863075;7716.845663086707;7719.845603087907;7740.961295193488;7743.612819359009;7746.612669366509;4233.597808208216;4237.258479766028;4239.173361194599;4239.872803815891;4243.045314804144;3714.3871261241593;3900.687944964396;3902.746321489094;3902.8829135125993;3906.374980003186;3239.5626590410466;3243.594550681165;3318.6515415881468;3360.1263671445113;3368.0737797105994;1101.0530943388678;1106.4080716816466;1109.606089838112;1109.6948339206783;1121.2599684208383;624.6033768556999;779.9532028078333;788.7278888783361;797.9122296547375;813.2314962360513;4518.593326600621;4566.771661416982;4573.3368661544555;4613.2388155953895;4624.583787459145;378.7651655973314;384.06863356360714;390.79287977372036;392.9351656976624;416.50227977567124;3312.188513814083;3355.966440335614;3356.714679252291;3361.983190084034;3452.998630397207;7626.237376262329;8045.07481639619;8050.5169689818795;8060.435769496196;8075.596220188967;8059.395545334006;8073.515589064675;8094.595270236465;8095.23095305945;8114.188581141839;6329.461995730322;6432.228132624022;6446.613203207822;6448.548601597843;6448.806535803839;4482.596566309048;4604.1252162089095;4621.168189725881;4630.189716799614;4636.8145274188655;7340.70637174507;7365.895115732683;7420.257974202753;7438.367738742268;7471.962640186982;7387.2243414442855;7402.962985185255;7448.14346350155;7478.850422991401;7523.548587084573;5695.943040569541;5800.796972105956;5810.389909059488;5830.329512106162;5941.079132734433;6185.474234689922;6341.460975817107;6348.047792830927;6349.809505714836;6353.269374022047;5476.67139971603;5585.106382978704;5636.4927156556105;5734.483896449339;5791.942080579141;5502.58730595215;5668.093105103164;5673.120666296731;5690.260266165372;5785.247917770663;5360.2227676987395;5360.785568577369;5386.461353864583;5408.702521361205;5437.32033495813;3926.1166237596312;3934.272159650474;4000.539937907178;4002.599740025974;4010.0776821330674;4039.6162364575316;4114.691398145092;4213.557576454428;4224.640905523065;4278.229918614555 23:06:57 INFO - PROCESS | 28022 | |4;prototype.html;292.76432471860153;298.34513243430666;304.236366719534;304.7638080487623;305.4486651593872;4845.80616775329;4868.56182943535;4869.391326084239;4881.072596206723;4881.731504767236;4770.499097594755;4776.90446191076;4790.401199850019;4807.687500312477;4843.806247750094;3603.94594081089;3688.8708895188674;3735.962640373589;3777.0746167189077;3791.507104076466;3797.373433383488;3797.3924172132324;3811.942820857689;3821.254855303203;3824.2542704172697;3772.207836354355;3773.132179598694;3780.262848744496;3781;3800.429935509668;3583.104223944027;3677.2645470905927;3685.4656074869263;3724.962750372516;3790.2798468290935;3347.4978753186974;3347.581552305962;3351.1957130288556;3357.4124528207467;3377.054424761071;4646.303054541812;4646.4888862225125;4649.930251046237;4664.857110008036;4671.696339737906;4005.198960207941;4306.35404689296;4320.4599425071865;4330.848420305274;4335.807652895479;4948.505149485059;4980.77586508608;4998.700077995332;5020;5023.196288593844;3548.077499850032;3579.0830473164547;3579.570451545805;3590.6588874056924;3594.748367614268;5269.6311258211945;5308.681479111266;5312.787488500456;5335.306410166731;5343.198520221998;3512.332656795201;3626.987022202703;3638.6543278388513;3661.3226553087766;3673.834677439468;3694.630536946284;3705.7030039486503;3722.4974628425357;3738.981305093457;3743.7005039596766;4227.492700875914;4240.321548552217;4271.188474189894;4290.50659174199;4295.334223195409;4761.714417052292;5008.924866127011;5078.13671675816;5085.364329458817;5103.234514822806;1245.3586403002462;1253.4547471849774;1254.5358217459598;1255.171586752757;1261.6656586004533;825.7605294464538;843.7721815109886;852.5225873510853;859.441363113981;866.9393142480092;4229.9365509516765;4262.976885547447;4335.089631177425;4363.454568178978;4418.248897687401;5140.30605868203;5181.35233095863;5196.558292545101;5210.671278823876;5236.947630523646;4416.227160246944;4420.226460369422;4423;4438.667099967515;4443.644508439317;2593.23499567628;2623.3997261670365;2658.8035384077243;2661.5228548155574;2669;4708.458527269339;4712.481627021025;4732.290156476487;4738.649484896788;4744.786484608201;5095.490450954949;5128.333316668809;5131.897362052813;5142.382914050338;5182.714950677673;4450.666200034945;4667.043256132417;4671.48613652498;4681.144501853866;4698.647601429906;4979.950200497949;5017.222330538772;5019.289583624948;5019.774110164978;5026.919212369358;4921.8523444296725;4924.236743304794;4929.704217746947;4938.530839570235;4940.407151141886;4593.448786145684;4891.437484689306;4908.361912951294;4910.263460480956;4912.066707325596;3783.356829338964;3783.356829338964;3787;3799.297130030953;3829.7319187656594;5256.553192978639;5275.393329767126;5276.076686579757;5285.947140528546;5289.312389389354;4929.654924155275;5034.496550345083;5063.734066483379;5072.41667208261;5082.4409314976065;5048.697078175322;5063.518965698253;5067.479756073237;5070.8225212117395;5075.923861142012;4973.502649734997;4974.303597496281;4978.47725988766;4989.927165659401;5008.649394542347;4895.143349913822;4897.485763994871;5031.396232452129;5089.618278629192;5138.280640710229;4874.8787778810365;4975.283527183116;4983.227599722049;4985.900281994413;5012.1980483122525 23:06:57 INFO - PROCESS | 28022 | |5;yui.html;594.7925710807062;616.3651439017813;665.2549144957649;674.5581644023166;687.1342108942731;11168.274062185952;11619.1285653576;11950.940245298783;12082.21465604735;12291.877081229186;12099.395030248474;12270.141090123694;12270.263784172956;12272.877271227286;12372.195807272521;738.841149152932;746.3320328306163;755.0674916478146;766.4519868294169;767.075673813054;611.4619135161053;625.0530446373748;732.8644200822838;767.9500832445901;770.6647608290411;790.9960450197741;800.7877912353231;800.951942883426;801.3388954112851;802.8956235689352;794.0868001797921;794.4875555266849;799.6321692021677;800.335721351277;800.9118996910336;469.54454179445884;471.6486217767751;560.3779804417094;590.0382376725952;590.1207201270076;12102.636920892388;12606.243625382414;12623.116381853273;12654.240745555204;12728.299943503103;10641.680749577525;10651.25441219115;11010.284331518425;11077.556897724082;11272.66182014541;10685.358878467317;10820.621278255223;10912.727181820439;10919.39943303118;10990.780184396348;3820.7134464914966;3822.9104705158898;3862.439946207784;3883.3010058189516;3891.708121890841;50871.745641271926;51879.48120518784;52647;52765.208521872584;53261.73369133168;9050.637974480947;9133.45199288045;9253;9265.166135047879;9468.19520340765;16112.516624501284;16161.59596010109;16189.271482783302;16248.350065997227;16335.428260010842;6330.8417289567205;6336.429721325103;6341.936580634227;6387.297397286387;6542.509311801634;3582.6238244984424;3602.963970360263;3632.182758879284;3666.7066634669163;3688.8340024698955;2396.664466974625;2468.148488771371;2471.3821544613847;2478.6901637295337;2481.962770558443;414.6579072265393;415.5885673183587;421.62686022869366;421.99789001054796;428.0860363124689;417.83286685325504;488.81669373984755;505.2824988516242;508.6261597725669;528.4952870009132;6827.351401616838;6949.235584085746;7035.155781306174;7052.894206586905;7210.170830354471;440.2801419678848;497;527.7493190734447;532.6561887804957;535.9410464848863;3268.1176082457605;3278.7704860659524;3283.244853683618;3302.4220761366664;3421.0934102462866;63862.36137638657;69880.6505967467;70645.2935470649;73018.2698173022;73042.63478682573;61817;62074.379256207765;62162.68918655378;62986;65284;56247.437525625035;57130.714346428;57410.81426971665;57645.711771440874;57967.420325797044;6472.126262954441;6677.933220667731;6773.762918297836;6964.825879353057;7055.118110236221;39782.40326395049;39913.40129897996;39944.60055399409;39994.60086386164;41517.37723934083;47037.529624704686;51147.74426127846;52742;53387.733061334446;54709;8015.919840801517;8080.2727754502375;8291.9585402075;8389.328853691812;8434.70478533273;9219.953900230455;9266.814663706553;9350.625974960925;9484.146426821619;9580.856287155559;8524.445911015764;8560.315174786127;8634.438761480484;8640.697575584825;8703.086175951434;8606.78483037929;8625.094365091825;8664.35017373687;8882.555872206492;8886;8806.157150528235;8839.911600883908;8875.33434992391;9030.503322317072;9197.402168859002;7893.210678932061;7955.403344749283;7970.880436793569;8308.501489910625;8369.246767790928;7613.08642962848;7996;8016.839663206587;8204.917950820416;8255.793605159919 23:06:57 INFO - PROCESS | 28022 | __end_tp_report 23:06:57 INFO - PROCESS | 28022 | __start_cc_report 23:06:57 INFO - PROCESS | 28022 | _x_x_mozilla_cycle_collect,1291 23:06:57 INFO - PROCESS | 28022 | __end_cc_report 23:06:57 INFO - PROCESS | 28022 | __startTimestamp1480144017984__endTimestamp 23:06:57 INFO - PROCESS | 28022 | 23:06:57 INFO - PROCESS | 28022 | ------- Summary: start ------- 23:06:57 INFO - PROCESS | 28022 | Number of tests: 6 23:06:57 INFO - PROCESS | 28022 | 23:06:57 INFO - PROCESS | 28022 | [#0] dojo.html Cycles:165 Average:4557.96 Median:4644.67 stddev:476.22 (10.3%) stddev-sans-first:450.69 23:06:57 INFO - PROCESS | 28022 | Values: 2542.9 2595.0 2601.2 2623.9 2629.9 4469.1 4545.0 4605.0 4627.1 4648.8 4552.6 4564.5 4565.0 4567.2 4572.9 4189.9 4206.9 4219.1 4247.9 4263.3 4281.1 4302.7 4308.0 4313.9 4316.8 4158.1 4202.8 4207.8 4228.8 4307.4 4227.7 4249.7 4286.1 4315.5 4324.0 4143.0 4189.5 4190.7 4226.9 4229.4 4584.7 4588.1 4591.8 4640.3 4648.2 4867.6 4885.6 4891.8 4896.9 4915.9 4811.4 4872.9 4880.2 4900.3 4927.7 4528.6 4602.2 4618.5 4622.7 4644.7 5116.9 5120.3 5148.8 5169.8 5172.9 4902.5 4909.0 4909.8 4915.1 4960.6 4764.3 4826.4 4997.4 4999.5 5046.4 4758.8 4828.2 4885.8 4896.4 4966.0 4886.1 4901.7 4902.4 4903.3 4947.8 4220.2 4261.6 4264.7 4272.6 4306.7 3647.0 3651.1 3651.9 3652.2 3688.2 4198.7 4214.6 4237.0 4241.3 4251.3 4901.7 4912.1 4925.1 4925.6 4972.6 4111.9 4168.4 4170.3 4208.0 4214.8 4449.9 4458.5 4465.6 4467.5 4468.5 4582.7 4613.1 4620.1 4624.7 4628.2 4916.9 4922.3 4925.1 4927.2 4927.5 4586.2 4609.2 4612.2 4617.4 4619.3 4842.6 4876.9 4888.1 4910.4 4927.8 4934.1 4958.6 4959.2 4963.2 5018.0 4702.9 4757.4 4816.9 4828.9 4865.4 4699.9 4763.8 4766.7 4778.5 4820.4 4787.5 4791.6 4792.3 4795.4 4840.1 4779.4 4893.3 4896.4 4900.3 4933.9 4691.2 4710.3 4719.7 4748.2 4789.1 23:06:57 INFO - PROCESS | 28022 | 23:06:57 INFO - PROCESS | 28022 | [#1] ext.html Cycles:180 Average:46693.18 Median:19831.27 stddev:89973.97 (453.7%) stddev-sans-first:90159.61 23:06:57 INFO - PROCESS | 28022 | Values: 530.1 539.5 553.1 554.2 571.8 26771.2 37218.6 38233.8 38255.8 41482.4 38583.8 38896.2 38926.0 38973.0 39009.1 7298.4 7436.9 7441.4 7445.3 7449.3 7220.2 7477.0 9444.1 9650.5 9665.2 9737.0 9790.2 9809.1 9820.8 9825.9 9615.5 9666.0 9676.3 9681.7 9689.0 9569.0 9630.5 9688.4 9690.4 9696.4 36058.3 36173.6 36256.0 36310.0 36315.8 2978.2 3028.7 3052.7 3210.2 3233.0 27928.4 27980.7 28282.4 28700.6 29408.1 3379.5 3425.2 3477.4 3604.3 3619.4 229352.0 231360.0 231382.0 231605.0 231962.0 48768.8 49168.5 49404.8 49481.0 49532.5 51670.7 51684.0 51698.0 51757.7 51851.7 14229.7 14529.4 14542.6 14551.2 14556.3 10342.8 10606.9 11266.1 11439.7 11448.1 13913.7 14481.6 14522.0 14912.2 14990.9 5893.7 5984.7 5997.6 6024.5 6064.5 763.3 925.5 961.8 969.3 992.5 26250.5 27026.3 27087.0 27304.7 27355.7 925.7 935.6 968.0 995.5 1032.1 13810.8 14181.3 14491.6 14622.2 14655.2 384610.0 389436.0 392279.0 556689.0 562827.0 47213.8 47753.5 47764.8 47811.3 47829.5 1065.5 1097.0 1135.8 1145.8 1172.2 23980.7 27904.7 27923.6 27940.4 28250.9 39836.2 40250.4 40399.8 40413.6 40428.0 272861.0 273381.0 274305.0 274659.0 274944.0 23176.5 23936.8 23965.6 25286.6 25602.0 38497.0 38525.8 38845.0 39997.4 40302.4 33524.2 33772.5 33947.0 34075.8 34632.5 33131.7 33167.7 33756.8 34047.1 34522.8 32998.7 33214.2 33455.2 33613.5 33718.2 29921.4 30296.5 31041.7 31235.2 31336.1 24149.9 24151.6 24152.6 24283.4 24315.5 23:06:57 INFO - PROCESS | 28022 | 23:06:57 INFO - PROCESS | 28022 | [#2] jquery.html Cycles:180 Average:22003.86 Median:24520.39 stddev:55042.37 (224.5%) stddev-sans-first:55172.72 23:06:57 INFO - PROCESS | 28022 | Values: 329.9 339.4 353.1 356.4 384.9 12273.7 15184.8 15444.5 16306.0 17111.4 16608.2 16625.3 16629.4 16733.7 16932.2 4796.8 4833.0 5007.1 5023.1 5057.2 3640.5 4930.5 5028.0 5032.7 5035.6 3817.0 5484.3 5719.0 5725.1 5834.5 5627.5 5827.0 5827.9 5830.9 5852.7 5160.3 5198.6 5203.5 5204.8 5206.6 19206.3 19567.3 19591.4 19645.7 19674.2 1859.2 1885.3 1904.2 1952.7 2181.5 8609.2 8815.8 9066.0 9413.4 12109.7 1600.4 1634.5 1759.7 1799.2 1880.8 43282.0 58567.7 59165.1 62074.0 67234.0 9458.8 9873.2 9907.4 9956.7 9987.6 13569.9 13575.0 13585.9 13598.0 13602.2 6918.4 6982.3 7056.5 7202.0 7411.6 6574.9 6580.2 6605.2 6728.1 6766.8 4263.7 4309.8 4334.7 4347.3 4428.8 1598.2 1721.7 1760.0 1774.2 1791.3 714.5 788.7 836.9 837.7 901.4 16294.4 16314.3 16481.1 16507.1 17135.2 818.8 820.6 821.9 840.5 922.8 8911.9 9447.5 9504.0 9524.2 9555.5 327039.0 332324.0 334064.0 334399.0 334851.0 69500.0 72146.3 76372.2 79471.2 81797.0 896.5 916.6 927.8 947.0 947.1 14506.9 14525.1 16333.4 16463.4 16758.6 29406.3 30731.8 36452.6 36821.8 37300.0 43120.4 44612.0 44989.1 45540.3 51102.0 7030.8 7033.5 7242.3 7307.6 7449.6 8102.9 11142.2 11354.3 11404.0 11836.5 10517.8 10559.3 10590.6 10723.6 10959.5 6737.3 9203.3 10538.8 10594.2 10875.6 10613.7 10622.0 10704.8 10774.8 11263.9 7448.1 7501.1 7588.2 7704.9 8087.8 9795.2 10049.3 10432.7 10475.7 10920.9 23:06:57 INFO - PROCESS | 28022 | 23:06:57 INFO - PROCESS | 28022 | [#3] mootools.html Cycles:180 Average:4438.03 Median:4617.20 stddev:2382.81 (51.6%) stddev-sans-first:2377.91 23:06:57 INFO - PROCESS | 28022 | Values: 1311.5 1353.2 1368.4 1613.4 1636.3 5978.1 6210.3 6487.9 6906.1 6912.2 6428.6 6691.0 6692.2 6809.8 6844.3 2017.1 2040.2 2045.4 2046.0 2053.4 1638.2 1757.6 2028.2 2030.7 2039.3 1718.0 1732.5 1736.3 1960.9 2021.8 1989.3 1993.4 1998.1 1998.6 1998.7 1955.9 1981.8 2041.5 2046.2 2052.9 6681.3 6684.8 6744.6 6758.3 6759.1 4049.7 4183.9 4185.3 4186.2 4189.2 2526.6 2628.2 2686.2 2701.9 2721.1 800.8 842.1 846.5 872.5 880.6 8880.0 8904.9 8926.2 8968.3 8974.5 3607.1 3677.7 3806.4 3830.9 3854.7 7716.8 7719.8 7741.0 7743.6 7746.6 4233.6 4237.3 4239.2 4239.9 4243.0 3714.4 3900.7 3902.7 3902.9 3906.4 3239.6 3243.6 3318.7 3360.1 3368.1 1101.1 1106.4 1109.6 1109.7 1121.3 624.6 780.0 788.7 797.9 813.2 4518.6 4566.8 4573.3 4613.2 4624.6 378.8 384.1 390.8 392.9 416.5 3312.2 3356.0 3356.7 3362.0 3453.0 7626.2 8045.1 8050.5 8060.4 8075.6 8059.4 8073.5 8094.6 8095.2 8114.2 6329.5 6432.2 6446.6 6448.5 6448.8 4482.6 4604.1 4621.2 4630.2 4636.8 7340.7 7365.9 7420.3 7438.4 7472.0 7387.2 7403.0 7448.1 7478.9 7523.5 5695.9 5800.8 5810.4 5830.3 5941.1 6185.5 6341.5 6348.0 6349.8 6353.3 5476.7 5585.1 5636.5 5734.5 5791.9 5502.6 5668.1 5673.1 5690.3 5785.2 5360.2 5360.8 5386.5 5408.7 5437.3 3926.1 3934.3 4000.5 4002.6 4010.1 4039.6 4114.7 4213.6 4224.6 4278.2 23:06:57 INFO - PROCESS | 28022 | 23:06:57 INFO - PROCESS | 28022 | [#4] prototype.html Cycles:180 Average:4162.65 Median:4703.55 stddev:1207.96 (25.7%) stddev-sans-first:1175.91 23:06:57 INFO - PROCESS | 28022 | Values: 292.8 298.3 304.2 304.8 305.4 4845.8 4868.6 4869.4 4881.1 4881.7 4770.5 4776.9 4790.4 4807.7 4843.8 3603.9 3688.9 3736.0 3777.1 3791.5 3797.4 3797.4 3811.9 3821.3 3824.3 3772.2 3773.1 3780.3 3781.0 3800.4 3583.1 3677.3 3685.5 3725.0 3790.3 3347.5 3347.6 3351.2 3357.4 3377.1 4646.3 4646.5 4649.9 4664.9 4671.7 4005.2 4306.4 4320.5 4330.8 4335.8 4948.5 4980.8 4998.7 5020.0 5023.2 3548.1 3579.1 3579.6 3590.7 3594.7 5269.6 5308.7 5312.8 5335.3 5343.2 3512.3 3627.0 3638.7 3661.3 3673.8 3694.6 3705.7 3722.5 3739.0 3743.7 4227.5 4240.3 4271.2 4290.5 4295.3 4761.7 5008.9 5078.1 5085.4 5103.2 1245.4 1253.5 1254.5 1255.2 1261.7 825.8 843.8 852.5 859.4 866.9 4229.9 4263.0 4335.1 4363.5 4418.2 5140.3 5181.4 5196.6 5210.7 5236.9 4416.2 4420.2 4423.0 4438.7 4443.6 2593.2 2623.4 2658.8 2661.5 2669.0 4708.5 4712.5 4732.3 4738.6 4744.8 5095.5 5128.3 5131.9 5142.4 5182.7 4450.7 4667.0 4671.5 4681.1 4698.6 4980.0 5017.2 5019.3 5019.8 5026.9 4921.9 4924.2 4929.7 4938.5 4940.4 4593.4 4891.4 4908.4 4910.3 4912.1 3783.4 3783.4 3787.0 3799.3 3829.7 5256.6 5275.4 5276.1 5285.9 5289.3 4929.7 5034.5 5063.7 5072.4 5082.4 5048.7 5063.5 5067.5 5070.8 5075.9 4973.5 4974.3 4978.5 4989.9 5008.6 4895.1 4897.5 5031.4 5089.6 5138.3 4874.9 4975.3 4983.2 4985.9 5012.2 23:06:57 INFO - PROCESS | 28022 | 23:06:57 INFO - PROCESS | 28022 | [#5] yui.html Cycles:180 Average:14376.66 Median:603.13 stddev:19416.68 (3219.3%) stddev-sans-first:19443.57 23:06:57 INFO - PROCESS | 28022 | Values: 594.8 616.4 665.3 674.6 687.1 11168.3 11619.1 11950.9 12082.2 12291.9 12099.4 12270.1 12270.3 12272.9 12372.2 738.8 746.3 755.1 766.5 767.1 611.5 625.1 732.9 768.0 770.7 791.0 800.8 801.0 801.3 802.9 794.1 794.5 799.6 800.3 800.9 469.5 471.6 560.4 590.0 590.1 12102.6 12606.2 12623.1 12654.2 12728.3 10641.7 10651.3 11010.3 11077.6 11272.7 10685.4 10820.6 10912.7 10919.4 10990.8 3820.7 3822.9 3862.4 3883.3 3891.7 50871.7 51879.5 52647.0 52765.2 53261.7 9050.6 9133.5 9253.0 9265.2 9468.2 16112.5 16161.6 16189.3 16248.4 16335.4 6330.8 6336.4 6341.9 6387.3 6542.5 3582.6 3603.0 3632.2 3666.7 3688.8 2396.7 2468.1 2471.4 2478.7 2482.0 414.7 415.6 421.6 422.0 428.1 417.8 488.8 505.3 508.6 528.5 6827.4 6949.2 7035.2 7052.9 7210.2 440.3 497.0 527.7 532.7 535.9 3268.1 3278.8 3283.2 3302.4 3421.1 63862.4 69880.7 70645.3 73018.3 73042.6 61817.0 62074.4 62162.7 62986.0 65284.0 56247.4 57130.7 57410.8 57645.7 57967.4 6472.1 6677.9 6773.8 6964.8 7055.1 39782.4 39913.4 39944.6 39994.6 41517.4 47037.5 51147.7 52742.0 53387.7 54709.0 8015.9 8080.3 8292.0 8389.3 8434.7 9220.0 9266.8 9350.6 9484.1 9580.9 8524.4 8560.3 8634.4 8640.7 8703.1 8606.8 8625.1 8664.4 8882.6 8886.0 8806.2 8839.9 8875.3 9030.5 9197.4 7893.2 7955.4 7970.9 8308.5 8369.2 7613.1 7996.0 8016.8 8204.9 8255.8 23:06:57 INFO - PROCESS | 28022 | -------- Summary: end -------- 23:06:57 INFO - PROCESS | 28022 | 23:06:58 INFO - TEST-INFO | 28022: exit 0 23:06:58 INFO - TEST-OK | dromaeo_css | took 1121819ms 23:06:58 INFO - TEST-START | kraken 23:06:58 INFO - operating with platform_type : linux_ 23:06:58 INFO - Initialising browser for kraken test... 23:06:58 INFO - TEST-INFO | started process 28328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB66Avb/profile http://localhost:40122/getInfo.html) 23:07:02 INFO - PROCESS | 28328 | __metrics Screen width/height:1600/1200 23:07:02 INFO - PROCESS | 28328 | colorDepth:24 23:07:02 INFO - PROCESS | 28328 | Browser inner width/height: 1024/697 23:07:02 INFO - PROCESS | 28328 | __metrics 23:07:03 INFO - PROCESS | 28328 | 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" 23:07:03 INFO - PROCESS | 28328 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:07:03 INFO - PROCESS | 28328 | console.error: PushService: 23:07:03 INFO - PROCESS | 28328 | stateChangeProcessEnqueue: Error transitioning state 23:07:03 INFO - PROCESS | 28328 | UnknownError 23:07:04 INFO - TEST-INFO | 28328: exit 0 23:07:04 INFO - Browser initialized. 23:07:04 INFO - Running cycle 1/1 for kraken test... 23:07:04 INFO - TEST-INFO | started process 28408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB66Avb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:17 INFO - PROCESS | 28408 | RSS: Main: 174845952 23:07:17 INFO - PROCESS | 28408 | 23:07:19 INFO - PROCESS | 28408 | Cycle 1(1): loaded http://localhost:40122/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40122/tests/kraken/driver.html?testName=audio-beat-detection) 23:07:20 INFO - PROCESS | 28408 | RSS: Main: 235839488 23:07:20 INFO - PROCESS | 28408 | 23:07:23 INFO - PROCESS | 28408 | Cycle 1(1): loaded http://localhost:40122/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40122/tests/kraken/driver.html?testName=audio-dft) 23:07:24 INFO - PROCESS | 28408 | RSS: Main: 218755072 23:07:24 INFO - PROCESS | 28408 | 23:07:27 INFO - PROCESS | 28408 | Cycle 1(1): loaded http://localhost:40122/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40122/tests/kraken/driver.html?testName=audio-fft) 23:07:27 INFO - PROCESS | 28408 | RSS: Main: 301309952 23:07:27 INFO - PROCESS | 28408 | 23:07:30 INFO - PROCESS | 28408 | Cycle 1(1): loaded http://localhost:40122/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40122/tests/kraken/driver.html?testName=audio-oscillator) 23:07:30 INFO - PROCESS | 28408 | RSS: Main: 212197376 23:07:30 INFO - PROCESS | 28408 | 23:07:32 INFO - PROCESS | 28408 | Cycle 1(1): loaded http://localhost:40122/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40122/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:07:33 INFO - PROCESS | 28408 | RSS: Main: 215511040 23:07:33 INFO - PROCESS | 28408 | 23:07:36 INFO - PROCESS | 28408 | Cycle 1(1): loaded http://localhost:40122/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40122/tests/kraken/driver.html?testName=imaging-darkroom) 23:07:37 INFO - PROCESS | 28408 | RSS: Main: 254808064 23:07:37 INFO - PROCESS | 28408 | 23:07:40 INFO - PROCESS | 28408 | Cycle 1(1): loaded http://localhost:40122/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40122/tests/kraken/driver.html?testName=imaging-desaturate) 23:07:41 INFO - PROCESS | 28408 | RSS: Main: 248541184 23:07:41 INFO - PROCESS | 28408 | 23:07:44 INFO - PROCESS | 28408 | Cycle 1(1): loaded http://localhost:40122/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40122/tests/kraken/driver.html?testName=json-parse-financial) 23:07:44 INFO - PROCESS | 28408 | RSS: Main: 250777600 23:07:44 INFO - PROCESS | 28408 | 23:07:46 INFO - PROCESS | 28408 | Cycle 1(1): loaded http://localhost:40122/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40122/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:07:47 INFO - PROCESS | 28408 | RSS: Main: 213766144 23:07:47 INFO - PROCESS | 28408 | 23:07:49 INFO - PROCESS | 28408 | Cycle 1(1): loaded http://localhost:40122/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40122/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:07:49 INFO - PROCESS | 28408 | RSS: Main: 220471296 23:07:49 INFO - PROCESS | 28408 | 23:07:52 INFO - PROCESS | 28408 | Cycle 1(1): loaded http://localhost:40122/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40122/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:07:52 INFO - PROCESS | 28408 | RSS: Main: 229752832 23:07:52 INFO - PROCESS | 28408 | 23:07:55 INFO - PROCESS | 28408 | Cycle 1(1): loaded http://localhost:40122/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40122/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:07:56 INFO - PROCESS | 28408 | RSS: Main: 238673920 23:07:56 INFO - PROCESS | 28408 | 23:07:59 INFO - PROCESS | 28408 | Cycle 1(1): loaded http://localhost:40122/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40122/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:07:59 INFO - PROCESS | 28408 | RSS: Main: 236072960 23:07:59 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | Cycle 1(1): loaded http://localhost:40122/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40122/tests/kraken/driver.html?testName=ai-astar) 23:08:01 INFO - PROCESS | 28408 | RSS: Main: 285691904 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | __start_tp_report 23:08:01 INFO - PROCESS | 28408 | _x_x_mozilla_page_load 23:08:01 INFO - PROCESS | 28408 | _x_x_mozilla_page_load_details 23:08:01 INFO - PROCESS | 28408 | |i|pagename|runs| 23:08:01 INFO - PROCESS | 28408 | |0;ai-astar;107;116;117;117;116;116;117;116;116;114 23:08:01 INFO - PROCESS | 28408 | |1;audio-beat-detection;156;135;134;159;132;134;129;128;153;128 23:08:01 INFO - PROCESS | 28408 | |2;audio-dft;163;163;163;163;163;162;164;165;164;163 23:08:01 INFO - PROCESS | 28408 | |3;audio-fft;76;76;81;114;78;79;77;77;91;77 23:08:01 INFO - PROCESS | 28408 | |4;audio-oscillator;84;84;108;85;83;84;97;85;84;113 23:08:01 INFO - PROCESS | 28408 | |5;imaging-gaussian-blur;117;118;116;117;117;117;117;117;116;117 23:08:01 INFO - PROCESS | 28408 | |6;imaging-darkroom;148;148;148;147;149;147;147;147;148;146 23:08:01 INFO - PROCESS | 28408 | |7;imaging-desaturate;97;96;96;95;96;95;95;95;95;95 23:08:01 INFO - PROCESS | 28408 | |8;json-parse-financial;64;64;64;65;66;66;64;64;64;64 23:08:01 INFO - PROCESS | 28408 | |9;json-stringify-tinderbox;66;67;66;67;67;76;66;67;67;66 23:08:01 INFO - PROCESS | 28408 | |10;stanford-crypto-aes;88;90;84;84;92;84;84;91;85;85 23:08:01 INFO - PROCESS | 28408 | |11;stanford-crypto-ccm;145;145;143;144;141;152;150;142;197;152 23:08:01 INFO - PROCESS | 28408 | |12;stanford-crypto-pbkdf2;174;174;174;179;175;173;188;176;174;176 23:08:01 INFO - PROCESS | 28408 | |13;stanford-crypto-sha256-iterative;68;69;69;69;71;70;68;68;68;68 23:08:01 INFO - PROCESS | 28408 | __end_tp_report 23:08:01 INFO - PROCESS | 28408 | __start_cc_report 23:08:01 INFO - PROCESS | 28408 | _x_x_mozilla_cycle_collect,1983 23:08:01 INFO - PROCESS | 28408 | __end_cc_report 23:08:01 INFO - PROCESS | 28408 | __startTimestamp1480144081970__endTimestamp 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | ------- Summary: start ------- 23:08:01 INFO - PROCESS | 28408 | Number of tests: 14 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:3.01 (2.6%) stddev-sans-first:0.93 23:08:01 INFO - PROCESS | 28408 | Values: 107.0 116.0 117.0 117.0 116.0 116.0 117.0 116.0 116.0 114.0 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:134.50 stddev:12.21 (9.1%) stddev-sans-first:11.25 23:08:01 INFO - PROCESS | 28408 | Values: 156.0 135.0 134.0 159.0 132.0 134.0 129.0 128.0 153.0 128.0 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 23:08:01 INFO - PROCESS | 28408 | Values: 163.0 163.0 163.0 163.0 163.0 162.0 164.0 165.0 164.0 163.0 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.50 stddev:11.90 (15.4%) stddev-sans-first:12.38 23:08:01 INFO - PROCESS | 28408 | Values: 76.0 76.0 81.0 114.0 78.0 79.0 77.0 77.0 91.0 77.0 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:84.00 stddev:11.26 (13.4%) stddev-sans-first:11.67 23:08:01 INFO - PROCESS | 28408 | Values: 84.0 84.0 108.0 85.0 83.0 84.0 97.0 85.0 84.0 113.0 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 23:08:01 INFO - PROCESS | 28408 | Values: 117.0 118.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 23:08:01 INFO - PROCESS | 28408 | Values: 148.0 148.0 148.0 147.0 149.0 147.0 147.0 147.0 148.0 146.0 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.50 23:08:01 INFO - PROCESS | 28408 | Values: 97.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 23:08:01 INFO - PROCESS | 28408 | Values: 64.0 64.0 64.0 65.0 66.0 66.0 64.0 64.0 64.0 64.0 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:3.03 (4.5%) stddev-sans-first:3.16 23:08:01 INFO - PROCESS | 28408 | Values: 66.0 67.0 66.0 67.0 67.0 76.0 66.0 67.0 67.0 66.0 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.50 stddev:3.23 (3.7%) stddev-sans-first:3.40 23:08:01 INFO - PROCESS | 28408 | Values: 88.0 90.0 84.0 84.0 92.0 84.0 84.0 91.0 85.0 85.0 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | [#11] stanford-crypto-ccm Cycles:10 Average:151.10 Median:147.50 stddev:16.62 (11.3%) stddev-sans-first:17.48 23:08:01 INFO - PROCESS | 28408 | Values: 145.0 145.0 143.0 144.0 141.0 152.0 150.0 142.0 197.0 152.0 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:175.50 stddev:4.45 (2.5%) stddev-sans-first:4.64 23:08:01 INFO - PROCESS | 28408 | Values: 174.0 174.0 174.0 179.0 175.0 173.0 188.0 176.0 174.0 176.0 23:08:01 INFO - PROCESS | 28408 | 23:08:01 INFO - PROCESS | 28408 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 23:08:01 INFO - PROCESS | 28408 | Values: 68.0 69.0 69.0 69.0 71.0 70.0 68.0 68.0 68.0 68.0 23:08:01 INFO - PROCESS | 28408 | -------- Summary: end -------- 23:08:01 INFO - PROCESS | 28408 | 23:08:03 INFO - TEST-INFO | 28408: exit 0 23:08:03 INFO - TEST-OK | kraken | took 64278ms 23:08:03 INFO - SUITE-END | took 1186s 23:08:03 INFO - Completed test suite (00:19:46) 23:08:03 INFO - javascript benchmark 23:08:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2542.936426589335, 2594.9610755838653, 2601.2456387647585, 2623.93440163996, 2629.908587936007, 4469.128519938613, 4544.954550454503, 4604.963883126299, 4627.120847039065, 4648.837290694826, 4552.613027892633, 4564.475085365184, 4565.018521017989, 4567.155076310884, 4572.885677858055, 4189.853355132571, 4206.894827629303, 4219.13507730916, 4247.851325203618, 4263.275243208662, 4281.05816720321, 4302.698811083225, 4307.956920430787, 4313.935290970638, 4316.784160791964, 4158.106007208449, 4202.831886724527, 4207.789610519477, 4228.809703563347, 4307.396964424983, 4227.725197862129, 4249.681273904439, 4286.142771445692, 4315.525292217853, 4324.005478739876, 4143.0, 4189.539150693421, 4190.664746820247, 4226.894327641833, 4229.36559516072, 4584.689824079327, 4588.082383523275, 4591.816327346902, 4640.303954406832, 4648.1865673507, 4867.561919427269, 4885.633577481668, 4891.755412229374, 4896.877578060541, 4915.852524424237, 4811.374521312242, 4872.8538143855385, 4880.194767863299, 4900.313956046157, 4927.704337739747, 4528.637708983273, 4602.217623004098, 4618.515055919147, 4622.653301002439, 4644.674872758875, 5116.923246151311, 5120.257562653394, 5148.794048238028, 5169.793208271627, 5172.870678232999, 4902.48523904992, 4909.0, 4909.803607855646, 4915.115279249698, 4960.553550180501, 4764.30917516965, 4826.396700412449, 4997.375328083989, 4999.47505511916, 5046.419661738873, 4758.78585463655, 4828.203346447867, 4885.8045678173185, 4896.436909755424, 4966.006798640286, 4886.071646387175, 4901.745854591817, 4902.436219834764, 4903.26451032348, 4947.802087916443, 4220.2192594370135, 4261.552536983634, 4264.680148988777, 4272.6154646082, 4306.74159550428, 3646.9817650912105, 3651.1054791576234, 3651.8721844735305, 3652.1782598915033, 3688.1517251032415, 4198.706090573692, 4214.599613036757, 4237.025484138665, 4241.300185469425, 4251.277282861921, 4901.730404827697, 4912.140375434285, 4925.11347957364, 4925.605951523869, 4972.577330926912, 4111.8972025699595, 4168.3955826405, 4170.311898536768, 4207.957920420757, 4214.810333534998, 4449.933251001237, 4458.487273963536, 4465.620422264079, 4467.463904331501, 4468.50846406895, 4582.747948862844, 4613.1004454131125, 4620.145273124483, 4624.722516649012, 4628.1669299525065, 4916.8770780730765, 4922.261660750916, 4925.064237794808, 4927.18701414277, 4927.457979622167, 4586.220342541843, 4609.170349337018, 4612.169809434334, 4617.376654151646, 4619.330197121331, 4842.564169224786, 4876.926846097241, 4888.095702295087, 4910.386201724785, 4927.802887884588, 4934.136526107988, 4958.628102892226, 4959.156943319572, 4963.230699241623, 5017.974910125426, 4702.858914232578, 4757.381540399864, 4816.927746083882, 4828.851767677985, 4865.440474345495, 4699.882502937454, 4763.833265835818, 4766.666333356632, 4778.546038126373, 4820.39745031871, 4787.54518320759, 4791.640626953063, 4792.346640409053, 4795.400574928134, 4840.104580652591, 4779.378680771617, 4893.314935908905, 4896.436909755424, 4900.313956046085, 4933.876653083702, 4691.249400095969, 4710.26990816424, 4719.716816990992, 4748.216544270157, 4789.090072886141], "value": 4527.795305848779, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.1358785180156, 539.4605394605394, 553.1067326268073, 554.2130175151285, 571.7912961768956, 26771.196864094083, 37218.62781372189, 38233.80883095581, 38255.808720956426, 41482.37776433348, 38583.80708096462, 38896.22207555847, 38926.0, 38973.0, 39009.07431942609, 7298.379637730786, 7436.925630743677, 7441.441891858105, 7445.255474452566, 7449.329560339568, 7220.169680486732, 7476.962615186916, 9444.102810233016, 9650.469224192666, 9665.226781857435, 9736.951315243414, 9790.21678265737, 9809.117179453884, 9820.82150141984, 9825.901740982606, 9615.471149086798, 9666.0, 9676.274279429072, 9681.709548713514, 9689.0, 9568.952155239249, 9630.518474076338, 9688.41869487833, 9690.370125941861, 9696.36973596721, 36058.27883442343, 36173.63826361729, 36256.0, 36310.0, 36315.81842090799, 2978.195887110468, 3028.6971302869756, 3052.740517056053, 3210.1653570071717, 3233.0, 27928.441431171264, 27980.720192798217, 28282.434351313063, 28700.569491457645, 29408.11775646734, 3379.509971054208, 3425.1950791563963, 3477.426224672926, 3604.2611264690936, 3619.4027985382645, 229352.0, 231360.0, 231382.0, 231605.0, 231962.0, 48768.7561562197, 49168.50831491711, 49404.752976234886, 49481.0, 49532.50467495279, 51670.74164629153, 51684.0, 51698.0, 51757.7412112937, 51851.74074129605, 14229.715405691828, 14529.418823247162, 14542.563723088324, 14551.199684017269, 14556.344964476411, 10342.793144137075, 10606.946965265124, 11266.098712103012, 11439.714007149722, 11448.084153267719, 13913.721725565432, 14481.565553033426, 14522.0, 14912.179830109231, 14990.925045374703, 5893.734781934738, 5984.700764961822, 5997.640141591519, 6024.548158888101, 6064.454199122012, 763.3397111498625, 925.4863550729275, 961.7835986902891, 969.3391639948387, 992.528548939248, 26250.474990500083, 27026.324341891217, 27087.0, 27304.726952730616, 27355.72644273532, 925.7132585705874, 935.5883411299143, 967.9516024198903, 995.4922989275522, 1032.1484775060605, 13810.792838107436, 14181.290935453393, 14491.565253042425, 14622.195779232245, 14655.159489672973, 384610.0, 389436.0, 392279.0, 556689.0, 562827.0, 47213.76393118081, 47753.522464775604, 47764.7611761939, 47811.28283075687, 47829.521704783205, 1065.4672663668166, 1096.9962484326752, 1135.795556799784, 1145.7593905279984, 1172.1560476456937, 23980.688568250516, 27904.720952791024, 27923.581146282417, 27940.441191175654, 28250.85874570614, 39836.2032759349, 40250.396244056945, 40399.7980010098, 40413.59586404098, 40428.0, 272861.0, 273381.0, 274305.0, 274659.0, 274944.0, 23176.536469270857, 23936.760632393452, 23965.64051539263, 25286.620700689873, 25602.0, 38497.0, 38525.80737096409, 38845.0, 39997.40003900002, 40302.39546406748, 33524.1618959528, 33772.493412599324, 33947.0, 34075.829620851735, 34632.48051279182, 33131.668683312855, 33167.66832331646, 33756.831215844744, 34047.14882127867, 34522.82738586291, 32998.67001329956, 33214.16964575905, 33455.16362090967, 33613.495797562566, 33718.15704607405, 29921.401571968872, 30296.5455518163, 31041.689583104784, 31235.219119522193, 31336.05991820249, 24149.894517932345, 24151.637725434484, 24152.63771043471, 24283.39291517726, 24315.513689725754], "value": 17189.154750415066, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.94253417795966, 339.35522507236266, 353.05557633330835, 356.413699464381, 384.9499565056542, 12273.693157671052, 15184.848151518481, 15444.536663900073, 16306.0, 17111.40110096147, 16608.169591520436, 16625.251863666133, 16629.41797037104, 16733.74899376507, 16932.238049287782, 4796.808127674897, 4833.0, 5007.073691367109, 5023.0707319145895, 5057.216131499624, 3640.526731524898, 4930.506949305059, 5028.0, 5032.672876263049, 5035.647504674675, 3816.9618303816883, 5484.2596249506405, 5719.0, 5725.055365864628, 5834.474897259246, 5627.465390787868, 5827.0, 5827.941720582803, 5830.912536311958, 5852.707364631751, 5160.329157209576, 5198.558122559587, 5203.531682148587, 5204.791808327663, 5206.609504287194, 19206.327778527822, 19567.315143970034, 19591.41225763215, 19645.705314420295, 19674.213031478725, 1859.20054376618, 1885.3401309541687, 1904.2043323377281, 1952.6973319135557, 2181.465540942479, 8609.225169734755, 8815.823683526358, 9066.048064953151, 9413.388129771543, 12109.697257568543, 1600.3758534171682, 1634.5423281481085, 1759.727242277449, 1799.190364336054, 1880.7743070831589, 43282.0, 58567.70716146434, 59165.112523312186, 62074.0, 67233.99149012817, 9458.763530911645, 9873.210143188528, 9907.356021858555, 9956.701298961043, 9987.600495980225, 13569.86430135686, 13575.0, 13585.864141358657, 13598.048136630341, 13602.183868967893, 6918.37734603878, 6982.266861979419, 7056.54132481387, 7202.0, 7411.592362420119, 6574.868502629921, 6580.21037475506, 6605.174353205849, 6728.091707619506, 6766.830829229309, 4263.680223983214, 4309.806058727365, 4334.718243314238, 4347.347897815353, 4428.778561071998, 1598.1609654931021, 1721.664275466297, 1760.0, 1774.2193434888607, 1791.3013924569427, 714.5069901767764, 788.7239466186903, 836.9455985360933, 837.7486753973783, 901.3735453859636, 16294.42969496062, 16314.34742610306, 16481.093539855185, 16507.09210993407, 17135.172696505186, 818.7543736878913, 820.5774026376421, 821.9342452603777, 840.537704262653, 922.8477301245354, 8911.910880891108, 9447.527623618791, 9503.952480237554, 9524.190443812215, 9555.533359968065, 327039.0, 332324.0, 334064.0, 334399.0, 334851.0, 69500.0, 72146.27853721501, 76372.23627763762, 79471.20528794754, 81797.0, 896.4576431259125, 916.6425094213262, 927.8144371125802, 946.9621215151454, 947.1333729637443, 14506.927465363027, 14525.139664804672, 16333.428330008393, 16463.423780168116, 16758.58103547421, 29406.264843379086, 30731.846340768152, 36452.63547364598, 36821.81589092038, 37300.0, 43120.35319470148, 44612.0, 44989.100217994805, 45540.31689524594, 51102.0, 7030.789076327718, 7033.507654464343, 7242.348188663045, 7307.634618269171, 7449.6275186241555, 8102.87845682327, 11142.164337674869, 11354.318740875575, 11404.0, 11836.526538938346, 10517.789644207227, 10559.257722475706, 10590.629327973484, 10723.571057157938, 10959.50682219318, 6737.292584278776, 9203.263738900738, 10538.841917371092, 10594.20543459259, 10875.564977400816, 10613.734656633645, 10622.0, 10704.785904282027, 10774.784504310026, 11263.887361126284, 7448.106227252548, 7501.099868015873, 7588.165301816685, 7704.92295077042, 8087.83824323522, 9795.216382689225, 10049.296549241482, 10432.68701938943, 10475.738106547396, 10920.890791091988], "value": 7941.356565793969, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.4754098360659, 1353.1542785758902, 1368.4321006782186, 1613.370785393696, 1636.2882146266375, 5978.07339862321, 6210.254769427664, 6487.902681459776, 6906.067680863076, 6912.205096413914, 6428.614283143014, 6691.0, 6692.163479565054, 6809.761658341959, 6844.2813504582045, 2017.082227586452, 2040.1533363654066, 2045.3761602711168, 2045.9795402046013, 2053.425040988518, 1638.1645360865925, 1757.6484703059375, 2028.229272876305, 2030.6953956906434, 2039.3474088291678, 1718.037898776689, 1732.5322163015978, 1736.3401907275218, 1960.8529360298035, 2021.7877122902105, 1989.2838578111869, 1993.4318719165042, 1998.1208268361875, 1998.6402447559433, 1998.740163778714, 1955.8533110016806, 1981.7522809648794, 2041.5202427429542, 2046.1610739596842, 2052.917883284667, 6681.265060843352, 6684.799456016327, 6744.629045402501, 6758.324167583251, 6759.053732477408, 4049.696272779524, 4183.874483765492, 4185.288500954845, 4186.246475634384, 4189.2040512302565, 2526.595744680842, 2628.158989123481, 2686.240512464339, 2701.9459610807676, 2721.0612338743103, 800.7877912353231, 842.1199846160777, 846.5354935960761, 872.5462759365095, 880.5949263338807, 8879.955600222022, 8904.8664270036, 8926.152015558511, 8968.282537396992, 8974.506402147814, 3607.098225443639, 3677.7241706871555, 3806.410006449005, 3830.942535861964, 3854.7494412863075, 7716.845663086707, 7719.845603087907, 7740.961295193488, 7743.612819359009, 7746.612669366509, 4233.597808208216, 4237.258479766028, 4239.173361194599, 4239.872803815891, 4243.045314804144, 3714.3871261241593, 3900.687944964396, 3902.746321489094, 3902.8829135125993, 3906.374980003186, 3239.5626590410466, 3243.594550681165, 3318.6515415881468, 3360.1263671445113, 3368.0737797105994, 1101.0530943388678, 1106.4080716816466, 1109.606089838112, 1109.6948339206783, 1121.2599684208383, 624.6033768556999, 779.9532028078333, 788.7278888783361, 797.9122296547375, 813.2314962360513, 4518.593326600621, 4566.771661416982, 4573.3368661544555, 4613.2388155953895, 4624.583787459145, 378.7651655973314, 384.06863356360714, 390.79287977372036, 392.9351656976624, 416.50227977567124, 3312.188513814083, 3355.966440335614, 3356.714679252291, 3361.983190084034, 3452.998630397207, 7626.237376262329, 8045.07481639619, 8050.5169689818795, 8060.435769496196, 8075.596220188967, 8059.395545334006, 8073.515589064675, 8094.595270236465, 8095.23095305945, 8114.188581141839, 6329.461995730322, 6432.228132624022, 6446.613203207822, 6448.548601597843, 6448.806535803839, 4482.596566309048, 4604.1252162089095, 4621.168189725881, 4630.189716799614, 4636.8145274188655, 7340.70637174507, 7365.895115732683, 7420.257974202753, 7438.367738742268, 7471.962640186982, 7387.2243414442855, 7402.962985185255, 7448.14346350155, 7478.850422991401, 7523.548587084573, 5695.943040569541, 5800.796972105956, 5810.389909059488, 5830.329512106162, 5941.079132734433, 6185.474234689922, 6341.460975817107, 6348.047792830927, 6349.809505714836, 6353.269374022047, 5476.67139971603, 5585.106382978704, 5636.4927156556105, 5734.483896449339, 5791.942080579141, 5502.58730595215, 5668.093105103164, 5673.120666296731, 5690.260266165372, 5785.247917770663, 5360.2227676987395, 5360.785568577369, 5386.461353864583, 5408.702521361205, 5437.32033495813, 3926.1166237596312, 3934.272159650474, 4000.539937907178, 4002.599740025974, 4010.0776821330674, 4039.6162364575316, 4114.691398145092, 4213.557576454428, 4224.640905523065, 4278.229918614555], "value": 3584.019781976652, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.76432471860153, 298.34513243430666, 304.236366719534, 304.7638080487623, 305.4486651593872, 4845.80616775329, 4868.56182943535, 4869.391326084239, 4881.072596206723, 4881.731504767236, 4770.499097594755, 4776.90446191076, 4790.401199850019, 4807.687500312477, 4843.806247750094, 3603.94594081089, 3688.8708895188674, 3735.962640373589, 3777.0746167189077, 3791.507104076466, 3797.373433383488, 3797.3924172132324, 3811.942820857689, 3821.254855303203, 3824.2542704172697, 3772.207836354355, 3773.132179598694, 3780.262848744496, 3781.0, 3800.429935509668, 3583.104223944027, 3677.2645470905927, 3685.4656074869263, 3724.962750372516, 3790.2798468290935, 3347.4978753186974, 3347.581552305962, 3351.1957130288556, 3357.4124528207467, 3377.054424761071, 4646.303054541812, 4646.4888862225125, 4649.930251046237, 4664.857110008036, 4671.696339737906, 4005.198960207941, 4306.35404689296, 4320.4599425071865, 4330.848420305274, 4335.807652895479, 4948.505149485059, 4980.77586508608, 4998.700077995332, 5020.0, 5023.196288593844, 3548.077499850032, 3579.0830473164547, 3579.570451545805, 3590.6588874056924, 3594.748367614268, 5269.6311258211945, 5308.681479111266, 5312.787488500456, 5335.306410166731, 5343.198520221998, 3512.332656795201, 3626.987022202703, 3638.6543278388513, 3661.3226553087766, 3673.834677439468, 3694.630536946284, 3705.7030039486503, 3722.4974628425357, 3738.981305093457, 3743.7005039596766, 4227.492700875914, 4240.321548552217, 4271.188474189894, 4290.50659174199, 4295.334223195409, 4761.714417052292, 5008.924866127011, 5078.13671675816, 5085.364329458817, 5103.234514822806, 1245.3586403002462, 1253.4547471849774, 1254.5358217459598, 1255.171586752757, 1261.6656586004533, 825.7605294464538, 843.7721815109886, 852.5225873510853, 859.441363113981, 866.9393142480092, 4229.9365509516765, 4262.976885547447, 4335.089631177425, 4363.454568178978, 4418.248897687401, 5140.30605868203, 5181.35233095863, 5196.558292545101, 5210.671278823876, 5236.947630523646, 4416.227160246944, 4420.226460369422, 4423.0, 4438.667099967515, 4443.644508439317, 2593.23499567628, 2623.3997261670365, 2658.8035384077243, 2661.5228548155574, 2669.0, 4708.458527269339, 4712.481627021025, 4732.290156476487, 4738.649484896788, 4744.786484608201, 5095.490450954949, 5128.333316668809, 5131.897362052813, 5142.382914050338, 5182.714950677673, 4450.666200034945, 4667.043256132417, 4671.48613652498, 4681.144501853866, 4698.647601429906, 4979.950200497949, 5017.222330538772, 5019.289583624948, 5019.774110164978, 5026.919212369358, 4921.8523444296725, 4924.236743304794, 4929.704217746947, 4938.530839570235, 4940.407151141886, 4593.448786145684, 4891.437484689306, 4908.361912951294, 4910.263460480956, 4912.066707325596, 3783.356829338964, 3783.356829338964, 3787.0, 3799.297130030953, 3829.7319187656594, 5256.553192978639, 5275.393329767126, 5276.076686579757, 5285.947140528546, 5289.312389389354, 4929.654924155275, 5034.496550345083, 5063.734066483379, 5072.41667208261, 5082.4409314976065, 5048.697078175322, 5063.518965698253, 5067.479756073237, 5070.8225212117395, 5075.923861142012, 4973.502649734997, 4974.303597496281, 4978.47725988766, 4989.927165659401, 5008.649394542347, 4895.143349913822, 4897.485763994871, 5031.396232452129, 5089.618278629192, 5138.280640710229, 4874.8787778810365, 4975.283527183116, 4983.227599722049, 4985.900281994413, 5012.1980483122525], "value": 3778.4300200192047, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.7925710807062, 616.3651439017813, 665.2549144957649, 674.5581644023166, 687.1342108942731, 11168.274062185952, 11619.1285653576, 11950.940245298783, 12082.21465604735, 12291.877081229186, 12099.395030248474, 12270.141090123694, 12270.263784172956, 12272.877271227286, 12372.195807272521, 738.841149152932, 746.3320328306163, 755.0674916478146, 766.4519868294169, 767.075673813054, 611.4619135161053, 625.0530446373748, 732.8644200822838, 767.9500832445901, 770.6647608290411, 790.9960450197741, 800.7877912353231, 800.951942883426, 801.3388954112851, 802.8956235689352, 794.0868001797921, 794.4875555266849, 799.6321692021677, 800.335721351277, 800.9118996910336, 469.54454179445884, 471.6486217767751, 560.3779804417094, 590.0382376725952, 590.1207201270076, 12102.636920892388, 12606.243625382414, 12623.116381853273, 12654.240745555204, 12728.299943503103, 10641.680749577525, 10651.25441219115, 11010.284331518425, 11077.556897724082, 11272.66182014541, 10685.358878467317, 10820.621278255223, 10912.727181820439, 10919.39943303118, 10990.780184396348, 3820.7134464914966, 3822.9104705158898, 3862.439946207784, 3883.3010058189516, 3891.708121890841, 50871.745641271926, 51879.48120518784, 52647.0, 52765.208521872584, 53261.73369133168, 9050.637974480947, 9133.45199288045, 9253.0, 9265.166135047879, 9468.19520340765, 16112.516624501284, 16161.59596010109, 16189.271482783302, 16248.350065997227, 16335.428260010842, 6330.8417289567205, 6336.429721325103, 6341.936580634227, 6387.297397286387, 6542.509311801634, 3582.6238244984424, 3602.963970360263, 3632.182758879284, 3666.7066634669163, 3688.8340024698955, 2396.664466974625, 2468.148488771371, 2471.3821544613847, 2478.6901637295337, 2481.962770558443, 414.6579072265393, 415.5885673183587, 421.62686022869366, 421.99789001054796, 428.0860363124689, 417.83286685325504, 488.81669373984755, 505.2824988516242, 508.6261597725669, 528.4952870009132, 6827.351401616838, 6949.235584085746, 7035.155781306174, 7052.894206586905, 7210.170830354471, 440.2801419678848, 497.0, 527.7493190734447, 532.6561887804957, 535.9410464848863, 3268.1176082457605, 3278.7704860659524, 3283.244853683618, 3302.4220761366664, 3421.0934102462866, 63862.36137638657, 69880.6505967467, 70645.2935470649, 73018.2698173022, 73042.63478682573, 61817.0, 62074.379256207765, 62162.68918655378, 62986.0, 65284.0, 56247.437525625035, 57130.714346428, 57410.81426971665, 57645.711771440874, 57967.420325797044, 6472.126262954441, 6677.933220667731, 6773.762918297836, 6964.825879353057, 7055.118110236221, 39782.40326395049, 39913.40129897996, 39944.60055399409, 39994.60086386164, 41517.37723934083, 47037.529624704686, 51147.74426127846, 52742.0, 53387.733061334446, 54709.0, 8015.919840801517, 8080.2727754502375, 8291.9585402075, 8389.328853691812, 8434.70478533273, 9219.953900230455, 9266.814663706553, 9350.625974960925, 9484.146426821619, 9580.856287155559, 8524.445911015764, 8560.315174786127, 8634.438761480484, 8640.697575584825, 8703.086175951434, 8606.78483037929, 8625.094365091825, 8664.35017373687, 8882.555872206492, 8886.0, 8806.157150528235, 8839.911600883908, 8875.33434992391, 9030.503322317072, 9197.402168859002, 7893.210678932061, 7955.403344749283, 7970.880436793569, 8308.501489910625, 8369.246767790928, 7613.08642962848, 7996.0, 8016.839663206587, 8204.917950820416, 8255.793605159919], "value": 5663.529861248037, "unit": "score"}], "name": "dromaeo_css", "value": 6016.031230639208, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 114.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 135.0, 134.0, 159.0, 132.0, 134.0, 129.0, 128.0, 153.0, 128.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 163.0, 162.0, 164.0, 165.0, 164.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 81.0, 114.0, 78.0, 79.0, 77.0, 77.0, 91.0, 77.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 108.0, 85.0, 83.0, 84.0, 97.0, 85.0, 84.0, 113.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 149.0, 147.0, 147.0, 147.0, 148.0, 146.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 66.0, 66.0, 64.0, 64.0, 64.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 76.0, 66.0, 67.0, 67.0, 66.0], "value": 67.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 84.0, 84.0, 92.0, 84.0, 84.0, 91.0, 85.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 143.0, 144.0, 141.0, 152.0, 150.0, 142.0, 197.0, 152.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 174.0, 179.0, 175.0, 173.0, 188.0, 176.0, 174.0, 176.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 69.0, 71.0, 70.0, 68.0, 68.0, 68.0, 68.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1565.3999999999999, "alertThreshold": 2.0}]} 23:08:03 INFO - Return code: 0 23:08:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:08:03 INFO - # TBPL SUCCESS # 23:08:03 INFO - Running post-action listener: _resource_record_post_action 23:08:03 INFO - [mozharness: 2016-11-26 07:08:03.737056Z] Finished run-tests step (success) 23:08:03 INFO - Running post-run listener: _resource_record_post_run 23:08:03 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394203136; Read time: 8; Write time: 265640 23:08:03 INFO - TinderboxPrint: CPU usage
13.1% 23:08:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 23:08:03 INFO - TinderboxPrint: I/O write bytes / time
394,203,136 / 265,640 23:08:03 INFO - TinderboxPrint: CPU idle
8,343.5 (86.9%) 23:08:03 INFO - TinderboxPrint: CPU user
1,208.7 (12.6%) 23:08:03 INFO - TinderboxPrint: Swap in / out
0 / 0 23:08:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99692544; Read time: 0; Write time: 80184 23:08:03 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 294510592; Read time: 0; Write time: 185456 23:08:04 INFO - Running post-run listener: _upload_blobber_files 23:08:04 INFO - Blob upload gear active. 23:08:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:08:04 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 23:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:08:04 INFO - (blobuploader) - INFO - Open directory for files ... 23:08:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:08:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:08:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:08:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:08:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:08:05 INFO - (blobuploader) - INFO - Done attempting. 23:08:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:08:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:08:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:08:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:08:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:08:08 INFO - (blobuploader) - INFO - Done attempting. 23:08:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:08:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:08:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:08:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:08:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:08:09 INFO - (blobuploader) - INFO - Done attempting. 23:08:09 INFO - (blobuploader) - INFO - Iteration through files over. 23:08:09 INFO - Return code: 0 23:08:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:08:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:08:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/978c069c543b20ed30f03054f185d7a36c7adc51b708869ee667269988a0262c9040ed0a2eae836f66a4a6bdf7dccaea38ae9fbfc45dd9baa93e8d7310ee231e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d393af37c81e95b23277801a862a3532697d90a9302797a7b4cc8417ec279ed1d4c481c23d2ddffba7a4348587171a5e8257bb125d1abb781644e24cafe1b85f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/add5cef6381e15a3d39e9d39d1e03c0748eba426ef155e6e1975a5b083a9d600d73df77ac76813dbf33691b84f3233395ef6873406e2f60f4907b67529a4e515"} 23:08:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:08:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:08:09 INFO - Contents: 23:08:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/978c069c543b20ed30f03054f185d7a36c7adc51b708869ee667269988a0262c9040ed0a2eae836f66a4a6bdf7dccaea38ae9fbfc45dd9baa93e8d7310ee231e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d393af37c81e95b23277801a862a3532697d90a9302797a7b4cc8417ec279ed1d4c481c23d2ddffba7a4348587171a5e8257bb125d1abb781644e24cafe1b85f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/add5cef6381e15a3d39e9d39d1e03c0748eba426ef155e6e1975a5b083a9d600d73df77ac76813dbf33691b84f3233395ef6873406e2f60f4907b67529a4e515"} 23:08:09 INFO - Running post-run listener: copy_logs_to_upload_dir 23:08:09 INFO - Copying logs to upload dir... 23:08:09 INFO - mkdir: /builds/slave/test/build/upload/logs 23:08:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.600843 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-11-25 23:08:08.429614) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 23:08:08.433405) ========= 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=923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/978c069c543b20ed30f03054f185d7a36c7adc51b708869ee667269988a0262c9040ed0a2eae836f66a4a6bdf7dccaea38ae9fbfc45dd9baa93e8d7310ee231e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d393af37c81e95b23277801a862a3532697d90a9302797a7b4cc8417ec279ed1d4c481c23d2ddffba7a4348587171a5e8257bb125d1abb781644e24cafe1b85f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/add5cef6381e15a3d39e9d39d1e03c0748eba426ef155e6e1975a5b083a9d600d73df77ac76813dbf33691b84f3233395ef6873406e2f60f4907b67529a4e515"} build_url:https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011488 build_url: 'https://queue.taskcluster.net/v1/task/WJ1FbDxQSTW0gyBvegc0pw/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/Firefox-Non-PGO/sha512/978c069c543b20ed30f03054f185d7a36c7adc51b708869ee667269988a0262c9040ed0a2eae836f66a4a6bdf7dccaea38ae9fbfc45dd9baa93e8d7310ee231e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d393af37c81e95b23277801a862a3532697d90a9302797a7b4cc8417ec279ed1d4c481c23d2ddffba7a4348587171a5e8257bb125d1abb781644e24cafe1b85f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/add5cef6381e15a3d39e9d39d1e03c0748eba426ef155e6e1975a5b083a9d600d73df77ac76813dbf33691b84f3233395ef6873406e2f60f4907b67529a4e515"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 23:08:08.459942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 23:08:08.460313) ========= 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=923d835db2ba3686ebe126b700000192-1480142772.453391-1613071212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 23:08:08.544420) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 23:08:08.544746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 23:08:08.545098) ========= ========= Total master_lag: 0.17 =========