builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1475166077.63 results: success (0) buildid: 20160929090019 builduid: 1f00a97dde5c49f59f8df14620bb9379 revision: f21ffbf119bd6d7084309123be42f97743f1f7e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 09:21:17.631890) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 09:21:17.632389) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 09:21:17.632691) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 09:21:17.647403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:21:17.647756) ========= 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=920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 09:21:17-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-09-29 09:21:17 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082899 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:21:17.745164) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:21:17.745519) ========= 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=920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018659 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:21:17.853856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:21:17.854307) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f21ffbf119bd6d7084309123be42f97743f1f7e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev f21ffbf119bd6d7084309123be42f97743f1f7e5 --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=920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 09:21:18,044 truncating revision to first 12 chars 2016-09-29 09:21:18,045 Setting DEBUG logging. 2016-09-29 09:21:18,045 attempt 1/10 2016-09-29 09:21:18,045 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f21ffbf119bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 09:21:18,415 unpacking tar archive at: autoland-f21ffbf119bd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.742794 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:21:18.610434) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 09:21:18.610774) ========= script_repo_revision: f21ffbf119bd6d7084309123be42f97743f1f7e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 09:21:18.611173) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 09:21:18.611438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 09:21:18.621000) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-29 09:21:18.621448) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:21:18 INFO - MultiFileLogger online at 20160929 09:21:18 in /builds/slave/test 09:21:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 09:21:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:21:18 INFO - {'append_to_log': False, 09:21:18 INFO - 'base_work_dir': '/builds/slave/test', 09:21:18 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 09:21:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:21:18 INFO - 'branch': 'Autoland-Non-PGO', 09:21:18 INFO - 'buildbot_json_path': 'buildprops.json', 09:21:18 INFO - 'config_files': ('talos/linux_config.py',), 09:21:18 INFO - 'default_actions': ('clobber', 09:21:18 INFO - 'read-buildbot-config', 09:21:18 INFO - 'download-and-extract', 09:21:18 INFO - 'populate-webroot', 09:21:18 INFO - 'create-virtualenv', 09:21:18 INFO - 'install', 09:21:18 INFO - 'run-tests'), 09:21:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:21:18 INFO - 'download_minidump_stackwalk': True, 09:21:18 INFO - 'download_symbols': 'ondemand', 09:21:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:21:18 INFO - 'tooltool.py': '/tools/tooltool.py', 09:21:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:21:18 INFO - '/tools/misc-python/virtualenv.py')}, 09:21:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:21:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:21:18 INFO - 'installer_path': 'installer.exe', 09:21:18 INFO - 'log_level': 'info', 09:21:18 INFO - 'log_name': 'talos', 09:21:18 INFO - 'log_to_console': True, 09:21:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:21:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:21:18 INFO - 'opt_config_files': (), 09:21:18 INFO - 'pip_index': False, 09:21:18 INFO - 'sps_profile': False, 09:21:18 INFO - 'sps_profile_interval': 0, 09:21:18 INFO - 'suite': 'dromaeojs', 09:21:18 INFO - 'system_bits': '32', 09:21:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:21:18 INFO - 'title': 'talos-linux64-ix-053', 09:21:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:21:18 INFO - 'use_talos_json': True, 09:21:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:21:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:21:18 INFO - 'work_dir': 'build'} 09:21:18 INFO - [mozharness: 2016-09-29 16:21:18.913861Z] Running clobber step. 09:21:18 INFO - Running pre-action listener: _resource_record_pre_action 09:21:18 INFO - Running main action method: clobber 09:21:18 INFO - rmtree: /builds/slave/test/build 09:21:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:21:19 INFO - Running post-action listener: _resource_record_post_action 09:21:19 INFO - [mozharness: 2016-09-29 16:21:19.891658Z] Finished clobber step (success) 09:21:19 INFO - [mozharness: 2016-09-29 16:21:19.891758Z] Running read-buildbot-config step. 09:21:19 INFO - Running pre-action listener: _resource_record_pre_action 09:21:19 INFO - Running main action method: read_buildbot_config 09:21:19 INFO - Using buildbot properties: 09:21:19 INFO - { 09:21:19 INFO - "project": "", 09:21:19 INFO - "product": "firefox", 09:21:19 INFO - "script_repo_revision": "production", 09:21:19 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 09:21:19 INFO - "repository": "", 09:21:19 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 09:21:19 INFO - "buildid": "20160929090019", 09:21:19 INFO - "pgo_build": "False", 09:21:19 INFO - "basedir": "/builds/slave/test", 09:21:19 INFO - "buildnumber": 671, 09:21:19 INFO - "slavename": "talos-linux64-ix-053", 09:21:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:21:19 INFO - "platform": "ubuntu64_hw", 09:21:19 INFO - "scheduler": "tests-autoland-linux64-talos", 09:21:19 INFO - "branch": "autoland", 09:21:19 INFO - "repo_path": "integration/autoland", 09:21:19 INFO - "revision": "f21ffbf119bd6d7084309123be42f97743f1f7e5", 09:21:19 INFO - "stage_platform": "linux64", 09:21:19 INFO - "builduid": "1f00a97dde5c49f59f8df14620bb9379", 09:21:19 INFO - "slavebuilddir": "test" 09:21:19 INFO - } 09:21:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:21:19 INFO - Running post-action listener: _resource_record_post_action 09:21:19 INFO - [mozharness: 2016-09-29 16:21:19.894161Z] Finished read-buildbot-config step (success) 09:21:19 INFO - [mozharness: 2016-09-29 16:21:19.894247Z] Running download-and-extract step. 09:21:19 INFO - Running pre-action listener: _resource_record_pre_action 09:21:19 INFO - Running main action method: download_and_extract 09:21:19 INFO - mkdir: /builds/slave/test/build/tests 09:21:19 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')]} 09:21:19 INFO - trying https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:21:19 INFO - Downloading https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:21:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:21:20 INFO - Downloaded 1361 bytes. 09:21:20 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:21:20 INFO - Using the following test package requirements: 09:21:20 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:21:20 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:21:20 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:21:20 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:20 INFO - u'jsshell-linux-x86_64.zip'], 09:21:20 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:21:20 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:21:20 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:21:20 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:21:20 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:21:20 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:20 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:21:20 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:21:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:21:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:21:20 INFO - Fetch https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:21:21 INFO - Http code: 200 09:21:21 INFO - Content-Encoding: None 09:21:21 INFO - Content-Type: application/zip 09:21:21 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 09:21:21 INFO - x-amz-cf-id: _jCvqhgJEKqF7WQ5yYw6XUsayIQKJJEYAuSYHAHske1clyAR-uNs0Q== 09:21:21 INFO - x-amz-version-id: bB.JJcmtlKp3tBq7A8vjucySz5EMwq6u 09:21:21 INFO - x-cache: Hit from cloudfront 09:21:21 INFO - Expected file size: 20418097 09:21:21 INFO - Obtained file size: 20418097 09:21:25 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:21:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:21:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:21:25 INFO - Fetch https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:21:25 INFO - Http code: 200 09:21:25 INFO - Content-Encoding: None 09:21:25 INFO - Content-Type: application/zip 09:21:25 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 09:21:25 INFO - x-amz-cf-id: uJADzyN_hLN6U7MOBy4pyb9Cd-I3Sti80rhBG9X7kzrtHyYqmex7yg== 09:21:25 INFO - x-amz-version-id: bB.JJcmtlKp3tBq7A8vjucySz5EMwq6u 09:21:25 INFO - x-cache: Hit from cloudfront 09:21:26 INFO - Expected file size: 20418097 09:21:26 INFO - Obtained file size: 20418097 09:21:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:21:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:21:30 INFO - Fetch https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:21:31 INFO - Http code: 200 09:21:31 INFO - Content-Encoding: None 09:21:31 INFO - Content-Type: application/zip 09:21:31 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 09:21:31 INFO - x-amz-cf-id: Bh6zW3wScejhnN5niVZ5acrN4ej0VJjA5tWbNskPMwUoqF_ai0pyWA== 09:21:31 INFO - x-amz-version-id: jHaIqFwmCkgHmft5HgwOgWGi2pyxm4oW 09:21:31 INFO - x-cache: Hit from cloudfront 09:21:31 INFO - Expected file size: 14414067 09:21:31 INFO - Obtained file size: 14414067 09:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:31 INFO - trying https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:21:31 INFO - Downloading https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:21:32 INFO - Downloaded 55744002 bytes. 09:21:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:21:32 INFO - mkdir: /builds/slave/test/properties 09:21:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:21:32 INFO - Writing to file /builds/slave/test/properties/build_url 09:21:32 INFO - Contents: 09:21:32 INFO - build_url:https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:21:33 INFO - Running post-action listener: _resource_record_post_action 09:21:33 INFO - Running post-action listener: set_extra_try_arguments 09:21:33 INFO - [mozharness: 2016-09-29 16:21:33.578869Z] Finished download-and-extract step (success) 09:21:33 INFO - [mozharness: 2016-09-29 16:21:33.579095Z] Running populate-webroot step. 09:21:33 INFO - Running pre-action listener: _resource_record_pre_action 09:21:33 INFO - Running main action method: populate_webroot 09:21:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:21:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:21:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:21:33 INFO - '--tppagecycles', 09:21:33 INFO - '7'], 09:21:33 INFO - 'tests': ['tsvgm']}}, 09:21:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:21:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:21:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:21:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:21:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:21:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:21:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:33 INFO - 'talos_options': ['--disable-e10s'], 09:21:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:33 INFO - 'talos_options': ['--disable-e10s'], 09:21:33 INFO - 'tests': ['damp', 'tps']}, 09:21:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:33 INFO - 'tests': ['damp', 'tps']}, 09:21:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:21:33 INFO - 'tests': ['dromaeo_dom']}, 09:21:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:21:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:21:33 INFO - 'tests': ['basic_compositor_video']}, 09:21:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:21:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:21:33 INFO - 'tests': ['a11yr', 09:21:33 INFO - 'ts_paint', 09:21:33 INFO - 'tpaint', 09:21:33 INFO - 'sessionrestore', 09:21:33 INFO - 'sessionrestore_no_auto_restore', 09:21:33 INFO - 'tabpaint']}, 09:21:33 INFO - 'other-e10s': {'tests': ['a11yr', 09:21:33 INFO - 'ts_paint', 09:21:33 INFO - 'tpaint', 09:21:33 INFO - 'sessionrestore', 09:21:33 INFO - 'sessionrestore_no_auto_restore', 09:21:33 INFO - 'tabpaint']}, 09:21:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:21:33 INFO - 'ts_paint', 09:21:33 INFO - 'tpaint', 09:21:33 INFO - 'sessionrestore', 09:21:33 INFO - 'sessionrestore_no_auto_restore', 09:21:33 INFO - 'tabpaint']}, 09:21:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:21:33 INFO - 'ts_paint', 09:21:33 INFO - 'tpaint', 09:21:33 INFO - 'sessionrestore', 09:21:33 INFO - 'sessionrestore_no_auto_restore', 09:21:33 INFO - 'tabpaint']}, 09:21:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:21:33 INFO - 'tests': ['a11yr', 09:21:33 INFO - 'ts_paint', 09:21:33 INFO - 'tpaint', 09:21:33 INFO - 'sessionrestore', 09:21:33 INFO - 'sessionrestore_no_auto_restore', 09:21:33 INFO - 'tabpaint']}, 09:21:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:21:33 INFO - 'tests': ['a11yr', 09:21:33 INFO - 'ts_paint', 09:21:33 INFO - 'tpaint', 09:21:33 INFO - 'sessionrestore', 09:21:33 INFO - 'sessionrestore_no_auto_restore', 09:21:33 INFO - 'tabpaint']}, 09:21:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:21:33 INFO - 'tests': ['tsvgx', 09:21:33 INFO - 'tsvgr_opacity', 09:21:33 INFO - 'tart', 09:21:33 INFO - 'tscrollx', 09:21:33 INFO - 'cart']}, 09:21:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:21:33 INFO - 'tsvgr_opacity', 09:21:33 INFO - 'tart', 09:21:33 INFO - 'tscrollx', 09:21:33 INFO - 'cart']}, 09:21:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:33 INFO - 'talos_options': ['--disable-e10s'], 09:21:33 INFO - 'tests': ['tp5o']}, 09:21:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:33 INFO - 'tests': ['tp5o']}, 09:21:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:33 INFO - 'talos_options': ['--disable-e10s', 09:21:33 INFO - '--xperf_path', 09:21:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:33 INFO - 'tests': ['tp5n']}, 09:21:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:33 INFO - 'talos_options': ['--xperf_path', 09:21:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:33 INFO - 'tests': ['tp5n']}}, 09:21:33 INFO - 'talos.zip': {'path': '', 09:21:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:21:33 INFO - Running post-action listener: _resource_record_post_action 09:21:33 INFO - [mozharness: 2016-09-29 16:21:33.597096Z] Finished populate-webroot step (success) 09:21:33 INFO - [mozharness: 2016-09-29 16:21:33.597183Z] Running create-virtualenv step. 09:21:33 INFO - Running pre-action listener: _resource_record_pre_action 09:21:33 INFO - Running main action method: create_virtualenv 09:21:33 INFO - Creating virtualenv /builds/slave/test/build/venv 09:21:33 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 09:21:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:21:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:21:33 INFO - Using real prefix '/usr' 09:21:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:21:34 INFO - Installing distribute.............................................................................................................................................................................................done. 09:21:36 INFO - Installing pip.................done. 09:21:36 INFO - Return code: 0 09:21:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:21:36 INFO - Reading from file tmpfile_stdout 09:21:36 INFO - Output received: 09:21:36 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) 09:21:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d6597ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee2f60>, '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 0xee3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee41d0>, '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': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', '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 09:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:21:36 INFO - Using env: {'DISPLAY': ':0', 09:21:36 INFO - 'HOME': '/home/cltbld', 09:21:36 INFO - 'LANG': 'en_US.UTF-8', 09:21:36 INFO - 'LANGUAGE': 'en_US:en', 09:21:36 INFO - 'LOGNAME': 'cltbld', 09:21:36 INFO - 'MAIL': '/var/mail/cltbld', 09:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:36 INFO - 'MOZ_NO_REMOTE': '1', 09:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:36 INFO - 'NO_EM_RESTART': '1', 09:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:36 INFO - 'PWD': '/builds/slave/test', 09:21:36 INFO - 'SHELL': '/bin/bash', 09:21:36 INFO - 'SHLVL': '1', 09:21:36 INFO - 'TERM': 'linux', 09:21:36 INFO - 'TMOUT': '86400', 09:21:36 INFO - 'USER': 'cltbld', 09:21:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', 09:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:36 INFO - '_': '/tools/buildbot/bin/python'} 09:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:36 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 09:21:36 INFO - Cleaning up... 09:21:36 INFO - Return code: 0 09:21:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4d6597ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee2f60>, '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 0xee3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee41d0>, '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': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', '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 09:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:21:36 INFO - Using env: {'DISPLAY': ':0', 09:21:36 INFO - 'HOME': '/home/cltbld', 09:21:36 INFO - 'LANG': 'en_US.UTF-8', 09:21:36 INFO - 'LANGUAGE': 'en_US:en', 09:21:36 INFO - 'LOGNAME': 'cltbld', 09:21:36 INFO - 'MAIL': '/var/mail/cltbld', 09:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:36 INFO - 'MOZ_NO_REMOTE': '1', 09:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:36 INFO - 'NO_EM_RESTART': '1', 09:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:36 INFO - 'PWD': '/builds/slave/test', 09:21:36 INFO - 'SHELL': '/bin/bash', 09:21:36 INFO - 'SHLVL': '1', 09:21:36 INFO - 'TERM': 'linux', 09:21:36 INFO - 'TMOUT': '86400', 09:21:36 INFO - 'USER': 'cltbld', 09:21:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', 09:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:36 INFO - '_': '/tools/buildbot/bin/python'} 09:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:36 INFO - Downloading/unpacking psutil>=3.1.1 09:21:36 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 09:21:36 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 09:21:36 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 09:21:36 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 09:21:36 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 09:21:36 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 09:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:21:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:38 INFO - Installing collected packages: psutil 09:21:38 INFO - Running setup.py install for psutil 09:21:38 INFO - building 'psutil._psutil_linux' extension 09:21:38 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 09:21:39 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 09:21:39 INFO - building 'psutil._psutil_posix' extension 09:21:39 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 09:21:39 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 09:21:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:39 INFO - Successfully installed psutil 09:21:39 INFO - Cleaning up... 09:21:39 INFO - Return code: 0 09:21:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:21:39 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')]} 09:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:39 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')]} 09:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:39 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 0x7f4d6597ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee2f60>, '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 0xee3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee41d0>, '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': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', '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 09:21:39 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 09:21:39 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 09:21:39 INFO - Using env: {'DISPLAY': ':0', 09:21:39 INFO - 'HOME': '/home/cltbld', 09:21:39 INFO - 'LANG': 'en_US.UTF-8', 09:21:39 INFO - 'LANGUAGE': 'en_US:en', 09:21:39 INFO - 'LOGNAME': 'cltbld', 09:21:39 INFO - 'MAIL': '/var/mail/cltbld', 09:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:39 INFO - 'MOZ_NO_REMOTE': '1', 09:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:39 INFO - 'NO_EM_RESTART': '1', 09:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:39 INFO - 'PWD': '/builds/slave/test', 09:21:39 INFO - 'SHELL': '/bin/bash', 09:21:39 INFO - 'SHLVL': '1', 09:21:39 INFO - 'TERM': 'linux', 09:21:39 INFO - 'TMOUT': '86400', 09:21:39 INFO - 'USER': 'cltbld', 09:21:39 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', 09:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:39 INFO - '_': '/tools/buildbot/bin/python'} 09:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:21:41 INFO - Installing collected packages: mozsystemmonitor 09:21:41 INFO - Running setup.py install for mozsystemmonitor 09:21:41 INFO - Successfully installed mozsystemmonitor 09:21:41 INFO - Cleaning up... 09:21:41 INFO - Return code: 0 09:21:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d6597ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee2f60>, '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 0xee3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee41d0>, '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': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', '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 09:21:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:21:41 INFO - Using env: {'DISPLAY': ':0', 09:21:41 INFO - 'HOME': '/home/cltbld', 09:21:41 INFO - 'LANG': 'en_US.UTF-8', 09:21:41 INFO - 'LANGUAGE': 'en_US:en', 09:21:41 INFO - 'LOGNAME': 'cltbld', 09:21:41 INFO - 'MAIL': '/var/mail/cltbld', 09:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:41 INFO - 'MOZ_NO_REMOTE': '1', 09:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:41 INFO - 'NO_EM_RESTART': '1', 09:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:41 INFO - 'PWD': '/builds/slave/test', 09:21:41 INFO - 'SHELL': '/bin/bash', 09:21:41 INFO - 'SHLVL': '1', 09:21:41 INFO - 'TERM': 'linux', 09:21:41 INFO - 'TMOUT': '86400', 09:21:41 INFO - 'USER': 'cltbld', 09:21:41 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', 09:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:41 INFO - '_': '/tools/buildbot/bin/python'} 09:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:41 INFO - Downloading/unpacking jsonschema==2.5.1 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:21:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:21:43 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 09:21:43 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 09:21:43 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 09:21:43 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 09:21:43 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 09:21:43 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 09:21:43 INFO - Downloading functools32-3.2.3-2.tar.gz 09:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:21:44 INFO - warning: no files found matching '*.txt' 09:21:44 INFO - no previously-included directories found matching 'build' 09:21:44 INFO - no previously-included directories found matching 'dist' 09:21:44 INFO - no previously-included directories found matching '.git*' 09:21:44 INFO - Installing collected packages: jsonschema, functools32 09:21:44 INFO - Running setup.py install for functools32 09:21:44 INFO - warning: no files found matching '*.txt' 09:21:44 INFO - no previously-included directories found matching 'build' 09:21:44 INFO - no previously-included directories found matching 'dist' 09:21:44 INFO - no previously-included directories found matching '.git*' 09:21:44 INFO - Successfully installed jsonschema functools32 09:21:44 INFO - Cleaning up... 09:21:44 INFO - Return code: 0 09:21:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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', '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 0x7f4d6597ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee2f60>, '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 0xee3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee41d0>, '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': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', '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 09:21: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:21: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 functools32==3.2.3-2 09:21:44 INFO - Using env: {'DISPLAY': ':0', 09:21:44 INFO - 'HOME': '/home/cltbld', 09:21:44 INFO - 'LANG': 'en_US.UTF-8', 09:21:44 INFO - 'LANGUAGE': 'en_US:en', 09:21:44 INFO - 'LOGNAME': 'cltbld', 09:21:44 INFO - 'MAIL': '/var/mail/cltbld', 09:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:44 INFO - 'MOZ_NO_REMOTE': '1', 09:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:44 INFO - 'NO_EM_RESTART': '1', 09:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:44 INFO - 'PWD': '/builds/slave/test', 09:21:44 INFO - 'SHELL': '/bin/bash', 09:21:44 INFO - 'SHLVL': '1', 09:21:44 INFO - 'TERM': 'linux', 09:21:44 INFO - 'TMOUT': '86400', 09:21:44 INFO - 'USER': 'cltbld', 09:21:44 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', 09:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:44 INFO - '_': '/tools/buildbot/bin/python'} 09:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:21:44 INFO - Cleaning up... 09:21:44 INFO - Return code: 0 09:21:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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', '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 0x7f4d6597ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee2f60>, '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 0xee3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee41d0>, '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': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', '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 09:21: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:21: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 blobuploader==1.2.4 09:21:44 INFO - Using env: {'DISPLAY': ':0', 09:21:44 INFO - 'HOME': '/home/cltbld', 09:21:44 INFO - 'LANG': 'en_US.UTF-8', 09:21:44 INFO - 'LANGUAGE': 'en_US:en', 09:21:44 INFO - 'LOGNAME': 'cltbld', 09:21:44 INFO - 'MAIL': '/var/mail/cltbld', 09:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:44 INFO - 'MOZ_NO_REMOTE': '1', 09:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:44 INFO - 'NO_EM_RESTART': '1', 09:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:44 INFO - 'PWD': '/builds/slave/test', 09:21:44 INFO - 'SHELL': '/bin/bash', 09:21:44 INFO - 'SHLVL': '1', 09:21:44 INFO - 'TERM': 'linux', 09:21:44 INFO - 'TMOUT': '86400', 09:21:44 INFO - 'USER': 'cltbld', 09:21:44 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', 09:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:44 INFO - '_': '/tools/buildbot/bin/python'} 09:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:44 INFO - Downloading/unpacking blobuploader==1.2.4 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21:46 INFO - Downloading blobuploader-1.2.4.tar.gz 09:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:21:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:21:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:47 INFO - Downloading docopt-0.6.1.tar.gz 09:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:21:47 INFO - Installing collected packages: blobuploader, requests, docopt 09:21:47 INFO - Running setup.py install for blobuploader 09:21:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:21:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:21:47 INFO - Running setup.py install for requests 09:21:47 INFO - Running setup.py install for docopt 09:21:47 INFO - Successfully installed blobuploader requests docopt 09:21:47 INFO - Cleaning up... 09:21:47 INFO - Return code: 0 09:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:47 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')]} 09:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:47 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')]} 09:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:47 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 0x7f4d6597ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee2f60>, '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 0xee3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee41d0>, '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': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', '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 09:21:47 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 09:21:47 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 09:21:47 INFO - Using env: {'DISPLAY': ':0', 09:21:47 INFO - 'HOME': '/home/cltbld', 09:21:47 INFO - 'LANG': 'en_US.UTF-8', 09:21:47 INFO - 'LANGUAGE': 'en_US:en', 09:21:47 INFO - 'LOGNAME': 'cltbld', 09:21:47 INFO - 'MAIL': '/var/mail/cltbld', 09:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:47 INFO - 'MOZ_NO_REMOTE': '1', 09:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:47 INFO - 'NO_EM_RESTART': '1', 09:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:47 INFO - 'PWD': '/builds/slave/test', 09:21:47 INFO - 'SHELL': '/bin/bash', 09:21:47 INFO - 'SHLVL': '1', 09:21:47 INFO - 'TERM': 'linux', 09:21:47 INFO - 'TMOUT': '86400', 09:21:47 INFO - 'USER': 'cltbld', 09:21:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', 09:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:47 INFO - '_': '/tools/buildbot/bin/python'} 09:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:48 INFO - Running setup.py (path:/tmp/pip-pEtmlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:48 INFO - Running setup.py (path:/tmp/pip-AQH1Q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:48 INFO - Running setup.py (path:/tmp/pip-TEOAcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:48 INFO - Running setup.py (path:/tmp/pip-1pMa_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:48 INFO - Running setup.py (path:/tmp/pip-rIjIvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:48 INFO - Running setup.py (path:/tmp/pip-X_zMgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:48 INFO - Running setup.py (path:/tmp/pip-DFptI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:48 INFO - Running setup.py (path:/tmp/pip-iSKqLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:48 INFO - Running setup.py (path:/tmp/pip-l5o5um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:48 INFO - Running setup.py (path:/tmp/pip-q6WIlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:48 INFO - Running setup.py (path:/tmp/pip-bStwoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:48 INFO - Running setup.py (path:/tmp/pip-U0aJ0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:49 INFO - Running setup.py (path:/tmp/pip-4jy3S6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:49 INFO - Running setup.py (path:/tmp/pip-6WGOxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:49 INFO - Running setup.py (path:/tmp/pip-I0t9uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:49 INFO - Running setup.py (path:/tmp/pip-6G6tnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:49 INFO - Running setup.py (path:/tmp/pip-xe41uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:21:49 INFO - Running setup.py install for manifestparser 09:21:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:21:49 INFO - Running setup.py install for mozcrash 09:21:49 INFO - Running setup.py install for mozdebug 09:21:49 INFO - Running setup.py install for mozdevice 09:21:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:21:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:21:49 INFO - Running setup.py install for mozfile 09:21:49 INFO - Running setup.py install for mozhttpd 09:21:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:21:50 INFO - Running setup.py install for mozinfo 09:21:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:21:50 INFO - Running setup.py install for mozInstall 09:21:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:21:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:21:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:21:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:21:50 INFO - Running setup.py install for mozleak 09:21:50 INFO - Running setup.py install for mozlog 09:21:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:21:50 INFO - Running setup.py install for moznetwork 09:21:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:21:50 INFO - Running setup.py install for mozprocess 09:21:50 INFO - Running setup.py install for mozprofile 09:21:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:21:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:21:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:21:50 INFO - Running setup.py install for mozrunner 09:21:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:21:50 INFO - Running setup.py install for mozscreenshot 09:21:50 INFO - Running setup.py install for moztest 09:21:51 INFO - Running setup.py install for mozversion 09:21:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:21:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:21:51 INFO - Cleaning up... 09:21:51 INFO - Return code: 0 09:21:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:51 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')]} 09:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 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')]} 09:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 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 0x7f4d6597ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee2f60>, '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 0xee3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee41d0>, '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': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', '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 09:21:51 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 09:21:51 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 09:21:51 INFO - Using env: {'DISPLAY': ':0', 09:21:51 INFO - 'HOME': '/home/cltbld', 09:21:51 INFO - 'LANG': 'en_US.UTF-8', 09:21:51 INFO - 'LANGUAGE': 'en_US:en', 09:21:51 INFO - 'LOGNAME': 'cltbld', 09:21:51 INFO - 'MAIL': '/var/mail/cltbld', 09:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:51 INFO - 'MOZ_NO_REMOTE': '1', 09:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:51 INFO - 'NO_EM_RESTART': '1', 09:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:51 INFO - 'PWD': '/builds/slave/test', 09:21:51 INFO - 'SHELL': '/bin/bash', 09:21:51 INFO - 'SHLVL': '1', 09:21:51 INFO - 'TERM': 'linux', 09:21:51 INFO - 'TMOUT': '86400', 09:21:51 INFO - 'USER': 'cltbld', 09:21:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', 09:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:51 INFO - '_': '/tools/buildbot/bin/python'} 09:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:51 INFO - Running setup.py (path:/tmp/pip-D6vurt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:51 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)) 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:51 INFO - Running setup.py (path:/tmp/pip-dL__qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:51 INFO - Running setup.py (path:/tmp/pip-vMmpru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:51 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)) 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:51 INFO - Running setup.py (path:/tmp/pip-y1QCH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:51 INFO - Running setup.py (path:/tmp/pip-VREva0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:51 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)) 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:51 INFO - Running setup.py (path:/tmp/pip-W7X8Hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:51 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)) 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:51 INFO - Running setup.py (path:/tmp/pip-ko2Vhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:51 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)) 09:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:51 INFO - Running setup.py (path:/tmp/pip-4XFic0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:52 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)) 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:52 INFO - Running setup.py (path:/tmp/pip-d0WeMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:52 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)) 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:52 INFO - Running setup.py (path:/tmp/pip-cqzzZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:52 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)) 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:52 INFO - Running setup.py (path:/tmp/pip-haY2FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:52 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)) 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:52 INFO - Running setup.py (path:/tmp/pip-19DZnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:52 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)) 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:52 INFO - Running setup.py (path:/tmp/pip-MOKGjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:52 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)) 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:52 INFO - Running setup.py (path:/tmp/pip-sHqa74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:52 INFO - Running setup.py (path:/tmp/pip-kFHpYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:52 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)) 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:52 INFO - Running setup.py (path:/tmp/pip-4VU8BP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:52 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)) 09:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:52 INFO - Running setup.py (path:/tmp/pip-Axn6Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:52 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)) 09:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:21:52 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)) 09:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:21:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:54 INFO - Downloading blessings-1.6.tar.gz 09:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:21:54 INFO - Installing collected packages: blessings 09:21:54 INFO - Running setup.py install for blessings 09:21:54 INFO - Successfully installed blessings 09:21:54 INFO - Cleaning up... 09:21:54 INFO - Return code: 0 09:21:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:21:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:55 INFO - Reading from file tmpfile_stdout 09:21:55 INFO - Current package versions: 09:21:55 INFO - argparse == 1.2.1 09:21:55 INFO - blessings == 1.6 09:21:55 INFO - blobuploader == 1.2.4 09:21:55 INFO - docopt == 0.6.1 09:21:55 INFO - functools32 == 3.2.3-2 09:21:55 INFO - jsonschema == 2.5.1 09:21:55 INFO - manifestparser == 1.1 09:21:55 INFO - mozInstall == 1.12 09:21:55 INFO - mozcrash == 0.17 09:21:55 INFO - mozdebug == 0.1 09:21:55 INFO - mozdevice == 0.48 09:21:55 INFO - mozfile == 1.2 09:21:55 INFO - mozhttpd == 0.7 09:21:55 INFO - mozinfo == 0.9 09:21:55 INFO - mozleak == 0.1 09:21:55 INFO - mozlog == 3.4 09:21:55 INFO - moznetwork == 0.27 09:21:55 INFO - mozprocess == 0.23 09:21:55 INFO - mozprofile == 0.28 09:21:55 INFO - mozrunner == 6.12 09:21:55 INFO - mozscreenshot == 0.1 09:21:55 INFO - mozsystemmonitor == 0.3 09:21:55 INFO - moztest == 0.7 09:21:55 INFO - mozversion == 1.4 09:21:55 INFO - psutil == 3.1.1 09:21:55 INFO - requests == 1.2.3 09:21:55 INFO - wsgiref == 0.1.2 09:21:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:55 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')]} 09:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:55 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')]} 09:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:55 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 0x7f4d6597ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee2f60>, '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 0xee3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee41d0>, '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': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', '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 09:21:55 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 09:21:55 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 09:21:55 INFO - Using env: {'DISPLAY': ':0', 09:21:55 INFO - 'HOME': '/home/cltbld', 09:21:55 INFO - 'LANG': 'en_US.UTF-8', 09:21:55 INFO - 'LANGUAGE': 'en_US:en', 09:21:55 INFO - 'LOGNAME': 'cltbld', 09:21:55 INFO - 'MAIL': '/var/mail/cltbld', 09:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:55 INFO - 'MOZ_NO_REMOTE': '1', 09:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:55 INFO - 'NO_EM_RESTART': '1', 09:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:55 INFO - 'PWD': '/builds/slave/test', 09:21:55 INFO - 'SHELL': '/bin/bash', 09:21:55 INFO - 'SHLVL': '1', 09:21:55 INFO - 'TERM': 'linux', 09:21:55 INFO - 'TMOUT': '86400', 09:21:55 INFO - 'USER': 'cltbld', 09:21:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', 09:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:55 INFO - '_': '/tools/buildbot/bin/python'} 09:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:55 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)) 09:21:55 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)) 09:21:55 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)) 09:21:55 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)) 09:21:55 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)) 09:21:55 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)) 09:21:55 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)) 09:21:55 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)) 09:21:55 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)) 09:21:55 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)) 09:21:55 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)) 09:21:55 INFO - Cleaning up... 09:21:55 INFO - Return code: 0 09:21:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:21:55 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')]} 09:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:55 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')]} 09:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:55 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 0x7f4d6597ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee2f60>, '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 0xee3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee41d0>, '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': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', '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 09:21:55 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 09:21:55 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 09:21:55 INFO - Using env: {'DISPLAY': ':0', 09:21:55 INFO - 'HOME': '/home/cltbld', 09:21:55 INFO - 'LANG': 'en_US.UTF-8', 09:21:55 INFO - 'LANGUAGE': 'en_US:en', 09:21:55 INFO - 'LOGNAME': 'cltbld', 09:21:55 INFO - 'MAIL': '/var/mail/cltbld', 09:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:55 INFO - 'MOZ_NO_REMOTE': '1', 09:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:55 INFO - 'NO_EM_RESTART': '1', 09:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:55 INFO - 'PWD': '/builds/slave/test', 09:21:55 INFO - 'SHELL': '/bin/bash', 09:21:55 INFO - 'SHLVL': '1', 09:21:55 INFO - 'TERM': 'linux', 09:21:55 INFO - 'TMOUT': '86400', 09:21:55 INFO - 'USER': 'cltbld', 09:21:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', 09:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:55 INFO - '_': '/tools/buildbot/bin/python'} 09:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:21:55 INFO - Cleaning up... 09:21:55 INFO - Return code: 0 09:21:55 INFO - Running post-action listener: _resource_record_post_action 09:21:55 INFO - Running post-action listener: _start_resource_monitoring 09:21:55 INFO - Starting resource monitoring. 09:21:55 INFO - [mozharness: 2016-09-29 16:21:55.517083Z] Finished create-virtualenv step (success) 09:21:55 INFO - [mozharness: 2016-09-29 16:21:55.517591Z] Running install step. 09:21:55 INFO - Running pre-action listener: _resource_record_pre_action 09:21:55 INFO - Running main action method: install 09:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:55 INFO - Reading from file tmpfile_stdout 09:21:55 INFO - Detecting whether we're running mozinstall >=1.0... 09:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:21:55 INFO - Reading from file tmpfile_stdout 09:21:55 INFO - Output received: 09:21:55 INFO - Usage: mozinstall [options] installer 09:21:55 INFO - Options: 09:21:55 INFO - -h, --help show this help message and exit 09:21:55 INFO - -d DEST, --destination=DEST 09:21:55 INFO - Directory to install application into. [default: 09:21:55 INFO - "/builds/slave/test"] 09:21:55 INFO - --app=APP Application being installed. [default: firefox] 09:21:55 INFO - mkdir: /builds/slave/test/build/application 09:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:22:12 INFO - Reading from file tmpfile_stdout 09:22:12 INFO - Output received: 09:22:12 INFO - /builds/slave/test/build/application/firefox/firefox 09:22:12 INFO - Running post-action listener: _resource_record_post_action 09:22:12 INFO - [mozharness: 2016-09-29 16:22:12.606958Z] Finished install step (success) 09:22:12 INFO - [mozharness: 2016-09-29 16:22:12.607204Z] Running run-tests step. 09:22:12 INFO - Running pre-action listener: _resource_record_pre_action 09:22:12 INFO - Running main action method: run_tests 09:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:22:12 INFO - Python 2.7.3 09:22:12 INFO - Return code: 0 09:22:12 INFO - grabbing minidump binary from tooltool 09:22:12 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')]} 09:22:12 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 0xee2f60>, '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 0xee3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:22:12 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 09:22:12 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 09:22:12 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 09:22:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:22:12 INFO - Return code: 0 09:22:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:22:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:22:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:22:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:22:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 09:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 09:22:12 INFO - Using env: {'DISPLAY': ':0', 09:22:12 INFO - 'HOME': '/home/cltbld', 09:22:12 INFO - 'LANG': 'en_US.UTF-8', 09:22:12 INFO - 'LANGUAGE': 'en_US:en', 09:22:12 INFO - 'LOGNAME': 'cltbld', 09:22:12 INFO - 'MAIL': '/var/mail/cltbld', 09:22:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:22:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:12 INFO - 'MOZ_NO_REMOTE': '1', 09:22:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:12 INFO - 'NO_EM_RESTART': '1', 09:22:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:12 INFO - 'PWD': '/builds/slave/test', 09:22:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:22:12 INFO - 'SHELL': '/bin/bash', 09:22:12 INFO - 'SHLVL': '1', 09:22:12 INFO - 'TERM': 'linux', 09:22:12 INFO - 'TMOUT': '86400', 09:22:12 INFO - 'USER': 'cltbld', 09:22:12 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462', 09:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:12 INFO - '_': '/tools/buildbot/bin/python'} 09:22:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 09:22:12 INFO - mozversion application_buildid: 20160929090019 09:22:12 INFO - mozversion application_changeset: f21ffbf119bd6d7084309123be42f97743f1f7e5 09:22:12 INFO - mozversion application_display_name: Nightly 09:22:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:22:12 INFO - mozversion application_name: Firefox 09:22:12 INFO - mozversion application_remotingname: firefox 09:22:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:22:12 INFO - mozversion application_vendor: Mozilla 09:22:12 INFO - mozversion application_version: 52.0a1 09:22:12 INFO - mozversion platform_buildid: 20160929090019 09:22:12 INFO - mozversion platform_changeset: f21ffbf119bd6d7084309123be42f97743f1f7e5 09:22:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:22:12 INFO - mozversion platform_version: 52.0a1 09:22:12 INFO - using testdate: 1475166132 09:22:12 INFO - actual date: 1475166132 09:22:12 INFO - starting webserver on 'localhost:51667' 09:22:12 INFO - SUITE-START | Running 2 tests 09:22:12 INFO - TEST-START | dromaeo_css 09:22:12 INFO - operating with platform_type : linux_ 09:22:12 INFO - Initialising browser for dromaeo_css test... 09:22:12 INFO - TEST-INFO | started process 31388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjNWb03/profile http://localhost:51667/getInfo.html) 09:22:17 INFO - PROCESS | 31388 | __metrics Screen width/height:1600/1200 09:22:17 INFO - PROCESS | 31388 | colorDepth:24 09:22:17 INFO - PROCESS | 31388 | Browser inner width/height: 1024/697 09:22:17 INFO - PROCESS | 31388 | __metrics 09:22:18 INFO - PROCESS | 31388 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:22:18 INFO - PROCESS | 31388 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:22:18 INFO - PROCESS | 31388 | console.error: PushService: 09:22:18 INFO - PROCESS | 31388 | stateChangeProcessEnqueue: Error transitioning state 09:22:18 INFO - PROCESS | 31388 | UnknownError 09:22:19 INFO - TEST-INFO | 31388: exit 0 09:22:19 INFO - Browser initialized. 09:22:19 INFO - Running cycle 1/1 for dromaeo_css test... 09:22:19 INFO - TEST-INFO | started process 31470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjNWb03/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:22:31 INFO - PROCESS | 31470 | RSS: Main: 174784512 09:22:31 INFO - PROCESS | 31470 | 09:23:22 INFO - PROCESS | 31470 | 1475166202994 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] 09:25:36 INFO - PROCESS | 31470 | Cycle 1(1): loaded http://localhost:51667/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51667/tests/dromaeo/cssquery-ext.html) 09:25:37 INFO - PROCESS | 31470 | RSS: Main: 267984896 09:25:37 INFO - PROCESS | 31470 | 09:28:40 INFO - PROCESS | 31470 | Cycle 1(1): loaded http://localhost:51667/tests/dromaeo/cssquery-ext.html (next: http://localhost:51667/tests/dromaeo/cssquery-jquery.html) 09:28:40 INFO - PROCESS | 31470 | RSS: Main: 273887232 09:28:40 INFO - PROCESS | 31470 | 09:31:42 INFO - PROCESS | 31470 | Cycle 1(1): loaded http://localhost:51667/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51667/tests/dromaeo/cssquery-mootools.html) 09:31:43 INFO - PROCESS | 31470 | RSS: Main: 218030080 09:31:43 INFO - PROCESS | 31470 | 09:34:45 INFO - PROCESS | 31470 | Cycle 1(1): loaded http://localhost:51667/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51667/tests/dromaeo/cssquery-prototype.html) 09:34:46 INFO - PROCESS | 31470 | RSS: Main: 245043200 09:34:46 INFO - PROCESS | 31470 | 09:37:49 INFO - PROCESS | 31470 | Cycle 1(1): loaded http://localhost:51667/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51667/tests/dromaeo/cssquery-yui.html) 09:37:50 INFO - PROCESS | 31470 | RSS: Main: 218296320 09:37:50 INFO - PROCESS | 31470 | 09:40:53 INFO - PROCESS | 31470 | Cycle 1(1): loaded http://localhost:51667/tests/dromaeo/cssquery-yui.html (next: http://localhost:51667/tests/dromaeo/cssquery-dojo.html) 09:40:53 INFO - PROCESS | 31470 | RSS: Main: 294559744 09:40:53 INFO - PROCESS | 31470 | 09:40:53 INFO - PROCESS | 31470 | __start_tp_report 09:40:53 INFO - PROCESS | 31470 | _x_x_mozilla_page_load 09:40:53 INFO - PROCESS | 31470 | _x_x_mozilla_page_load_details 09:40:53 INFO - PROCESS | 31470 | |i|pagename|runs| 09:40:53 INFO - PROCESS | 31470 | |0;dojo.html;2554.9872250638746;2584.9870750646246;2615.058578911592;2621.4232868768877;2632.881520331586;4604.148232576976;4650.1629706652875;4663.65022623303;4700.0599880024;4709.058188362328;4679.812807487705;4687.648426368019;4689.671722979393;4698.741569213692;4705.929411058837;4312.05134870328;4341.696081274312;4426.955730442686;4431.158079964796;4442.400275962752;4290.785460726951;4385.671074669397;4390.078083602447;4394.384786129928;4405.933910991338;4359.476862776455;4391.297392417214;4402.845900393487;4404.977975110136;4435.711678740888;4184.8744537663915;4217.7891105444605;4341.218580655481;4388.363687265344;4390.363397307405;4235.8729238122905;4240.957590424118;4244.681648876316;4247.787610619487;4256.44666193396;4567.474740404863;4575.062112267011;4632.606228470584;4651.790669419885;4659.836905708318;4954.826581069681;4981.178105612569;5000.774965126578;5003.274525193863;5059.3169922060415;4883.340748998875;4924.926126108111;4974;5014.648974571782;5023.171176755831;4638.605718513897;4664.13713463007;4664.323673067386;4667.6265898728025;4724.645651576146;5120.385553733501;5123.154679477844;5125.897482050338;5130.846074617767;5199.740012999335;4829.6860704054125;4861.562459378673;4889.9022019560125;4912.263160525878;4916.188828843201;5013.623978201649;5014.0974624567925;5014.548690617862;5016.523430274118;5065.822696205615;4979.576735977483;4980.850574482772;4983.975080124576;5030.346055012825;5044.218146187347;4869.63477739171;4870.0746858096845;4908.754562271872;4911.607071434277;4985.052839960396;3945.2504024235304;3946.427767973628;3994.840206391712;4005.8597949072227;4005.899852503711;3462.844172012215;3469.65303469651;3484.878029269014;3532.8233588320995;3533.452314891196;4185.183889141649;4223.345381465878;4337.479502459725;4350.2387082260475;4396.406485124531;5038.672486288379;5063.822766203165;5073.847784566469;5077.162268225775;5146.665466744649;4390.1000294940095;4401.6698747594055;4403.317485789644;4403.911921761547;4454.665900057508;4463.732176069446;4604.993655519719;4621.6764826462495;4621.861344159681;4675.064987002613;4648.2098043332035;4773.952260477351;4783.928241076317;4787.664863459664;4788.401449818773;5065.645404821775;5077.822276220462;5078.263651770547;5078.289039534394;5081;4769.332293478847;4791.089692958327;4829.9517004830905;4829.975850120727;4904.754762261944;5024.346834911438;5032.245163225399;5041.2438134280155;5042.949570504248;5103.92344114846;4869.366982292421;5076.289319495199;5115.462876397924;5126.154184559506;5126.436092029949;4802.471728109975;4831.73425461603;4862.31927530139;4876.804927802848;4956.752162391938;4840.2255639097575;4893.437254715611;4896;4899.191633380595;4958.355413796327;4659.138059459011;4822.228443449031;4827.903441931071;4836.733979631154;4894.657373983787;4792.712437253636;4877.829275975324;4911.557959783637;4937.777799998937;4998.725070121178;4822.107910036514;4836.298736683231;4837.733924634038;4838.564529192389;4888.560029597354 09:40:53 INFO - PROCESS | 31470 | |1;ext.html;531.8271561742433;557.4759725857692;561.4806304168645;565.9745311460983;581.9650820950741;27706.307342316428;28283.858580707092;30984.69015309849;37550.62449375505;38694.419583706265;39209.80395098028;39762.60237397625;39811.402828957514;39822.60177398225;39839.20321593566;7597.810054748647;7741.806454838617;7752.612369381536;7753.069631644183;7757.10793258774;7568.167501574822;7649.617519124049;7658.655360508763;7662.1954694756805;7666.080070391561;7678.769636910902;7705.768826935201;7716.459847810655;7720.575368354738;7726.8454630907345;7630.694772209105;7650.196729343423;7682.347000504964;7695.692172313156;7702.961485192566;7641.044869391326;7690.077190737147;7697.307242348215;7705.922940770577;7710;36620;36946;37036;37089;37100.25799484022;3036.316828713544;3083.830389328586;3190.3140824722796;3345.9665403346144;3370.275390790992;27703.722962770516;28155.859220703765;28348.149555513366;28380.432391352264;28473.57289640657;3169.4611915974338;3210.1011716719354;3260.559824423696;3281.8851340202978;3338.065341704327;222338;224302;225069;225109.99999999837;225362;30170.547441788392;49322;49807.501924981014;49869.25196122061;49908.750456247486;31031.224219394244;33025.174370640925;33025.83487082597;33026.834865826;33053.17367065795;12316.384180790925;12423.068269879795;12435.689107772198;12440.253584784941;12445.688857778447;10037.297389182833;10085.596576137019;10121.949390253001;10130.746731331628;10132.848007279898;7636.31273185416;7659;7718.382529397635;7725.961370193113;7735.265149810759;3000.159955212544;3005.557332480422;3055.358374741329;3089.428455735696;3095.6440009399207;855.9486430814171;868.0408148995269;923.4136323434667;926.4302453990747;947.9952600237093;26762.866185669336;27592.758325875384;27715.86142069317;27872.581911271347;28003.15990520247;907.2379201470796;916.922061624756;951.2342564235719;958.8561715742555;964.7298756348234;13848;14801.777973330409;14848.925755371154;15031.849681503045;15108.622284442978;363847;366301;367757;368415;368606;47509.28736068962;48008;48019.35651582749;48107.75946120247;48160.27759583609;1054.5570860238718;1087.9728006799894;1129.170060005895;1141.8287256911365;1170.0931777872217;25407.6188857171;28466.82783766649;28790.424191515634;28832.855835720686;29381.41237175287;40353.1929361417;40752.388714168716;40870.386944196456;40899.1820163601;40962;281843;283445;283711;283826;284137;21668.34994950154;22226.777732222472;31878.52182217222;38455;38888.80555597317;37551.24897502089;41221;41258.587414125475;41674.37488437615;42624.14751705011;35450.29099418049;35679.82160089183;36022.09944751297;36107.81946090253;36126.819365904055;35227.29545409129;36049;36213.456798148574;36244.63755362518;36251;35449.291014179056;35945.92162235137;35958.8202058988;36107.45838812472;36764;31090.378192436478;32378.838105809322;32386.676133238365;33355.33289334151;33929.83035084809;25104.874475627505;25266;25524;25557.74442255628;25978.87010565011 09:40:53 INFO - PROCESS | 31470 | |2;jquery.html;343.91402149462635;347.7305088556369;348.7053439843333;351.84694657823843;371.47992810065904;12399.876001239985;15079.773803392944;15226.77159842602;15706.21468926552;16823.15884205791;14987.400503979856;15332.15673137977;15555.455559055436;15634.765478517804;15837.84162158378;3679.319325924699;4576.405067341241;4729.432468103815;4729.810807567693;5242.659227150242;5119;5177.30106435632;5179.896402071956;5181.9740901295445;5203.219517072432;4964.528369804881;5090.669106508084;5186.948130518685;5190.11767999441;5191.377034755835;5063.31645227895;5100.923486147711;5104.770285337168;5105.157648987913;5106.08090543702;4455.4207952966235;4618.122556714214;4622.237330840408;4623.052274283764;4649.697769644996;19664.60670786576;20261.594768104704;20475.5904881903;20496.5900681987;20641.8967905161;1758.2966813274793;1839.6228773101616;1840.3282801777389;1844.9077546122774;1977.74289342386;8679.43583667066;9084.137006984325;9191.770205744842;11858.703532411673;13198.472061117543;1672.3645014894262;1708.854747346477;1723.7069698151345;1759.13802236903;1784.357631252748;63403.682981584796;64746;66050.66974665145;66837.66581167062;69173.93822008328;9160.908390916138;9357.20463760588;9420;9424.528773561295;9624.326297159132;12681.590497805388;12685.746285074247;12689.428975696115;12700.936495317465;12711.809322860165;6672.966635166793;6721.092652491949;6755.1556055493065;6786.864262714718;6832.931670683329;6178.907316390258;6194.287656919512;6314.968425157845;6357.078223657636;6384.84037899047;3900.8439662413753;3964.623360780721;3969.4045893115685;4028.3554631258858;4031.2139132869397;1589.6184915620167;1643.556239815243;1671.6405972715925;1702.7701260329945;1731.5930756272267;705.5660768627359;841.2050612171562;875.3041332140963;890.8351954888367;913.164454524103;16225;16921.238544265536;17557.473275801745;17810.5547361317;17949.7307540387;792.8295416485483;852.3309202276183;863.9956800215958;880.6125304865839;927.2813569483569;9391.906080939103;9874.40753554789;9920.156786673213;9947.20422366209;10006.19950403966;369908;374168;374304;374971;379239;45657;45857.312140317925;49367;75941.6202918993;79415.20584794079;850.6852464588142;870.1950695606539;877.5129802959419;877.5480627476854;887.2414085956543;14958.551243462714;15198.924005379902;15461.922690386476;15841.52475425739;16099.517014489584;31893.362132756753;36312.273754524234;36719.63280367269;37526.62473375232;37564.436533452565;45512;47098.29352559783;48218.75890620524;50209.74895125501;50285;7422.851542969219;7560.395168386626;7602.50583712057;7659.387249019954;7665.578393188428;10814.783704325711;11195.664130076111;11410.201285909907;11832.112591555495;12327.876721233031;10522.736931576772;10648.520816563117;10730.248882578144;10767.300125491818;10917.781644367227;7307.488475806643;8853.867191991996;10219.437930913871;10408.427536485566;10703.839442408525;10214.131798796889;10601.151907847508;10648.361098334124;11132.666020019413;11140.554377825121;7384.704611815468;7504.474686771873;7539.434542409232;7609.467337286558;7819.765407037798;9920.652777152765;10493;10543.367397956146;10738.624148154777;10774.515146818569 09:40:53 INFO - PROCESS | 31470 | |3;mootools.html;1341.4500054977455;1378.8207533020707;1434.3832152174562;1653.6857996980566;1681.6048228666268;6611.6363600002105;6936.895946560806;7192.604406757633;7754.030746156731;7774.455788094836;7146.106736657918;7456.96271518643;7479.252074792518;7678.462507624468;7692.115406728228;2119.544297975935;2149.7420309562795;2152.9665760434923;2154.806067453929;2176.662617294314;1799.190364336054;1865.449692340756;2041.2345370486069;2101.8949052547387;2129.361191642509;2091.884946327951;2135.284679632325;2136.3590922723197;2140.8715477071346;2141.132841199309;2048.365006847882;2086.634838903186;2095.9790402096014;2100.6428907085833;2101.63221436248;2089.8119169274837;2090.310197634792;2107.2729908181655;2108.98945505273;2111.820495257905;7540.660670269851;7601.049868766404;7634.6182690865235;7635.236476352376;7645.655945482411;4273.401723758676;4470.173017991682;4521.59305662492;4530;4541.591256786905;2700.6894207166233;2782.373965857686;2788.986055069732;2793.0782841662203;2822.5342818434933;901.1966220047133;902.3908861518514;917.9403338782957;927.3045216087934;932.2355668351954;10187.490625468698;10190.745231369276;10194.286399951932;10219.642312519101;10244.129249013842;3811.676007539335;3960.32674445345;4146.792660366969;4170.603792639695;4183.247015537172;8915.197632213132;8919.643214271357;8932.776680583038;8939.150780675825;8942.552872356357;4614.8384806532285;4615.399998000238;4629.722216667011;4635.1656701794;4637.698549594265;4109.753414795122;4179.435776170239;4200.306949353384;4204.894877628084;4205.474315710536;3519.9120021999656;3551.3430015447225;3656.926861462809;3659.835307411173;3667.743257971916;1071.8285074388216;1118.4743170709917;1178.7288923547633;1184.8755880632582;1226.2709579492873;655.2497390487865;742.5470463017555;811.4522697179381;812.4800127918137;820.8235229425702;4938.777755001033;5077.162268225775;5220.660657057279;5253.474652534793;5256.316678831728;793.1156760212322;804.7325462396749;825.3232349473374;826.4710585225461;869.6434461870602;3295.703386695209;3331.3670402623907;3335.2495688470385;3340.9498857517156;3483.7038851697384;8946.37375383717;9356.719298421058;9360.531973401303;9378.43729376226;9384.483853388128;9146.771330716652;9228.8615670765;9274.721758347261;9309.953450232706;9310.487923164292;7086.2205157432645;7172.354488096201;7186.496945213889;7189.820254493679;7197.9640101800205;4770.403699537558;4796.328514008112;4808.927866082082;4882.92675609859;5078.060558796635;8164.224398682116;8509.574521274035;8522.27560657351;8691.130886911258;8726.476411415335;8497.405181637227;8799.780005499657;8852.24755895756;8858.468491890508;8904.688335908471;6610.206775187008;6696.7656132035145;6753.3246675332075;6757.020232066421;6758.560693554903;7307.159676637255;7405.481616286808;7447.776566703008;7461.962690186731;7490.737824176128;5233.345831771028;6465.191851018622;6468.126802881551;6667.266600674019;6672.866542669022;6426.775062872777;6434.64609446485;6436.324185960407;6469.094326794158;6550.868982620225;6093.878122437615;6201.503879689524;6202.782902598387;6205.410486004003;6216.44052035319;4198.538160802248;4204.810783514688;4208.32666773327;4289.742615443083;4305.31115021595;4174.749515029108;4188.643965262865;4355.324924636687;4360.542143074931;4412.602865742098 09:40:53 INFO - PROCESS | 31470 | |4;prototype.html;286.2271865961902;287.9841608711521;294.586106520339;301.25890309837797;302.1479428013003;4595.540445955403;4744.062428184607;4759.381280433543;4827.78274977626;4853.640980525454;4561.22459181939;4685.3206285088645;4700.6474514411475;4732.668713190078;4775.785089670964;3787.3182827091114;3788.5264341957322;3800.20195758891;3806.257779732953;3812.370958791796;3549.4498352755363;3667.7249206309634;3790.5216965383524;3796.8799204234815;3801.8289176986964;3699.18617904062;3753.7184711146638;3768.5316117942793;3770.095177157476;3773.5471743390694;3752.587215406303;3761.2665530221616;3761.8307176177;3762.360398732222;3766.6045065268163;3332.100332910125;3332.5334453176574;3337.215754297738;3339.382214290364;3340.3987282289177;4500.459944806644;4586.4266966629175;4627.953720462786;4665.88335291617;4683.859484215445;4290.163418133465;4297.011687311936;4307.483102027777;4307.633851122627;4308.547602501755;4992.276119962585;4994.550490455877;4998.7250701211415;5010.644996851474;5015.673981191248;3345.799252044885;3533.522974398449;3656.835442405098;3657.0674478007936;3659.249853779969;5140.614453915971;5153.742312884341;5160.303359046556;5173.379194496647;5180.818671346522;3579.498870158128;3580.1407662160896;3580.606133325332;3583.623719509414;3591.2278860044694;3634.6547078027547;3653.2510835278704;3669.1654172913545;3670.4127339625534;3676.8161591920298;3967.8412863485137;4139.254934111888;4172.7913604320265;4177.749335039907;4220.388043733641;4957.231629097496;4962.280469331927;4976.004799040206;4979.6265280104135;4987.700737955734;1163.8777928317575;1197.700574856286;1218.5186851193728;1251.949922003128;1267.2575209087504;850.2475309351269;851.9148085191431;870.0944930601961;870.8214815962713;872.5942436766934;4395.604395604411;4406.757628330409;4418.5802348776815;4421.1483593082285;4424.424824772824;5070.847874563769;5082.331775817725;5087.592992560661;5097.974510127426;5109.259157422153;4409.669274804339;4409.889752756207;4426.313921342197;4438.533953934855;4442.489113751895;2298.2071185440996;2374.25211058516;2383.5947888858936;2395.9880200598886;2415.7342692303832;4273.768968721006;4296.935545966813;4307.461567304087;4313.2746901239125;4374.993751437188;4527.551183621275;4548.431446069175;4615.376924115269;4657.301404789241;4667.533246675305;4142.751434913915;4295.871123866289;4305.5048669402795;4311.340134048414;4327.2643650579475;4476.9328460072475;4498.505164431976;4502.3921770560555;4518.209313370213;4531.84138555149;4417.602415782595;4443.55564443566;4456.264716321771;4465.9058530660195;4490.730556166641;4086.7956602170366;4307.203167414038;4318.632916202158;4321.265384884514;4340.848070317524;3262.487884329101;3269.150020994511;3274.312394397203;3287.375398674244;3324.6010478742705;4542.296638760465;4547.545245475559;4548.272276435754;4556.772161391984;4557;4787.712737235777;4883.36516252899;4911.803527858846;4935.001324463598;4943.505649435027;4471.418715566955;4994.400671919393;5024.29659847629;5024.648274620741;5052.520010598987;4920.384951881015;4930.975345123252;4953.851384458472;4966.652334336562;4991.5258050485145;4860.538248866352;5021.5229553192385;5038.294638750651;5038.697678139323;5043.319151914445;4914.9036107252205;4923.187674033744;4938.654294199371;4939.160342741814;4940.530649588283 09:40:53 INFO - PROCESS | 31470 | |5;yui.html;640.497209690393;641.4996302883752;672.2403683837263;718.188447054828;736.3483317264223;13062.542811001616;14141.575752727435;14146.292685365715;14149.221792801392;14180.22008789516;13187.538436154713;13239.139455935381;13241.801372979413;13249.735005299888;13289.667758306046;611.150500803883;628.5788521690456;742.3467348733121;754.4605606991;774.4307933668749;775.8409526047146;777.9377649788032;778.1246098139593;778.3656320099129;778.4900889917113;813.556611646654;814.6415577146066;815.0504662068682;815.2581151152452;816.2123550773503;638.7700427845972;653.7058323754329;799.3605115907309;807.9676812927476;824.0976131136456;585.5900869391401;591.2018774654225;591.8786648736999;592.1266132454595;592.1266132454638;13169.53906613264;13171.736565268737;13190.604281871463;13219.735605287937;13229.536966206233;11656.242344247597;11938.343391113485;11972.58095966637;12271.325077120755;12613.243205407705;9674.613015479372;9722.513874306256;9743.123118919331;9754.561044753003;9847.16299114576;3365.3269346130874;3385.64450732672;3399.286149908522;3404.285100128976;3406.931861362784;61603.38396615977;61656.69171654158;62423;62661;63197.68401157965;10502.842457363146;10687.572497100184;10692.144628429707;10843;11198.272112312836;19926.20295188176;20000.899995500222;20003.59992800136;20112.09495572703;20204.69692954607;6678.165229346332;6720.495962802809;6810.284920083419;6815.965920170466;6819.454443644497;3703.8518459261327;3729.9254014920093;3768.1710023795267;3822.445745366906;3850.383938569815;2733.5352989991748;2849.7292757188447;2850.6579210494874;2850.857457127135;2854.986479799683;510.0869443695817;515.1242887091959;516.0813751522221;524.1011664994553;524.2032111191045;489.5471688687949;538.3780986595306;596.6181643747918;611.7430679114782;619.4208415131866;8116.837663246702;8231.42380033392;8476.618552165168;8479.576021199038;8673.566321684017;586.7975548435783;597.7818096394784;603.5865432178883;620.4478014567039;623.2583225961092;3558.7153027757718;3925.9907711025644;3994.6404823566018;4072.2669919414197;4078.572499625167;57495.42504574984;58594.4140558589;88636.5568172155;95322.52338738262;100763.49618252009;48460.5153948456;77417;78241.60879195681;80820.59589702131;82567.587162065;57182.7140864293;57613.423865761644;58729;66928.31894245863;71488.64255678689;8076.4750291230885;8474.110218427222;8577.871331930151;8627.309815214643;8759;40357.798211008754;41444.71105778796;42303.36544951767;42536.5746342545;42974.42153470802;36965;61425.38574614197;61462.692686536284;61707;63328.366716332246;10316.690499285034;10429.95700429951;10501.26491145643;10579.841302380317;10639.361638301727;12457.813132803196;12638.873611264138;13147.474101035852;13198.340082996005;13279.66800829987;11673.708157296136;12116.333601651993;12123.654309195499;12150.392480376122;12654.177478463871;11626.88373116258;11870.52517899309;12034.097442691658;12680;12683.492660293485;11576;11859.940700296444;12149.696257593278;12740.108192426442;12853.293068881301;9486.430814151174;9622.556249099976;9631.181349585364;9794.461304628314;10398.532066056894;9475.815523059617;10067.597296108073;10149.543270552991;10159.315864269805;10318.896811031793 09:40:53 INFO - PROCESS | 31470 | __end_tp_report 09:40:53 INFO - PROCESS | 31470 | __start_cc_report 09:40:53 INFO - PROCESS | 31470 | _x_x_mozilla_cycle_collect,1079 09:40:53 INFO - PROCESS | 31470 | __end_cc_report 09:40:53 INFO - PROCESS | 31470 | __startTimestamp1475167253395__endTimestamp 09:40:53 INFO - PROCESS | 31470 | 09:40:53 INFO - PROCESS | 31470 | ------- Summary: start ------- 09:40:53 INFO - PROCESS | 31470 | Number of tests: 6 09:40:53 INFO - PROCESS | 31470 | 09:40:53 INFO - PROCESS | 31470 | [#0] dojo.html Cycles:165 Average:4631.44 Median:4791.09 stddev:510.06 (10.6%) stddev-sans-first:484.92 09:40:53 INFO - PROCESS | 31470 | Values: 2555.0 2585.0 2615.1 2621.4 2632.9 4604.1 4650.2 4663.7 4700.1 4709.1 4679.8 4687.6 4689.7 4698.7 4705.9 4312.1 4341.7 4427.0 4431.2 4442.4 4290.8 4385.7 4390.1 4394.4 4405.9 4359.5 4391.3 4402.8 4405.0 4435.7 4184.9 4217.8 4341.2 4388.4 4390.4 4235.9 4241.0 4244.7 4247.8 4256.4 4567.5 4575.1 4632.6 4651.8 4659.8 4954.8 4981.2 5000.8 5003.3 5059.3 4883.3 4924.9 4974.0 5014.6 5023.2 4638.6 4664.1 4664.3 4667.6 4724.6 5120.4 5123.2 5125.9 5130.8 5199.7 4829.7 4861.6 4889.9 4912.3 4916.2 5013.6 5014.1 5014.5 5016.5 5065.8 4979.6 4980.9 4984.0 5030.3 5044.2 4869.6 4870.1 4908.8 4911.6 4985.1 3945.3 3946.4 3994.8 4005.9 4005.9 3462.8 3469.7 3484.9 3532.8 3533.5 4185.2 4223.3 4337.5 4350.2 4396.4 5038.7 5063.8 5073.8 5077.2 5146.7 4390.1 4401.7 4403.3 4403.9 4454.7 4463.7 4605.0 4621.7 4621.9 4675.1 4648.2 4774.0 4783.9 4787.7 4788.4 5065.6 5077.8 5078.3 5078.3 5081.0 4769.3 4791.1 4830.0 4830.0 4904.8 5024.3 5032.2 5041.2 5042.9 5103.9 4869.4 5076.3 5115.5 5126.2 5126.4 4802.5 4831.7 4862.3 4876.8 4956.8 4840.2 4893.4 4896.0 4899.2 4958.4 4659.1 4822.2 4827.9 4836.7 4894.7 4792.7 4877.8 4911.6 4937.8 4998.7 4822.1 4836.3 4837.7 4838.6 4888.6 09:40:53 INFO - PROCESS | 31470 | 09:40:53 INFO - PROCESS | 31470 | [#1] ext.html Cycles:180 Average:43588.30 Median:36107.64 stddev:78331.79 (216.9%) stddev-sans-first:78484.82 09:40:53 INFO - PROCESS | 31470 | Values: 531.8 557.5 561.5 566.0 582.0 27706.3 28283.9 30984.7 37550.6 38694.4 39209.8 39762.6 39811.4 39822.6 39839.2 7597.8 7741.8 7752.6 7753.1 7757.1 7568.2 7649.6 7658.7 7662.2 7666.1 7678.8 7705.8 7716.5 7720.6 7726.8 7630.7 7650.2 7682.3 7695.7 7703.0 7641.0 7690.1 7697.3 7705.9 7710.0 36620.0 36946.0 37036.0 37089.0 37100.3 3036.3 3083.8 3190.3 3346.0 3370.3 27703.7 28155.9 28348.1 28380.4 28473.6 3169.5 3210.1 3260.6 3281.9 3338.1 222338.0 224302.0 225069.0 225110.0 225362.0 30170.5 49322.0 49807.5 49869.3 49908.8 31031.2 33025.2 33025.8 33026.8 33053.2 12316.4 12423.1 12435.7 12440.3 12445.7 10037.3 10085.6 10121.9 10130.7 10132.8 7636.3 7659.0 7718.4 7726.0 7735.3 3000.2 3005.6 3055.4 3089.4 3095.6 855.9 868.0 923.4 926.4 948.0 26762.9 27592.8 27715.9 27872.6 28003.2 907.2 916.9 951.2 958.9 964.7 13848.0 14801.8 14848.9 15031.8 15108.6 363847.0 366301.0 367757.0 368415.0 368606.0 47509.3 48008.0 48019.4 48107.8 48160.3 1054.6 1088.0 1129.2 1141.8 1170.1 25407.6 28466.8 28790.4 28832.9 29381.4 40353.2 40752.4 40870.4 40899.2 40962.0 281843.0 283445.0 283711.0 283826.0 284137.0 21668.3 22226.8 31878.5 38455.0 38888.8 37551.2 41221.0 41258.6 41674.4 42624.1 35450.3 35679.8 36022.1 36107.8 36126.8 35227.3 36049.0 36213.5 36244.6 36251.0 35449.3 35945.9 35958.8 36107.5 36764.0 31090.4 32378.8 32386.7 33355.3 33929.8 25104.9 25266.0 25524.0 25557.7 25978.9 09:40:53 INFO - PROCESS | 31470 | 09:40:53 INFO - PROCESS | 31470 | [#2] jquery.html Cycles:180 Average:22998.20 Median:4243.32 stddev:61581.27 (1451.3%) stddev-sans-first:61730.53 09:40:53 INFO - PROCESS | 31470 | Values: 343.9 347.7 348.7 351.8 371.5 12399.9 15079.8 15226.8 15706.2 16823.2 14987.4 15332.2 15555.5 15634.8 15837.8 3679.3 4576.4 4729.4 4729.8 5242.7 5119.0 5177.3 5179.9 5182.0 5203.2 4964.5 5090.7 5186.9 5190.1 5191.4 5063.3 5100.9 5104.8 5105.2 5106.1 4455.4 4618.1 4622.2 4623.1 4649.7 19664.6 20261.6 20475.6 20496.6 20641.9 1758.3 1839.6 1840.3 1844.9 1977.7 8679.4 9084.1 9191.8 11858.7 13198.5 1672.4 1708.9 1723.7 1759.1 1784.4 63403.7 64746.0 66050.7 66837.7 69173.9 9160.9 9357.2 9420.0 9424.5 9624.3 12681.6 12685.7 12689.4 12700.9 12711.8 6673.0 6721.1 6755.2 6786.9 6832.9 6178.9 6194.3 6315.0 6357.1 6384.8 3900.8 3964.6 3969.4 4028.4 4031.2 1589.6 1643.6 1671.6 1702.8 1731.6 705.6 841.2 875.3 890.8 913.2 16225.0 16921.2 17557.5 17810.6 17949.7 792.8 852.3 864.0 880.6 927.3 9391.9 9874.4 9920.2 9947.2 10006.2 369908.0 374168.0 374304.0 374971.0 379239.0 45657.0 45857.3 49367.0 75941.6 79415.2 850.7 870.2 877.5 877.5 887.2 14958.6 15198.9 15461.9 15841.5 16099.5 31893.4 36312.3 36719.6 37526.6 37564.4 45512.0 47098.3 48218.8 50209.7 50285.0 7422.9 7560.4 7602.5 7659.4 7665.6 10814.8 11195.7 11410.2 11832.1 12327.9 10522.7 10648.5 10730.2 10767.3 10917.8 7307.5 8853.9 10219.4 10408.4 10703.8 10214.1 10601.2 10648.4 11132.7 11140.6 7384.7 7504.5 7539.4 7609.5 7819.8 9920.7 10493.0 10543.4 10738.6 10774.5 09:40:53 INFO - PROCESS | 31470 | 09:40:53 INFO - PROCESS | 31470 | [#3] mootools.html Cycles:180 Average:4967.78 Median:5077.61 stddev:2783.50 (54.8%) stddev-sans-first:2777.97 09:40:53 INFO - PROCESS | 31470 | Values: 1341.5 1378.8 1434.4 1653.7 1681.6 6611.6 6936.9 7192.6 7754.0 7774.5 7146.1 7457.0 7479.3 7678.5 7692.1 2119.5 2149.7 2153.0 2154.8 2176.7 1799.2 1865.4 2041.2 2101.9 2129.4 2091.9 2135.3 2136.4 2140.9 2141.1 2048.4 2086.6 2096.0 2100.6 2101.6 2089.8 2090.3 2107.3 2109.0 2111.8 7540.7 7601.0 7634.6 7635.2 7645.7 4273.4 4470.2 4521.6 4530.0 4541.6 2700.7 2782.4 2789.0 2793.1 2822.5 901.2 902.4 917.9 927.3 932.2 10187.5 10190.7 10194.3 10219.6 10244.1 3811.7 3960.3 4146.8 4170.6 4183.2 8915.2 8919.6 8932.8 8939.2 8942.6 4614.8 4615.4 4629.7 4635.2 4637.7 4109.8 4179.4 4200.3 4204.9 4205.5 3519.9 3551.3 3656.9 3659.8 3667.7 1071.8 1118.5 1178.7 1184.9 1226.3 655.2 742.5 811.5 812.5 820.8 4938.8 5077.2 5220.7 5253.5 5256.3 793.1 804.7 825.3 826.5 869.6 3295.7 3331.4 3335.2 3340.9 3483.7 8946.4 9356.7 9360.5 9378.4 9384.5 9146.8 9228.9 9274.7 9310.0 9310.5 7086.2 7172.4 7186.5 7189.8 7198.0 4770.4 4796.3 4808.9 4882.9 5078.1 8164.2 8509.6 8522.3 8691.1 8726.5 8497.4 8799.8 8852.2 8858.5 8904.7 6610.2 6696.8 6753.3 6757.0 6758.6 7307.2 7405.5 7447.8 7462.0 7490.7 5233.3 6465.2 6468.1 6667.3 6672.9 6426.8 6434.6 6436.3 6469.1 6550.9 6093.9 6201.5 6202.8 6205.4 6216.4 4198.5 4204.8 4208.3 4289.7 4305.3 4174.7 4188.6 4355.3 4360.5 4412.6 09:40:53 INFO - PROCESS | 31470 | 09:40:53 INFO - PROCESS | 31470 | [#4] prototype.html Cycles:180 Average:4012.54 Median:4419.86 stddev:1156.67 (26.2%) stddev-sans-first:1125.59 09:40:53 INFO - PROCESS | 31470 | Values: 286.2 288.0 294.6 301.3 302.1 4595.5 4744.1 4759.4 4827.8 4853.6 4561.2 4685.3 4700.6 4732.7 4775.8 3787.3 3788.5 3800.2 3806.3 3812.4 3549.4 3667.7 3790.5 3796.9 3801.8 3699.2 3753.7 3768.5 3770.1 3773.5 3752.6 3761.3 3761.8 3762.4 3766.6 3332.1 3332.5 3337.2 3339.4 3340.4 4500.5 4586.4 4628.0 4665.9 4683.9 4290.2 4297.0 4307.5 4307.6 4308.5 4992.3 4994.6 4998.7 5010.6 5015.7 3345.8 3533.5 3656.8 3657.1 3659.2 5140.6 5153.7 5160.3 5173.4 5180.8 3579.5 3580.1 3580.6 3583.6 3591.2 3634.7 3653.3 3669.2 3670.4 3676.8 3967.8 4139.3 4172.8 4177.7 4220.4 4957.2 4962.3 4976.0 4979.6 4987.7 1163.9 1197.7 1218.5 1251.9 1267.3 850.2 851.9 870.1 870.8 872.6 4395.6 4406.8 4418.6 4421.1 4424.4 5070.8 5082.3 5087.6 5098.0 5109.3 4409.7 4409.9 4426.3 4438.5 4442.5 2298.2 2374.3 2383.6 2396.0 2415.7 4273.8 4296.9 4307.5 4313.3 4375.0 4527.6 4548.4 4615.4 4657.3 4667.5 4142.8 4295.9 4305.5 4311.3 4327.3 4476.9 4498.5 4502.4 4518.2 4531.8 4417.6 4443.6 4456.3 4465.9 4490.7 4086.8 4307.2 4318.6 4321.3 4340.8 3262.5 3269.2 3274.3 3287.4 3324.6 4542.3 4547.5 4548.3 4556.8 4557.0 4787.7 4883.4 4911.8 4935.0 4943.5 4471.4 4994.4 5024.3 5024.6 5052.5 4920.4 4931.0 4953.9 4966.7 4991.5 4860.5 5021.5 5038.3 5038.7 5043.3 4914.9 4923.2 4938.7 4939.2 4940.5 09:40:53 INFO - PROCESS | 31470 | 09:40:53 INFO - PROCESS | 31470 | [#5] yui.html Cycles:180 Average:16492.27 Median:515.60 stddev:22371.74 (4338.9%) stddev-sans-first:22402.84 09:40:53 INFO - PROCESS | 31470 | Values: 640.5 641.5 672.2 718.2 736.3 13062.5 14141.6 14146.3 14149.2 14180.2 13187.5 13239.1 13241.8 13249.7 13289.7 611.2 628.6 742.3 754.5 774.4 775.8 777.9 778.1 778.4 778.5 813.6 814.6 815.1 815.3 816.2 638.8 653.7 799.4 808.0 824.1 585.6 591.2 591.9 592.1 592.1 13169.5 13171.7 13190.6 13219.7 13229.5 11656.2 11938.3 11972.6 12271.3 12613.2 9674.6 9722.5 9743.1 9754.6 9847.2 3365.3 3385.6 3399.3 3404.3 3406.9 61603.4 61656.7 62423.0 62661.0 63197.7 10502.8 10687.6 10692.1 10843.0 11198.3 19926.2 20000.9 20003.6 20112.1 20204.7 6678.2 6720.5 6810.3 6816.0 6819.5 3703.9 3729.9 3768.2 3822.4 3850.4 2733.5 2849.7 2850.7 2850.9 2855.0 510.1 515.1 516.1 524.1 524.2 489.5 538.4 596.6 611.7 619.4 8116.8 8231.4 8476.6 8479.6 8673.6 586.8 597.8 603.6 620.4 623.3 3558.7 3926.0 3994.6 4072.3 4078.6 57495.4 58594.4 88636.6 95322.5 100763.5 48460.5 77417.0 78241.6 80820.6 82567.6 57182.7 57613.4 58729.0 66928.3 71488.6 8076.5 8474.1 8577.9 8627.3 8759.0 40357.8 41444.7 42303.4 42536.6 42974.4 36965.0 61425.4 61462.7 61707.0 63328.4 10316.7 10430.0 10501.3 10579.8 10639.4 12457.8 12638.9 13147.5 13198.3 13279.7 11673.7 12116.3 12123.7 12150.4 12654.2 11626.9 11870.5 12034.1 12680.0 12683.5 11576.0 11859.9 12149.7 12740.1 12853.3 9486.4 9622.6 9631.2 9794.5 10398.5 9475.8 10067.6 10149.5 10159.3 10318.9 09:40:53 INFO - PROCESS | 31470 | -------- Summary: end -------- 09:40:53 INFO - PROCESS | 31470 | 09:40:54 INFO - TEST-INFO | 31470: exit 0 09:40:54 INFO - TEST-OK | dromaeo_css | took 1121395ms 09:40:54 INFO - TEST-START | kraken 09:40:54 INFO - operating with platform_type : linux_ 09:40:54 INFO - Initialising browser for kraken test... 09:40:54 INFO - TEST-INFO | started process 31775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0mBhlf/profile http://localhost:51667/getInfo.html) 09:40:59 INFO - PROCESS | 31775 | __metrics Screen width/height:1600/1200 09:40:59 INFO - PROCESS | 31775 | colorDepth:24 09:40:59 INFO - PROCESS | 31775 | Browser inner width/height: 1024/697 09:40:59 INFO - PROCESS | 31775 | __metrics 09:40:59 INFO - PROCESS | 31775 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:40:59 INFO - PROCESS | 31775 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:41:00 INFO - PROCESS | 31775 | console.error: PushService: 09:41:00 INFO - PROCESS | 31775 | stateChangeProcessEnqueue: Error transitioning state 09:41:00 INFO - PROCESS | 31775 | UnknownError 09:41:00 INFO - TEST-INFO | 31775: exit 0 09:41:00 INFO - Browser initialized. 09:41:00 INFO - Running cycle 1/1 for kraken test... 09:41:00 INFO - TEST-INFO | started process 31856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0mBhlf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:13 INFO - PROCESS | 31856 | RSS: Main: 174931968 09:41:13 INFO - PROCESS | 31856 | 09:41:15 INFO - PROCESS | 31856 | Cycle 1(1): loaded http://localhost:51667/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51667/tests/kraken/driver.html?testName=audio-beat-detection) 09:41:16 INFO - PROCESS | 31856 | RSS: Main: 238059520 09:41:16 INFO - PROCESS | 31856 | 09:41:19 INFO - PROCESS | 31856 | Cycle 1(1): loaded http://localhost:51667/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51667/tests/kraken/driver.html?testName=audio-dft) 09:41:20 INFO - PROCESS | 31856 | RSS: Main: 217862144 09:41:20 INFO - PROCESS | 31856 | 09:41:23 INFO - PROCESS | 31856 | Cycle 1(1): loaded http://localhost:51667/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51667/tests/kraken/driver.html?testName=audio-fft) 09:41:24 INFO - PROCESS | 31856 | RSS: Main: 300068864 09:41:24 INFO - PROCESS | 31856 | 09:41:26 INFO - PROCESS | 31856 | Cycle 1(1): loaded http://localhost:51667/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51667/tests/kraken/driver.html?testName=audio-oscillator) 09:41:26 INFO - PROCESS | 31856 | RSS: Main: 209813504 09:41:26 INFO - PROCESS | 31856 | 09:41:29 INFO - PROCESS | 31856 | Cycle 1(1): loaded http://localhost:51667/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51667/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:41:29 INFO - PROCESS | 31856 | RSS: Main: 213241856 09:41:29 INFO - PROCESS | 31856 | 09:41:32 INFO - PROCESS | 31856 | Cycle 1(1): loaded http://localhost:51667/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51667/tests/kraken/driver.html?testName=imaging-darkroom) 09:41:33 INFO - PROCESS | 31856 | RSS: Main: 250064896 09:41:33 INFO - PROCESS | 31856 | 09:41:36 INFO - PROCESS | 31856 | Cycle 1(1): loaded http://localhost:51667/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51667/tests/kraken/driver.html?testName=imaging-desaturate) 09:41:37 INFO - PROCESS | 31856 | RSS: Main: 249618432 09:41:37 INFO - PROCESS | 31856 | 09:41:40 INFO - PROCESS | 31856 | Cycle 1(1): loaded http://localhost:51667/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51667/tests/kraken/driver.html?testName=json-parse-financial) 09:41:41 INFO - PROCESS | 31856 | RSS: Main: 249262080 09:41:41 INFO - PROCESS | 31856 | 09:41:42 INFO - PROCESS | 31856 | Cycle 1(1): loaded http://localhost:51667/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51667/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:41:43 INFO - PROCESS | 31856 | RSS: Main: 211546112 09:41:43 INFO - PROCESS | 31856 | 09:41:45 INFO - PROCESS | 31856 | Cycle 1(1): loaded http://localhost:51667/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51667/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:41:45 INFO - PROCESS | 31856 | RSS: Main: 218734592 09:41:45 INFO - PROCESS | 31856 | 09:41:48 INFO - PROCESS | 31856 | Cycle 1(1): loaded http://localhost:51667/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51667/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:41:48 INFO - PROCESS | 31856 | RSS: Main: 223158272 09:41:48 INFO - PROCESS | 31856 | 09:41:51 INFO - PROCESS | 31856 | Cycle 1(1): loaded http://localhost:51667/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51667/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:41:52 INFO - PROCESS | 31856 | RSS: Main: 224636928 09:41:52 INFO - PROCESS | 31856 | 09:41:55 INFO - PROCESS | 31856 | Cycle 1(1): loaded http://localhost:51667/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51667/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:41:55 INFO - PROCESS | 31856 | RSS: Main: 222306304 09:41:55 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | Cycle 1(1): loaded http://localhost:51667/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51667/tests/kraken/driver.html?testName=ai-astar) 09:41:57 INFO - PROCESS | 31856 | RSS: Main: 273862656 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | __start_tp_report 09:41:57 INFO - PROCESS | 31856 | _x_x_mozilla_page_load 09:41:57 INFO - PROCESS | 31856 | _x_x_mozilla_page_load_details 09:41:57 INFO - PROCESS | 31856 | |i|pagename|runs| 09:41:57 INFO - PROCESS | 31856 | |0;ai-astar;112;116;115;114;115;114;113;114;113;114 09:41:57 INFO - PROCESS | 31856 | |1;audio-beat-detection;151;124;131;178;131;125;126;124;165;140 09:41:57 INFO - PROCESS | 31856 | |2;audio-dft;163;162;160;161;160;161;163;161;161;161 09:41:57 INFO - PROCESS | 31856 | |3;audio-fft;75;77;77;120;77;77;78;76;106;76 09:41:57 INFO - PROCESS | 31856 | |4;audio-oscillator;83;83;111;83;84;84;113;83;84;118 09:41:57 INFO - PROCESS | 31856 | |5;imaging-gaussian-blur;116;117;117;117;116;117;116;116;117;117 09:41:57 INFO - PROCESS | 31856 | |6;imaging-darkroom;146;146;147;145;146;146;147;146;146;146 09:41:57 INFO - PROCESS | 31856 | |7;imaging-desaturate;96;95;96;96;96;96;95;96;95;95 09:41:57 INFO - PROCESS | 31856 | |8;json-parse-financial;63;62;62;61;63;63;63;63;63;65 09:41:57 INFO - PROCESS | 31856 | |9;json-stringify-tinderbox;66;66;65;66;67;67;66;66;67;66 09:41:57 INFO - PROCESS | 31856 | |10;stanford-crypto-aes;88;82;93;92;84;84;84;83;85;83 09:41:57 INFO - PROCESS | 31856 | |11;stanford-crypto-ccm;136;150;138;141;133;140;143;132;172;140 09:41:57 INFO - PROCESS | 31856 | |12;stanford-crypto-pbkdf2;174;175;177;172;172;172;172;174;172;172 09:41:57 INFO - PROCESS | 31856 | |13;stanford-crypto-sha256-iterative;70;73;73;68;68;68;68;70;69;68 09:41:57 INFO - PROCESS | 31856 | __end_tp_report 09:41:57 INFO - PROCESS | 31856 | __start_cc_report 09:41:57 INFO - PROCESS | 31856 | _x_x_mozilla_cycle_collect,1885 09:41:57 INFO - PROCESS | 31856 | __end_cc_report 09:41:57 INFO - PROCESS | 31856 | __startTimestamp1475167317851__endTimestamp 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | ------- Summary: start ------- 09:41:57 INFO - PROCESS | 31856 | Number of tests: 14 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:1.15 (1.0%) stddev-sans-first:0.97 09:41:57 INFO - PROCESS | 31856 | Values: 112.0 116.0 115.0 114.0 115.0 114.0 113.0 114.0 113.0 114.0 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:135.50 stddev:19.10 (14.1%) stddev-sans-first:19.80 09:41:57 INFO - PROCESS | 31856 | Values: 151.0 124.0 131.0 178.0 131.0 125.0 126.0 124.0 165.0 140.0 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 09:41:57 INFO - PROCESS | 31856 | Values: 163.0 162.0 160.0 161.0 160.0 161.0 163.0 161.0 161.0 161.0 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | [#3] audio-fft Cycles:10 Average:83.90 Median:77.00 stddev:15.71 (20.4%) stddev-sans-first:16.33 09:41:57 INFO - PROCESS | 31856 | Values: 75.0 77.0 77.0 120.0 77.0 77.0 78.0 76.0 106.0 76.0 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:83.00 stddev:14.87 (17.9%) stddev-sans-first:15.36 09:41:57 INFO - PROCESS | 31856 | Values: 83.0 83.0 111.0 83.0 84.0 84.0 113.0 83.0 84.0 118.0 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:41:57 INFO - PROCESS | 31856 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 09:41:57 INFO - PROCESS | 31856 | Values: 146.0 146.0 147.0 145.0 146.0 146.0 147.0 146.0 146.0 146.0 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:41:57 INFO - PROCESS | 31856 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 09:41:57 INFO - PROCESS | 31856 | Values: 63.0 62.0 62.0 61.0 63.0 63.0 63.0 63.0 63.0 65.0 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 09:41:57 INFO - PROCESS | 31856 | Values: 66.0 66.0 65.0 66.0 67.0 67.0 66.0 66.0 67.0 66.0 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:84.50 stddev:3.88 (4.6%) stddev-sans-first:4.03 09:41:57 INFO - PROCESS | 31856 | Values: 88.0 82.0 93.0 92.0 84.0 84.0 84.0 83.0 85.0 83.0 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:140.50 stddev:11.57 (8.2%) stddev-sans-first:12.03 09:41:57 INFO - PROCESS | 31856 | Values: 136.0 150.0 138.0 141.0 133.0 140.0 143.0 132.0 172.0 140.0 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.00 stddev:1.75 (1.0%) stddev-sans-first:1.83 09:41:57 INFO - PROCESS | 31856 | Values: 174.0 175.0 177.0 172.0 172.0 172.0 172.0 174.0 172.0 172.0 09:41:57 INFO - PROCESS | 31856 | 09:41:57 INFO - PROCESS | 31856 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:2.01 (2.9%) stddev-sans-first:2.13 09:41:57 INFO - PROCESS | 31856 | Values: 70.0 73.0 73.0 68.0 68.0 68.0 68.0 70.0 69.0 68.0 09:41:57 INFO - PROCESS | 31856 | -------- Summary: end -------- 09:41:57 INFO - PROCESS | 31856 | 09:41:59 INFO - TEST-INFO | 31856: exit 0 09:41:59 INFO - TEST-OK | kraken | took 64978ms 09:41:59 INFO - SUITE-END | took 1186s 09:41:59 INFO - Completed test suite (00:19:46) 09:41:59 INFO - javascript benchmark 09:41:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2554.9872250638746, 2584.9870750646246, 2615.058578911592, 2621.4232868768877, 2632.881520331586, 4604.148232576976, 4650.1629706652875, 4663.65022623303, 4700.0599880024, 4709.058188362328, 4679.812807487705, 4687.648426368019, 4689.671722979393, 4698.741569213692, 4705.929411058837, 4312.05134870328, 4341.696081274312, 4426.955730442686, 4431.158079964796, 4442.400275962752, 4290.785460726951, 4385.671074669397, 4390.078083602447, 4394.384786129928, 4405.933910991338, 4359.476862776455, 4391.297392417214, 4402.845900393487, 4404.977975110136, 4435.711678740888, 4184.8744537663915, 4217.7891105444605, 4341.218580655481, 4388.363687265344, 4390.363397307405, 4235.8729238122905, 4240.957590424118, 4244.681648876316, 4247.787610619487, 4256.44666193396, 4567.474740404863, 4575.062112267011, 4632.606228470584, 4651.790669419885, 4659.836905708318, 4954.826581069681, 4981.178105612569, 5000.774965126578, 5003.274525193863, 5059.3169922060415, 4883.340748998875, 4924.926126108111, 4974.0, 5014.648974571782, 5023.171176755831, 4638.605718513897, 4664.13713463007, 4664.323673067386, 4667.6265898728025, 4724.645651576146, 5120.385553733501, 5123.154679477844, 5125.897482050338, 5130.846074617767, 5199.740012999335, 4829.6860704054125, 4861.562459378673, 4889.9022019560125, 4912.263160525878, 4916.188828843201, 5013.623978201649, 5014.0974624567925, 5014.548690617862, 5016.523430274118, 5065.822696205615, 4979.576735977483, 4980.850574482772, 4983.975080124576, 5030.346055012825, 5044.218146187347, 4869.63477739171, 4870.0746858096845, 4908.754562271872, 4911.607071434277, 4985.052839960396, 3945.2504024235304, 3946.427767973628, 3994.840206391712, 4005.8597949072227, 4005.899852503711, 3462.844172012215, 3469.65303469651, 3484.878029269014, 3532.8233588320995, 3533.452314891196, 4185.183889141649, 4223.345381465878, 4337.479502459725, 4350.2387082260475, 4396.406485124531, 5038.672486288379, 5063.822766203165, 5073.847784566469, 5077.162268225775, 5146.665466744649, 4390.1000294940095, 4401.6698747594055, 4403.317485789644, 4403.911921761547, 4454.665900057508, 4463.732176069446, 4604.993655519719, 4621.6764826462495, 4621.861344159681, 4675.064987002613, 4648.2098043332035, 4773.952260477351, 4783.928241076317, 4787.664863459664, 4788.401449818773, 5065.645404821775, 5077.822276220462, 5078.263651770547, 5078.289039534394, 5081.0, 4769.332293478847, 4791.089692958327, 4829.9517004830905, 4829.975850120727, 4904.754762261944, 5024.346834911438, 5032.245163225399, 5041.2438134280155, 5042.949570504248, 5103.92344114846, 4869.366982292421, 5076.289319495199, 5115.462876397924, 5126.154184559506, 5126.436092029949, 4802.471728109975, 4831.73425461603, 4862.31927530139, 4876.804927802848, 4956.752162391938, 4840.2255639097575, 4893.437254715611, 4896.0, 4899.191633380595, 4958.355413796327, 4659.138059459011, 4822.228443449031, 4827.903441931071, 4836.733979631154, 4894.657373983787, 4792.712437253636, 4877.829275975324, 4911.557959783637, 4937.777799998937, 4998.725070121178, 4822.107910036514, 4836.298736683231, 4837.733924634038, 4838.564529192389, 4888.560029597354], "value": 4597.209298698531, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.8271561742433, 557.4759725857692, 561.4806304168645, 565.9745311460983, 581.9650820950741, 27706.307342316428, 28283.858580707092, 30984.69015309849, 37550.62449375505, 38694.419583706265, 39209.80395098028, 39762.60237397625, 39811.402828957514, 39822.60177398225, 39839.20321593566, 7597.810054748647, 7741.806454838617, 7752.612369381536, 7753.069631644183, 7757.10793258774, 7568.167501574822, 7649.617519124049, 7658.655360508763, 7662.1954694756805, 7666.080070391561, 7678.769636910902, 7705.768826935201, 7716.459847810655, 7720.575368354738, 7726.8454630907345, 7630.694772209105, 7650.196729343423, 7682.347000504964, 7695.692172313156, 7702.961485192566, 7641.044869391326, 7690.077190737147, 7697.307242348215, 7705.922940770577, 7710.0, 36620.0, 36946.0, 37036.0, 37089.0, 37100.25799484022, 3036.316828713544, 3083.830389328586, 3190.3140824722796, 3345.9665403346144, 3370.275390790992, 27703.722962770516, 28155.859220703765, 28348.149555513366, 28380.432391352264, 28473.57289640657, 3169.4611915974338, 3210.1011716719354, 3260.559824423696, 3281.8851340202978, 3338.065341704327, 222338.0, 224302.0, 225069.0, 225109.99999999837, 225362.0, 30170.547441788392, 49322.0, 49807.501924981014, 49869.25196122061, 49908.750456247486, 31031.224219394244, 33025.174370640925, 33025.83487082597, 33026.834865826, 33053.17367065795, 12316.384180790925, 12423.068269879795, 12435.689107772198, 12440.253584784941, 12445.688857778447, 10037.297389182833, 10085.596576137019, 10121.949390253001, 10130.746731331628, 10132.848007279898, 7636.31273185416, 7659.0, 7718.382529397635, 7725.961370193113, 7735.265149810759, 3000.159955212544, 3005.557332480422, 3055.358374741329, 3089.428455735696, 3095.6440009399207, 855.9486430814171, 868.0408148995269, 923.4136323434667, 926.4302453990747, 947.9952600237093, 26762.866185669336, 27592.758325875384, 27715.86142069317, 27872.581911271347, 28003.15990520247, 907.2379201470796, 916.922061624756, 951.2342564235719, 958.8561715742555, 964.7298756348234, 13848.0, 14801.777973330409, 14848.925755371154, 15031.849681503045, 15108.622284442978, 363847.0, 366301.0, 367757.0, 368415.0, 368606.0, 47509.28736068962, 48008.0, 48019.35651582749, 48107.75946120247, 48160.27759583609, 1054.5570860238718, 1087.9728006799894, 1129.170060005895, 1141.8287256911365, 1170.0931777872217, 25407.6188857171, 28466.82783766649, 28790.424191515634, 28832.855835720686, 29381.41237175287, 40353.1929361417, 40752.388714168716, 40870.386944196456, 40899.1820163601, 40962.0, 281843.0, 283445.0, 283711.0, 283826.0, 284137.0, 21668.34994950154, 22226.777732222472, 31878.52182217222, 38455.0, 38888.80555597317, 37551.24897502089, 41221.0, 41258.587414125475, 41674.37488437615, 42624.14751705011, 35450.29099418049, 35679.82160089183, 36022.09944751297, 36107.81946090253, 36126.819365904055, 35227.29545409129, 36049.0, 36213.456798148574, 36244.63755362518, 36251.0, 35449.291014179056, 35945.92162235137, 35958.8202058988, 36107.45838812472, 36764.0, 31090.378192436478, 32378.838105809322, 32386.676133238365, 33355.33289334151, 33929.83035084809, 25104.874475627505, 25266.0, 25524.0, 25557.74442255628, 25978.87010565011], "value": 16003.19057720558, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.91402149462635, 347.7305088556369, 348.7053439843333, 351.84694657823843, 371.47992810065904, 12399.876001239985, 15079.773803392944, 15226.77159842602, 15706.21468926552, 16823.15884205791, 14987.400503979856, 15332.15673137977, 15555.455559055436, 15634.765478517804, 15837.84162158378, 3679.319325924699, 4576.405067341241, 4729.432468103815, 4729.810807567693, 5242.659227150242, 5119.0, 5177.30106435632, 5179.896402071956, 5181.9740901295445, 5203.219517072432, 4964.528369804881, 5090.669106508084, 5186.948130518685, 5190.11767999441, 5191.377034755835, 5063.31645227895, 5100.923486147711, 5104.770285337168, 5105.157648987913, 5106.08090543702, 4455.4207952966235, 4618.122556714214, 4622.237330840408, 4623.052274283764, 4649.697769644996, 19664.60670786576, 20261.594768104704, 20475.5904881903, 20496.5900681987, 20641.8967905161, 1758.2966813274793, 1839.6228773101616, 1840.3282801777389, 1844.9077546122774, 1977.74289342386, 8679.43583667066, 9084.137006984325, 9191.770205744842, 11858.703532411673, 13198.472061117543, 1672.3645014894262, 1708.854747346477, 1723.7069698151345, 1759.13802236903, 1784.357631252748, 63403.682981584796, 64746.0, 66050.66974665145, 66837.66581167062, 69173.93822008328, 9160.908390916138, 9357.20463760588, 9420.0, 9424.528773561295, 9624.326297159132, 12681.590497805388, 12685.746285074247, 12689.428975696115, 12700.936495317465, 12711.809322860165, 6672.966635166793, 6721.092652491949, 6755.1556055493065, 6786.864262714718, 6832.931670683329, 6178.907316390258, 6194.287656919512, 6314.968425157845, 6357.078223657636, 6384.84037899047, 3900.8439662413753, 3964.623360780721, 3969.4045893115685, 4028.3554631258858, 4031.2139132869397, 1589.6184915620167, 1643.556239815243, 1671.6405972715925, 1702.7701260329945, 1731.5930756272267, 705.5660768627359, 841.2050612171562, 875.3041332140963, 890.8351954888367, 913.164454524103, 16225.0, 16921.238544265536, 17557.473275801745, 17810.5547361317, 17949.7307540387, 792.8295416485483, 852.3309202276183, 863.9956800215958, 880.6125304865839, 927.2813569483569, 9391.906080939103, 9874.40753554789, 9920.156786673213, 9947.20422366209, 10006.19950403966, 369908.0, 374168.0, 374304.0, 374971.0, 379239.0, 45657.0, 45857.312140317925, 49367.0, 75941.6202918993, 79415.20584794079, 850.6852464588142, 870.1950695606539, 877.5129802959419, 877.5480627476854, 887.2414085956543, 14958.551243462714, 15198.924005379902, 15461.922690386476, 15841.52475425739, 16099.517014489584, 31893.362132756753, 36312.273754524234, 36719.63280367269, 37526.62473375232, 37564.436533452565, 45512.0, 47098.29352559783, 48218.75890620524, 50209.74895125501, 50285.0, 7422.851542969219, 7560.395168386626, 7602.50583712057, 7659.387249019954, 7665.578393188428, 10814.783704325711, 11195.664130076111, 11410.201285909907, 11832.112591555495, 12327.876721233031, 10522.736931576772, 10648.520816563117, 10730.248882578144, 10767.300125491818, 10917.781644367227, 7307.488475806643, 8853.867191991996, 10219.437930913871, 10408.427536485566, 10703.839442408525, 10214.131798796889, 10601.151907847508, 10648.361098334124, 11132.666020019413, 11140.554377825121, 7384.704611815468, 7504.474686771873, 7539.434542409232, 7609.467337286558, 7819.765407037798, 9920.652777152765, 10493.0, 10543.367397956146, 10738.624148154777, 10774.515146818569], "value": 7862.435789332251, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.4500054977455, 1378.8207533020707, 1434.3832152174562, 1653.6857996980566, 1681.6048228666268, 6611.6363600002105, 6936.895946560806, 7192.604406757633, 7754.030746156731, 7774.455788094836, 7146.106736657918, 7456.96271518643, 7479.252074792518, 7678.462507624468, 7692.115406728228, 2119.544297975935, 2149.7420309562795, 2152.9665760434923, 2154.806067453929, 2176.662617294314, 1799.190364336054, 1865.449692340756, 2041.2345370486069, 2101.8949052547387, 2129.361191642509, 2091.884946327951, 2135.284679632325, 2136.3590922723197, 2140.8715477071346, 2141.132841199309, 2048.365006847882, 2086.634838903186, 2095.9790402096014, 2100.6428907085833, 2101.63221436248, 2089.8119169274837, 2090.310197634792, 2107.2729908181655, 2108.98945505273, 2111.820495257905, 7540.660670269851, 7601.049868766404, 7634.6182690865235, 7635.236476352376, 7645.655945482411, 4273.401723758676, 4470.173017991682, 4521.59305662492, 4530.0, 4541.591256786905, 2700.6894207166233, 2782.373965857686, 2788.986055069732, 2793.0782841662203, 2822.5342818434933, 901.1966220047133, 902.3908861518514, 917.9403338782957, 927.3045216087934, 932.2355668351954, 10187.490625468698, 10190.745231369276, 10194.286399951932, 10219.642312519101, 10244.129249013842, 3811.676007539335, 3960.32674445345, 4146.792660366969, 4170.603792639695, 4183.247015537172, 8915.197632213132, 8919.643214271357, 8932.776680583038, 8939.150780675825, 8942.552872356357, 4614.8384806532285, 4615.399998000238, 4629.722216667011, 4635.1656701794, 4637.698549594265, 4109.753414795122, 4179.435776170239, 4200.306949353384, 4204.894877628084, 4205.474315710536, 3519.9120021999656, 3551.3430015447225, 3656.926861462809, 3659.835307411173, 3667.743257971916, 1071.8285074388216, 1118.4743170709917, 1178.7288923547633, 1184.8755880632582, 1226.2709579492873, 655.2497390487865, 742.5470463017555, 811.4522697179381, 812.4800127918137, 820.8235229425702, 4938.777755001033, 5077.162268225775, 5220.660657057279, 5253.474652534793, 5256.316678831728, 793.1156760212322, 804.7325462396749, 825.3232349473374, 826.4710585225461, 869.6434461870602, 3295.703386695209, 3331.3670402623907, 3335.2495688470385, 3340.9498857517156, 3483.7038851697384, 8946.37375383717, 9356.719298421058, 9360.531973401303, 9378.43729376226, 9384.483853388128, 9146.771330716652, 9228.8615670765, 9274.721758347261, 9309.953450232706, 9310.487923164292, 7086.2205157432645, 7172.354488096201, 7186.496945213889, 7189.820254493679, 7197.9640101800205, 4770.403699537558, 4796.328514008112, 4808.927866082082, 4882.92675609859, 5078.060558796635, 8164.224398682116, 8509.574521274035, 8522.27560657351, 8691.130886911258, 8726.476411415335, 8497.405181637227, 8799.780005499657, 8852.24755895756, 8858.468491890508, 8904.688335908471, 6610.206775187008, 6696.7656132035145, 6753.3246675332075, 6757.020232066421, 6758.560693554903, 7307.159676637255, 7405.481616286808, 7447.776566703008, 7461.962690186731, 7490.737824176128, 5233.345831771028, 6465.191851018622, 6468.126802881551, 6667.266600674019, 6672.866542669022, 6426.775062872777, 6434.64609446485, 6436.324185960407, 6469.094326794158, 6550.868982620225, 6093.878122437615, 6201.503879689524, 6202.782902598387, 6205.410486004003, 6216.44052035319, 4198.538160802248, 4204.810783514688, 4208.32666773327, 4289.742615443083, 4305.31115021595, 4174.749515029108, 4188.643965262865, 4355.324924636687, 4360.542143074931, 4412.602865742098], "value": 4000.1580084841594, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.2271865961902, 287.9841608711521, 294.586106520339, 301.25890309837797, 302.1479428013003, 4595.540445955403, 4744.062428184607, 4759.381280433543, 4827.78274977626, 4853.640980525454, 4561.22459181939, 4685.3206285088645, 4700.6474514411475, 4732.668713190078, 4775.785089670964, 3787.3182827091114, 3788.5264341957322, 3800.20195758891, 3806.257779732953, 3812.370958791796, 3549.4498352755363, 3667.7249206309634, 3790.5216965383524, 3796.8799204234815, 3801.8289176986964, 3699.18617904062, 3753.7184711146638, 3768.5316117942793, 3770.095177157476, 3773.5471743390694, 3752.587215406303, 3761.2665530221616, 3761.8307176177, 3762.360398732222, 3766.6045065268163, 3332.100332910125, 3332.5334453176574, 3337.215754297738, 3339.382214290364, 3340.3987282289177, 4500.459944806644, 4586.4266966629175, 4627.953720462786, 4665.88335291617, 4683.859484215445, 4290.163418133465, 4297.011687311936, 4307.483102027777, 4307.633851122627, 4308.547602501755, 4992.276119962585, 4994.550490455877, 4998.7250701211415, 5010.644996851474, 5015.673981191248, 3345.799252044885, 3533.522974398449, 3656.835442405098, 3657.0674478007936, 3659.249853779969, 5140.614453915971, 5153.742312884341, 5160.303359046556, 5173.379194496647, 5180.818671346522, 3579.498870158128, 3580.1407662160896, 3580.606133325332, 3583.623719509414, 3591.2278860044694, 3634.6547078027547, 3653.2510835278704, 3669.1654172913545, 3670.4127339625534, 3676.8161591920298, 3967.8412863485137, 4139.254934111888, 4172.7913604320265, 4177.749335039907, 4220.388043733641, 4957.231629097496, 4962.280469331927, 4976.004799040206, 4979.6265280104135, 4987.700737955734, 1163.8777928317575, 1197.700574856286, 1218.5186851193728, 1251.949922003128, 1267.2575209087504, 850.2475309351269, 851.9148085191431, 870.0944930601961, 870.8214815962713, 872.5942436766934, 4395.604395604411, 4406.757628330409, 4418.5802348776815, 4421.1483593082285, 4424.424824772824, 5070.847874563769, 5082.331775817725, 5087.592992560661, 5097.974510127426, 5109.259157422153, 4409.669274804339, 4409.889752756207, 4426.313921342197, 4438.533953934855, 4442.489113751895, 2298.2071185440996, 2374.25211058516, 2383.5947888858936, 2395.9880200598886, 2415.7342692303832, 4273.768968721006, 4296.935545966813, 4307.461567304087, 4313.2746901239125, 4374.993751437188, 4527.551183621275, 4548.431446069175, 4615.376924115269, 4657.301404789241, 4667.533246675305, 4142.751434913915, 4295.871123866289, 4305.5048669402795, 4311.340134048414, 4327.2643650579475, 4476.9328460072475, 4498.505164431976, 4502.3921770560555, 4518.209313370213, 4531.84138555149, 4417.602415782595, 4443.55564443566, 4456.264716321771, 4465.9058530660195, 4490.730556166641, 4086.7956602170366, 4307.203167414038, 4318.632916202158, 4321.265384884514, 4340.848070317524, 3262.487884329101, 3269.150020994511, 3274.312394397203, 3287.375398674244, 3324.6010478742705, 4542.296638760465, 4547.545245475559, 4548.272276435754, 4556.772161391984, 4557.0, 4787.712737235777, 4883.36516252899, 4911.803527858846, 4935.001324463598, 4943.505649435027, 4471.418715566955, 4994.400671919393, 5024.29659847629, 5024.648274620741, 5052.520010598987, 4920.384951881015, 4930.975345123252, 4953.851384458472, 4966.652334336562, 4991.5258050485145, 4860.538248866352, 5021.5229553192385, 5038.294638750651, 5038.697678139323, 5043.319151914445, 4914.9036107252205, 4923.187674033744, 4938.654294199371, 4939.160342741814, 4940.530649588283], "value": 3648.3270876895353, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.497209690393, 641.4996302883752, 672.2403683837263, 718.188447054828, 736.3483317264223, 13062.542811001616, 14141.575752727435, 14146.292685365715, 14149.221792801392, 14180.22008789516, 13187.538436154713, 13239.139455935381, 13241.801372979413, 13249.735005299888, 13289.667758306046, 611.150500803883, 628.5788521690456, 742.3467348733121, 754.4605606991, 774.4307933668749, 775.8409526047146, 777.9377649788032, 778.1246098139593, 778.3656320099129, 778.4900889917113, 813.556611646654, 814.6415577146066, 815.0504662068682, 815.2581151152452, 816.2123550773503, 638.7700427845972, 653.7058323754329, 799.3605115907309, 807.9676812927476, 824.0976131136456, 585.5900869391401, 591.2018774654225, 591.8786648736999, 592.1266132454595, 592.1266132454638, 13169.53906613264, 13171.736565268737, 13190.604281871463, 13219.735605287937, 13229.536966206233, 11656.242344247597, 11938.343391113485, 11972.58095966637, 12271.325077120755, 12613.243205407705, 9674.613015479372, 9722.513874306256, 9743.123118919331, 9754.561044753003, 9847.16299114576, 3365.3269346130874, 3385.64450732672, 3399.286149908522, 3404.285100128976, 3406.931861362784, 61603.38396615977, 61656.69171654158, 62423.0, 62661.0, 63197.68401157965, 10502.842457363146, 10687.572497100184, 10692.144628429707, 10843.0, 11198.272112312836, 19926.20295188176, 20000.899995500222, 20003.59992800136, 20112.09495572703, 20204.69692954607, 6678.165229346332, 6720.495962802809, 6810.284920083419, 6815.965920170466, 6819.454443644497, 3703.8518459261327, 3729.9254014920093, 3768.1710023795267, 3822.445745366906, 3850.383938569815, 2733.5352989991748, 2849.7292757188447, 2850.6579210494874, 2850.857457127135, 2854.986479799683, 510.0869443695817, 515.1242887091959, 516.0813751522221, 524.1011664994553, 524.2032111191045, 489.5471688687949, 538.3780986595306, 596.6181643747918, 611.7430679114782, 619.4208415131866, 8116.837663246702, 8231.42380033392, 8476.618552165168, 8479.576021199038, 8673.566321684017, 586.7975548435783, 597.7818096394784, 603.5865432178883, 620.4478014567039, 623.2583225961092, 3558.7153027757718, 3925.9907711025644, 3994.6404823566018, 4072.2669919414197, 4078.572499625167, 57495.42504574984, 58594.4140558589, 88636.5568172155, 95322.52338738262, 100763.49618252009, 48460.5153948456, 77417.0, 78241.60879195681, 80820.59589702131, 82567.587162065, 57182.7140864293, 57613.423865761644, 58729.0, 66928.31894245863, 71488.64255678689, 8076.4750291230885, 8474.110218427222, 8577.871331930151, 8627.309815214643, 8759.0, 40357.798211008754, 41444.71105778796, 42303.36544951767, 42536.5746342545, 42974.42153470802, 36965.0, 61425.38574614197, 61462.692686536284, 61707.0, 63328.366716332246, 10316.690499285034, 10429.95700429951, 10501.26491145643, 10579.841302380317, 10639.361638301727, 12457.813132803196, 12638.873611264138, 13147.474101035852, 13198.340082996005, 13279.66800829987, 11673.708157296136, 12116.333601651993, 12123.654309195499, 12150.392480376122, 12654.177478463871, 11626.88373116258, 11870.52517899309, 12034.097442691658, 12680.0, 12683.492660293485, 11576.0, 11859.940700296444, 12149.696257593278, 12740.108192426442, 12853.293068881301, 9486.430814151174, 9622.556249099976, 9631.181349585364, 9794.461304628314, 10398.532066056894, 9475.815523059617, 10067.597296108073, 10149.543270552991, 10159.315864269805, 10318.896811031793], "value": 6446.003980586053, "unit": "score"}], "name": "dromaeo_css", "value": 6155.944011247982, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 115.0, 114.0, 115.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 131.0, 178.0, 131.0, 125.0, 126.0, 124.0, 165.0, 140.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 161.0, 160.0, 161.0, 163.0, 161.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 120.0, 77.0, 77.0, 78.0, 76.0, 106.0, 76.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 111.0, 83.0, 84.0, 84.0, 113.0, 83.0, 84.0, 118.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 61.0, 63.0, 63.0, 63.0, 63.0, 63.0, 65.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 93.0, 92.0, 84.0, 84.0, 84.0, 83.0, 85.0, 83.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 150.0, 138.0, 141.0, 133.0, 140.0, 143.0, 132.0, 172.0, 140.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 177.0, 172.0, 172.0, 172.0, 172.0, 174.0, 172.0, 172.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 73.0, 68.0, 68.0, 68.0, 68.0, 70.0, 69.0, 68.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1549.6000000000001, "alertThreshold": 2.0}]} 09:41:59 INFO - Return code: 0 09:41:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:41:59 INFO - # TBPL SUCCESS # 09:41:59 INFO - Running post-action listener: _resource_record_post_action 09:41:59 INFO - [mozharness: 2016-09-29 16:41:59.646171Z] Finished run-tests step (success) 09:41:59 INFO - Running post-run listener: _resource_record_post_run 09:41:59 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393072640; Read time: 16; Write time: 391000 09:41:59 INFO - TinderboxPrint: CPU usage
13.1% 09:41:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:41:59 INFO - TinderboxPrint: I/O write bytes / time
393,072,640 / 391,000 09:41:59 INFO - TinderboxPrint: CPU idle
8,351.0 (86.9%) 09:41:59 INFO - TinderboxPrint: CPU user
1,203.8 (12.5%) 09:41:59 INFO - TinderboxPrint: Swap in / out
0 / 0 09:41:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102666240; Read time: 0; Write time: 118352 09:41:59 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 289423360; Read time: 0; Write time: 272560 09:42:00 INFO - Running post-run listener: _upload_blobber_files 09:42:00 INFO - Blob upload gear active. 09:42:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:42:00 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 09:42:00 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:42:00 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:42:00 INFO - (blobuploader) - INFO - Open directory for files ... 09:42:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:42:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:42:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:01 INFO - (blobuploader) - INFO - Done attempting. 09:42:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:42:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:42:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:07 INFO - (blobuploader) - INFO - Done attempting. 09:42:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:42:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:42:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:07 INFO - (blobuploader) - INFO - Done attempting. 09:42:07 INFO - (blobuploader) - INFO - Iteration through files over. 09:42:07 INFO - Return code: 0 09:42:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:42:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:42:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0e651169e22473eb647fcf5751c78c23774df39bf92977a57b78f46d1179efee1cd4fd5fdb17236395efb563b56d49d46ae16a80c633ac1f09a4b2fb35c6248f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7ad08e38332419be912d230e60d383009ba842398732876f4b4db9b45c2c23d0e5b3d0d169531bf83e6ed8a9c5b0dc9879a7fe126742b0319d0b04688e350e10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b1c30c3307c3c7d27d3464d89bda78d37d9b3d462c39d7d54034e6424e04fd3d119a66b26b6bebde9a8f4b5a5c53e8b753af53a285c6c677dc3b9b3515cc047a"} 09:42:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:42:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:42:07 INFO - Contents: 09:42:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0e651169e22473eb647fcf5751c78c23774df39bf92977a57b78f46d1179efee1cd4fd5fdb17236395efb563b56d49d46ae16a80c633ac1f09a4b2fb35c6248f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7ad08e38332419be912d230e60d383009ba842398732876f4b4db9b45c2c23d0e5b3d0d169531bf83e6ed8a9c5b0dc9879a7fe126742b0319d0b04688e350e10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b1c30c3307c3c7d27d3464d89bda78d37d9b3d462c39d7d54034e6424e04fd3d119a66b26b6bebde9a8f4b5a5c53e8b753af53a285c6c677dc3b9b3515cc047a"} 09:42:07 INFO - Running post-run listener: copy_logs_to_upload_dir 09:42:07 INFO - Copying logs to upload dir... 09:42:07 INFO - mkdir: /builds/slave/test/build/upload/logs 09:42:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.104526 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-29 09:42:07.750389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 09:42:07.755175) ========= 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=920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0e651169e22473eb647fcf5751c78c23774df39bf92977a57b78f46d1179efee1cd4fd5fdb17236395efb563b56d49d46ae16a80c633ac1f09a4b2fb35c6248f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7ad08e38332419be912d230e60d383009ba842398732876f4b4db9b45c2c23d0e5b3d0d169531bf83e6ed8a9c5b0dc9879a7fe126742b0319d0b04688e350e10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b1c30c3307c3c7d27d3464d89bda78d37d9b3d462c39d7d54034e6424e04fd3d119a66b26b6bebde9a8f4b5a5c53e8b753af53a285c6c677dc3b9b3515cc047a"} build_url:https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/IiP6YN_dSxqYXRKUsTAHdQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0e651169e22473eb647fcf5751c78c23774df39bf92977a57b78f46d1179efee1cd4fd5fdb17236395efb563b56d49d46ae16a80c633ac1f09a4b2fb35c6248f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7ad08e38332419be912d230e60d383009ba842398732876f4b4db9b45c2c23d0e5b3d0d169531bf83e6ed8a9c5b0dc9879a7fe126742b0319d0b04688e350e10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b1c30c3307c3c7d27d3464d89bda78d37d9b3d462c39d7d54034e6424e04fd3d119a66b26b6bebde9a8f4b5a5c53e8b753af53a285c6c677dc3b9b3515cc047a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 09:42:07.787829) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:42:07.788194) ========= 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=920470bf432669ad7e3a5387000001ca-1475166077.25053-1948323462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:42:07.870544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 09:42:07.870874) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 09:42:07.871180) ========= ========= Total master_lag: 0.24 =========