builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-004 starttime: 1472567810.87 results: success (0) buildid: 20160829095331 builduid: ab03fec5eb2a482f8b120150feff764c revision: 7293879d87d780790cb0f67e98226b7d4de6d4e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 07:36:50.867128) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 07:36:50.867582) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 07:36:50.867865) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 07:36:50.908531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 07:36:50.908860) ========= 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=c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 07:36:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-08-30 07:36:51 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174494 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 07:36:51.129559) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 07:36:51.129838) ========= 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=c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017841 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 07:36:51.192757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 07:36:51.193109) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7293879d87d780790cb0f67e98226b7d4de6d4e1 --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 7293879d87d780790cb0f67e98226b7d4de6d4e1 --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=c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 07:36:51,446 truncating revision to first 12 chars 2016-08-30 07:36:51,446 Setting DEBUG logging. 2016-08-30 07:36:51,446 attempt 1/10 2016-08-30 07:36:51,446 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7293879d87d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 07:36:51,852 unpacking tar archive at: autoland-7293879d87d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.693582 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 07:36:51.901943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 07:36:51.902303) ========= script_repo_revision: 7293879d87d780790cb0f67e98226b7d4de6d4e1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 07:36:51.902822) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 07:36:51.903109) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 07:36:51.916054) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-30 07:36:51.916333) ========= /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=c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:36:52 INFO - MultiFileLogger online at 20160830 07:36:52 in /builds/slave/test 07:36:52 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 07:36:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:36:52 INFO - {'append_to_log': False, 07:36:52 INFO - 'base_work_dir': '/builds/slave/test', 07:36:52 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 07:36:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:36:52 INFO - 'branch': 'Autoland-Non-PGO', 07:36:52 INFO - 'buildbot_json_path': 'buildprops.json', 07:36:52 INFO - 'config_files': ('talos/linux_config.py',), 07:36:52 INFO - 'default_actions': ('clobber', 07:36:52 INFO - 'read-buildbot-config', 07:36:52 INFO - 'download-and-extract', 07:36:52 INFO - 'populate-webroot', 07:36:52 INFO - 'create-virtualenv', 07:36:52 INFO - 'install', 07:36:52 INFO - 'run-tests'), 07:36:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:36:52 INFO - 'download_minidump_stackwalk': True, 07:36:52 INFO - 'download_symbols': 'ondemand', 07:36:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:36:52 INFO - 'tooltool.py': '/tools/tooltool.py', 07:36:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:36:52 INFO - '/tools/misc-python/virtualenv.py')}, 07:36:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:36:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:36:52 INFO - 'installer_path': 'installer.exe', 07:36:52 INFO - 'log_level': 'info', 07:36:52 INFO - 'log_name': 'talos', 07:36:52 INFO - 'log_to_console': True, 07:36:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:36:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:36:52 INFO - 'opt_config_files': (), 07:36:52 INFO - 'pip_index': False, 07:36:52 INFO - 'sps_profile': False, 07:36:52 INFO - 'sps_profile_interval': 0, 07:36:52 INFO - 'suite': 'dromaeojs', 07:36:52 INFO - 'system_bits': '32', 07:36:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:36:52 INFO - 'title': 'talos-linux64-ix-004', 07:36:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:36:52 INFO - 'use_talos_json': True, 07:36:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:36:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:36:52 INFO - 'work_dir': 'build'} 07:36:52 INFO - [mozharness: 2016-08-30 14:36:52.263153Z] Running clobber step. 07:36:52 INFO - Running pre-action listener: _resource_record_pre_action 07:36:52 INFO - Running main action method: clobber 07:36:52 INFO - rmtree: /builds/slave/test/build 07:36:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:36:52 INFO - Running post-action listener: _resource_record_post_action 07:36:52 INFO - [mozharness: 2016-08-30 14:36:52.718263Z] Finished clobber step (success) 07:36:52 INFO - [mozharness: 2016-08-30 14:36:52.718365Z] Running read-buildbot-config step. 07:36:52 INFO - Running pre-action listener: _resource_record_pre_action 07:36:52 INFO - Running main action method: read_buildbot_config 07:36:52 INFO - Using buildbot properties: 07:36:52 INFO - { 07:36:52 INFO - "project": "", 07:36:52 INFO - "product": "firefox", 07:36:52 INFO - "script_repo_revision": "production", 07:36:52 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 07:36:52 INFO - "repository": "", 07:36:52 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 07:36:52 INFO - "buildid": "20160829095331", 07:36:52 INFO - "pgo_build": "False", 07:36:52 INFO - "basedir": "/builds/slave/test", 07:36:52 INFO - "buildnumber": 562, 07:36:52 INFO - "slavename": "talos-linux64-ix-004", 07:36:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:36:52 INFO - "platform": "ubuntu64_hw", 07:36:52 INFO - "scheduler": "tests-autoland-linux64-talos", 07:36:52 INFO - "branch": "autoland", 07:36:52 INFO - "repo_path": "integration/autoland", 07:36:52 INFO - "revision": "7293879d87d780790cb0f67e98226b7d4de6d4e1", 07:36:52 INFO - "stage_platform": "linux64", 07:36:52 INFO - "builduid": "ab03fec5eb2a482f8b120150feff764c", 07:36:52 INFO - "slavebuilddir": "test" 07:36:52 INFO - } 07:36:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:36:52 INFO - Running post-action listener: _resource_record_post_action 07:36:52 INFO - [mozharness: 2016-08-30 14:36:52.720790Z] Finished read-buildbot-config step (success) 07:36:52 INFO - [mozharness: 2016-08-30 14:36:52.720881Z] Running download-and-extract step. 07:36:52 INFO - Running pre-action listener: _resource_record_pre_action 07:36:52 INFO - Running main action method: download_and_extract 07:36:52 INFO - mkdir: /builds/slave/test/build/tests 07:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:52 INFO - trying https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:36:52 INFO - Downloading https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:36:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:36:53 INFO - Downloaded 1361 bytes. 07:36:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:36:53 INFO - Using the following test package requirements: 07:36:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:36:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:36:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:53 INFO - u'jsshell-linux-x86_64.zip'], 07:36:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:36:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:36:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:36:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:36:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:36:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:53 INFO - trying https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:36:53 INFO - Downloading https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:36:54 INFO - Downloaded 20308050 bytes. 07:36:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:36:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:58 INFO - trying https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:36:58 INFO - Downloading https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:36:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:36:59 INFO - Downloaded 20308050 bytes. 07:36:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:37:03 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')]} 07:37:03 INFO - trying https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:03 INFO - Downloading https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:37:04 INFO - Downloaded 14413998 bytes. 07:37:04 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 07:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:04 INFO - trying https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:37:04 INFO - Downloading https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:37:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:37:05 INFO - Downloaded 55872786 bytes. 07:37:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:37:05 INFO - mkdir: /builds/slave/test/properties 07:37:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:05 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:05 INFO - Contents: 07:37:05 INFO - build_url:https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:37:06 INFO - Running post-action listener: _resource_record_post_action 07:37:06 INFO - Running post-action listener: set_extra_try_arguments 07:37:06 INFO - [mozharness: 2016-08-30 14:37:06.540430Z] Finished download-and-extract step (success) 07:37:06 INFO - [mozharness: 2016-08-30 14:37:06.540659Z] Running populate-webroot step. 07:37:06 INFO - Running pre-action listener: _resource_record_pre_action 07:37:06 INFO - Running main action method: populate_webroot 07:37:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:06 INFO - '--tppagecycles', 07:37:06 INFO - '7'], 07:37:06 INFO - 'tests': ['tsvgm']}}, 07:37:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:37:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:37:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:06 INFO - 'talos_options': ['--disable-e10s'], 07:37:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:06 INFO - 'talos_options': ['--disable-e10s'], 07:37:06 INFO - 'tests': ['damp', 'tps']}, 07:37:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:06 INFO - 'tests': ['damp', 'tps']}, 07:37:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:37:06 INFO - 'tests': ['dromaeo_dom']}, 07:37:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:37:06 INFO - 'tests': ['basic_compositor_video']}, 07:37:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:37:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:37:06 INFO - 'tests': ['a11yr', 07:37:06 INFO - 'ts_paint', 07:37:06 INFO - 'tpaint', 07:37:06 INFO - 'sessionrestore', 07:37:06 INFO - 'sessionrestore_no_auto_restore', 07:37:06 INFO - 'tabpaint']}, 07:37:06 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:06 INFO - 'ts_paint', 07:37:06 INFO - 'tpaint', 07:37:06 INFO - 'sessionrestore', 07:37:06 INFO - 'sessionrestore_no_auto_restore', 07:37:06 INFO - 'tabpaint']}, 07:37:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:37:06 INFO - 'ts_paint', 07:37:06 INFO - 'tpaint', 07:37:06 INFO - 'sessionrestore', 07:37:06 INFO - 'sessionrestore_no_auto_restore', 07:37:06 INFO - 'tabpaint']}, 07:37:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:37:06 INFO - 'ts_paint', 07:37:06 INFO - 'tpaint', 07:37:06 INFO - 'sessionrestore', 07:37:06 INFO - 'sessionrestore_no_auto_restore', 07:37:06 INFO - 'tabpaint']}, 07:37:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:37:06 INFO - 'tests': ['a11yr', 07:37:06 INFO - 'ts_paint', 07:37:06 INFO - 'tpaint', 07:37:06 INFO - 'sessionrestore', 07:37:06 INFO - 'sessionrestore_no_auto_restore', 07:37:06 INFO - 'tabpaint']}, 07:37:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:37:06 INFO - 'tests': ['a11yr', 07:37:06 INFO - 'ts_paint', 07:37:06 INFO - 'tpaint', 07:37:06 INFO - 'sessionrestore', 07:37:06 INFO - 'sessionrestore_no_auto_restore', 07:37:06 INFO - 'tabpaint']}, 07:37:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:37:06 INFO - 'tests': ['tsvgx', 07:37:06 INFO - 'tsvgr_opacity', 07:37:06 INFO - 'tart', 07:37:06 INFO - 'tscrollx', 07:37:06 INFO - 'cart']}, 07:37:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:06 INFO - 'tsvgr_opacity', 07:37:06 INFO - 'tart', 07:37:06 INFO - 'tscrollx', 07:37:06 INFO - 'cart']}, 07:37:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:06 INFO - 'talos_options': ['--disable-e10s'], 07:37:06 INFO - 'tests': ['tp5o']}, 07:37:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:06 INFO - 'tests': ['tp5o']}, 07:37:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:06 INFO - 'talos_options': ['--disable-e10s', 07:37:06 INFO - '--xperf_path', 07:37:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:06 INFO - 'tests': ['tp5n']}, 07:37:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:06 INFO - 'talos_options': ['--xperf_path', 07:37:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:06 INFO - 'tests': ['tp5n']}}, 07:37:06 INFO - 'talos.zip': {'path': '', 07:37:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:06 INFO - Running post-action listener: _resource_record_post_action 07:37:06 INFO - [mozharness: 2016-08-30 14:37:06.562333Z] Finished populate-webroot step (success) 07:37:06 INFO - [mozharness: 2016-08-30 14:37:06.562423Z] Running create-virtualenv step. 07:37:06 INFO - Running pre-action listener: _resource_record_pre_action 07:37:06 INFO - Running main action method: create_virtualenv 07:37:06 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:06 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 07:37:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:06 INFO - Using real prefix '/usr' 07:37:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:07 INFO - Installing distribute.............................................................................................................................................................................................done. 07:37:09 INFO - Installing pip.................done. 07:37:09 INFO - Return code: 0 07:37:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:37:09 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')]} 07:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:09 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')]} 07:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:09 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 0x7fde356faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b21d20>, '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 0x1b22c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b230b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', '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 07:37:09 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 07:37:09 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 07:37:09 INFO - Using env: {'DISPLAY': ':0', 07:37:09 INFO - 'HOME': '/home/cltbld', 07:37:09 INFO - 'LANG': 'en_US.UTF-8', 07:37:09 INFO - 'LANGUAGE': 'en_US:en', 07:37:09 INFO - 'LOGNAME': 'cltbld', 07:37:09 INFO - 'MAIL': '/var/mail/cltbld', 07:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:09 INFO - 'MOZ_NO_REMOTE': '1', 07:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:09 INFO - 'NO_EM_RESTART': '1', 07:37:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:09 INFO - 'PWD': '/builds/slave/test', 07:37:09 INFO - 'SHELL': '/bin/bash', 07:37:09 INFO - 'SHLVL': '1', 07:37:09 INFO - 'TERM': 'linux', 07:37:09 INFO - 'TMOUT': '86400', 07:37:09 INFO - 'USER': 'cltbld', 07:37:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', 07:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:09 INFO - '_': '/tools/buildbot/bin/python'} 07:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:09 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 07:37:09 INFO - Cleaning up... 07:37:09 INFO - Return code: 0 07:37:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:37:09 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')]} 07:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:09 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')]} 07:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:09 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 0x7fde356faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b21d20>, '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 0x1b22c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b230b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', '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 07:37:09 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 07:37:09 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 07:37:09 INFO - Using env: {'DISPLAY': ':0', 07:37:09 INFO - 'HOME': '/home/cltbld', 07:37:09 INFO - 'LANG': 'en_US.UTF-8', 07:37:09 INFO - 'LANGUAGE': 'en_US:en', 07:37:09 INFO - 'LOGNAME': 'cltbld', 07:37:09 INFO - 'MAIL': '/var/mail/cltbld', 07:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:09 INFO - 'MOZ_NO_REMOTE': '1', 07:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:09 INFO - 'NO_EM_RESTART': '1', 07:37:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:09 INFO - 'PWD': '/builds/slave/test', 07:37:09 INFO - 'SHELL': '/bin/bash', 07:37:09 INFO - 'SHLVL': '1', 07:37:09 INFO - 'TERM': 'linux', 07:37:09 INFO - 'TMOUT': '86400', 07:37:09 INFO - 'USER': 'cltbld', 07:37:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', 07:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:09 INFO - '_': '/tools/buildbot/bin/python'} 07:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:09 INFO - Downloading/unpacking psutil>=3.1.1 07:37:09 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 07:37:09 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 07:37:09 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 07:37:09 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 07:37:09 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 07:37:09 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 07:37:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:37:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:11 INFO - Installing collected packages: psutil 07:37:11 INFO - Running setup.py install for psutil 07:37:11 INFO - building 'psutil._psutil_linux' extension 07:37:11 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 07:37:11 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 07:37:11 INFO - building 'psutil._psutil_posix' extension 07:37:11 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 07:37:11 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 07:37:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:12 INFO - Successfully installed psutil 07:37:12 INFO - Cleaning up... 07:37:12 INFO - Return code: 0 07:37:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:12 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 0x7fde356faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b21d20>, '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 0x1b22c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b230b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', '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 07:37:12 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 07:37:12 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 07:37:12 INFO - Using env: {'DISPLAY': ':0', 07:37:12 INFO - 'HOME': '/home/cltbld', 07:37:12 INFO - 'LANG': 'en_US.UTF-8', 07:37:12 INFO - 'LANGUAGE': 'en_US:en', 07:37:12 INFO - 'LOGNAME': 'cltbld', 07:37:12 INFO - 'MAIL': '/var/mail/cltbld', 07:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:12 INFO - 'MOZ_NO_REMOTE': '1', 07:37:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:12 INFO - 'NO_EM_RESTART': '1', 07:37:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:12 INFO - 'PWD': '/builds/slave/test', 07:37:12 INFO - 'SHELL': '/bin/bash', 07:37:12 INFO - 'SHLVL': '1', 07:37:12 INFO - 'TERM': 'linux', 07:37:12 INFO - 'TMOUT': '86400', 07:37:12 INFO - 'USER': 'cltbld', 07:37:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', 07:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:12 INFO - '_': '/tools/buildbot/bin/python'} 07:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:37:12 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 07:37:12 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 07:37:12 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 07:37:12 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 07:37:12 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 07:37:12 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 07:37:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:37:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:37:14 INFO - Installing collected packages: mozsystemmonitor 07:37:14 INFO - Running setup.py install for mozsystemmonitor 07:37:14 INFO - Successfully installed mozsystemmonitor 07:37:14 INFO - Cleaning up... 07:37:14 INFO - Return code: 0 07:37:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:37:14 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')]} 07:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:14 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')]} 07:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:14 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 0x7fde356faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b21d20>, '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 0x1b22c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b230b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', '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 07:37:14 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 07:37:14 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 07:37:14 INFO - Using env: {'DISPLAY': ':0', 07:37:14 INFO - 'HOME': '/home/cltbld', 07:37:14 INFO - 'LANG': 'en_US.UTF-8', 07:37:14 INFO - 'LANGUAGE': 'en_US:en', 07:37:14 INFO - 'LOGNAME': 'cltbld', 07:37:14 INFO - 'MAIL': '/var/mail/cltbld', 07:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:14 INFO - 'MOZ_NO_REMOTE': '1', 07:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:14 INFO - 'NO_EM_RESTART': '1', 07:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:14 INFO - 'PWD': '/builds/slave/test', 07:37:14 INFO - 'SHELL': '/bin/bash', 07:37:14 INFO - 'SHLVL': '1', 07:37:14 INFO - 'TERM': 'linux', 07:37:14 INFO - 'TMOUT': '86400', 07:37:14 INFO - 'USER': 'cltbld', 07:37:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', 07:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:14 INFO - '_': '/tools/buildbot/bin/python'} 07:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:14 INFO - Downloading/unpacking jsonschema==2.5.1 07:37:14 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 07:37:14 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 07:37:14 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 07:37:14 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 07:37:14 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 07:37:14 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 07:37:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:37:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:37:16 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 07:37:16 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 07:37:16 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 07:37:16 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 07:37:16 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 07:37:16 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 07:37:16 INFO - Downloading functools32-3.2.3-2.tar.gz 07:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:37:16 INFO - warning: no files found matching '*.txt' 07:37:16 INFO - no previously-included directories found matching 'build' 07:37:16 INFO - no previously-included directories found matching 'dist' 07:37:16 INFO - no previously-included directories found matching '.git*' 07:37:16 INFO - Installing collected packages: jsonschema, functools32 07:37:16 INFO - Running setup.py install for functools32 07:37:16 INFO - warning: no files found matching '*.txt' 07:37:16 INFO - no previously-included directories found matching 'build' 07:37:16 INFO - no previously-included directories found matching 'dist' 07:37:16 INFO - no previously-included directories found matching '.git*' 07:37:16 INFO - Successfully installed jsonschema functools32 07:37:16 INFO - Cleaning up... 07:37:16 INFO - Return code: 0 07:37:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:16 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 0x7fde356faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b21d20>, '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 0x1b22c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b230b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', '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 07:37:16 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 07:37:16 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 07:37:16 INFO - Using env: {'DISPLAY': ':0', 07:37:16 INFO - 'HOME': '/home/cltbld', 07:37:16 INFO - 'LANG': 'en_US.UTF-8', 07:37:16 INFO - 'LANGUAGE': 'en_US:en', 07:37:16 INFO - 'LOGNAME': 'cltbld', 07:37:16 INFO - 'MAIL': '/var/mail/cltbld', 07:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:16 INFO - 'MOZ_NO_REMOTE': '1', 07:37:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:16 INFO - 'NO_EM_RESTART': '1', 07:37:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:16 INFO - 'PWD': '/builds/slave/test', 07:37:16 INFO - 'SHELL': '/bin/bash', 07:37:16 INFO - 'SHLVL': '1', 07:37:16 INFO - 'TERM': 'linux', 07:37:16 INFO - 'TMOUT': '86400', 07:37:16 INFO - 'USER': 'cltbld', 07:37:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', 07:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:16 INFO - '_': '/tools/buildbot/bin/python'} 07:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:37:17 INFO - Cleaning up... 07:37:17 INFO - Return code: 0 07:37:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:17 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 0x7fde356faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b21d20>, '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 0x1b22c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b230b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', '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 07:37:17 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 07:37:17 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 07:37:17 INFO - Using env: {'DISPLAY': ':0', 07:37:17 INFO - 'HOME': '/home/cltbld', 07:37:17 INFO - 'LANG': 'en_US.UTF-8', 07:37:17 INFO - 'LANGUAGE': 'en_US:en', 07:37:17 INFO - 'LOGNAME': 'cltbld', 07:37:17 INFO - 'MAIL': '/var/mail/cltbld', 07:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:17 INFO - 'MOZ_NO_REMOTE': '1', 07:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:17 INFO - 'NO_EM_RESTART': '1', 07:37:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:17 INFO - 'PWD': '/builds/slave/test', 07:37:17 INFO - 'SHELL': '/bin/bash', 07:37:17 INFO - 'SHLVL': '1', 07:37:17 INFO - 'TERM': 'linux', 07:37:17 INFO - 'TMOUT': '86400', 07:37:17 INFO - 'USER': 'cltbld', 07:37:17 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', 07:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:17 INFO - '_': '/tools/buildbot/bin/python'} 07:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:17 INFO - Downloading/unpacking blobuploader==1.2.4 07:37:17 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 07:37:17 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 07:37:17 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 07:37:17 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 07:37:17 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 07:37:17 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 07:37:19 INFO - Downloading blobuploader-1.2.4.tar.gz 07:37:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:37:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:37:19 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 07:37:19 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 07:37:19 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 07:37:19 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 07:37:19 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 07:37:19 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 07:37:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:37:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:37:19 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 07:37:19 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 07:37:19 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 07:37:19 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 07:37:19 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 07:37:19 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 07:37:19 INFO - Downloading docopt-0.6.1.tar.gz 07:37:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:37:20 INFO - Installing collected packages: blobuploader, requests, docopt 07:37:20 INFO - Running setup.py install for blobuploader 07:37:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:37:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:37:20 INFO - Running setup.py install for requests 07:37:20 INFO - Running setup.py install for docopt 07:37:20 INFO - Successfully installed blobuploader requests docopt 07:37:20 INFO - Cleaning up... 07:37:20 INFO - Return code: 0 07:37:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:20 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 0x7fde356faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b21d20>, '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 0x1b22c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b230b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', '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 07:37:20 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 07:37:20 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 07:37:20 INFO - Using env: {'DISPLAY': ':0', 07:37:20 INFO - 'HOME': '/home/cltbld', 07:37:20 INFO - 'LANG': 'en_US.UTF-8', 07:37:20 INFO - 'LANGUAGE': 'en_US:en', 07:37:20 INFO - 'LOGNAME': 'cltbld', 07:37:20 INFO - 'MAIL': '/var/mail/cltbld', 07:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:20 INFO - 'MOZ_NO_REMOTE': '1', 07:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:20 INFO - 'NO_EM_RESTART': '1', 07:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:20 INFO - 'PWD': '/builds/slave/test', 07:37:20 INFO - 'SHELL': '/bin/bash', 07:37:20 INFO - 'SHLVL': '1', 07:37:20 INFO - 'TERM': 'linux', 07:37:20 INFO - 'TMOUT': '86400', 07:37:20 INFO - 'USER': 'cltbld', 07:37:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', 07:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:20 INFO - '_': '/tools/buildbot/bin/python'} 07:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:20 INFO - Running setup.py (path:/tmp/pip-Gxc4OP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:20 INFO - Running setup.py (path:/tmp/pip-xTVFQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:20 INFO - Running setup.py (path:/tmp/pip-bnliu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:21 INFO - Running setup.py (path:/tmp/pip-0y50sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:21 INFO - Running setup.py (path:/tmp/pip-VdDS4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:21 INFO - Running setup.py (path:/tmp/pip-hMRSJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:21 INFO - Running setup.py (path:/tmp/pip-iemxYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:21 INFO - Running setup.py (path:/tmp/pip-MAJ1D3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:21 INFO - Running setup.py (path:/tmp/pip-MO3MZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:21 INFO - Running setup.py (path:/tmp/pip-Mkgybl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:21 INFO - Running setup.py (path:/tmp/pip-HvGmgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:21 INFO - Running setup.py (path:/tmp/pip-lZClnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:21 INFO - Running setup.py (path:/tmp/pip-XwRWLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:21 INFO - Running setup.py (path:/tmp/pip-q3d3Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:21 INFO - Running setup.py (path:/tmp/pip-UKCZrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:21 INFO - Running setup.py (path:/tmp/pip-acQiFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:21 INFO - Running setup.py (path:/tmp/pip-E3qHo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:37:22 INFO - Running setup.py install for manifestparser 07:37:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:37:22 INFO - Running setup.py install for mozcrash 07:37:22 INFO - Running setup.py install for mozdebug 07:37:22 INFO - Running setup.py install for mozdevice 07:37:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:37:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:37:22 INFO - Running setup.py install for mozfile 07:37:22 INFO - Running setup.py install for mozhttpd 07:37:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:37:22 INFO - Running setup.py install for mozinfo 07:37:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:37:22 INFO - Running setup.py install for mozInstall 07:37:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:37:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:37:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:37:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:37:22 INFO - Running setup.py install for mozleak 07:37:22 INFO - Running setup.py install for mozlog 07:37:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:37:23 INFO - Running setup.py install for moznetwork 07:37:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:37:23 INFO - Running setup.py install for mozprocess 07:37:23 INFO - Running setup.py install for mozprofile 07:37:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:37:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:37:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:37:23 INFO - Running setup.py install for mozrunner 07:37:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:37:23 INFO - Running setup.py install for mozscreenshot 07:37:23 INFO - Running setup.py install for moztest 07:37:23 INFO - Running setup.py install for mozversion 07:37:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:37:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:37:23 INFO - Cleaning up... 07:37:23 INFO - Return code: 0 07:37:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:23 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')]} 07:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:23 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')]} 07:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:23 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 0x7fde356faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b21d20>, '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 0x1b22c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b230b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', '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 07:37:23 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 07:37:23 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 07:37:23 INFO - Using env: {'DISPLAY': ':0', 07:37:23 INFO - 'HOME': '/home/cltbld', 07:37:23 INFO - 'LANG': 'en_US.UTF-8', 07:37:23 INFO - 'LANGUAGE': 'en_US:en', 07:37:23 INFO - 'LOGNAME': 'cltbld', 07:37:23 INFO - 'MAIL': '/var/mail/cltbld', 07:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:23 INFO - 'MOZ_NO_REMOTE': '1', 07:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:23 INFO - 'NO_EM_RESTART': '1', 07:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:23 INFO - 'PWD': '/builds/slave/test', 07:37:23 INFO - 'SHELL': '/bin/bash', 07:37:23 INFO - 'SHLVL': '1', 07:37:23 INFO - 'TERM': 'linux', 07:37:23 INFO - 'TMOUT': '86400', 07:37:23 INFO - 'USER': 'cltbld', 07:37:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', 07:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:23 INFO - '_': '/tools/buildbot/bin/python'} 07:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:24 INFO - Running setup.py (path:/tmp/pip-pTUeeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:24 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)) 07:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:24 INFO - Running setup.py (path:/tmp/pip-vouNKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:24 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)) 07:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:24 INFO - Running setup.py (path:/tmp/pip-MN0VDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:24 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)) 07:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:24 INFO - Running setup.py (path:/tmp/pip-8moNmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:24 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)) 07:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:24 INFO - Running setup.py (path:/tmp/pip-EFghK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:24 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)) 07:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:24 INFO - Running setup.py (path:/tmp/pip-AQOdD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:24 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)) 07:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:24 INFO - Running setup.py (path:/tmp/pip-0BWxYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:24 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)) 07:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:24 INFO - Running setup.py (path:/tmp/pip-zcdA8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:24 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)) 07:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:24 INFO - Running setup.py (path:/tmp/pip-fWZtgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:24 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)) 07:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:24 INFO - Running setup.py (path:/tmp/pip-cyLVxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 07:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:24 INFO - Running setup.py (path:/tmp/pip-jElZJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:24 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)) 07:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:24 INFO - Running setup.py (path:/tmp/pip-5l_0rJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:24 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)) 07:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:24 INFO - Running setup.py (path:/tmp/pip-tZOZVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:25 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)) 07:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:25 INFO - Running setup.py (path:/tmp/pip-HimMee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:25 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)) 07:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:25 INFO - Running setup.py (path:/tmp/pip-FEl8kY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:25 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)) 07:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:25 INFO - Running setup.py (path:/tmp/pip-Cww8BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:25 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)) 07:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:25 INFO - Running setup.py (path:/tmp/pip-VBITRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:25 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)) 07:37:25 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)) 07:37:25 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)) 07:37:25 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)) 07:37:25 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)) 07:37:25 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)) 07:37:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:27 INFO - Downloading blessings-1.6.tar.gz 07:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:37:27 INFO - Installing collected packages: blessings 07:37:27 INFO - Running setup.py install for blessings 07:37:27 INFO - Successfully installed blessings 07:37:27 INFO - Cleaning up... 07:37:27 INFO - Return code: 0 07:37:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:37:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:27 INFO - Reading from file tmpfile_stdout 07:37:27 INFO - Current package versions: 07:37:27 INFO - argparse == 1.2.1 07:37:27 INFO - blessings == 1.6 07:37:27 INFO - blobuploader == 1.2.4 07:37:27 INFO - docopt == 0.6.1 07:37:27 INFO - functools32 == 3.2.3-2 07:37:27 INFO - jsonschema == 2.5.1 07:37:27 INFO - manifestparser == 1.1 07:37:27 INFO - mozInstall == 1.12 07:37:27 INFO - mozcrash == 0.17 07:37:27 INFO - mozdebug == 0.1 07:37:27 INFO - mozdevice == 0.48 07:37:27 INFO - mozfile == 1.2 07:37:27 INFO - mozhttpd == 0.7 07:37:27 INFO - mozinfo == 0.9 07:37:27 INFO - mozleak == 0.1 07:37:27 INFO - mozlog == 3.3 07:37:27 INFO - moznetwork == 0.27 07:37:27 INFO - mozprocess == 0.23 07:37:27 INFO - mozprofile == 0.28 07:37:27 INFO - mozrunner == 6.12 07:37:27 INFO - mozscreenshot == 0.1 07:37:27 INFO - mozsystemmonitor == 0.3 07:37:27 INFO - moztest == 0.7 07:37:27 INFO - mozversion == 1.4 07:37:27 INFO - psutil == 3.1.1 07:37:27 INFO - requests == 1.2.3 07:37:27 INFO - wsgiref == 0.1.2 07:37:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:27 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 0x7fde356faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b21d20>, '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 0x1b22c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b230b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', '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 07:37:27 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 07:37:27 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 07:37:27 INFO - Using env: {'DISPLAY': ':0', 07:37:27 INFO - 'HOME': '/home/cltbld', 07:37:27 INFO - 'LANG': 'en_US.UTF-8', 07:37:27 INFO - 'LANGUAGE': 'en_US:en', 07:37:27 INFO - 'LOGNAME': 'cltbld', 07:37:27 INFO - 'MAIL': '/var/mail/cltbld', 07:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:27 INFO - 'MOZ_NO_REMOTE': '1', 07:37:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:27 INFO - 'NO_EM_RESTART': '1', 07:37:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:27 INFO - 'PWD': '/builds/slave/test', 07:37:27 INFO - 'SHELL': '/bin/bash', 07:37:27 INFO - 'SHLVL': '1', 07:37:27 INFO - 'TERM': 'linux', 07:37:27 INFO - 'TMOUT': '86400', 07:37:27 INFO - 'USER': 'cltbld', 07:37:27 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', 07:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:27 INFO - '_': '/tools/buildbot/bin/python'} 07:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:27 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)) 07:37:27 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)) 07:37:27 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)) 07:37:27 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)) 07:37:27 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)) 07:37:27 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)) 07:37:27 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)) 07:37:27 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)) 07:37:27 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)) 07:37:27 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)) 07:37:27 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)) 07:37:27 INFO - Cleaning up... 07:37:27 INFO - Return code: 0 07:37:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde356faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b21d20>, '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 0x1b22c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b230b0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', '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 07:37:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:37:27 INFO - Using env: {'DISPLAY': ':0', 07:37:27 INFO - 'HOME': '/home/cltbld', 07:37:27 INFO - 'LANG': 'en_US.UTF-8', 07:37:27 INFO - 'LANGUAGE': 'en_US:en', 07:37:27 INFO - 'LOGNAME': 'cltbld', 07:37:27 INFO - 'MAIL': '/var/mail/cltbld', 07:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:27 INFO - 'MOZ_NO_REMOTE': '1', 07:37:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:27 INFO - 'NO_EM_RESTART': '1', 07:37:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:27 INFO - 'PWD': '/builds/slave/test', 07:37:27 INFO - 'SHELL': '/bin/bash', 07:37:27 INFO - 'SHLVL': '1', 07:37:27 INFO - 'TERM': 'linux', 07:37:27 INFO - 'TMOUT': '86400', 07:37:27 INFO - 'USER': 'cltbld', 07:37:27 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', 07:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:27 INFO - '_': '/tools/buildbot/bin/python'} 07:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:37:28 INFO - Cleaning up... 07:37:28 INFO - Return code: 0 07:37:28 INFO - Running post-action listener: _resource_record_post_action 07:37:28 INFO - Running post-action listener: _start_resource_monitoring 07:37:28 INFO - Starting resource monitoring. 07:37:28 INFO - [mozharness: 2016-08-30 14:37:28.146351Z] Finished create-virtualenv step (success) 07:37:28 INFO - [mozharness: 2016-08-30 14:37:28.146810Z] Running install step. 07:37:28 INFO - Running pre-action listener: _resource_record_pre_action 07:37:28 INFO - Running main action method: install 07:37:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:28 INFO - Reading from file tmpfile_stdout 07:37:28 INFO - Detecting whether we're running mozinstall >=1.0... 07:37:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:37:28 INFO - Reading from file tmpfile_stdout 07:37:28 INFO - Output received: 07:37:28 INFO - Usage: mozinstall [options] installer 07:37:28 INFO - Options: 07:37:28 INFO - -h, --help show this help message and exit 07:37:28 INFO - -d DEST, --destination=DEST 07:37:28 INFO - Directory to install application into. [default: 07:37:28 INFO - "/builds/slave/test"] 07:37:28 INFO - --app=APP Application being installed. [default: firefox] 07:37:28 INFO - mkdir: /builds/slave/test/build/application 07:37:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:37:44 INFO - Reading from file tmpfile_stdout 07:37:44 INFO - Output received: 07:37:44 INFO - /builds/slave/test/build/application/firefox/firefox 07:37:44 INFO - Running post-action listener: _resource_record_post_action 07:37:44 INFO - [mozharness: 2016-08-30 14:37:44.577814Z] Finished install step (success) 07:37:44 INFO - [mozharness: 2016-08-30 14:37:44.578102Z] Running run-tests step. 07:37:44 INFO - Running pre-action listener: _resource_record_pre_action 07:37:44 INFO - Running main action method: run_tests 07:37:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:44 INFO - Python 2.7.3 07:37:44 INFO - Return code: 0 07:37:44 INFO - grabbing minidump binary from tooltool 07:37: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')]} 07:37:44 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 0x1b21d20>, '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 0x1b22c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b230b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:44 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 07:37:44 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 07:37:44 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 07:37:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:44 INFO - Return code: 0 07:37:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:37:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:37:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:44 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/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 07:37:44 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/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 07:37:44 INFO - Using env: {'DISPLAY': ':0', 07:37:44 INFO - 'HOME': '/home/cltbld', 07:37:44 INFO - 'LANG': 'en_US.UTF-8', 07:37:44 INFO - 'LANGUAGE': 'en_US:en', 07:37:44 INFO - 'LOGNAME': 'cltbld', 07:37:44 INFO - 'MAIL': '/var/mail/cltbld', 07:37:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:44 INFO - 'MOZ_NO_REMOTE': '1', 07:37:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:44 INFO - 'NO_EM_RESTART': '1', 07:37:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:44 INFO - 'PWD': '/builds/slave/test', 07:37:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:44 INFO - 'SHELL': '/bin/bash', 07:37:44 INFO - 'SHLVL': '1', 07:37:44 INFO - 'TERM': 'linux', 07:37:44 INFO - 'TMOUT': '86400', 07:37:44 INFO - 'USER': 'cltbld', 07:37:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171', 07:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:44 INFO - '_': '/tools/buildbot/bin/python'} 07:37:44 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/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 07:37:44 INFO - mozversion application_buildid: 20160829095331 07:37:44 INFO - mozversion application_changeset: 7293879d87d780790cb0f67e98226b7d4de6d4e1 07:37:44 INFO - mozversion application_display_name: Nightly 07:37:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:44 INFO - mozversion application_name: Firefox 07:37:44 INFO - mozversion application_remotingname: firefox 07:37:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 07:37:44 INFO - mozversion application_vendor: Mozilla 07:37:44 INFO - mozversion application_version: 51.0a1 07:37:44 INFO - mozversion platform_buildid: 20160829095331 07:37:44 INFO - mozversion platform_changeset: 7293879d87d780790cb0f67e98226b7d4de6d4e1 07:37:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 07:37:44 INFO - mozversion platform_version: 51.0a1 07:37:44 INFO - using testdate: 1472567864 07:37:44 INFO - actual date: 1472567864 07:37:44 INFO - starting webserver on 'localhost:44279' 07:37:44 INFO - SUITE-START | Running 2 tests 07:37:44 INFO - TEST-START | dromaeo_css 07:37:44 INFO - operating with platform_type : linux_ 07:37:44 INFO - Initialising browser for dromaeo_css test... 07:37:44 INFO - TEST-INFO | started process 5554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwBZmHS/profile http://localhost:44279/getInfo.html) 07:37:49 INFO - PROCESS | 5554 | __metrics Screen width/height:1600/1200 07:37:49 INFO - PROCESS | 5554 | colorDepth:24 07:37:49 INFO - PROCESS | 5554 | Browser inner width/height: 1024/697 07:37:49 INFO - PROCESS | 5554 | __metrics 07:37:50 INFO - PROCESS | 5554 | 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" 07:37:50 INFO - PROCESS | 5554 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:37:50 INFO - PROCESS | 5554 | console.error: PushService: 07:37:50 INFO - PROCESS | 5554 | stateChangeProcessEnqueue: Error transitioning state 07:37:50 INFO - PROCESS | 5554 | UnknownError 07:37:51 INFO - TEST-INFO | 5554: exit 0 07:37:51 INFO - Browser initialized. 07:37:51 INFO - Running cycle 1/1 for dromaeo_css test... 07:37:51 INFO - TEST-INFO | started process 5637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwBZmHS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:03 INFO - PROCESS | 5637 | RSS: Main: 181460992 07:38:03 INFO - PROCESS | 5637 | 07:38:54 INFO - PROCESS | 5637 | 1472567934593 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] 07:41:07 INFO - PROCESS | 5637 | Cycle 1(1): loaded http://localhost:44279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44279/tests/dromaeo/cssquery-ext.html) 07:41:09 INFO - PROCESS | 5637 | RSS: Main: 279461888 07:41:09 INFO - PROCESS | 5637 | 07:44:11 INFO - PROCESS | 5637 | Cycle 1(1): loaded http://localhost:44279/tests/dromaeo/cssquery-ext.html (next: http://localhost:44279/tests/dromaeo/cssquery-jquery.html) 07:44:12 INFO - PROCESS | 5637 | RSS: Main: 271757312 07:44:12 INFO - PROCESS | 5637 | 07:47:14 INFO - PROCESS | 5637 | Cycle 1(1): loaded http://localhost:44279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44279/tests/dromaeo/cssquery-mootools.html) 07:47:15 INFO - PROCESS | 5637 | RSS: Main: 218828800 07:47:15 INFO - PROCESS | 5637 | 07:50:17 INFO - PROCESS | 5637 | Cycle 1(1): loaded http://localhost:44279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44279/tests/dromaeo/cssquery-prototype.html) 07:50:18 INFO - PROCESS | 5637 | RSS: Main: 260210688 07:50:18 INFO - PROCESS | 5637 | 07:53:21 INFO - PROCESS | 5637 | Cycle 1(1): loaded http://localhost:44279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44279/tests/dromaeo/cssquery-yui.html) 07:53:21 INFO - PROCESS | 5637 | RSS: Main: 218972160 07:53:21 INFO - PROCESS | 5637 | 07:56:25 INFO - PROCESS | 5637 | Cycle 1(1): loaded http://localhost:44279/tests/dromaeo/cssquery-yui.html (next: http://localhost:44279/tests/dromaeo/cssquery-dojo.html) 07:56:25 INFO - PROCESS | 5637 | RSS: Main: 307748864 07:56:25 INFO - PROCESS | 5637 | 07:56:25 INFO - PROCESS | 5637 | __start_tp_report 07:56:25 INFO - PROCESS | 5637 | _x_x_mozilla_page_load 07:56:25 INFO - PROCESS | 5637 | _x_x_mozilla_page_load_details 07:56:25 INFO - PROCESS | 5637 | |i|pagename|runs| 07:56:25 INFO - PROCESS | 5637 | |0;dojo.html;2576.4331846993655;2580.25172699917;2596.2470883443802;2606.8826902789374;2615.4246065865505;4635.096156249524;4637.5594318539725;4693.647976401767;4712.151812673713;4749.548792864676;4700.200965835807;4722.7874745636445;4766.142094423011;4766.332713420115;4781.043791241748;4290.313549832027;4309.159713855799;4357.193919124956;4419.801108950089;4432.135733531963;4327.199468098412;4357.106793107421;4377.015171586383;4407.052483716;4410.470743510783;4279.358096285582;4318.632916202095;4323.762193079411;4347.5217726050105;4376.343548467724;4285.571442855689;4286.54991225923;4328.394024836525;4376.671749618791;4386.166628340605;4253.340732186516;4314.935275970863;4320.3951446797155;4328.826846926119;4379.912401751979;4582.450105987303;4699.577038066556;4729.621630269605;4733.100710864925;4744.430668319824;4960.503949605047;4982.7259500727805;5002.099622068026;5005.499450055002;5017.247412888059;5025.748712564357;5040.984621480392;5043.293938848564;5058.873528161788;5059.241113832918;4547.3179023146795;4675.251959686434;4700.9059818803435;4711.905761884743;4731.739754313477;5172.508611681884;5201.739913004335;5217.7912883485;5278.498542638443;5284.682919024871;4972.72650004246;4979.775910084055;4983.825566105169;4989.401271847401;5050.797968081236;4955.677880937727;5021.698698078127;5069.923951140736;5073.492650734897;5076.873078173076;4904.8773780655765;4956.306117143603;4970.378702662168;5009.499050095034;5010.048090862724;4931.50684931504;4942.1104201244125;4946.08497427977;4946.455889852114;5011.924821127686;4200;4231.597998190167;4232.682548808852;4245.617894389458;4292.055747735493;3705.8517659293866;3739.08392443853;3753.3806921858136;3804.7336686432236;3844.3656796628243;4404.823807047746;4410.42664453619;4410.889727756832;4450.5104438511735;4463.4420697412825;5013.097642424399;5113.923291150636;5125.410577783603;5130.12787826063;5134.05020071288;4311.849085282063;4340.045190058182;4394.560543945579;4402.801873915681;4462.0183559616835;4520.118576877478;4568.1548913451115;4568.954310456853;4573.108243892409;4628.305754136906;4634.745089020002;4758.571728544378;4759.0719809636785;4761.476237613929;4807.399075115611;5008.624353173599;5038.798448062036;5050.72221027847;5166;5187.507186817246;4797.784099715452;4798.184308667465;4799.112164249625;4848.854534363974;4856.077345304381;5002.474740152377;5038.319826823332;5038.697678139323;5039.974800125976;5043.621728370314;4988.152014157529;5040.16837221869;5049.318342023927;5090.567301779391;5157.303763991813;4969.751512424436;4972.975135124301;4977.502249775139;4977.726225057511;5021.598272138293;4921.212605983025;4928.063667903087;4979.053979743837;4979.302897594413;5035.899282014266;4725.6219502439035;4818.084563932842;4872.049950259665;4902.803887844446;4911.214205727067;5013.147764880052;5017.37282839645;5019.623528235324;5020;5048.091343558195;4798.424189097331;4891.388576427947;4900.362952816111;4904.705717656952;4937.21004639256 07:56:25 INFO - PROCESS | 5637 | |1;ext.html;571.8370264474624;576.584858901591;583.4807021750643;585.607642879271;586.2173997713053;27350.316242093933;29889;29924.700752992463;36278.63721362786;38116.42825357622;38787;38826.22347553054;39160.60839391605;39271.60728392715;39313.23090460936;7555.131159916611;7710.498817576839;7712.383009359266;7712.421568382366;7715.151333353327;7101.076860008217;7524.661390237453;9732.51337433129;9930.702078937607;9972.800543989117;10097.040781125781;10153.136983356424;10159.6952091437;10164.64423745169;10176.694699159;9912.207023438144;9916.801663966753;9968.601255949754;9969.601215951354;9979.101880830687;9753.366031207948;9825.606975720963;9839.90160098397;9841.704748857546;9843.163331116864;36841.63158368409;37116.44325335095;37146.8142659285;37198.25603487942;37213.62786372156;2786.70739572346;2825.6891741908375;2888.8266703997615;3039.6200474940633;3347.297067615804;27537.586936195974;27575.690917089876;27907.441851163065;28114;29529.409411811645;3472.6527347265323;3508.438649816017;3510.1224693826543;3546.415445728943;3600.5499312585926;242942;243855;244114;245109;245125;49413.50586494161;49672.25491617629;49749;49757.75121124371;49826.25260621094;31389.37221255562;32493.35013299768;32546.674533254365;34498.310033799185;34509.827450862584;12789.808152877527;12941.870581294255;12953.54662586805;12958.222506649443;12958.28729419891;9521.190698790542;10253.74365640865;10372;10377.117944974761;10381.2214083944;16761.7485737714;17363.3054677814;17387.391441299747;18014;18020.54948626295;6663.833404164838;6809.242256885969;6811.659417029228;6974.197967233732;6975.581465112109;771.4445599168589;868.5353335965228;924.4638109896244;925.921296689789;929.7350255177378;26375.73624263733;26383.208503744918;27447.451050979267;27504;27700;901.2204443156753;946.2713710443059;948.8956214816365;984.6504490905626;1038.4911393417322;13481.59555213345;14244.928775356264;14373.78439323411;14636.268186590627;14690.853091469162;374140;376322;376542;376892;377176;46544.53455465402;46948.7652561735;46978.5302146981;47008.52991470041;47057.29414058792;1064.5528877871313;1148.2593727046176;1161.1639619474133;1183.621241202807;1184.224333061846;26081.73918260869;26651.466970660866;27694;28378.57432138478;28829.85585072061;39468.2106357877;39863.60136398599;39903.600963989986;39993.2001359977;40009;294419;294786;294931;295258;295371;23788.431735239854;24797.380065498506;24798.628020579345;25842.87078564595;25979.74020259773;39768.2046359077;40036.1992760149;40237;40465.79767101146;41569.1686166281;34037.319253615286;34321.65678343185;34491;34610.307793844484;34672.479912801835;33558.328833423686;33696.49455258222;33773.83113084419;33829.32341353208;33904;33365.666343336256;33933.15167120842;34375.656243437246;34382.31235375329;34502.48246276258;30191.245218869703;31123.37753244968;31134.844325778227;31867.20331991719;32178.67821321757;23516.6472502916;24080;24333.27000189997;24355.26934191977;24533.386665332797 07:56:25 INFO - PROCESS | 5637 | |2;jquery.html;334.7623187536849;351.2413187514968;352.8447483107434;353.25463272495034;380.0479798105745;12367.814482782755;12984.54554090607;13214.339283035857;14944.171773008522;17138.742918856227;12094.153409261333;12333.136680432352;13834;14312.427502899898;14438.350274237659;4558.863234102965;4563.931541026887;4575.245084561044;4698.530146985308;4700.529947005306;4575.107853968478;4619.930701039487;4642.512536183686;4643.466001409831;4645.744484053375;3418.2308980479315;4646.140464014151;5062.645614806965;5320.4679532046675;5364.946350536503;5311.468853114677;5320.361556613192;5321.255024296602;5325.174597937287;5326.360836699582;4875.171220892456;4986.700797952099;4990.575801056878;4997.100521906055;5012.649114561982;11097.611583594535;11151.832722509169;12455.688607784787;18756.81243187578;18861.905690471598;1867.7508667780771;2003.9799602003939;2045.6931460280928;2059.423361458794;2420.9152679656127;9336.412809822346;9361.906380936172;9644.18024467921;9685.70942871715;10620.309679870861;1478.290420598108;1532.1266877879614;1540.1606124662087;1565.2486806333025;1587.1191488723753;66349.3365066348;69939.65030174867;70020;70054;71526.28473715248;9755.414675119515;9887.555060022316;9950.601975921027;10202.38785672862;10273.948630256951;13420.664483387993;13470.191788492722;13482.595522134352;13513.594592162252;13524.729505409836;6729.4764463326255;6974.860502789916;7029.22678505364;7145;7157.320054594805;6219.378062193744;6572.474202063823;6743.460523158135;6774.93225067743;6797.422219111332;4025.9194816103513;4314.309710446313;4324.697271190987;4330.112326972963;4392.978035109804;1704.573856535866;1732.6101627133794;1743.9564010899828;1774.210476338017;1832.9633407331778;846.5597889097635;850.5364576305805;893.1381217125505;906.2523418180028;921.764949937775;16433.506994790176;16640.50078497647;17041.48875533736;17153.914230429018;17367.47897563075;806.4717609965364;817.3869597801648;824.3652387661467;836.2975100915139;840.0423517190408;8899.332550058642;9015.819683606422;9557.665481708107;9682.90317096834;9754.0733630305;360961;362826;366076;366967;377228;73998.63000684962;76039;76639.61680191563;78645;79381;856.0839901305668;876.6975393489236;878.4685265414332;878.4773060029272;879.6525372477963;14904.18027008525;15336.309866055832;16767;16800.831991679926;16881.746773798648;27397.123302053795;27966.440671186054;37119.25761484701;37244;39030;45920;48127.75936120297;48376.27435588539;49631.503684962685;49680.75159624179;6667.199936007516;6827.112475378368;7009.1939426966555;7407.444441667004;7459.36595389398;10777.676669699922;12361.443735032126;12481.188722732993;12602.991760659308;12707.87292127067;9690.903090969001;9947.253955953478;10220.02909723575;10302.484875756032;10398.896011040095;10335.276530643083;10676.252662313564;10889.945550272198;10906.563737450413;10959.232853700165;10561.20790940698;10603.734906627396;10774.037139786307;10862.619808306672;11091.112710983263;7721.420893432903;7731.38148948094;7787.29914307715;8116.107228205011;8153.429259951747;9426.340156189;10338;10393.480325983519;10515.263931525025;10734.785304293715 07:56:25 INFO - PROCESS | 5637 | |3;mootools.html;1220.4751956658633;1304.6673098359918;1361.8501964783877;1361.8706222908822;1649.0353143411103;7311.999999999994;7679.57762323072;7712.421568382373;7946.602669866513;7952.761417157494;7782.455228134033;7882.330001949841;7885.1326354101;7888.842223155533;7890.408219383555;2055.7122002919605;2078.0960282277183;2080.760712518065;2084.47888027993;2087.4155236533793;2130.0627723801554;2164.83763717721;2189.824814014875;2199.8900054997266;2200.6148923938326;2082.146320008797;2084.770675225724;2095.528506086134;2095.8952052397394;2128.45724340293;2091.8221951134174;2120.5122821751083;2122.649762789138;2129.968050479244;2130.4141361125658;2040.4286799696108;2096.444442222812;2124.107874692633;2134.445044288481;2139.775323591016;7708.807279818049;7824.452288339819;7835.725749598737;7842.333401660866;7853.725119620786;4289.4852617685765;4455.754933478657;4477.552244775529;4496.235639941217;4507.5943165115295;2949.9262518437213;3037.726604605596;3077.353755711303;3100.410921924827;3105.223694076481;946.9384490008127;950.5294879034852;963.5086106085877;965.8502932045544;975.059067999384;10569.207309451745;10656.360618362845;10671.57313707443;10673.679789606324;10688.46557672121;3966.4050392440786;4087.7547347159266;4130.876073717794;4224.239636865394;4237.110206856594;8344.165583441607;8467.237948584658;8481.660733570588;8486.32109431244;8489.235968762841;4421.226285400042;4433.6009759121835;4439.511653718088;4441.977790111094;4443.200223959654;3581.71346292296;3684.4399532386046;3751;4100.036491424513;4100.446439730657;3339.5825521809775;3460.1003739028033;3473.9826300868335;3507.6667716566885;3530.188056746911;1025.123519390925;1029.6705054382526;1037.4708898461688;1041.7812259425455;1045.581767293089;800.1318569352202;806.9394795390369;809.8258874342044;812.3095368936475;828.2587084559285;5149.897002059938;5152.433232344439;5253.763580638881;5278.419373868871;5406.702631355313;412.2085595656347;413.3448484152652;428.2612493448838;429.79155109771733;432.4896621986024;3443.1220038889924;3500.369933411959;3552.609212986569;3625.9456108158397;3783.7729736215365;9209.309301802392;9802.75493112678;9824.901750982399;9837.508124593742;9837.55730992107;9671.226301895831;9681.951590242004;9715;9743.269254805919;9775.804483910424;7284.745033923893;7336.413086953031;7411.777646670608;7415.221401752846;7419.2209817969415;5101.107306221322;5107.310513080835;5189.844304670866;5242.475752424727;5348.572114230775;8782.956085219534;8851.33614978892;8976.192142707188;9001.729948101567;9124.270058395445;8913.153250441197;9040.63837446521;9096.590653420744;9188.219001384958;9203.677871274473;6392.105105285357;6449;6457.806265812033;6465.3857883501;6468.062130991074;7043.506954513135;7077.929220707933;7157.534760240567;7465.7013719450615;7527.3601743850195;6620.3710647488415;6631.204255489372;6632.668366581748;6637.867242655217;6704.161979752531;6449.645269510034;6449.871002580016;6455.548111632328;6461.160049193575;6624.039514270307;5840.357560668238;5966.0454327307425;6029.095635654687;6162.198914141133;6164.383561643979;4474.574915383034;4546.590806827401;4558.475775285885;4622.815087396601;4623.237165867594;4422.77886105687;4468.285074388083;4654.18551753435;4769.046190761792;4778.068276686013 07:56:25 INFO - PROCESS | 5637 | |4;prototype.html;277.43680328932265;281.36692442005494;285.54883284410636;293.3048674641101;299.742221689347;4630.421197350332;4777.283407488879;4806.615470762339;4824.710517368956;4859.562639362461;4605.148047611195;4718.8584342469785;4744.675109196494;4746.264329028997;4764.880877978052;3753.8738378486482;3759.8684046058393;3773.9811300943456;3778.244351129771;3778.565464971536;3597.874074407396;3630.56433228013;3762.134709016928;3786.602406747293;3808.504894363729;3737.663610275075;3741.6071312512204;3762.529683789526;3763.1156678180605;3764.868229611964;3727.7763334200035;3747.775133491986;3771.15149091455;3785.413260944558;3786.5077539919907;3303.719183869374;3306.3056758080834;3312.4368857294317;3317.96682033179;3318.1041118898;4495.336725411586;4621;4639.86080417588;4670.229412146991;4678.6257099432305;4255.2978758504805;4269.615734583902;4269.765162916038;4280.357946308048;4289.828406863753;4975.353204083446;5005.199168133081;5008.724520151391;5030.748462576857;5038.244263360489;3337.5327454156436;3524.4713293006;3641.2353405784816;3652.9954262578003;3655.963440365589;5214.253225169573;5228.738563071869;5232.869178270574;5234.110201265832;5275;3643.981780091083;3666.65166809158;3666.7249956253386;3678.2459595782802;3684.9815750921075;3720.9627903720616;3726.9627303727157;3728.254349130185;3747.4940882980995;3758.229562939591;4155.252054630135;4206.116715489781;4212.705110642226;4214.840918747369;4226.619604235633;4968.683298925787;4980.352554167935;4987.304316532396;4989.775460104232;4992.676940610741;1181.255808840425;1225.136278923357;1250.6748245456247;1258.9748205035849;1265.7721610110268;827.8302947895667;846.9068402475723;854.2781349759443;864.9135086491301;865.6667183134413;4435.1351486459835;4441.244988351988;4442.311441726538;4478.552144785495;4498.235299999008;5144.845654630367;5171.2501687255135;5184.585233181412;5196.285225875452;5205.713685747244;4287.614114729689;4426.601605855489;4515.480719717275;4535.365048893158;4543.954560454419;2759.889604415801;2772.6811416686937;2775.9583606245924;2776.194903478009;2781.332480204777;4838.129136755418;4877.268409738496;4883.755812209375;4891.603114473954;4891.657583969088;5086.821961231413;5272.182811664198;5273.393559740679;5278.97360513195;5280.313559237275;4829;4848.151573474557;4858.878528036827;4862.82980095695;4870.172070748053;5048.570871475966;5184.274201611702;5199.76601052946;5211.374635043819;5217.8173763918085;5016.993202718942;5023.497650234947;5024.492652204251;5056.367954005749;5057.963117560817;4826.32431459603;4835.806567737392;4838.935434204469;4840.6127509799835;4858.222684370484;3660.8352624131444;3675.6875665568728;3691.4093745000673;3698.6116457772623;3701.1302343948614;5021.573166280907;5130.56344223618;5158.535731784157;5169.741512924414;5183.896322073462;5004.249362595494;5006.496751624188;5014.623903207201;5024.171011783015;5025.447200807981;5014.172661510956;5042.84871453857;5051.520105589963;5057.519535644108;5063.493650634907;4684.227102528181;4715.669903106749;4808.879778005438;4878.170710979071;4890.046440943982;5032.949670503248;5056.367954005749;5062.746862656926;5067.592893375617;5092.567131793839;4954.455009948831;4957.182064959241;4958.404991401055;4969.627277954096;4975.7512124392915 07:56:25 INFO - PROCESS | 5637 | |5;yui.html;620.6865532905882;622.3030206169092;688.4320435640597;705.8411857332101;731.3965978068094;11557.190996630228;12788.104832661717;12921.483140674374;12927.67680807978;12988.870111298884;12790.552330668428;12878.3560821959;12886.033547483952;12887.226766394024;12903;595.0598055072975;721.2354903801961;731.8865575835754;732.8351120997772;736.6095969136367;743.6170372258291;744.3821628048706;751.5190278221943;751.7331347371686;751.868423025971;785.5090568394753;787.9881801772977;789.171370061436;789.763071078677;790.4269404681588;633.4109278371113;649.5615459564775;786.8426314737076;786.9370450363986;787.8148635070754;476.5948943398084;476.6830058011418;549.881775418287;566.8922904648103;570.5749216833444;11742.236754610924;11793.29240245588;11820.23168494045;11840.881591184065;11880.940595297054;12207.572734954323;12847.614571562775;12916.612501624872;13017.28404937728;13331.933340333333;11286.887131128748;11611;11736.237144585575;12088.818667719992;12173.756524869454;3958.9010274743073;3996.100877302613;4066.755994640331;4100.897477563055;4144.150449157915;63661;65477;65552.67223663851;65649.67175164094;66101.33898661;9434.386764860263;9689.70930872075;10321.74195645115;10422.21833362501;10496.370217786956;17531.73702394465;17722.46832595024;17784.644307114046;17800.46598602044;17809.376671816422;5896.204012458349;6056.727447264883;6188.8762224755255;6297.4962003039645;6354.872902541923;3517.718582513393;3532.540769699974;3602.693771029492;3630.455431685268;3759.2481503698823;2748.8900443982416;2868.0965495868736;2868.4119755450083;2872.2101422108667;2873.5689646552764;513.9177731562932;517.1312195511576;526.9829229586858;527.6543863769238;535.5180337696105;500.35204410288765;519.2107995846293;522.0342366621795;523.0062880526954;535.199876185098;6772.153480814898;7090.716371345192;7232.240614735482;7345.562716906296;7413.36986356155;476.3141076849326;486.7833813952757;491.25329499161074;497.9377577802775;507.75373943637305;3238.4008958342783;3343.6154842192973;3368.3335066015334;3440.1055725511546;3523.295340931824;99040.00959990452;102981.48509257406;103085.48457257665;104541.47729261305;105513.47243263734;53377.46622533802;59289;88000;88440;89207.10792892118;76070;76796;76955.2304476948;77419.61290193626;78657.60671196607;6575.572587781779;6608.273089960005;6623.801285961236;6629.806882474689;6793.354631310018;45599.900037485946;46520.53479465297;47142;47274.76362618165;47624.761876191784;58313;58425;63934.68032659807;65150.34849651632;65867.34132658804;8635.87046194295;8728.956355218183;8741.825163496822;8777.122287771172;9026.45841249527;9173.908260917306;9196;9285.72142835716;9802.65690700822;9890.159336456481;9316.48759318244;9461.810763784824;9531.65474051949;9776;9802.607895684378;9711.465869376969;11514.481848316678;11610.70973225676;11890;11891.702707432383;11003.779924401628;11472.426378681199;11700.88299116998;11998.820017699916;12302.446389912297;8561.400701950804;8729.694460693845;8949.555249248637;9254.814903702023;9357.625694972125;8021.839563208587;8041.004653750097;8497.447665901944;8530.011257630998;8794.956025219833 07:56:25 INFO - PROCESS | 5637 | __end_tp_report 07:56:25 INFO - PROCESS | 5637 | __start_cc_report 07:56:25 INFO - PROCESS | 5637 | _x_x_mozilla_cycle_collect,1006 07:56:25 INFO - PROCESS | 5637 | __end_cc_report 07:56:25 INFO - PROCESS | 5637 | __startTimestamp1472568985253__endTimestamp 07:56:25 INFO - PROCESS | 5637 | 07:56:25 INFO - PROCESS | 5637 | ------- Summary: start ------- 07:56:25 INFO - PROCESS | 5637 | Number of tests: 6 07:56:25 INFO - PROCESS | 5637 | 07:56:25 INFO - PROCESS | 5637 | [#0] dojo.html Cycles:165 Average:4675.91 Median:4798.42 stddev:496.84 (10.4%) stddev-sans-first:470.28 07:56:25 INFO - PROCESS | 5637 | Values: 2576.4 2580.3 2596.2 2606.9 2615.4 4635.1 4637.6 4693.6 4712.2 4749.5 4700.2 4722.8 4766.1 4766.3 4781.0 4290.3 4309.2 4357.2 4419.8 4432.1 4327.2 4357.1 4377.0 4407.1 4410.5 4279.4 4318.6 4323.8 4347.5 4376.3 4285.6 4286.5 4328.4 4376.7 4386.2 4253.3 4314.9 4320.4 4328.8 4379.9 4582.5 4699.6 4729.6 4733.1 4744.4 4960.5 4982.7 5002.1 5005.5 5017.2 5025.7 5041.0 5043.3 5058.9 5059.2 4547.3 4675.3 4700.9 4711.9 4731.7 5172.5 5201.7 5217.8 5278.5 5284.7 4972.7 4979.8 4983.8 4989.4 5050.8 4955.7 5021.7 5069.9 5073.5 5076.9 4904.9 4956.3 4970.4 5009.5 5010.0 4931.5 4942.1 4946.1 4946.5 5011.9 4200.0 4231.6 4232.7 4245.6 4292.1 3705.9 3739.1 3753.4 3804.7 3844.4 4404.8 4410.4 4410.9 4450.5 4463.4 5013.1 5113.9 5125.4 5130.1 5134.1 4311.8 4340.0 4394.6 4402.8 4462.0 4520.1 4568.2 4569.0 4573.1 4628.3 4634.7 4758.6 4759.1 4761.5 4807.4 5008.6 5038.8 5050.7 5166.0 5187.5 4797.8 4798.2 4799.1 4848.9 4856.1 5002.5 5038.3 5038.7 5040.0 5043.6 4988.2 5040.2 5049.3 5090.6 5157.3 4969.8 4973.0 4977.5 4977.7 5021.6 4921.2 4928.1 4979.1 4979.3 5035.9 4725.6 4818.1 4872.0 4902.8 4911.2 5013.1 5017.4 5019.6 5020.0 5048.1 4798.4 4891.4 4900.4 4904.7 4937.2 07:56:25 INFO - PROCESS | 5637 | 07:56:25 INFO - PROCESS | 5637 | [#1] ext.html Cycles:180 Average:44934.48 Median:34378.98 stddev:81484.69 (237.0%) stddev-sans-first:81645.20 07:56:25 INFO - PROCESS | 5637 | Values: 571.8 576.6 583.5 585.6 586.2 27350.3 29889.0 29924.7 36278.6 38116.4 38787.0 38826.2 39160.6 39271.6 39313.2 7555.1 7710.5 7712.4 7712.4 7715.2 7101.1 7524.7 9732.5 9930.7 9972.8 10097.0 10153.1 10159.7 10164.6 10176.7 9912.2 9916.8 9968.6 9969.6 9979.1 9753.4 9825.6 9839.9 9841.7 9843.2 36841.6 37116.4 37146.8 37198.3 37213.6 2786.7 2825.7 2888.8 3039.6 3347.3 27537.6 27575.7 27907.4 28114.0 29529.4 3472.7 3508.4 3510.1 3546.4 3600.5 242942.0 243855.0 244114.0 245109.0 245125.0 49413.5 49672.3 49749.0 49757.8 49826.3 31389.4 32493.4 32546.7 34498.3 34509.8 12789.8 12941.9 12953.5 12958.2 12958.3 9521.2 10253.7 10372.0 10377.1 10381.2 16761.7 17363.3 17387.4 18014.0 18020.5 6663.8 6809.2 6811.7 6974.2 6975.6 771.4 868.5 924.5 925.9 929.7 26375.7 26383.2 27447.5 27504.0 27700.0 901.2 946.3 948.9 984.7 1038.5 13481.6 14244.9 14373.8 14636.3 14690.9 374140.0 376322.0 376542.0 376892.0 377176.0 46544.5 46948.8 46978.5 47008.5 47057.3 1064.6 1148.3 1161.2 1183.6 1184.2 26081.7 26651.5 27694.0 28378.6 28829.9 39468.2 39863.6 39903.6 39993.2 40009.0 294419.0 294786.0 294931.0 295258.0 295371.0 23788.4 24797.4 24798.6 25842.9 25979.7 39768.2 40036.2 40237.0 40465.8 41569.2 34037.3 34321.7 34491.0 34610.3 34672.5 33558.3 33696.5 33773.8 33829.3 33904.0 33365.7 33933.2 34375.7 34382.3 34502.5 30191.2 31123.4 31134.8 31867.2 32178.7 23516.6 24080.0 24333.3 24355.3 24533.4 07:56:25 INFO - PROCESS | 5637 | 07:56:25 INFO - PROCESS | 5637 | [#2] jquery.html Cycles:180 Average:23130.79 Median:4475.92 stddev:60757.55 (1357.4%) stddev-sans-first:60903.88 07:56:25 INFO - PROCESS | 5637 | Values: 334.8 351.2 352.8 353.3 380.0 12367.8 12984.5 13214.3 14944.2 17138.7 12094.2 12333.1 13834.0 14312.4 14438.4 4558.9 4563.9 4575.2 4698.5 4700.5 4575.1 4619.9 4642.5 4643.5 4645.7 3418.2 4646.1 5062.6 5320.5 5364.9 5311.5 5320.4 5321.3 5325.2 5326.4 4875.2 4986.7 4990.6 4997.1 5012.6 11097.6 11151.8 12455.7 18756.8 18861.9 1867.8 2004.0 2045.7 2059.4 2420.9 9336.4 9361.9 9644.2 9685.7 10620.3 1478.3 1532.1 1540.2 1565.2 1587.1 66349.3 69939.7 70020.0 70054.0 71526.3 9755.4 9887.6 9950.6 10202.4 10273.9 13420.7 13470.2 13482.6 13513.6 13524.7 6729.5 6974.9 7029.2 7145.0 7157.3 6219.4 6572.5 6743.5 6774.9 6797.4 4025.9 4314.3 4324.7 4330.1 4393.0 1704.6 1732.6 1744.0 1774.2 1833.0 846.6 850.5 893.1 906.3 921.8 16433.5 16640.5 17041.5 17153.9 17367.5 806.5 817.4 824.4 836.3 840.0 8899.3 9015.8 9557.7 9682.9 9754.1 360961.0 362826.0 366076.0 366967.0 377228.0 73998.6 76039.0 76639.6 78645.0 79381.0 856.1 876.7 878.5 878.5 879.7 14904.2 15336.3 16767.0 16800.8 16881.7 27397.1 27966.4 37119.3 37244.0 39030.0 45920.0 48127.8 48376.3 49631.5 49680.8 6667.2 6827.1 7009.2 7407.4 7459.4 10777.7 12361.4 12481.2 12603.0 12707.9 9690.9 9947.3 10220.0 10302.5 10398.9 10335.3 10676.3 10889.9 10906.6 10959.2 10561.2 10603.7 10774.0 10862.6 11091.1 7721.4 7731.4 7787.3 8116.1 8153.4 9426.3 10338.0 10393.5 10515.3 10734.8 07:56:25 INFO - PROCESS | 5637 | 07:56:25 INFO - PROCESS | 5637 | [#3] mootools.html Cycles:180 Average:5054.74 Median:5104.21 stddev:2893.24 (56.7%) stddev-sans-first:2887.01 07:56:25 INFO - PROCESS | 5637 | Values: 1220.5 1304.7 1361.9 1361.9 1649.0 7312.0 7679.6 7712.4 7946.6 7952.8 7782.5 7882.3 7885.1 7888.8 7890.4 2055.7 2078.1 2080.8 2084.5 2087.4 2130.1 2164.8 2189.8 2199.9 2200.6 2082.1 2084.8 2095.5 2095.9 2128.5 2091.8 2120.5 2122.6 2130.0 2130.4 2040.4 2096.4 2124.1 2134.4 2139.8 7708.8 7824.5 7835.7 7842.3 7853.7 4289.5 4455.8 4477.6 4496.2 4507.6 2949.9 3037.7 3077.4 3100.4 3105.2 946.9 950.5 963.5 965.9 975.1 10569.2 10656.4 10671.6 10673.7 10688.5 3966.4 4087.8 4130.9 4224.2 4237.1 8344.2 8467.2 8481.7 8486.3 8489.2 4421.2 4433.6 4439.5 4442.0 4443.2 3581.7 3684.4 3751.0 4100.0 4100.4 3339.6 3460.1 3474.0 3507.7 3530.2 1025.1 1029.7 1037.5 1041.8 1045.6 800.1 806.9 809.8 812.3 828.3 5149.9 5152.4 5253.8 5278.4 5406.7 412.2 413.3 428.3 429.8 432.5 3443.1 3500.4 3552.6 3625.9 3783.8 9209.3 9802.8 9824.9 9837.5 9837.6 9671.2 9682.0 9715.0 9743.3 9775.8 7284.7 7336.4 7411.8 7415.2 7419.2 5101.1 5107.3 5189.8 5242.5 5348.6 8783.0 8851.3 8976.2 9001.7 9124.3 8913.2 9040.6 9096.6 9188.2 9203.7 6392.1 6449.0 6457.8 6465.4 6468.1 7043.5 7077.9 7157.5 7465.7 7527.4 6620.4 6631.2 6632.7 6637.9 6704.2 6449.6 6449.9 6455.5 6461.2 6624.0 5840.4 5966.0 6029.1 6162.2 6164.4 4474.6 4546.6 4558.5 4622.8 4623.2 4422.8 4468.3 4654.2 4769.0 4778.1 07:56:25 INFO - PROCESS | 5637 | 07:56:25 INFO - PROCESS | 5637 | [#4] prototype.html Cycles:180 Average:4168.75 Median:4745.47 stddev:1208.89 (25.5%) stddev-sans-first:1176.47 07:56:25 INFO - PROCESS | 5637 | Values: 277.4 281.4 285.5 293.3 299.7 4630.4 4777.3 4806.6 4824.7 4859.6 4605.1 4718.9 4744.7 4746.3 4764.9 3753.9 3759.9 3774.0 3778.2 3778.6 3597.9 3630.6 3762.1 3786.6 3808.5 3737.7 3741.6 3762.5 3763.1 3764.9 3727.8 3747.8 3771.2 3785.4 3786.5 3303.7 3306.3 3312.4 3318.0 3318.1 4495.3 4621.0 4639.9 4670.2 4678.6 4255.3 4269.6 4269.8 4280.4 4289.8 4975.4 5005.2 5008.7 5030.7 5038.2 3337.5 3524.5 3641.2 3653.0 3656.0 5214.3 5228.7 5232.9 5234.1 5275.0 3644.0 3666.7 3666.7 3678.2 3685.0 3721.0 3727.0 3728.3 3747.5 3758.2 4155.3 4206.1 4212.7 4214.8 4226.6 4968.7 4980.4 4987.3 4989.8 4992.7 1181.3 1225.1 1250.7 1259.0 1265.8 827.8 846.9 854.3 864.9 865.7 4435.1 4441.2 4442.3 4478.6 4498.2 5144.8 5171.3 5184.6 5196.3 5205.7 4287.6 4426.6 4515.5 4535.4 4544.0 2759.9 2772.7 2776.0 2776.2 2781.3 4838.1 4877.3 4883.8 4891.6 4891.7 5086.8 5272.2 5273.4 5279.0 5280.3 4829.0 4848.2 4858.9 4862.8 4870.2 5048.6 5184.3 5199.8 5211.4 5217.8 5017.0 5023.5 5024.5 5056.4 5058.0 4826.3 4835.8 4838.9 4840.6 4858.2 3660.8 3675.7 3691.4 3698.6 3701.1 5021.6 5130.6 5158.5 5169.7 5183.9 5004.2 5006.5 5014.6 5024.2 5025.4 5014.2 5042.8 5051.5 5057.5 5063.5 4684.2 4715.7 4808.9 4878.2 4890.0 5032.9 5056.4 5062.7 5067.6 5092.6 4954.5 4957.2 4958.4 4969.6 4975.8 07:56:25 INFO - PROCESS | 5637 | 07:56:25 INFO - PROCESS | 5637 | [#5] yui.html Cycles:180 Average:17440.88 Median:568.73 stddev:25895.33 (4553.2%) stddev-sans-first:25937.18 07:56:25 INFO - PROCESS | 5637 | Values: 620.7 622.3 688.4 705.8 731.4 11557.2 12788.1 12921.5 12927.7 12988.9 12790.6 12878.4 12886.0 12887.2 12903.0 595.1 721.2 731.9 732.8 736.6 743.6 744.4 751.5 751.7 751.9 785.5 788.0 789.2 789.8 790.4 633.4 649.6 786.8 786.9 787.8 476.6 476.7 549.9 566.9 570.6 11742.2 11793.3 11820.2 11840.9 11880.9 12207.6 12847.6 12916.6 13017.3 13331.9 11286.9 11611.0 11736.2 12088.8 12173.8 3958.9 3996.1 4066.8 4100.9 4144.2 63661.0 65477.0 65552.7 65649.7 66101.3 9434.4 9689.7 10321.7 10422.2 10496.4 17531.7 17722.5 17784.6 17800.5 17809.4 5896.2 6056.7 6188.9 6297.5 6354.9 3517.7 3532.5 3602.7 3630.5 3759.2 2748.9 2868.1 2868.4 2872.2 2873.6 513.9 517.1 527.0 527.7 535.5 500.4 519.2 522.0 523.0 535.2 6772.2 7090.7 7232.2 7345.6 7413.4 476.3 486.8 491.3 497.9 507.8 3238.4 3343.6 3368.3 3440.1 3523.3 99040.0 102981.5 103085.5 104541.5 105513.5 53377.5 59289.0 88000.0 88440.0 89207.1 76070.0 76796.0 76955.2 77419.6 78657.6 6575.6 6608.3 6623.8 6629.8 6793.4 45599.9 46520.5 47142.0 47274.8 47624.8 58313.0 58425.0 63934.7 65150.3 65867.3 8635.9 8729.0 8741.8 8777.1 9026.5 9173.9 9196.0 9285.7 9802.7 9890.2 9316.5 9461.8 9531.7 9776.0 9802.6 9711.5 11514.5 11610.7 11890.0 11891.7 11003.8 11472.4 11700.9 11998.8 12302.4 8561.4 8729.7 8949.6 9254.8 9357.6 8021.8 8041.0 8497.4 8530.0 8795.0 07:56:25 INFO - PROCESS | 5637 | -------- Summary: end -------- 07:56:25 INFO - PROCESS | 5637 | 07:56:26 INFO - TEST-INFO | 5637: exit 0 07:56:26 INFO - TEST-OK | dromaeo_css | took 1121435ms 07:56:26 INFO - TEST-START | kraken 07:56:26 INFO - operating with platform_type : linux_ 07:56:26 INFO - Initialising browser for kraken test... 07:56:26 INFO - TEST-INFO | started process 5944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm7S0lK/profile http://localhost:44279/getInfo.html) 07:56:30 INFO - PROCESS | 5944 | __metrics Screen width/height:1600/1200 07:56:30 INFO - PROCESS | 5944 | colorDepth:24 07:56:30 INFO - PROCESS | 5944 | Browser inner width/height: 1024/697 07:56:30 INFO - PROCESS | 5944 | __metrics 07:56:31 INFO - PROCESS | 5944 | 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" 07:56:31 INFO - PROCESS | 5944 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:56:31 INFO - PROCESS | 5944 | console.error: PushService: 07:56:31 INFO - PROCESS | 5944 | stateChangeProcessEnqueue: Error transitioning state 07:56:31 INFO - PROCESS | 5944 | UnknownError 07:56:32 INFO - TEST-INFO | 5944: exit 0 07:56:32 INFO - Browser initialized. 07:56:32 INFO - Running cycle 1/1 for kraken test... 07:56:32 INFO - TEST-INFO | started process 6027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm7S0lK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:44 INFO - PROCESS | 6027 | RSS: Main: 181772288 07:56:44 INFO - PROCESS | 6027 | 07:56:47 INFO - PROCESS | 6027 | Cycle 1(1): loaded http://localhost:44279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44279/tests/kraken/driver.html?testName=audio-beat-detection) 07:56:48 INFO - PROCESS | 6027 | RSS: Main: 234516480 07:56:48 INFO - PROCESS | 6027 | 07:56:51 INFO - PROCESS | 6027 | Cycle 1(1): loaded http://localhost:44279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44279/tests/kraken/driver.html?testName=audio-dft) 07:56:51 INFO - PROCESS | 6027 | RSS: Main: 225943552 07:56:51 INFO - PROCESS | 6027 | 07:56:55 INFO - PROCESS | 6027 | Cycle 1(1): loaded http://localhost:44279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44279/tests/kraken/driver.html?testName=audio-fft) 07:56:55 INFO - PROCESS | 6027 | RSS: Main: 302456832 07:56:55 INFO - PROCESS | 6027 | 07:56:57 INFO - PROCESS | 6027 | Cycle 1(1): loaded http://localhost:44279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44279/tests/kraken/driver.html?testName=audio-oscillator) 07:56:58 INFO - PROCESS | 6027 | RSS: Main: 213659648 07:56:58 INFO - PROCESS | 6027 | 07:57:00 INFO - PROCESS | 6027 | Cycle 1(1): loaded http://localhost:44279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:01 INFO - PROCESS | 6027 | RSS: Main: 215756800 07:57:01 INFO - PROCESS | 6027 | 07:57:04 INFO - PROCESS | 6027 | Cycle 1(1): loaded http://localhost:44279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44279/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:04 INFO - PROCESS | 6027 | RSS: Main: 252907520 07:57:04 INFO - PROCESS | 6027 | 07:57:08 INFO - PROCESS | 6027 | Cycle 1(1): loaded http://localhost:44279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44279/tests/kraken/driver.html?testName=imaging-desaturate) 07:57:09 INFO - PROCESS | 6027 | RSS: Main: 247193600 07:57:09 INFO - PROCESS | 6027 | 07:57:11 INFO - PROCESS | 6027 | Cycle 1(1): loaded http://localhost:44279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44279/tests/kraken/driver.html?testName=json-parse-financial) 07:57:12 INFO - PROCESS | 6027 | RSS: Main: 250351616 07:57:12 INFO - PROCESS | 6027 | 07:57:14 INFO - PROCESS | 6027 | Cycle 1(1): loaded http://localhost:44279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:57:14 INFO - PROCESS | 6027 | RSS: Main: 214073344 07:57:14 INFO - PROCESS | 6027 | 07:57:16 INFO - PROCESS | 6027 | Cycle 1(1): loaded http://localhost:44279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44279/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:57:17 INFO - PROCESS | 6027 | RSS: Main: 220876800 07:57:17 INFO - PROCESS | 6027 | 07:57:19 INFO - PROCESS | 6027 | Cycle 1(1): loaded http://localhost:44279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:57:20 INFO - PROCESS | 6027 | RSS: Main: 222171136 07:57:20 INFO - PROCESS | 6027 | 07:57:23 INFO - PROCESS | 6027 | Cycle 1(1): loaded http://localhost:44279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:57:23 INFO - PROCESS | 6027 | RSS: Main: 223760384 07:57:23 INFO - PROCESS | 6027 | 07:57:26 INFO - PROCESS | 6027 | Cycle 1(1): loaded http://localhost:44279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:57:27 INFO - PROCESS | 6027 | RSS: Main: 221061120 07:57:27 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | Cycle 1(1): loaded http://localhost:44279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44279/tests/kraken/driver.html?testName=ai-astar) 07:57:29 INFO - PROCESS | 6027 | RSS: Main: 271347712 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | __start_tp_report 07:57:29 INFO - PROCESS | 6027 | _x_x_mozilla_page_load 07:57:29 INFO - PROCESS | 6027 | _x_x_mozilla_page_load_details 07:57:29 INFO - PROCESS | 6027 | |i|pagename|runs| 07:57:29 INFO - PROCESS | 6027 | |0;ai-astar;115;114;132;113;114;114;115;114;114;114 07:57:29 INFO - PROCESS | 6027 | |1;audio-beat-detection;155;123;152;174;126;152;149;128;185;122 07:57:29 INFO - PROCESS | 6027 | |2;audio-dft;162;160;162;163;164;161;161;161;162;161 07:57:29 INFO - PROCESS | 6027 | |3;audio-fft;77;76;77;166;77;77;76;75;161;77 07:57:29 INFO - PROCESS | 6027 | |4;audio-oscillator;84;84;156;83;83;85;141;83;83;138 07:57:29 INFO - PROCESS | 6027 | |5;imaging-gaussian-blur;117;117;117;119;117;116;117;117;117;118 07:57:29 INFO - PROCESS | 6027 | |6;imaging-darkroom;147;147;147;147;148;146;147;146;148;147 07:57:29 INFO - PROCESS | 6027 | |7;imaging-desaturate;95;95;96;96;95;95;95;95;95;96 07:57:29 INFO - PROCESS | 6027 | |8;json-parse-financial;66;65;66;65;72;65;64;65;64;65 07:57:29 INFO - PROCESS | 6027 | |9;json-stringify-tinderbox;70;64;64;65;65;65;66;65;64;65 07:57:29 INFO - PROCESS | 6027 | |10;stanford-crypto-aes;85;88;82;83;82;81;82;85;81;81 07:57:29 INFO - PROCESS | 6027 | |11;stanford-crypto-ccm;138;139;128;130;132;130;141;139;167;141 07:57:29 INFO - PROCESS | 6027 | |12;stanford-crypto-pbkdf2;174;174;175;173;171;177;172;171;173;174 07:57:29 INFO - PROCESS | 6027 | |13;stanford-crypto-sha256-iterative;69;73;70;68;68;69;68;69;67;68 07:57:29 INFO - PROCESS | 6027 | __end_tp_report 07:57:29 INFO - PROCESS | 6027 | __start_cc_report 07:57:29 INFO - PROCESS | 6027 | _x_x_mozilla_cycle_collect,1999 07:57:29 INFO - PROCESS | 6027 | __end_cc_report 07:57:29 INFO - PROCESS | 6027 | __startTimestamp1472569049306__endTimestamp 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | ------- Summary: start ------- 07:57:29 INFO - PROCESS | 6027 | Number of tests: 14 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | [#0] ai-astar Cycles:10 Average:115.90 Median:114.00 stddev:5.69 (5.0%) stddev-sans-first:6.02 07:57:29 INFO - PROCESS | 6027 | Values: 115.0 114.0 132.0 113.0 114.0 114.0 115.0 114.0 114.0 114.0 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:152.00 stddev:21.84 (14.4%) stddev-sans-first:22.95 07:57:29 INFO - PROCESS | 6027 | Values: 155.0 123.0 152.0 174.0 126.0 152.0 149.0 128.0 185.0 122.0 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 07:57:29 INFO - PROCESS | 6027 | Values: 162.0 160.0 162.0 163.0 164.0 161.0 161.0 161.0 162.0 161.0 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | [#3] audio-fft Cycles:10 Average:93.90 Median:77.00 stddev:36.71 (47.7%) stddev-sans-first:38.42 07:57:29 INFO - PROCESS | 6027 | Values: 77.0 76.0 77.0 166.0 77.0 77.0 76.0 75.0 161.0 77.0 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:83.00 stddev:30.03 (36.2%) stddev-sans-first:31.13 07:57:29 INFO - PROCESS | 6027 | Values: 84.0 84.0 156.0 83.0 83.0 85.0 141.0 83.0 83.0 138.0 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 07:57:29 INFO - PROCESS | 6027 | Values: 117.0 117.0 117.0 119.0 117.0 116.0 117.0 117.0 117.0 118.0 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 07:57:29 INFO - PROCESS | 6027 | Values: 147.0 147.0 147.0 147.0 148.0 146.0 147.0 146.0 148.0 147.0 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:57:29 INFO - PROCESS | 6027 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.00 stddev:2.31 (3.6%) stddev-sans-first:2.45 07:57:29 INFO - PROCESS | 6027 | Values: 66.0 65.0 66.0 65.0 72.0 65.0 64.0 65.0 64.0 65.0 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:1.77 (2.7%) stddev-sans-first:0.67 07:57:29 INFO - PROCESS | 6027 | Values: 70.0 64.0 64.0 65.0 65.0 65.0 66.0 65.0 64.0 65.0 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:82.50 stddev:2.31 (2.8%) stddev-sans-first:2.33 07:57:29 INFO - PROCESS | 6027 | Values: 85.0 88.0 82.0 83.0 82.0 81.0 82.0 85.0 81.0 81.0 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:139.00 stddev:11.17 (8.0%) stddev-sans-first:11.84 07:57:29 INFO - PROCESS | 6027 | Values: 138.0 139.0 128.0 130.0 132.0 130.0 141.0 139.0 167.0 141.0 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:174.00 stddev:1.84 (1.1%) stddev-sans-first:1.94 07:57:29 INFO - PROCESS | 6027 | Values: 174.0 174.0 175.0 173.0 171.0 177.0 172.0 171.0 173.0 174.0 07:57:29 INFO - PROCESS | 6027 | 07:57:29 INFO - PROCESS | 6027 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.66 (2.4%) stddev-sans-first:1.76 07:57:29 INFO - PROCESS | 6027 | Values: 69.0 73.0 70.0 68.0 68.0 69.0 68.0 69.0 67.0 68.0 07:57:29 INFO - PROCESS | 6027 | -------- Summary: end -------- 07:57:29 INFO - PROCESS | 6027 | 07:57:30 INFO - TEST-INFO | 6027: exit 0 07:57:30 INFO - TEST-OK | kraken | took 64303ms 07:57:30 INFO - SUITE-END | took 1185s 07:57:30 INFO - Completed test suite (00:19:46) 07:57:30 INFO - javascript benchmark 07:57:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.4331846993655, 2580.25172699917, 2596.2470883443802, 2606.8826902789374, 2615.4246065865505, 4635.096156249524, 4637.5594318539725, 4693.647976401767, 4712.151812673713, 4749.548792864676, 4700.200965835807, 4722.7874745636445, 4766.142094423011, 4766.332713420115, 4781.043791241748, 4290.313549832027, 4309.159713855799, 4357.193919124956, 4419.801108950089, 4432.135733531963, 4327.199468098412, 4357.106793107421, 4377.015171586383, 4407.052483716, 4410.470743510783, 4279.358096285582, 4318.632916202095, 4323.762193079411, 4347.5217726050105, 4376.343548467724, 4285.571442855689, 4286.54991225923, 4328.394024836525, 4376.671749618791, 4386.166628340605, 4253.340732186516, 4314.935275970863, 4320.3951446797155, 4328.826846926119, 4379.912401751979, 4582.450105987303, 4699.577038066556, 4729.621630269605, 4733.100710864925, 4744.430668319824, 4960.503949605047, 4982.7259500727805, 5002.099622068026, 5005.499450055002, 5017.247412888059, 5025.748712564357, 5040.984621480392, 5043.293938848564, 5058.873528161788, 5059.241113832918, 4547.3179023146795, 4675.251959686434, 4700.9059818803435, 4711.905761884743, 4731.739754313477, 5172.508611681884, 5201.739913004335, 5217.7912883485, 5278.498542638443, 5284.682919024871, 4972.72650004246, 4979.775910084055, 4983.825566105169, 4989.401271847401, 5050.797968081236, 4955.677880937727, 5021.698698078127, 5069.923951140736, 5073.492650734897, 5076.873078173076, 4904.8773780655765, 4956.306117143603, 4970.378702662168, 5009.499050095034, 5010.048090862724, 4931.50684931504, 4942.1104201244125, 4946.08497427977, 4946.455889852114, 5011.924821127686, 4200.0, 4231.597998190167, 4232.682548808852, 4245.617894389458, 4292.055747735493, 3705.8517659293866, 3739.08392443853, 3753.3806921858136, 3804.7336686432236, 3844.3656796628243, 4404.823807047746, 4410.42664453619, 4410.889727756832, 4450.5104438511735, 4463.4420697412825, 5013.097642424399, 5113.923291150636, 5125.410577783603, 5130.12787826063, 5134.05020071288, 4311.849085282063, 4340.045190058182, 4394.560543945579, 4402.801873915681, 4462.0183559616835, 4520.118576877478, 4568.1548913451115, 4568.954310456853, 4573.108243892409, 4628.305754136906, 4634.745089020002, 4758.571728544378, 4759.0719809636785, 4761.476237613929, 4807.399075115611, 5008.624353173599, 5038.798448062036, 5050.72221027847, 5166.0, 5187.507186817246, 4797.784099715452, 4798.184308667465, 4799.112164249625, 4848.854534363974, 4856.077345304381, 5002.474740152377, 5038.319826823332, 5038.697678139323, 5039.974800125976, 5043.621728370314, 4988.152014157529, 5040.16837221869, 5049.318342023927, 5090.567301779391, 5157.303763991813, 4969.751512424436, 4972.975135124301, 4977.502249775139, 4977.726225057511, 5021.598272138293, 4921.212605983025, 4928.063667903087, 4979.053979743837, 4979.302897594413, 5035.899282014266, 4725.6219502439035, 4818.084563932842, 4872.049950259665, 4902.803887844446, 4911.214205727067, 5013.147764880052, 5017.37282839645, 5019.623528235324, 5020.0, 5048.091343558195, 4798.424189097331, 4891.388576427947, 4900.362952816111, 4904.705717656952, 4937.21004639256], "value": 4643.414750926087, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.8370264474624, 576.584858901591, 583.4807021750643, 585.607642879271, 586.2173997713053, 27350.316242093933, 29889.0, 29924.700752992463, 36278.63721362786, 38116.42825357622, 38787.0, 38826.22347553054, 39160.60839391605, 39271.60728392715, 39313.23090460936, 7555.131159916611, 7710.498817576839, 7712.383009359266, 7712.421568382366, 7715.151333353327, 7101.076860008217, 7524.661390237453, 9732.51337433129, 9930.702078937607, 9972.800543989117, 10097.040781125781, 10153.136983356424, 10159.6952091437, 10164.64423745169, 10176.694699159, 9912.207023438144, 9916.801663966753, 9968.601255949754, 9969.601215951354, 9979.101880830687, 9753.366031207948, 9825.606975720963, 9839.90160098397, 9841.704748857546, 9843.163331116864, 36841.63158368409, 37116.44325335095, 37146.8142659285, 37198.25603487942, 37213.62786372156, 2786.70739572346, 2825.6891741908375, 2888.8266703997615, 3039.6200474940633, 3347.297067615804, 27537.586936195974, 27575.690917089876, 27907.441851163065, 28114.0, 29529.409411811645, 3472.6527347265323, 3508.438649816017, 3510.1224693826543, 3546.415445728943, 3600.5499312585926, 242942.0, 243855.0, 244114.0, 245109.0, 245125.0, 49413.50586494161, 49672.25491617629, 49749.0, 49757.75121124371, 49826.25260621094, 31389.37221255562, 32493.35013299768, 32546.674533254365, 34498.310033799185, 34509.827450862584, 12789.808152877527, 12941.870581294255, 12953.54662586805, 12958.222506649443, 12958.28729419891, 9521.190698790542, 10253.74365640865, 10372.0, 10377.117944974761, 10381.2214083944, 16761.7485737714, 17363.3054677814, 17387.391441299747, 18014.0, 18020.54948626295, 6663.833404164838, 6809.242256885969, 6811.659417029228, 6974.197967233732, 6975.581465112109, 771.4445599168589, 868.5353335965228, 924.4638109896244, 925.921296689789, 929.7350255177378, 26375.73624263733, 26383.208503744918, 27447.451050979267, 27504.0, 27700.0, 901.2204443156753, 946.2713710443059, 948.8956214816365, 984.6504490905626, 1038.4911393417322, 13481.59555213345, 14244.928775356264, 14373.78439323411, 14636.268186590627, 14690.853091469162, 374140.0, 376322.0, 376542.0, 376892.0, 377176.0, 46544.53455465402, 46948.7652561735, 46978.5302146981, 47008.52991470041, 47057.29414058792, 1064.5528877871313, 1148.2593727046176, 1161.1639619474133, 1183.621241202807, 1184.224333061846, 26081.73918260869, 26651.466970660866, 27694.0, 28378.57432138478, 28829.85585072061, 39468.2106357877, 39863.60136398599, 39903.600963989986, 39993.2001359977, 40009.0, 294419.0, 294786.0, 294931.0, 295258.0, 295371.0, 23788.431735239854, 24797.380065498506, 24798.628020579345, 25842.87078564595, 25979.74020259773, 39768.2046359077, 40036.1992760149, 40237.0, 40465.79767101146, 41569.1686166281, 34037.319253615286, 34321.65678343185, 34491.0, 34610.307793844484, 34672.479912801835, 33558.328833423686, 33696.49455258222, 33773.83113084419, 33829.32341353208, 33904.0, 33365.666343336256, 33933.15167120842, 34375.656243437246, 34382.31235375329, 34502.48246276258, 30191.245218869703, 31123.37753244968, 31134.844325778227, 31867.20331991719, 32178.67821321757, 23516.6472502916, 24080.0, 24333.27000189997, 24355.26934191977, 24533.386665332797], "value": 17063.466350563656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.7623187536849, 351.2413187514968, 352.8447483107434, 353.25463272495034, 380.0479798105745, 12367.814482782755, 12984.54554090607, 13214.339283035857, 14944.171773008522, 17138.742918856227, 12094.153409261333, 12333.136680432352, 13834.0, 14312.427502899898, 14438.350274237659, 4558.863234102965, 4563.931541026887, 4575.245084561044, 4698.530146985308, 4700.529947005306, 4575.107853968478, 4619.930701039487, 4642.512536183686, 4643.466001409831, 4645.744484053375, 3418.2308980479315, 4646.140464014151, 5062.645614806965, 5320.4679532046675, 5364.946350536503, 5311.468853114677, 5320.361556613192, 5321.255024296602, 5325.174597937287, 5326.360836699582, 4875.171220892456, 4986.700797952099, 4990.575801056878, 4997.100521906055, 5012.649114561982, 11097.611583594535, 11151.832722509169, 12455.688607784787, 18756.81243187578, 18861.905690471598, 1867.7508667780771, 2003.9799602003939, 2045.6931460280928, 2059.423361458794, 2420.9152679656127, 9336.412809822346, 9361.906380936172, 9644.18024467921, 9685.70942871715, 10620.309679870861, 1478.290420598108, 1532.1266877879614, 1540.1606124662087, 1565.2486806333025, 1587.1191488723753, 66349.3365066348, 69939.65030174867, 70020.0, 70054.0, 71526.28473715248, 9755.414675119515, 9887.555060022316, 9950.601975921027, 10202.38785672862, 10273.948630256951, 13420.664483387993, 13470.191788492722, 13482.595522134352, 13513.594592162252, 13524.729505409836, 6729.4764463326255, 6974.860502789916, 7029.22678505364, 7145.0, 7157.320054594805, 6219.378062193744, 6572.474202063823, 6743.460523158135, 6774.93225067743, 6797.422219111332, 4025.9194816103513, 4314.309710446313, 4324.697271190987, 4330.112326972963, 4392.978035109804, 1704.573856535866, 1732.6101627133794, 1743.9564010899828, 1774.210476338017, 1832.9633407331778, 846.5597889097635, 850.5364576305805, 893.1381217125505, 906.2523418180028, 921.764949937775, 16433.506994790176, 16640.50078497647, 17041.48875533736, 17153.914230429018, 17367.47897563075, 806.4717609965364, 817.3869597801648, 824.3652387661467, 836.2975100915139, 840.0423517190408, 8899.332550058642, 9015.819683606422, 9557.665481708107, 9682.90317096834, 9754.0733630305, 360961.0, 362826.0, 366076.0, 366967.0, 377228.0, 73998.63000684962, 76039.0, 76639.61680191563, 78645.0, 79381.0, 856.0839901305668, 876.6975393489236, 878.4685265414332, 878.4773060029272, 879.6525372477963, 14904.18027008525, 15336.309866055832, 16767.0, 16800.831991679926, 16881.746773798648, 27397.123302053795, 27966.440671186054, 37119.25761484701, 37244.0, 39030.0, 45920.0, 48127.75936120297, 48376.27435588539, 49631.503684962685, 49680.75159624179, 6667.199936007516, 6827.112475378368, 7009.1939426966555, 7407.444441667004, 7459.36595389398, 10777.676669699922, 12361.443735032126, 12481.188722732993, 12602.991760659308, 12707.87292127067, 9690.903090969001, 9947.253955953478, 10220.02909723575, 10302.484875756032, 10398.896011040095, 10335.276530643083, 10676.252662313564, 10889.945550272198, 10906.563737450413, 10959.232853700165, 10561.20790940698, 10603.734906627396, 10774.037139786307, 10862.619808306672, 11091.112710983263, 7721.420893432903, 7731.38148948094, 7787.29914307715, 8116.107228205011, 8153.429259951747, 9426.340156189, 10338.0, 10393.480325983519, 10515.263931525025, 10734.785304293715], "value": 7852.234717844885, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1220.4751956658633, 1304.6673098359918, 1361.8501964783877, 1361.8706222908822, 1649.0353143411103, 7311.999999999994, 7679.57762323072, 7712.421568382373, 7946.602669866513, 7952.761417157494, 7782.455228134033, 7882.330001949841, 7885.1326354101, 7888.842223155533, 7890.408219383555, 2055.7122002919605, 2078.0960282277183, 2080.760712518065, 2084.47888027993, 2087.4155236533793, 2130.0627723801554, 2164.83763717721, 2189.824814014875, 2199.8900054997266, 2200.6148923938326, 2082.146320008797, 2084.770675225724, 2095.528506086134, 2095.8952052397394, 2128.45724340293, 2091.8221951134174, 2120.5122821751083, 2122.649762789138, 2129.968050479244, 2130.4141361125658, 2040.4286799696108, 2096.444442222812, 2124.107874692633, 2134.445044288481, 2139.775323591016, 7708.807279818049, 7824.452288339819, 7835.725749598737, 7842.333401660866, 7853.725119620786, 4289.4852617685765, 4455.754933478657, 4477.552244775529, 4496.235639941217, 4507.5943165115295, 2949.9262518437213, 3037.726604605596, 3077.353755711303, 3100.410921924827, 3105.223694076481, 946.9384490008127, 950.5294879034852, 963.5086106085877, 965.8502932045544, 975.059067999384, 10569.207309451745, 10656.360618362845, 10671.57313707443, 10673.679789606324, 10688.46557672121, 3966.4050392440786, 4087.7547347159266, 4130.876073717794, 4224.239636865394, 4237.110206856594, 8344.165583441607, 8467.237948584658, 8481.660733570588, 8486.32109431244, 8489.235968762841, 4421.226285400042, 4433.6009759121835, 4439.511653718088, 4441.977790111094, 4443.200223959654, 3581.71346292296, 3684.4399532386046, 3751.0, 4100.036491424513, 4100.446439730657, 3339.5825521809775, 3460.1003739028033, 3473.9826300868335, 3507.6667716566885, 3530.188056746911, 1025.123519390925, 1029.6705054382526, 1037.4708898461688, 1041.7812259425455, 1045.581767293089, 800.1318569352202, 806.9394795390369, 809.8258874342044, 812.3095368936475, 828.2587084559285, 5149.897002059938, 5152.433232344439, 5253.763580638881, 5278.419373868871, 5406.702631355313, 412.2085595656347, 413.3448484152652, 428.2612493448838, 429.79155109771733, 432.4896621986024, 3443.1220038889924, 3500.369933411959, 3552.609212986569, 3625.9456108158397, 3783.7729736215365, 9209.309301802392, 9802.75493112678, 9824.901750982399, 9837.508124593742, 9837.55730992107, 9671.226301895831, 9681.951590242004, 9715.0, 9743.269254805919, 9775.804483910424, 7284.745033923893, 7336.413086953031, 7411.777646670608, 7415.221401752846, 7419.2209817969415, 5101.107306221322, 5107.310513080835, 5189.844304670866, 5242.475752424727, 5348.572114230775, 8782.956085219534, 8851.33614978892, 8976.192142707188, 9001.729948101567, 9124.270058395445, 8913.153250441197, 9040.63837446521, 9096.590653420744, 9188.219001384958, 9203.677871274473, 6392.105105285357, 6449.0, 6457.806265812033, 6465.3857883501, 6468.062130991074, 7043.506954513135, 7077.929220707933, 7157.534760240567, 7465.7013719450615, 7527.3601743850195, 6620.3710647488415, 6631.204255489372, 6632.668366581748, 6637.867242655217, 6704.161979752531, 6449.645269510034, 6449.871002580016, 6455.548111632328, 6461.160049193575, 6624.039514270307, 5840.357560668238, 5966.0454327307425, 6029.095635654687, 6162.198914141133, 6164.383561643979, 4474.574915383034, 4546.590806827401, 4558.475775285885, 4622.815087396601, 4623.237165867594, 4422.77886105687, 4468.285074388083, 4654.18551753435, 4769.046190761792, 4778.068276686013], "value": 3981.998674351629, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.43680328932265, 281.36692442005494, 285.54883284410636, 293.3048674641101, 299.742221689347, 4630.421197350332, 4777.283407488879, 4806.615470762339, 4824.710517368956, 4859.562639362461, 4605.148047611195, 4718.8584342469785, 4744.675109196494, 4746.264329028997, 4764.880877978052, 3753.8738378486482, 3759.8684046058393, 3773.9811300943456, 3778.244351129771, 3778.565464971536, 3597.874074407396, 3630.56433228013, 3762.134709016928, 3786.602406747293, 3808.504894363729, 3737.663610275075, 3741.6071312512204, 3762.529683789526, 3763.1156678180605, 3764.868229611964, 3727.7763334200035, 3747.775133491986, 3771.15149091455, 3785.413260944558, 3786.5077539919907, 3303.719183869374, 3306.3056758080834, 3312.4368857294317, 3317.96682033179, 3318.1041118898, 4495.336725411586, 4621.0, 4639.86080417588, 4670.229412146991, 4678.6257099432305, 4255.2978758504805, 4269.615734583902, 4269.765162916038, 4280.357946308048, 4289.828406863753, 4975.353204083446, 5005.199168133081, 5008.724520151391, 5030.748462576857, 5038.244263360489, 3337.5327454156436, 3524.4713293006, 3641.2353405784816, 3652.9954262578003, 3655.963440365589, 5214.253225169573, 5228.738563071869, 5232.869178270574, 5234.110201265832, 5275.0, 3643.981780091083, 3666.65166809158, 3666.7249956253386, 3678.2459595782802, 3684.9815750921075, 3720.9627903720616, 3726.9627303727157, 3728.254349130185, 3747.4940882980995, 3758.229562939591, 4155.252054630135, 4206.116715489781, 4212.705110642226, 4214.840918747369, 4226.619604235633, 4968.683298925787, 4980.352554167935, 4987.304316532396, 4989.775460104232, 4992.676940610741, 1181.255808840425, 1225.136278923357, 1250.6748245456247, 1258.9748205035849, 1265.7721610110268, 827.8302947895667, 846.9068402475723, 854.2781349759443, 864.9135086491301, 865.6667183134413, 4435.1351486459835, 4441.244988351988, 4442.311441726538, 4478.552144785495, 4498.235299999008, 5144.845654630367, 5171.2501687255135, 5184.585233181412, 5196.285225875452, 5205.713685747244, 4287.614114729689, 4426.601605855489, 4515.480719717275, 4535.365048893158, 4543.954560454419, 2759.889604415801, 2772.6811416686937, 2775.9583606245924, 2776.194903478009, 2781.332480204777, 4838.129136755418, 4877.268409738496, 4883.755812209375, 4891.603114473954, 4891.657583969088, 5086.821961231413, 5272.182811664198, 5273.393559740679, 5278.97360513195, 5280.313559237275, 4829.0, 4848.151573474557, 4858.878528036827, 4862.82980095695, 4870.172070748053, 5048.570871475966, 5184.274201611702, 5199.76601052946, 5211.374635043819, 5217.8173763918085, 5016.993202718942, 5023.497650234947, 5024.492652204251, 5056.367954005749, 5057.963117560817, 4826.32431459603, 4835.806567737392, 4838.935434204469, 4840.6127509799835, 4858.222684370484, 3660.8352624131444, 3675.6875665568728, 3691.4093745000673, 3698.6116457772623, 3701.1302343948614, 5021.573166280907, 5130.56344223618, 5158.535731784157, 5169.741512924414, 5183.896322073462, 5004.249362595494, 5006.496751624188, 5014.623903207201, 5024.171011783015, 5025.447200807981, 5014.172661510956, 5042.84871453857, 5051.520105589963, 5057.519535644108, 5063.493650634907, 4684.227102528181, 4715.669903106749, 4808.879778005438, 4878.170710979071, 4890.046440943982, 5032.949670503248, 5056.367954005749, 5062.746862656926, 5067.592893375617, 5092.567131793839, 4954.455009948831, 4957.182064959241, 4958.404991401055, 4969.627277954096, 4975.7512124392915], "value": 3779.4996383795365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.6865532905882, 622.3030206169092, 688.4320435640597, 705.8411857332101, 731.3965978068094, 11557.190996630228, 12788.104832661717, 12921.483140674374, 12927.67680807978, 12988.870111298884, 12790.552330668428, 12878.3560821959, 12886.033547483952, 12887.226766394024, 12903.0, 595.0598055072975, 721.2354903801961, 731.8865575835754, 732.8351120997772, 736.6095969136367, 743.6170372258291, 744.3821628048706, 751.5190278221943, 751.7331347371686, 751.868423025971, 785.5090568394753, 787.9881801772977, 789.171370061436, 789.763071078677, 790.4269404681588, 633.4109278371113, 649.5615459564775, 786.8426314737076, 786.9370450363986, 787.8148635070754, 476.5948943398084, 476.6830058011418, 549.881775418287, 566.8922904648103, 570.5749216833444, 11742.236754610924, 11793.29240245588, 11820.23168494045, 11840.881591184065, 11880.940595297054, 12207.572734954323, 12847.614571562775, 12916.612501624872, 13017.28404937728, 13331.933340333333, 11286.887131128748, 11611.0, 11736.237144585575, 12088.818667719992, 12173.756524869454, 3958.9010274743073, 3996.100877302613, 4066.755994640331, 4100.897477563055, 4144.150449157915, 63661.0, 65477.0, 65552.67223663851, 65649.67175164094, 66101.33898661, 9434.386764860263, 9689.70930872075, 10321.74195645115, 10422.21833362501, 10496.370217786956, 17531.73702394465, 17722.46832595024, 17784.644307114046, 17800.46598602044, 17809.376671816422, 5896.204012458349, 6056.727447264883, 6188.8762224755255, 6297.4962003039645, 6354.872902541923, 3517.718582513393, 3532.540769699974, 3602.693771029492, 3630.455431685268, 3759.2481503698823, 2748.8900443982416, 2868.0965495868736, 2868.4119755450083, 2872.2101422108667, 2873.5689646552764, 513.9177731562932, 517.1312195511576, 526.9829229586858, 527.6543863769238, 535.5180337696105, 500.35204410288765, 519.2107995846293, 522.0342366621795, 523.0062880526954, 535.199876185098, 6772.153480814898, 7090.716371345192, 7232.240614735482, 7345.562716906296, 7413.36986356155, 476.3141076849326, 486.7833813952757, 491.25329499161074, 497.9377577802775, 507.75373943637305, 3238.4008958342783, 3343.6154842192973, 3368.3335066015334, 3440.1055725511546, 3523.295340931824, 99040.00959990452, 102981.48509257406, 103085.48457257665, 104541.47729261305, 105513.47243263734, 53377.46622533802, 59289.0, 88000.0, 88440.0, 89207.10792892118, 76070.0, 76796.0, 76955.2304476948, 77419.61290193626, 78657.60671196607, 6575.572587781779, 6608.273089960005, 6623.801285961236, 6629.806882474689, 6793.354631310018, 45599.900037485946, 46520.53479465297, 47142.0, 47274.76362618165, 47624.761876191784, 58313.0, 58425.0, 63934.68032659807, 65150.34849651632, 65867.34132658804, 8635.87046194295, 8728.956355218183, 8741.825163496822, 8777.122287771172, 9026.45841249527, 9173.908260917306, 9196.0, 9285.72142835716, 9802.65690700822, 9890.159336456481, 9316.48759318244, 9461.810763784824, 9531.65474051949, 9776.0, 9802.607895684378, 9711.465869376969, 11514.481848316678, 11610.70973225676, 11890.0, 11891.702707432383, 11003.779924401628, 11472.426378681199, 11700.88299116998, 11998.820017699916, 12302.446389912297, 8561.400701950804, 8729.694460693845, 8949.555249248637, 9254.814903702023, 9357.625694972125, 8021.839563208587, 8041.004653750097, 8497.447665901944, 8530.011257630998, 8794.956025219833], "value": 6172.187961388358, "unit": "score"}], "name": "dromaeo_css", "value": 6218.042499670481, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 132.0, 113.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 152.0, 174.0, 126.0, 152.0, 149.0, 128.0, 185.0, 122.0], "value": 146.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 163.0, 164.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 166.0, 77.0, 77.0, 76.0, 75.0, 161.0, 77.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 156.0, 83.0, 83.0, 85.0, 141.0, 83.0, 83.0, 138.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 119.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 146.0, 148.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 72.0, 65.0, 64.0, 65.0, 64.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 64.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 64.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 82.0, 83.0, 82.0, 81.0, 82.0, 85.0, 81.0, 81.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 128.0, 130.0, 132.0, 130.0, 141.0, 139.0, 167.0, 141.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 175.0, 173.0, 171.0, 177.0, 172.0, 171.0, 173.0, 174.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 70.0, 68.0, 68.0, 69.0, 68.0, 69.0, 67.0, 68.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1574.4, "alertThreshold": 2.0}]} 07:57:31 INFO - Return code: 0 07:57:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:57:31 INFO - # TBPL SUCCESS # 07:57:31 INFO - Running post-action listener: _resource_record_post_action 07:57:31 INFO - [mozharness: 2016-08-30 14:57:31.121357Z] Finished run-tests step (success) 07:57:31 INFO - Running post-run listener: _resource_record_post_run 07:57:31 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418230272; Read time: 16; Write time: 380044 07:57:31 INFO - TinderboxPrint: CPU usage
13.0% 07:57:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:57:31 INFO - TinderboxPrint: I/O write bytes / time
418,230,272 / 380,044 07:57:31 INFO - TinderboxPrint: CPU idle
8,341.7 (87.0%) 07:57:31 INFO - TinderboxPrint: CPU user
1,200.1 (12.5%) 07:57:31 INFO - TinderboxPrint: Swap in / out
0 / 0 07:57:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 125186048; Read time: 0; Write time: 95800 07:57:31 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 293044224; Read time: 0; Write time: 284244 07:57:31 INFO - Running post-run listener: _upload_blobber_files 07:57:31 INFO - Blob upload gear active. 07:57:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:57:31 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 07:57:31 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'] 07:57:31 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 07:57:32 INFO - (blobuploader) - INFO - Open directory for files ... 07:57:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:57:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:57:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:32 INFO - (blobuploader) - INFO - Done attempting. 07:57:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:57:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:57:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:33 INFO - (blobuploader) - INFO - Done attempting. 07:57:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:57:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:57:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:37 INFO - (blobuploader) - INFO - Done attempting. 07:57:37 INFO - (blobuploader) - INFO - Iteration through files over. 07:57:37 INFO - Return code: 0 07:57:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:57:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:57:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dd2ba3cdce45757670afda175b8fb6002b60aaa9e199eddcb57ae894d2be8f115b69766bd96eba35dca1145acea958c5d36b80c5603e23924e5b97d60a3d2a35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/27b7d3f10648d98f063dbfb8d3a57617744ef85ad6046c38f00b4255e94a445ade286d3b4cffb417dfd9cd5710605a18b4ad68a487677e1648a42345d208edce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5cfd6601146d92e17586a4d58ec1828d7865c06b95b5e4b961e13e0bd73154bfd2cb3a7ac95055c351c738a6d9629d5f0f20bbab6bb4981f33a3f0c05b799705"} 07:57:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:57:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:57:37 INFO - Contents: 07:57:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dd2ba3cdce45757670afda175b8fb6002b60aaa9e199eddcb57ae894d2be8f115b69766bd96eba35dca1145acea958c5d36b80c5603e23924e5b97d60a3d2a35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/27b7d3f10648d98f063dbfb8d3a57617744ef85ad6046c38f00b4255e94a445ade286d3b4cffb417dfd9cd5710605a18b4ad68a487677e1648a42345d208edce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5cfd6601146d92e17586a4d58ec1828d7865c06b95b5e4b961e13e0bd73154bfd2cb3a7ac95055c351c738a6d9629d5f0f20bbab6bb4981f33a3f0c05b799705"} 07:57:37 INFO - Running post-run listener: copy_logs_to_upload_dir 07:57:37 INFO - Copying logs to upload dir... 07:57:37 INFO - mkdir: /builds/slave/test/build/upload/logs 07:57:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.540006 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-30 07:57:37.471925) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 07:57:37.475563) ========= 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=c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171 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/dd2ba3cdce45757670afda175b8fb6002b60aaa9e199eddcb57ae894d2be8f115b69766bd96eba35dca1145acea958c5d36b80c5603e23924e5b97d60a3d2a35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/27b7d3f10648d98f063dbfb8d3a57617744ef85ad6046c38f00b4255e94a445ade286d3b4cffb417dfd9cd5710605a18b4ad68a487677e1648a42345d208edce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5cfd6601146d92e17586a4d58ec1828d7865c06b95b5e4b961e13e0bd73154bfd2cb3a7ac95055c351c738a6d9629d5f0f20bbab6bb4981f33a3f0c05b799705"} build_url:https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011443 build_url: 'https://queue.taskcluster.net/v1/task/abt_Tg_HTSeQcP6UE0C0NA/artifacts/public/build/firefox-51.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/dd2ba3cdce45757670afda175b8fb6002b60aaa9e199eddcb57ae894d2be8f115b69766bd96eba35dca1145acea958c5d36b80c5603e23924e5b97d60a3d2a35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/27b7d3f10648d98f063dbfb8d3a57617744ef85ad6046c38f00b4255e94a445ade286d3b4cffb417dfd9cd5710605a18b4ad68a487677e1648a42345d208edce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5cfd6601146d92e17586a4d58ec1828d7865c06b95b5e4b961e13e0bd73154bfd2cb3a7ac95055c351c738a6d9629d5f0f20bbab6bb4981f33a3f0c05b799705"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 07:57:37.500999) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 07:57:37.501318) ========= 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=c6927cf182745ad25b1d38b9000001fe-1472567179.308681-240141171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 07:57:37.586264) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 07:57:37.586575) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 07:57:37.586888) ========= ========= Total master_lag: 0.22 =========