builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1472118351.06 results: success (0) buildid: 20160825004526 builduid: a643a2f0c5514fad98b0016e64e1da80 revision: 0f54395b2ac4a4562266d46081f8895c9d333f42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 02:45:51.065156) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 02:45:51.065617) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 02:45:51.065909) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 02:45:51.166128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 02:45:51.166398) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 02:45: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% 40.9M=0s 2016-08-25 02:45:51 (40.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074993 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 02:45:51.313166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 02:45:51.313450) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015628 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 02:45:51.346014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 02:45:51.346358) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0f54395b2ac4a4562266d46081f8895c9d333f42 --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 0f54395b2ac4a4562266d46081f8895c9d333f42 --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=5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 02:45:51,571 truncating revision to first 12 chars 2016-08-25 02:45:51,571 Setting DEBUG logging. 2016-08-25 02:45:51,571 attempt 1/10 2016-08-25 02:45:51,571 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0f54395b2ac4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 02:45:52,166 unpacking tar archive at: autoland-0f54395b2ac4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.883791 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 02:45:52.243614) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 02:45:52.243910) ========= script_repo_revision: 0f54395b2ac4a4562266d46081f8895c9d333f42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 02:45:52.244341) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 02:45:52.244613) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 02:45:52.253527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-25 02:45:52.253806) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:45:52 INFO - MultiFileLogger online at 20160825 02:45:52 in /builds/slave/test 02:45:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 02:45:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:45:52 INFO - {'append_to_log': False, 02:45:52 INFO - 'base_work_dir': '/builds/slave/test', 02:45:52 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 02:45:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:45:52 INFO - 'branch': 'Autoland-Non-PGO', 02:45:52 INFO - 'buildbot_json_path': 'buildprops.json', 02:45:52 INFO - 'config_files': ('talos/linux_config.py',), 02:45:52 INFO - 'default_actions': ('clobber', 02:45:52 INFO - 'read-buildbot-config', 02:45:52 INFO - 'download-and-extract', 02:45:52 INFO - 'populate-webroot', 02:45:52 INFO - 'create-virtualenv', 02:45:52 INFO - 'install', 02:45:52 INFO - 'run-tests'), 02:45:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:45:52 INFO - 'download_minidump_stackwalk': True, 02:45:52 INFO - 'download_symbols': 'ondemand', 02:45:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:45:52 INFO - 'tooltool.py': '/tools/tooltool.py', 02:45:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:45:52 INFO - '/tools/misc-python/virtualenv.py')}, 02:45:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:45:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:45:52 INFO - 'installer_path': 'installer.exe', 02:45:52 INFO - 'log_level': 'info', 02:45:52 INFO - 'log_name': 'talos', 02:45:52 INFO - 'log_to_console': True, 02:45:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:45:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:45:52 INFO - 'opt_config_files': (), 02:45:52 INFO - 'pip_index': False, 02:45:52 INFO - 'sps_profile': False, 02:45:52 INFO - 'sps_profile_interval': 0, 02:45:52 INFO - 'suite': 'dromaeojs-e10s', 02:45:52 INFO - 'system_bits': '32', 02:45:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:45:52 INFO - 'title': 'talos-linux64-ix-011', 02:45:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:45:52 INFO - 'use_talos_json': True, 02:45:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:45:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:45:52 INFO - 'work_dir': 'build'} 02:45:52 INFO - [mozharness: 2016-08-25 09:45:52.571541Z] Running clobber step. 02:45:52 INFO - Running pre-action listener: _resource_record_pre_action 02:45:52 INFO - Running main action method: clobber 02:45:52 INFO - rmtree: /builds/slave/test/build 02:45:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:45:53 INFO - Running post-action listener: _resource_record_post_action 02:45:53 INFO - [mozharness: 2016-08-25 09:45:53.549169Z] Finished clobber step (success) 02:45:53 INFO - [mozharness: 2016-08-25 09:45:53.549272Z] Running read-buildbot-config step. 02:45:53 INFO - Running pre-action listener: _resource_record_pre_action 02:45:53 INFO - Running main action method: read_buildbot_config 02:45:53 INFO - Using buildbot properties: 02:45:53 INFO - { 02:45:53 INFO - "project": "", 02:45:53 INFO - "product": "firefox", 02:45:53 INFO - "script_repo_revision": "production", 02:45:53 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 02:45:53 INFO - "repository": "", 02:45:53 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 02:45:53 INFO - "buildid": "20160825004526", 02:45:53 INFO - "pgo_build": "False", 02:45:53 INFO - "basedir": "/builds/slave/test", 02:45:53 INFO - "buildnumber": 364, 02:45:53 INFO - "slavename": "talos-linux64-ix-011", 02:45:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:45:53 INFO - "platform": "ubuntu64_hw", 02:45:53 INFO - "scheduler": "tests-autoland-linux64-talos-7-3600", 02:45:53 INFO - "branch": "autoland", 02:45:53 INFO - "repo_path": "integration/autoland", 02:45:53 INFO - "revision": "0f54395b2ac4a4562266d46081f8895c9d333f42", 02:45:53 INFO - "stage_platform": "linux64", 02:45:53 INFO - "builduid": "a643a2f0c5514fad98b0016e64e1da80", 02:45:53 INFO - "slavebuilddir": "test" 02:45:53 INFO - } 02:45:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:45:53 INFO - Running post-action listener: _resource_record_post_action 02:45:53 INFO - [mozharness: 2016-08-25 09:45:53.551675Z] Finished read-buildbot-config step (success) 02:45:53 INFO - [mozharness: 2016-08-25 09:45:53.551762Z] Running download-and-extract step. 02:45:53 INFO - Running pre-action listener: _resource_record_pre_action 02:45:53 INFO - Running main action method: download_and_extract 02:45:53 INFO - mkdir: /builds/slave/test/build/tests 02:45: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')]} 02:45:53 INFO - trying https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:45:53 INFO - Downloading https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/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 02:45:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/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 02:45:54 INFO - Downloaded 1361 bytes. 02:45:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:45:54 INFO - Using the following test package requirements: 02:45:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:45:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:45:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:45:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:54 INFO - u'jsshell-linux-x86_64.zip'], 02:45:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:45:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:45:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:45:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:45:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:45:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:45:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:45:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:45:54 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')]} 02:45:54 INFO - trying https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:45:54 INFO - Downloading https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/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 02:45:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/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 02:45:54 INFO - Downloaded 20324178 bytes. 02:45: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 02:45:59 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 02:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:59 INFO - trying https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:45:59 INFO - Downloading https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/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 02:45:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/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 02:46:00 INFO - Downloaded 20324178 bytes. 02:46:00 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 02:46: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')]} 02:46:04 INFO - trying https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:46:04 INFO - Downloading https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/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 02:46:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/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 02:46:05 INFO - Downloaded 14413981 bytes. 02:46:05 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 02:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:05 INFO - trying https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:46:05 INFO - Downloading https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/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 02:46:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/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 02:46:07 INFO - Downloaded 55764993 bytes. 02:46:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:46:07 INFO - mkdir: /builds/slave/test/properties 02:46:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:46:07 INFO - Writing to file /builds/slave/test/properties/build_url 02:46:07 INFO - Contents: 02:46:07 INFO - build_url:https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:46:07 INFO - Running post-action listener: _resource_record_post_action 02:46:07 INFO - Running post-action listener: set_extra_try_arguments 02:46:07 INFO - [mozharness: 2016-08-25 09:46:07.784227Z] Finished download-and-extract step (success) 02:46:07 INFO - [mozharness: 2016-08-25 09:46:07.784450Z] Running populate-webroot step. 02:46:07 INFO - Running pre-action listener: _resource_record_pre_action 02:46:07 INFO - Running main action method: populate_webroot 02:46:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:46:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:46:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:46:07 INFO - '--tppagecycles', 02:46:07 INFO - '7'], 02:46:07 INFO - 'tests': ['tsvgm']}}, 02:46:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:46:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:46:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:46:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:46:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:46:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:46:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:46:07 INFO - 'talos_options': ['--disable-e10s'], 02:46:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:46:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:46:07 INFO - 'talos_options': ['--disable-e10s'], 02:46:07 INFO - 'tests': ['damp', 'tps']}, 02:46:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:46:07 INFO - 'tests': ['damp', 'tps']}, 02:46:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:46:07 INFO - 'tests': ['dromaeo_dom']}, 02:46:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:46:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:46:07 INFO - 'tests': ['basic_compositor_video']}, 02:46:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:46:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:46:07 INFO - 'tests': ['a11yr', 02:46:07 INFO - 'ts_paint', 02:46:07 INFO - 'tpaint', 02:46:07 INFO - 'sessionrestore', 02:46:07 INFO - 'sessionrestore_no_auto_restore', 02:46:07 INFO - 'tabpaint']}, 02:46:07 INFO - 'other-e10s': {'tests': ['a11yr', 02:46:07 INFO - 'ts_paint', 02:46:07 INFO - 'tpaint', 02:46:07 INFO - 'sessionrestore', 02:46:07 INFO - 'sessionrestore_no_auto_restore', 02:46:07 INFO - 'tabpaint']}, 02:46:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:46:07 INFO - 'ts_paint', 02:46:07 INFO - 'tpaint', 02:46:07 INFO - 'sessionrestore', 02:46:07 INFO - 'sessionrestore_no_auto_restore', 02:46:07 INFO - 'tabpaint']}, 02:46:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:46:07 INFO - 'ts_paint', 02:46:07 INFO - 'tpaint', 02:46:07 INFO - 'sessionrestore', 02:46:07 INFO - 'sessionrestore_no_auto_restore', 02:46:07 INFO - 'tabpaint']}, 02:46:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:46:07 INFO - 'tests': ['a11yr', 02:46:07 INFO - 'ts_paint', 02:46:07 INFO - 'tpaint', 02:46:07 INFO - 'sessionrestore', 02:46:07 INFO - 'sessionrestore_no_auto_restore', 02:46:07 INFO - 'tabpaint']}, 02:46:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:46:07 INFO - 'tests': ['a11yr', 02:46:07 INFO - 'ts_paint', 02:46:07 INFO - 'tpaint', 02:46:07 INFO - 'sessionrestore', 02:46:07 INFO - 'sessionrestore_no_auto_restore', 02:46:07 INFO - 'tabpaint']}, 02:46:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:46:07 INFO - 'tests': ['tsvgx', 02:46:07 INFO - 'tsvgr_opacity', 02:46:07 INFO - 'tart', 02:46:07 INFO - 'tscrollx', 02:46:07 INFO - 'cart']}, 02:46:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:46:07 INFO - 'tsvgr_opacity', 02:46:07 INFO - 'tart', 02:46:07 INFO - 'tscrollx', 02:46:07 INFO - 'cart']}, 02:46:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:46:07 INFO - 'talos_options': ['--disable-e10s'], 02:46:07 INFO - 'tests': ['tp5o']}, 02:46:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:46:07 INFO - 'tests': ['tp5o']}, 02:46:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:46:07 INFO - 'talos_options': ['--disable-e10s', 02:46:07 INFO - '--xperf_path', 02:46:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:07 INFO - 'tests': ['tp5n']}, 02:46:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:46:07 INFO - 'talos_options': ['--xperf_path', 02:46:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:07 INFO - 'tests': ['tp5n']}}, 02:46:07 INFO - 'talos.zip': {'path': '', 02:46:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:46:07 INFO - Running post-action listener: _resource_record_post_action 02:46:07 INFO - [mozharness: 2016-08-25 09:46:07.808390Z] Finished populate-webroot step (success) 02:46:07 INFO - [mozharness: 2016-08-25 09:46:07.808478Z] Running create-virtualenv step. 02:46:07 INFO - Running pre-action listener: _resource_record_pre_action 02:46:07 INFO - Running main action method: create_virtualenv 02:46:07 INFO - Creating virtualenv /builds/slave/test/build/venv 02:46:07 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 02:46:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:46:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:46:07 INFO - Using real prefix '/usr' 02:46:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:46:08 INFO - Installing distribute.............................................................................................................................................................................................done. 02:46:10 INFO - Installing pip.................done. 02:46:10 INFO - Return code: 0 02:46:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:46:10 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')]} 02:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:10 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')]} 02:46:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:10 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 0x7f8b65a58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', '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 02:46:10 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 02:46:10 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 02:46:10 INFO - Using env: {'DISPLAY': ':0', 02:46:10 INFO - 'HOME': '/home/cltbld', 02:46:10 INFO - 'LANG': 'en_US.UTF-8', 02:46:10 INFO - 'LANGUAGE': 'en_US:en', 02:46:10 INFO - 'LOGNAME': 'cltbld', 02:46:10 INFO - 'MAIL': '/var/mail/cltbld', 02:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:10 INFO - 'MOZ_NO_REMOTE': '1', 02:46:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:10 INFO - 'NO_EM_RESTART': '1', 02:46:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:10 INFO - 'PWD': '/builds/slave/test', 02:46:10 INFO - 'SHELL': '/bin/bash', 02:46:10 INFO - 'SHLVL': '1', 02:46:10 INFO - 'TERM': 'linux', 02:46:10 INFO - 'TMOUT': '86400', 02:46:10 INFO - 'USER': 'cltbld', 02:46:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', 02:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:10 INFO - '_': '/tools/buildbot/bin/python'} 02:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:10 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 02:46:10 INFO - Cleaning up... 02:46:10 INFO - Return code: 0 02:46:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:46:10 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')]} 02:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:10 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')]} 02:46:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:10 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 0x7f8b65a58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', '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 02:46:10 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 02:46:10 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 02:46:10 INFO - Using env: {'DISPLAY': ':0', 02:46:10 INFO - 'HOME': '/home/cltbld', 02:46:10 INFO - 'LANG': 'en_US.UTF-8', 02:46:10 INFO - 'LANGUAGE': 'en_US:en', 02:46:10 INFO - 'LOGNAME': 'cltbld', 02:46:10 INFO - 'MAIL': '/var/mail/cltbld', 02:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:10 INFO - 'MOZ_NO_REMOTE': '1', 02:46:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:10 INFO - 'NO_EM_RESTART': '1', 02:46:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:10 INFO - 'PWD': '/builds/slave/test', 02:46:10 INFO - 'SHELL': '/bin/bash', 02:46:10 INFO - 'SHLVL': '1', 02:46:10 INFO - 'TERM': 'linux', 02:46:10 INFO - 'TMOUT': '86400', 02:46:10 INFO - 'USER': 'cltbld', 02:46:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', 02:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:10 INFO - '_': '/tools/buildbot/bin/python'} 02:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:10 INFO - Downloading/unpacking psutil>=3.1.1 02:46:10 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 02:46:10 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 02:46:10 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 02:46:10 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 02:46:10 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 02:46:10 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 02:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:46:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:13 INFO - Installing collected packages: psutil 02:46:13 INFO - Running setup.py install for psutil 02:46:13 INFO - building 'psutil._psutil_linux' extension 02:46:13 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 02:46:13 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 02:46:13 INFO - building 'psutil._psutil_posix' extension 02:46:13 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 02:46:13 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 02:46:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:13 INFO - Successfully installed psutil 02:46:13 INFO - Cleaning up... 02:46:13 INFO - Return code: 0 02:46:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:46:13 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')]} 02:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:13 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')]} 02:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:13 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 0x7f8b65a58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', '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 02:46:13 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 02:46:13 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 02:46:13 INFO - Using env: {'DISPLAY': ':0', 02:46:13 INFO - 'HOME': '/home/cltbld', 02:46:13 INFO - 'LANG': 'en_US.UTF-8', 02:46:13 INFO - 'LANGUAGE': 'en_US:en', 02:46:13 INFO - 'LOGNAME': 'cltbld', 02:46:13 INFO - 'MAIL': '/var/mail/cltbld', 02:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:13 INFO - 'MOZ_NO_REMOTE': '1', 02:46:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:13 INFO - 'NO_EM_RESTART': '1', 02:46:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:13 INFO - 'PWD': '/builds/slave/test', 02:46:13 INFO - 'SHELL': '/bin/bash', 02:46:13 INFO - 'SHLVL': '1', 02:46:13 INFO - 'TERM': 'linux', 02:46:13 INFO - 'TMOUT': '86400', 02:46:13 INFO - 'USER': 'cltbld', 02:46:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', 02:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:13 INFO - '_': '/tools/buildbot/bin/python'} 02:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:46:13 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 02:46:13 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 02:46:13 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 02:46:13 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 02:46:13 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 02:46:13 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 02:46:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:46:15 INFO - Installing collected packages: mozsystemmonitor 02:46:15 INFO - Running setup.py install for mozsystemmonitor 02:46:15 INFO - Successfully installed mozsystemmonitor 02:46:15 INFO - Cleaning up... 02:46:15 INFO - Return code: 0 02:46:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:46:15 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')]} 02:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:15 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')]} 02:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:15 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 0x7f8b65a58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', '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 02:46:15 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 02:46:15 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 02:46:15 INFO - Using env: {'DISPLAY': ':0', 02:46:15 INFO - 'HOME': '/home/cltbld', 02:46:15 INFO - 'LANG': 'en_US.UTF-8', 02:46:15 INFO - 'LANGUAGE': 'en_US:en', 02:46:15 INFO - 'LOGNAME': 'cltbld', 02:46:15 INFO - 'MAIL': '/var/mail/cltbld', 02:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:15 INFO - 'MOZ_NO_REMOTE': '1', 02:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:15 INFO - 'NO_EM_RESTART': '1', 02:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:15 INFO - 'PWD': '/builds/slave/test', 02:46:15 INFO - 'SHELL': '/bin/bash', 02:46:15 INFO - 'SHLVL': '1', 02:46:15 INFO - 'TERM': 'linux', 02:46:15 INFO - 'TMOUT': '86400', 02:46:15 INFO - 'USER': 'cltbld', 02:46:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', 02:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:15 INFO - '_': '/tools/buildbot/bin/python'} 02:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:16 INFO - Downloading/unpacking jsonschema==2.5.1 02:46: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 02:46: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 02:46: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 02:46: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 02:46: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 02:46: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 02:46:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:46:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:46: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 02:46: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 02:46: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 02:46: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 02:46: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 02:46: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 02:46:18 INFO - Downloading functools32-3.2.3-2.tar.gz 02:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:46:18 INFO - warning: no files found matching '*.txt' 02:46:18 INFO - no previously-included directories found matching 'build' 02:46:18 INFO - no previously-included directories found matching 'dist' 02:46:18 INFO - no previously-included directories found matching '.git*' 02:46:18 INFO - Installing collected packages: jsonschema, functools32 02:46:18 INFO - Running setup.py install for functools32 02:46:18 INFO - warning: no files found matching '*.txt' 02:46:18 INFO - no previously-included directories found matching 'build' 02:46:18 INFO - no previously-included directories found matching 'dist' 02:46:18 INFO - no previously-included directories found matching '.git*' 02:46:18 INFO - Successfully installed jsonschema functools32 02:46:18 INFO - Cleaning up... 02:46:18 INFO - Return code: 0 02:46:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:46:18 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')]} 02:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:18 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')]} 02:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:18 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 0x7f8b65a58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', '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 02:46:18 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 02:46:18 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 02:46:18 INFO - Using env: {'DISPLAY': ':0', 02:46:18 INFO - 'HOME': '/home/cltbld', 02:46:18 INFO - 'LANG': 'en_US.UTF-8', 02:46:18 INFO - 'LANGUAGE': 'en_US:en', 02:46:18 INFO - 'LOGNAME': 'cltbld', 02:46:18 INFO - 'MAIL': '/var/mail/cltbld', 02:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:18 INFO - 'MOZ_NO_REMOTE': '1', 02:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:18 INFO - 'NO_EM_RESTART': '1', 02:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:18 INFO - 'PWD': '/builds/slave/test', 02:46:18 INFO - 'SHELL': '/bin/bash', 02:46:18 INFO - 'SHLVL': '1', 02:46:18 INFO - 'TERM': 'linux', 02:46:18 INFO - 'TMOUT': '86400', 02:46:18 INFO - 'USER': 'cltbld', 02:46:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', 02:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:18 INFO - '_': '/tools/buildbot/bin/python'} 02:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:46:18 INFO - Cleaning up... 02:46:18 INFO - Return code: 0 02:46:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:46:18 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')]} 02:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:18 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')]} 02:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:18 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 0x7f8b65a58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', '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 02:46:18 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 02:46:18 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 02:46:18 INFO - Using env: {'DISPLAY': ':0', 02:46:18 INFO - 'HOME': '/home/cltbld', 02:46:18 INFO - 'LANG': 'en_US.UTF-8', 02:46:18 INFO - 'LANGUAGE': 'en_US:en', 02:46:18 INFO - 'LOGNAME': 'cltbld', 02:46:18 INFO - 'MAIL': '/var/mail/cltbld', 02:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:18 INFO - 'MOZ_NO_REMOTE': '1', 02:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:18 INFO - 'NO_EM_RESTART': '1', 02:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:18 INFO - 'PWD': '/builds/slave/test', 02:46:18 INFO - 'SHELL': '/bin/bash', 02:46:18 INFO - 'SHLVL': '1', 02:46:18 INFO - 'TERM': 'linux', 02:46:18 INFO - 'TMOUT': '86400', 02:46:18 INFO - 'USER': 'cltbld', 02:46:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', 02:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:18 INFO - '_': '/tools/buildbot/bin/python'} 02:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:18 INFO - Downloading/unpacking blobuploader==1.2.4 02:46:18 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 02:46:18 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 02:46:18 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 02:46:18 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 02:46:18 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 02:46:18 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 02:46:20 INFO - Downloading blobuploader-1.2.4.tar.gz 02:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:46:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:46:20 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 02:46:20 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 02:46:20 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 02:46:20 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 02:46:20 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 02:46:20 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 02:46:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:46:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:46:21 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 02:46:21 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 02:46:21 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 02:46:21 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 02:46:21 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 02:46:21 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 02:46:21 INFO - Downloading docopt-0.6.1.tar.gz 02:46:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:46:21 INFO - Installing collected packages: blobuploader, requests, docopt 02:46:21 INFO - Running setup.py install for blobuploader 02:46:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:46:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:46:21 INFO - Running setup.py install for requests 02:46:21 INFO - Running setup.py install for docopt 02:46:22 INFO - Successfully installed blobuploader requests docopt 02:46:22 INFO - Cleaning up... 02:46:22 INFO - Return code: 0 02:46:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:22 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 0x7f8b65a58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', '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 02:46:22 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 02:46:22 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 02:46:22 INFO - Using env: {'DISPLAY': ':0', 02:46:22 INFO - 'HOME': '/home/cltbld', 02:46:22 INFO - 'LANG': 'en_US.UTF-8', 02:46:22 INFO - 'LANGUAGE': 'en_US:en', 02:46:22 INFO - 'LOGNAME': 'cltbld', 02:46:22 INFO - 'MAIL': '/var/mail/cltbld', 02:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:22 INFO - 'MOZ_NO_REMOTE': '1', 02:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:22 INFO - 'NO_EM_RESTART': '1', 02:46:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:22 INFO - 'PWD': '/builds/slave/test', 02:46:22 INFO - 'SHELL': '/bin/bash', 02:46:22 INFO - 'SHLVL': '1', 02:46:22 INFO - 'TERM': 'linux', 02:46:22 INFO - 'TMOUT': '86400', 02:46:22 INFO - 'USER': 'cltbld', 02:46:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', 02:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:22 INFO - '_': '/tools/buildbot/bin/python'} 02:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:22 INFO - Running setup.py (path:/tmp/pip-kJDaSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:22 INFO - Running setup.py (path:/tmp/pip-9aQ8LW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:22 INFO - Running setup.py (path:/tmp/pip-xdB_6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:22 INFO - Running setup.py (path:/tmp/pip-kA2iA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:22 INFO - Running setup.py (path:/tmp/pip-rvzsIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:22 INFO - Running setup.py (path:/tmp/pip-JfPGL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:22 INFO - Running setup.py (path:/tmp/pip-5h_JR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:22 INFO - Running setup.py (path:/tmp/pip-qIblVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:22 INFO - Running setup.py (path:/tmp/pip-1UPYk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:22 INFO - Running setup.py (path:/tmp/pip-O1Vlnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:23 INFO - Running setup.py (path:/tmp/pip-Mqh6yG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:23 INFO - Running setup.py (path:/tmp/pip-V2PuXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:23 INFO - Running setup.py (path:/tmp/pip-bqHJsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:23 INFO - Running setup.py (path:/tmp/pip-klOSfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:23 INFO - Running setup.py (path:/tmp/pip-hhHeaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:23 INFO - Running setup.py (path:/tmp/pip-hBwKvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:23 INFO - Running setup.py (path:/tmp/pip-7V2tuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:46:23 INFO - Running setup.py install for manifestparser 02:46:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:46:23 INFO - Running setup.py install for mozcrash 02:46:23 INFO - Running setup.py install for mozdebug 02:46:23 INFO - Running setup.py install for mozdevice 02:46:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:46:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:46:23 INFO - Running setup.py install for mozfile 02:46:24 INFO - Running setup.py install for mozhttpd 02:46:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:46:24 INFO - Running setup.py install for mozinfo 02:46:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:46:24 INFO - Running setup.py install for mozInstall 02:46:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:46:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:46:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:46:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:46:24 INFO - Running setup.py install for mozleak 02:46:24 INFO - Running setup.py install for mozlog 02:46:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:46:24 INFO - Running setup.py install for moznetwork 02:46:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:46:24 INFO - Running setup.py install for mozprocess 02:46:24 INFO - Running setup.py install for mozprofile 02:46:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:46:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:46:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:46:24 INFO - Running setup.py install for mozrunner 02:46:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:46:25 INFO - Running setup.py install for mozscreenshot 02:46:25 INFO - Running setup.py install for moztest 02:46:25 INFO - Running setup.py install for mozversion 02:46:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:46:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:46:25 INFO - Cleaning up... 02:46:25 INFO - Return code: 0 02:46:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:25 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 0x7f8b65a58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', '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 02:46:25 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 02:46:25 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 02:46:25 INFO - Using env: {'DISPLAY': ':0', 02:46:25 INFO - 'HOME': '/home/cltbld', 02:46:25 INFO - 'LANG': 'en_US.UTF-8', 02:46:25 INFO - 'LANGUAGE': 'en_US:en', 02:46:25 INFO - 'LOGNAME': 'cltbld', 02:46:25 INFO - 'MAIL': '/var/mail/cltbld', 02:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:25 INFO - 'MOZ_NO_REMOTE': '1', 02:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:25 INFO - 'NO_EM_RESTART': '1', 02:46:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:25 INFO - 'PWD': '/builds/slave/test', 02:46:25 INFO - 'SHELL': '/bin/bash', 02:46:25 INFO - 'SHLVL': '1', 02:46:25 INFO - 'TERM': 'linux', 02:46:25 INFO - 'TMOUT': '86400', 02:46:25 INFO - 'USER': 'cltbld', 02:46:25 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', 02:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:25 INFO - '_': '/tools/buildbot/bin/python'} 02:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:25 INFO - Running setup.py (path:/tmp/pip-9iN2c1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:25 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)) 02:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:25 INFO - Running setup.py (path:/tmp/pip-rQC6cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:25 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)) 02:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:25 INFO - Running setup.py (path:/tmp/pip-v9FL0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:25 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)) 02:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:25 INFO - Running setup.py (path:/tmp/pip-4qmBvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:25 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)) 02:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:25 INFO - Running setup.py (path:/tmp/pip-VTlfyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:25 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)) 02:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:25 INFO - Running setup.py (path:/tmp/pip-5_gloe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:25 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)) 02:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:25 INFO - Running setup.py (path:/tmp/pip-W5hDLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:26 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)) 02:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:26 INFO - Running setup.py (path:/tmp/pip-0uMwYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:26 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)) 02:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:26 INFO - Running setup.py (path:/tmp/pip-u2BCOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:26 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)) 02:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:26 INFO - Running setup.py (path:/tmp/pip-Kkbr7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:26 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)) 02:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:26 INFO - Running setup.py (path:/tmp/pip-im3WEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:26 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)) 02:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:26 INFO - Running setup.py (path:/tmp/pip-tc7tjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:26 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)) 02:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:26 INFO - Running setup.py (path:/tmp/pip-XMQjVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:26 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)) 02:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:26 INFO - Running setup.py (path:/tmp/pip-DF2ZLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:26 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)) 02:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:26 INFO - Running setup.py (path:/tmp/pip-Xdo84o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:26 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)) 02:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:26 INFO - Running setup.py (path:/tmp/pip-nfdczL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:26 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)) 02:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:26 INFO - Running setup.py (path:/tmp/pip-pW_8So-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:26 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)) 02:46:26 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)) 02:46:26 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)) 02:46:26 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)) 02:46:26 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)) 02:46:26 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)) 02:46:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:28 INFO - Downloading blessings-1.6.tar.gz 02:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:46:28 INFO - Installing collected packages: blessings 02:46:28 INFO - Running setup.py install for blessings 02:46:28 INFO - Successfully installed blessings 02:46:28 INFO - Cleaning up... 02:46:28 INFO - Return code: 0 02:46:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:46:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:29 INFO - Reading from file tmpfile_stdout 02:46:29 INFO - Current package versions: 02:46:29 INFO - argparse == 1.2.1 02:46:29 INFO - blessings == 1.6 02:46:29 INFO - blobuploader == 1.2.4 02:46:29 INFO - docopt == 0.6.1 02:46:29 INFO - functools32 == 3.2.3-2 02:46:29 INFO - jsonschema == 2.5.1 02:46:29 INFO - manifestparser == 1.1 02:46:29 INFO - mozInstall == 1.12 02:46:29 INFO - mozcrash == 0.17 02:46:29 INFO - mozdebug == 0.1 02:46:29 INFO - mozdevice == 0.48 02:46:29 INFO - mozfile == 1.2 02:46:29 INFO - mozhttpd == 0.7 02:46:29 INFO - mozinfo == 0.9 02:46:29 INFO - mozleak == 0.1 02:46:29 INFO - mozlog == 3.3 02:46:29 INFO - moznetwork == 0.27 02:46:29 INFO - mozprocess == 0.23 02:46:29 INFO - mozprofile == 0.28 02:46:29 INFO - mozrunner == 6.12 02:46:29 INFO - mozscreenshot == 0.1 02:46:29 INFO - mozsystemmonitor == 0.3 02:46:29 INFO - moztest == 0.7 02:46:29 INFO - mozversion == 1.4 02:46:29 INFO - psutil == 3.1.1 02:46:29 INFO - requests == 1.2.3 02:46:29 INFO - wsgiref == 0.1.2 02:46:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:29 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')]} 02:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:29 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')]} 02:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:29 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 0x7f8b65a58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', '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 02:46:29 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 02:46:29 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 02:46:29 INFO - Using env: {'DISPLAY': ':0', 02:46:29 INFO - 'HOME': '/home/cltbld', 02:46:29 INFO - 'LANG': 'en_US.UTF-8', 02:46:29 INFO - 'LANGUAGE': 'en_US:en', 02:46:29 INFO - 'LOGNAME': 'cltbld', 02:46:29 INFO - 'MAIL': '/var/mail/cltbld', 02:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:29 INFO - 'MOZ_NO_REMOTE': '1', 02:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:29 INFO - 'NO_EM_RESTART': '1', 02:46:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:29 INFO - 'PWD': '/builds/slave/test', 02:46:29 INFO - 'SHELL': '/bin/bash', 02:46:29 INFO - 'SHLVL': '1', 02:46:29 INFO - 'TERM': 'linux', 02:46:29 INFO - 'TMOUT': '86400', 02:46:29 INFO - 'USER': 'cltbld', 02:46:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', 02:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:29 INFO - '_': '/tools/buildbot/bin/python'} 02:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:29 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)) 02:46:29 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)) 02:46:29 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)) 02:46:29 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)) 02:46:29 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)) 02:46:29 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)) 02:46:29 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)) 02:46:29 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)) 02:46:29 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)) 02:46:29 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)) 02:46:29 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)) 02:46:29 INFO - Cleaning up... 02:46:29 INFO - Return code: 0 02:46:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:46:29 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')]} 02:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:29 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')]} 02:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:29 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 0x7f8b65a58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5e40>, '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': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', '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 02:46:29 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 02:46:29 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 02:46:29 INFO - Using env: {'DISPLAY': ':0', 02:46:29 INFO - 'HOME': '/home/cltbld', 02:46:29 INFO - 'LANG': 'en_US.UTF-8', 02:46:29 INFO - 'LANGUAGE': 'en_US:en', 02:46:29 INFO - 'LOGNAME': 'cltbld', 02:46:29 INFO - 'MAIL': '/var/mail/cltbld', 02:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:29 INFO - 'MOZ_NO_REMOTE': '1', 02:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:29 INFO - 'NO_EM_RESTART': '1', 02:46:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:29 INFO - 'PWD': '/builds/slave/test', 02:46:29 INFO - 'SHELL': '/bin/bash', 02:46:29 INFO - 'SHLVL': '1', 02:46:29 INFO - 'TERM': 'linux', 02:46:29 INFO - 'TMOUT': '86400', 02:46:29 INFO - 'USER': 'cltbld', 02:46:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', 02:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:29 INFO - '_': '/tools/buildbot/bin/python'} 02:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:46:29 INFO - Cleaning up... 02:46:29 INFO - Return code: 0 02:46:29 INFO - Running post-action listener: _resource_record_post_action 02:46:29 INFO - Running post-action listener: _start_resource_monitoring 02:46:29 INFO - Starting resource monitoring. 02:46:29 INFO - [mozharness: 2016-08-25 09:46:29.618278Z] Finished create-virtualenv step (success) 02:46:29 INFO - [mozharness: 2016-08-25 09:46:29.618739Z] Running install step. 02:46:29 INFO - Running pre-action listener: _resource_record_pre_action 02:46:29 INFO - Running main action method: install 02:46:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:29 INFO - Reading from file tmpfile_stdout 02:46:29 INFO - Detecting whether we're running mozinstall >=1.0... 02:46:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:46:29 INFO - Reading from file tmpfile_stdout 02:46:29 INFO - Output received: 02:46:29 INFO - Usage: mozinstall [options] installer 02:46:29 INFO - Options: 02:46:29 INFO - -h, --help show this help message and exit 02:46:29 INFO - -d DEST, --destination=DEST 02:46:29 INFO - Directory to install application into. [default: 02:46:29 INFO - "/builds/slave/test"] 02:46:29 INFO - --app=APP Application being installed. [default: firefox] 02:46:29 INFO - mkdir: /builds/slave/test/build/application 02:46:29 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'] 02:46:29 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 02:46:45 INFO - Reading from file tmpfile_stdout 02:46:45 INFO - Output received: 02:46:45 INFO - /builds/slave/test/build/application/firefox/firefox 02:46:45 INFO - Running post-action listener: _resource_record_post_action 02:46:45 INFO - [mozharness: 2016-08-25 09:46:45.996895Z] Finished install step (success) 02:46:45 INFO - [mozharness: 2016-08-25 09:46:45.997340Z] Running run-tests step. 02:46:45 INFO - Running pre-action listener: _resource_record_pre_action 02:46:45 INFO - Running main action method: run_tests 02:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:46:46 INFO - Python 2.7.3 02:46:46 INFO - Return code: 0 02:46:46 INFO - grabbing minidump binary from tooltool 02:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:46 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 0x1ce2090>, '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 0x1ce59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:46:46 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 02:46:46 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 02:46:46 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 02:46:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:46:46 INFO - Return code: 0 02:46:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:46:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:46:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:46:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:46:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:46:46 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:46:46 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:46:46 INFO - Using env: {'DISPLAY': ':0', 02:46:46 INFO - 'HOME': '/home/cltbld', 02:46:46 INFO - 'LANG': 'en_US.UTF-8', 02:46:46 INFO - 'LANGUAGE': 'en_US:en', 02:46:46 INFO - 'LOGNAME': 'cltbld', 02:46:46 INFO - 'MAIL': '/var/mail/cltbld', 02:46:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:46:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:46 INFO - 'MOZ_NO_REMOTE': '1', 02:46:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:46 INFO - 'NO_EM_RESTART': '1', 02:46:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:46 INFO - 'PWD': '/builds/slave/test', 02:46:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:46:46 INFO - 'SHELL': '/bin/bash', 02:46:46 INFO - 'SHLVL': '1', 02:46:46 INFO - 'TERM': 'linux', 02:46:46 INFO - 'TMOUT': '86400', 02:46:46 INFO - 'USER': 'cltbld', 02:46:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269', 02:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:46 INFO - '_': '/tools/buildbot/bin/python'} 02:46:46 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:46:46 INFO - mozversion application_buildid: 20160825004526 02:46:46 INFO - mozversion application_changeset: 0f54395b2ac4a4562266d46081f8895c9d333f42 02:46:46 INFO - mozversion application_display_name: Nightly 02:46:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:46:46 INFO - mozversion application_name: Firefox 02:46:46 INFO - mozversion application_remotingname: firefox 02:46:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 02:46:46 INFO - mozversion application_vendor: Mozilla 02:46:46 INFO - mozversion application_version: 51.0a1 02:46:46 INFO - mozversion platform_buildid: 20160825004526 02:46:46 INFO - mozversion platform_changeset: 0f54395b2ac4a4562266d46081f8895c9d333f42 02:46:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 02:46:46 INFO - mozversion platform_version: 51.0a1 02:46:46 INFO - using testdate: 1472118406 02:46:46 INFO - actual date: 1472118406 02:46:46 INFO - starting webserver on 'localhost:42551' 02:46:46 INFO - SUITE-START | Running 2 tests 02:46:46 INFO - TEST-START | dromaeo_css 02:46:46 INFO - operating with platform_type : linux_ 02:46:46 INFO - Initialising browser for dromaeo_css test... 02:46:46 INFO - TEST-INFO | started process 6464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsp9OW5/profile http://localhost:42551/getInfo.html) 02:46:51 INFO - PROCESS | 6464 | __metrics Screen width/height:1600/1200 02:46:51 INFO - PROCESS | 6464 | colorDepth:24 02:46:51 INFO - PROCESS | 6464 | Browser inner width/height: 1024/697 02:46:51 INFO - PROCESS | 6464 | __metrics 02:46:52 ERROR - PROCESS | 6464 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 02:46:53 INFO - TEST-INFO | 6464: exit 0 02:46:53 INFO - Browser initialized. 02:46:53 INFO - Running cycle 1/1 for dromaeo_css test... 02:46:53 INFO - TEST-INFO | started process 6581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsp9OW5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:05 INFO - PROCESS | 6581 | RSS: Main: 193134592 02:47:05 INFO - PROCESS | 6581 | 02:47:55 INFO - PROCESS | 6581 | 1472118475250 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] 02:50:07 INFO - PROCESS | 6581 | Cycle 1(1): loaded http://localhost:42551/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42551/tests/dromaeo/cssquery-ext.html) 02:50:09 INFO - PROCESS | 6581 | RSS: Main: 213495808 02:50:09 INFO - PROCESS | 6581 | 02:53:11 INFO - PROCESS | 6581 | Cycle 1(1): loaded http://localhost:42551/tests/dromaeo/cssquery-ext.html (next: http://localhost:42551/tests/dromaeo/cssquery-jquery.html) 02:53:12 INFO - PROCESS | 6581 | RSS: Main: 208506880 02:53:12 INFO - PROCESS | 6581 | 02:56:14 INFO - PROCESS | 6581 | Cycle 1(1): loaded http://localhost:42551/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42551/tests/dromaeo/cssquery-mootools.html) 02:56:14 INFO - PROCESS | 6581 | RSS: Main: 204357632 02:56:14 INFO - PROCESS | 6581 | 02:59:16 INFO - PROCESS | 6581 | Cycle 1(1): loaded http://localhost:42551/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42551/tests/dromaeo/cssquery-prototype.html) 02:59:17 INFO - PROCESS | 6581 | RSS: Main: 197447680 02:59:17 INFO - PROCESS | 6581 | 03:02:20 INFO - PROCESS | 6581 | Cycle 1(1): loaded http://localhost:42551/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42551/tests/dromaeo/cssquery-yui.html) 03:02:20 INFO - PROCESS | 6581 | RSS: Main: 199163904 03:02:20 INFO - PROCESS | 6581 | 03:05:23 INFO - PROCESS | 6581 | Cycle 1(1): loaded http://localhost:42551/tests/dromaeo/cssquery-yui.html (next: http://localhost:42551/tests/dromaeo/cssquery-dojo.html) 03:05:23 INFO - PROCESS | 6581 | RSS: Main: 199159808 03:05:23 INFO - PROCESS | 6581 | 03:05:23 INFO - PROCESS | 6581 | __start_tp_report 03:05:23 INFO - PROCESS | 6581 | _x_x_mozilla_page_load 03:05:23 INFO - PROCESS | 6581 | _x_x_mozilla_page_load_details 03:05:23 INFO - PROCESS | 6581 | |i|pagename|runs| 03:05:23 INFO - PROCESS | 6581 | |0;dojo.html;2661.4277930245;2670.6394636724035;2680.4237089025855;2705.0667519705703;2716.7690746286567;4720.504347043562;4800.375951126353;4854.732989685562;4898.167311557035;4917.4836642152595;4745.074710431467;4807.8798030049265;4818.445878723948;4843.418789745236;4861.756912154387;4336.6313863321575;4426.114777044588;4426.579474949891;4502.032063106431;4530.864074077766;4476.060027394235;4476.8880777980485;4477.194105061088;4518.412606361168;4570.948681803187;4346.826126954918;4398.208322501981;4398.7580683062415;4432.224360736858;4489.865304040852;4442.777861106964;4454.866354009385;4461.665375096881;4504.391907092533;4513.413256276663;4372.103718737651;4406.250937340627;4428.357888106207;4434.046679963823;4470.038941627533;4679.9298010529865;4749.050189962021;4796.6162706983705;4797.280407938802;4803.1114243864995;5177.974110129463;5181.1969144782615;5193.766280517386;5194.0910340690225;5217.739113044333;5211.635185537014;5215.739213039333;5223.582113430916;5226.608004399685;5291.603129765283;4712.034033023222;4773.164696178155;4813.711177329372;4826.276058591239;4854.2718592211095;5295.073362161606;5304.787808487617;5305.36335639718;5308.575313974873;5361.785528578813;5081.568066714371;5090.465501122403;5092.6435149539175;5100.209467532539;5161;4994;5084.288199652052;5138.177891537411;5148.4079330876675;5167.870803229949;5134.204198349262;5151.948480515147;5155.639105262596;5156.303898973665;5156.432792392834;5133.255677926754;5147.742612869341;5149.176131818891;5150.97424512875;5199.0641684496395;4289.849855255051;4335.436393268855;4362.062156636339;4383.693141480129;4403.515613282536;3809.8095095245126;3821.9044523887123;3822.7897465639658;3869.1487872667967;3871.1483473635753;4347.326164444453;4434.046679963759;4435.778211089432;4476.4180656514445;4493;5062.848114556569;5077.8730531737;5111;5115.846524604268;5194.3247377840635;4359.106383191438;4365.956340436618;4376.168527979674;4395.120975804788;4429.623482004065;4603.4015577975315;4613.469451013109;4615.284630882219;4617.191991401492;4638.512956139624;4740.312654665055;4791.664583479123;4811.49479304668;4844.152273352079;4859.416869975626;5186.325777649033;5199.038177937094;5207.244949482228;5207.505286997729;5264.052470555183;4836.758162091811;4846.224604063474;4851.757412129309;4852.199387101089;4913.263010548446;4976.377952755905;5067.062593420229;5076.619253555924;5079.11115554769;5201.661891977009;5190.351206099238;5223.869403264796;5224.712640804641;5225.712585807817;5226.346706661668;5074.847754567369;5079.263506791421;5084.9745751271;5087.898242035212;5117.104506711236;4936.358273424432;5001.074801161797;5017;5051.2423136529815;5140.948590514047;4997.225430058346;5002.099622068063;5004.374453193351;5005.224190250517;5072.213806859942;5105.821296254613;5109.20807274873;5109.259157422227;5109.8722531937;5121.129408000724;4753.881152971203;4801.351817504592;4832.323474713473;4859.07677541266;4910.21436570147 03:05:23 INFO - PROCESS | 6581 | |1;ext.html;549.2201074474247;556.4518948835398;560.1737437280012;568.2016766443144;568.2612603615299;32971.34057318852;37036.629633703655;37062.81468592653;37080.62919370805;37143.25713485732;36766;37368.81315593425;37411;37470.25059498809;37483.25033499328;7535.849283014322;7630.694772209105;7676.692932282702;7677.961610191941;7684.4236682248775;7624.885626715603;7636.809079772995;7705.306522412981;7717.72987945422;7727.61361931904;7622.771316860503;7662.003939487887;7696.191899850519;7717.151113377524;7748.070231572191;7653.732119375795;7701.80745481359;7710.804825252038;7717.768466946;7746.302832745024;7595.316421522034;7597.544147351176;7624.35193008595;7633.236676332378;7634.847303053908;36116.63883361159;36606.08484787875;36659.266814663824;36686.81656591727;36722.816385918166;2768.5431903735857;2822.9153125406065;2841.5169421198448;3015.9246018849485;3168.9700847224744;28364.858175709196;28517;28588.285292867637;29131;30209.546856797166;3177.809331440098;3204.1829333520036;3207.1020114368016;3257.5928008998876;3284.786488878215;234429;236208;237050;237325;238204;30808;31672.683273167433;31693.366132677216;50114;50511.74744126256;32713.345733085203;32722.67277327244;32813.179670507954;32845.17887052843;32859.3428131436;12759.872401275868;12885.48458061667;12889.226646401246;12897.097203195874;12915.16051456671;10811;10838.783224335626;10978.725531861608;11025.779484410426;11034.062104721028;7639.388848892187;7649.847003059907;7666.195049519832;7821.804454888674;7830.804229894298;2970.643522777237;3026.72759451646;3054.526548385004;3056.9541456878164;3062.2803641144314;836.2306677856386;848.4103548034057;881.2289246908955;890.955452227386;907.3784457646533;26696.466070678478;27631;27963.440731185263;28278.85860570725;28405.289867753057;916.5325683901258;941.152962333905;1003.5233264199447;1004.1063453526367;1060.2684147937898;14342.354594043292;15070.397184112731;15114.319855606303;15211.315490802941;15303.770443443358;359398;363879;364898;365960;366480;47853;48200.27699584509;48241.45223299295;48434;48534.27198592024;1155.774623948322;1184.7512022475378;1204.4339160594682;1214.489914236023;1218.987810121905;25779.484410311314;26539.469210615294;27445.588316175672;27482;27620.723792761815;41526.37710434286;41845.581544185385;41919;41919.7904010478;41963;307664;307705;307789;307970;309328;24827.751722482542;25183.748162518874;25267.494650107263;25291;25369.74630253748;40277;40620;40733.79633101816;40920.79539602402;41949.161016780105;34919.47620785741;35302.646973530966;35513;35603.465948010286;36155.45766813447;35324.823375883985;35340.64659353373;35540.289194216486;35596.82201588975;35717.46423803593;30048.098557043322;34947.330530293955;36145.27709445744;36407;36748;34456.827715862266;36713.81643091767;37008.444873326385;37535;38034.429483557215;28383.716162838933;29694.851525742233;30359.241018974702;30596;30963.225919351295 03:05:23 INFO - PROCESS | 6581 | |2;jquery.html;357.49593073765993;368.5595713122818;369.48641388470026;377.4847333389924;384.7076222071225;15745.13401762904;16223.26995285212;17154.5711357216;17179.570510737205;17190.74213886793;16019.599510012256;16427;16570.17149142541;16627.83372166278;16650.66698666026;4888.217885138379;5159.355080614923;5161.354830646169;5171.250168725533;5176.637635365526;4898.265260210979;5009.899802003976;5077.162268225738;5077.289179514871;5078.5175408336145;5037.5718063964605;5102;5125.923111153335;5128.282040514331;5130.281760553526;4895.167821470323;5087.79648814047;5112.744362781865;5116.744162791864;5117.769700363474;4478.507364189936;4494.595486406207;4496.190685676577;4500.347449619787;4532.9546704533195;20316.187352505884;20992.370228893156;21057;21117.15531378743;21132.260370886946;1877.2772482594164;1902.5243689077731;2012.9698054529194;2217.6119179143584;2364.9645255321184;12895.419706113154;13691.657708557266;14046;14208.07647502909;14416.062955907832;1529.7934778804831;1558.6648870492897;1574.9763753543707;1610.1868556378954;1641.5321633334443;67195;67242;68051.31948680549;68389;68787.31212687859;9638.241085976475;9725;9831.75420614476;9921.114988152229;10205.642802501878;13427.731445371039;13601.659958501117;13604.387802548908;13624.114432561852;13672.794908076386;7303.01409309747;7463.8507229855095;7479.626018699043;7714.1128770192145;7724.3434308083315;7168;7228.566286022856;7394.889076663854;7412.740554080581;7433.962830185815;6000.249968753906;6128.233970753656;6187.390394156382;6222.12890195373;6345.555811093179;1763.3387479695114;1810.8913465192131;1866.2534986005705;1878.4834170603194;1883.7456943312477;878.7803049237691;883.7923088074298;886.2909672262293;896.852019416802;921.7465197070859;16336.264868080965;16954.88063992001;17145.914270428817;17617.559561011076;18405;790.9129995700468;793.7936136604525;808.6967387229789;810.9107998120202;874.776931882366;7549.320561149523;9337.346385753068;9661.565229564687;9981.550830212658;10019.298649094493;169810;170914.14542927453;171078;374455;374988;82256.70973161126;82969.58515207506;83380;83436;83492;911.2983003087586;918.3479729392072;938.7324612485409;939.2767568971854;939.5349302095507;15106.54680359591;15779;16193.02841829494;16378.262978165772;16692.081935493177;38555.6144438552;38840;39846.800765995984;40827.7958610205;40847.79576102101;46460.30309545292;47742.5225747752;49898.75050624869;50253.246201306276;51557.96884062223;5018.698878067327;6780.457563395015;7276.308750668678;7405.666744996596;7873.0945941215205;8381.37139714536;11804.822927656263;11874.109441791727;11909.52361905514;12182.573609923611;10078.596856125672;10269.640562580274;10380;10454.477276136315;10982.450877456255;10386;10480.842787358044;10601.1519078472;10693.89306106929;10786.514606842868;10448.895511044791;10646.414447205168;10672.199585030998;10895.073918716998;11067;7350.411967042731;7486.962565187139;7601.695932162652;7648.65581048843;7660.20229825881;7876.448648594773;9526.237900967768;10402.375857448576;10594.735131621772;10895.291806032583 03:05:23 INFO - PROCESS | 6581 | |3;mootools.html;1350.581319790865;1373.821403217582;1461.41543382647;1638.9918050409747;1675.4806010136858;6772.593644381341;7306;7310.488265821388;7908.0905695844995;7992.200779922012;7351.301626345502;7537.020187375633;7692.230776922305;7697.114831794345;7701.306882380584;2158.3093410108772;2212.358416059341;2215.7894999975056;2216;2218.0794970087395;2127.3405244374217;2135.722356093713;2229.732432108141;2230.888455577223;2233.352327824929;2202.6255536558824;2207.9668804967937;2213.900374483144;2215.3907675389314;2226.521297920947;2119.8940052997286;2120.162535798366;2137.1558234497443;2149.613069647463;2149.838762092834;2133.7546182189094;2200.449887528118;2206.900689468962;2207.0509680837235;2207.6578130389817;7772.183920688303;7795.454318197729;7854.72508462201;7865.2134786521465;7878.881816772753;4372.978135109336;4472.798724057425;4481.148581769454;4490.550944905516;4520.615747661453;2876.3240638449947;2899.5070837957596;2965.288330800614;2978.1214541710247;2980.3443242486833;870.8824308718368;935.864299676543;940.6378544260441;946.8248374050822;965.0542468381026;10250.179985601135;10458.163346932228;10497.475126243657;10505.9474702626;10524.31591946521;3968.940465893014;4115.900890545843;4237.703360764778;4287.742735435884;4308.719933204332;9000.954995225113;9052.049534798884;9052.728418147466;9067.410618309788;9073.863892041625;4605.332226827091;4614.561616646413;4624.699394539344;4639.164950308977;4647.140279048387;3688.575813781396;4019.4975628046495;4123.381492776108;4158.6673066154635;4164.604362585549;3622.710183185339;3681.1533347330264;3696.390095634244;3713.4801127842125;3742.120601658608;1164.4759858063906;1186;1186.2052424875353;1189.4766302826729;1191.4876603060593;699.5872435263219;752.9472936894365;767.6353731977377;818.9959050204711;821.954792486407;4949.554540091409;5275.366955965309;5369.114096174166;5399.1091469907815;5442.2108794225405;407.4031543788305;408.6648947862724;413.40056917469786;415.991680166395;428.361741005899;3726.552813662378;3741.139537906297;3772.2078363543415;3793.393057110849;3836.961630383716;8990.325725570608;9139.543022848831;9514;9515.571799268911;9525.19035881944;9301.395409298373;9407.623695052258;9409.76475588102;9419.340646154704;9419.481928493999;7112.786616401413;7128.607926564089;7157.284271572905;7184.461165412615;7208.675609597581;4962.675217042253;5016.87457813543;5023;5074.543291103819;5168.483151684952;8655.956720216358;8664.393492455467;8744.125587441205;8839.46963182211;8883.289336852908;8722.912770872465;8881.511516866634;8907.198352148078;8951.597178127131;8978.595963181542;6037.939620603738;6497.155369801895;6702.463802895854;6793;6860.3139686031;7544.47188696786;7555.16893141743;7560.281773231534;7574.621268936641;7604.8479030417975;6686.83282917931;6814.488913331421;6824.829379265558;6834.658267086526;7014.824629384306;6655.933440665725;6706.6646667665445;6730.899036514358;6755.7973260802255;6942.409895158766;6235.282942461494;6269.153664255267;6310.968445157745;6316.273628532777;6326.746930122744;4681.906361872811;4759.500252473579;4817.421909370898;4874.6344024197615;4951.9752401237765;4592.862214133581;4685.437747470325;4734.313524538991;4740.336352910665;4759.095771803346 03:05:23 INFO - PROCESS | 6581 | |4;prototype.html;290.2887924584768;295.9674435812061;301.9516877299632;303.57954233386766;306.5968251748951;4836.685615434994;4945.505449455052;5032.245163225518;5036.697798132105;5050.671706339085;4867.3185753994385;4956.6121485983895;4981.982297169643;4986.900261994758;5000.949990500094;3951.170254246612;3951.5653278139525;3960.544537378195;3966.8809935701975;3970.7816070116132;3751.962480375202;3954.062509370402;3968.2658708138943;3973.8807835764974;3977.6618987386105;3925.4896863407716;3944.126539893556;3948.269570129521;3953.62440568147;3953.7743299577223;3936.114374265796;3936.6063393660693;3945.3884647879627;3953.683705303569;3953.822078006468;3497.2306092659574;3506.4389697648508;3507.754457187998;3508.7368447366293;3516.384632689295;4676.275177347517;4922.704637721748;4928.926066109011;4937.827176048857;4951.762059485129;4512.706674066208;4529.909401811979;4537.183307004738;4551.317302404633;4558.544145585448;5292.988664307577;5306.681599104066;5313.840584782462;5330.494667506305;5338.733063346817;3678.3746763050344;3791.469194312798;3813.4470501777364;3816.2367526494536;3833.386658134685;5502.80740174096;5505.357428434374;5525.475079867406;5526.834194974117;5562.7774889004395;3893.5717071122153;3909;3915.3164139420323;3917.8236979335998;3930.292547341506;3829.617038296148;3959.4654721612214;3976.1252524444576;3979.3633018716864;3979.900502487461;4469.508354081048;4491.573300536509;4496.123255965055;4496.572825581565;4501.212287849678;5250.579953603703;5300.814471493556;5306.442823503554;5306.469353064663;5308.284201059274;1305.6017914536158;1347.6900312927885;1363.243399913038;1369.4795977528474;1373.9175649460865;914.7804526913626;934.7522906429665;952.8756067839877;956.3496822160859;957.9712608621613;4516.322551617218;4521.59305662492;4527;4538.478075021415;4538.909221815611;5369.838904832861;5375.354957405137;5382.4886635769535;5406.405295417501;5420.457954204548;4367.58507941745;4517.232070548015;4519.502854685982;4528.977355113203;4537.523560026216;2486.925392238236;2512.32167314824;2525.0052458557534;2531.544361991862;2540.7713305802567;4461.776911154494;4463.598276155097;4464.308032255006;4473.888152796141;4478.910421791546;4788.473267940523;4829.855104346875;4842.803749525367;4853.563179313879;4879.341288926021;4682.461516925529;5071.199724097892;5083.517065878736;5083.694978301313;5100.41887015034;5465.72671366438;5468.753906074316;5472.699001554953;5485.341758988947;5490.176473529003;5248.685078895279;5379.2469054333205;5383.784648614168;5399.868076515533;5410.266915828066;5101.8724531887;5104.9489505104475;5111.3355263815465;5113.187746739204;5117.513836185556;3765.1151979285396;3800.56293526248;3812.237552489458;3820.7707537547835;3835.8465661373234;5294.311739473844;5444.373897001896;5467.87908478753;5483.972580137074;5484.232207491034;5239.559121241689;5241.397239317374;5243.606729495379;5251.238570407346;5275.366955965309;5249.947500524946;5259.289995850664;5267.499587539178;5302.257683924331;5304.9204261936875;5010.799568017239;5206.661566998133;5208.557272631869;5215.869603259949;5235.65968212065;5331.680099194061;5335.653182543122;5339.662710805746;5346.331708536433;5361.839144825662;5116.948830511647;5117.744112794271;5132.307138536399;5138.691678499302;5149.403684857706 03:05:23 INFO - PROCESS | 6581 | |5;yui.html;574.4399210769499;582.1471544187765;602.0938487576198;616.260487415102;646.6191552233616;12960.870391296085;13678.24769637672;13828.930855345734;13982.720345593081;14001.999999999987;13424.463021479129;13489.325533723324;13585.59243222705;13593.456261749543;13611.727765444684;743.2270438743714;759.5290919629837;761.4555592751182;762.161622215564;762.7826069570174;620.435403782558;729.9306565876233;764.3121190928154;771.9691212351499;774.7598244544181;805.4965646470955;807.2532907060975;808.8827120067616;811.0632219786127;812.5165526511717;793.3970182661191;794.8291117409727;796.1600511460407;801.3709238247976;802.2739420824164;591.2402562706944;593.5162842283526;593.6230493636572;594.4174708785415;594.9970250148722;13043.08698391113;13067.803982940264;13089;13101.868981310161;13120.60638180856;12598.37008149598;13173.209607423585;13224.677532246698;13253.801192982113;13577.321133943362;8917.910820891837;9126.543672816399;9129.269658427309;9139.451632902048;9288.442693438416;3125.859336329848;3158.7630927680516;3184.1243657994005;3197.616286045666;3224.629167645727;50878.49121508774;52917.73541132308;53557.46442535564;60095.098573521;63871;9332.673356432628;9590;9664.130228279488;9868.753281168028;9883.703488895344;18575.81424185768;18621.534461638566;18718.81281187198;18740.344087957128;19052.71420928687;6528.967355163194;6551.951687730036;6627.304133065959;6692.765753198712;6769.966150169316;3427.9314413711586;3474.4788281757938;3486.7559270850797;3488.389531831919;3581.8030008349792;2957.822530648168;3070.1557071804987;3070.815751054944;3093.1957691000503;3105.580746599225;474.28383141456646;476.3521610609568;479.7457347605705;488.6310835319382;489.49581930611527;457.31859529301767;491.19241192411556;509.5617768718899;518.1604312047708;518.800261899164;7585.772426827204;7669.309762121436;8189.1401402853035;8202.958985205156;8308.626111824982;523.0933840575378;528.1101344234976;537.4813305160461;543.5787264869679;545.6698697288163;3557.928841423157;3648.52569166012;3690.040589446763;3695.5380577427823;3718.7768733875514;100451;103475;103915.48042259741;108257;108797;88070;88070.55964720136;90697;94160;95346;56176.43823561794;67654;79134.6475943817;79804;80006.19993800104;6650.534462587572;6951.6871740770775;7144.142702875688;7377;7526.924730752622;41203.58796411997;42697;44995.32507012463;46053;46111.308330375745;40335.99160021023;54131.729341354614;55366;56033.71983140058;57661.711691441276;10554.419506926886;10803.351798892092;10918.126549875831;10922.071623912056;11002.559897604006;11418.429078546205;11691.415429228335;12132.818007729715;12404.441800119197;12664.374262978943;10892.346459212473;11121.610743623934;11176.438265838704;11373.488193031499;11773.88226117728;10897.455127243447;10947.56209751601;11036.337819730841;11076;11094.944525277644;8955.120223431468;9750.85373719409;9826.459544725109;10747.516361763583;10810.00014997228;9059.428451502146;9318.50903855407;9542.284328675516;9831.557579908778;9922.900770992486;9388.436693798394;10038.498075096362;10078;10085.84763294375;10113.832975164132 03:05:23 INFO - PROCESS | 6581 | __end_tp_report 03:05:23 INFO - PROCESS | 6581 | __start_cc_report 03:05:23 INFO - PROCESS | 6581 | _x_x_mozilla_cycle_collect,379 03:05:23 INFO - PROCESS | 6581 | __end_cc_report 03:05:23 INFO - PROCESS | 6581 | __startTimestamp1472119523649__endTimestamp 03:05:23 INFO - PROCESS | 6581 | 03:05:23 INFO - PROCESS | 6581 | ------- Summary: start ------- 03:05:23 INFO - PROCESS | 6581 | Number of tests: 6 03:05:23 INFO - PROCESS | 6581 | 03:05:23 INFO - PROCESS | 6581 | [#0] dojo.html Cycles:165 Average:4770.45 Median:4854.73 stddev:506.47 (10.4%) stddev-sans-first:480.24 03:05:23 INFO - PROCESS | 6581 | Values: 2661.4 2670.6 2680.4 2705.1 2716.8 4720.5 4800.4 4854.7 4898.2 4917.5 4745.1 4807.9 4818.4 4843.4 4861.8 4336.6 4426.1 4426.6 4502.0 4530.9 4476.1 4476.9 4477.2 4518.4 4570.9 4346.8 4398.2 4398.8 4432.2 4489.9 4442.8 4454.9 4461.7 4504.4 4513.4 4372.1 4406.3 4428.4 4434.0 4470.0 4679.9 4749.1 4796.6 4797.3 4803.1 5178.0 5181.2 5193.8 5194.1 5217.7 5211.6 5215.7 5223.6 5226.6 5291.6 4712.0 4773.2 4813.7 4826.3 4854.3 5295.1 5304.8 5305.4 5308.6 5361.8 5081.6 5090.5 5092.6 5100.2 5161.0 4994.0 5084.3 5138.2 5148.4 5167.9 5134.2 5151.9 5155.6 5156.3 5156.4 5133.3 5147.7 5149.2 5151.0 5199.1 4289.8 4335.4 4362.1 4383.7 4403.5 3809.8 3821.9 3822.8 3869.1 3871.1 4347.3 4434.0 4435.8 4476.4 4493.0 5062.8 5077.9 5111.0 5115.8 5194.3 4359.1 4366.0 4376.2 4395.1 4429.6 4603.4 4613.5 4615.3 4617.2 4638.5 4740.3 4791.7 4811.5 4844.2 4859.4 5186.3 5199.0 5207.2 5207.5 5264.1 4836.8 4846.2 4851.8 4852.2 4913.3 4976.4 5067.1 5076.6 5079.1 5201.7 5190.4 5223.9 5224.7 5225.7 5226.3 5074.8 5079.3 5085.0 5087.9 5117.1 4936.4 5001.1 5017.0 5051.2 5140.9 4997.2 5002.1 5004.4 5005.2 5072.2 5105.8 5109.2 5109.3 5109.9 5121.1 4753.9 4801.4 4832.3 4859.1 4910.2 03:05:23 INFO - PROCESS | 6581 | 03:05:23 INFO - PROCESS | 6581 | [#1] ext.html Cycles:180 Average:44469.82 Median:35568.56 stddev:80962.03 (227.6%) stddev-sans-first:81121.99 03:05:23 INFO - PROCESS | 6581 | Values: 549.2 556.5 560.2 568.2 568.3 32971.3 37036.6 37062.8 37080.6 37143.3 36766.0 37368.8 37411.0 37470.3 37483.3 7535.8 7630.7 7676.7 7678.0 7684.4 7624.9 7636.8 7705.3 7717.7 7727.6 7622.8 7662.0 7696.2 7717.2 7748.1 7653.7 7701.8 7710.8 7717.8 7746.3 7595.3 7597.5 7624.4 7633.2 7634.8 36116.6 36606.1 36659.3 36686.8 36722.8 2768.5 2822.9 2841.5 3015.9 3169.0 28364.9 28517.0 28588.3 29131.0 30209.5 3177.8 3204.2 3207.1 3257.6 3284.8 234429.0 236208.0 237050.0 237325.0 238204.0 30808.0 31672.7 31693.4 50114.0 50511.7 32713.3 32722.7 32813.2 32845.2 32859.3 12759.9 12885.5 12889.2 12897.1 12915.2 10811.0 10838.8 10978.7 11025.8 11034.1 7639.4 7649.8 7666.2 7821.8 7830.8 2970.6 3026.7 3054.5 3057.0 3062.3 836.2 848.4 881.2 891.0 907.4 26696.5 27631.0 27963.4 28278.9 28405.3 916.5 941.2 1003.5 1004.1 1060.3 14342.4 15070.4 15114.3 15211.3 15303.8 359398.0 363879.0 364898.0 365960.0 366480.0 47853.0 48200.3 48241.5 48434.0 48534.3 1155.8 1184.8 1204.4 1214.5 1219.0 25779.5 26539.5 27445.6 27482.0 27620.7 41526.4 41845.6 41919.0 41919.8 41963.0 307664.0 307705.0 307789.0 307970.0 309328.0 24827.8 25183.7 25267.5 25291.0 25369.7 40277.0 40620.0 40733.8 40920.8 41949.2 34919.5 35302.6 35513.0 35603.5 36155.5 35324.8 35340.6 35540.3 35596.8 35717.5 30048.1 34947.3 36145.3 36407.0 36748.0 34456.8 36713.8 37008.4 37535.0 38034.4 28383.7 29694.9 30359.2 30596.0 30963.2 03:05:23 INFO - PROCESS | 6581 | 03:05:23 INFO - PROCESS | 6581 | [#2] jquery.html Cycles:180 Average:20775.25 Median:4495.39 stddev:46280.42 (1029.5%) stddev-sans-first:46384.86 03:05:23 INFO - PROCESS | 6581 | Values: 357.5 368.6 369.5 377.5 384.7 15745.1 16223.3 17154.6 17179.6 17190.7 16019.6 16427.0 16570.2 16627.8 16650.7 4888.2 5159.4 5161.4 5171.3 5176.6 4898.3 5009.9 5077.2 5077.3 5078.5 5037.6 5102.0 5125.9 5128.3 5130.3 4895.2 5087.8 5112.7 5116.7 5117.8 4478.5 4494.6 4496.2 4500.3 4533.0 20316.2 20992.4 21057.0 21117.2 21132.3 1877.3 1902.5 2013.0 2217.6 2365.0 12895.4 13691.7 14046.0 14208.1 14416.1 1529.8 1558.7 1575.0 1610.2 1641.5 67195.0 67242.0 68051.3 68389.0 68787.3 9638.2 9725.0 9831.8 9921.1 10205.6 13427.7 13601.7 13604.4 13624.1 13672.8 7303.0 7463.9 7479.6 7714.1 7724.3 7168.0 7228.6 7394.9 7412.7 7434.0 6000.2 6128.2 6187.4 6222.1 6345.6 1763.3 1810.9 1866.3 1878.5 1883.7 878.8 883.8 886.3 896.9 921.7 16336.3 16954.9 17145.9 17617.6 18405.0 790.9 793.8 808.7 810.9 874.8 7549.3 9337.3 9661.6 9981.6 10019.3 169810.0 170914.1 171078.0 374455.0 374988.0 82256.7 82969.6 83380.0 83436.0 83492.0 911.3 918.3 938.7 939.3 939.5 15106.5 15779.0 16193.0 16378.3 16692.1 38555.6 38840.0 39846.8 40827.8 40847.8 46460.3 47742.5 49898.8 50253.2 51558.0 5018.7 6780.5 7276.3 7405.7 7873.1 8381.4 11804.8 11874.1 11909.5 12182.6 10078.6 10269.6 10380.0 10454.5 10982.5 10386.0 10480.8 10601.2 10693.9 10786.5 10448.9 10646.4 10672.2 10895.1 11067.0 7350.4 7487.0 7601.7 7648.7 7660.2 7876.4 9526.2 10402.4 10594.7 10895.3 03:05:23 INFO - PROCESS | 6581 | 03:05:23 INFO - PROCESS | 6581 | [#3] mootools.html Cycles:180 Average:5090.40 Median:4957.33 stddev:2835.60 (57.2%) stddev-sans-first:2829.62 03:05:23 INFO - PROCESS | 6581 | Values: 1350.6 1373.8 1461.4 1639.0 1675.5 6772.6 7306.0 7310.5 7908.1 7992.2 7351.3 7537.0 7692.2 7697.1 7701.3 2158.3 2212.4 2215.8 2216.0 2218.1 2127.3 2135.7 2229.7 2230.9 2233.4 2202.6 2208.0 2213.9 2215.4 2226.5 2119.9 2120.2 2137.2 2149.6 2149.8 2133.8 2200.4 2206.9 2207.1 2207.7 7772.2 7795.5 7854.7 7865.2 7878.9 4373.0 4472.8 4481.1 4490.6 4520.6 2876.3 2899.5 2965.3 2978.1 2980.3 870.9 935.9 940.6 946.8 965.1 10250.2 10458.2 10497.5 10505.9 10524.3 3968.9 4115.9 4237.7 4287.7 4308.7 9001.0 9052.0 9052.7 9067.4 9073.9 4605.3 4614.6 4624.7 4639.2 4647.1 3688.6 4019.5 4123.4 4158.7 4164.6 3622.7 3681.2 3696.4 3713.5 3742.1 1164.5 1186.0 1186.2 1189.5 1191.5 699.6 752.9 767.6 819.0 822.0 4949.6 5275.4 5369.1 5399.1 5442.2 407.4 408.7 413.4 416.0 428.4 3726.6 3741.1 3772.2 3793.4 3837.0 8990.3 9139.5 9514.0 9515.6 9525.2 9301.4 9407.6 9409.8 9419.3 9419.5 7112.8 7128.6 7157.3 7184.5 7208.7 4962.7 5016.9 5023.0 5074.5 5168.5 8656.0 8664.4 8744.1 8839.5 8883.3 8722.9 8881.5 8907.2 8951.6 8978.6 6037.9 6497.2 6702.5 6793.0 6860.3 7544.5 7555.2 7560.3 7574.6 7604.8 6686.8 6814.5 6824.8 6834.7 7014.8 6655.9 6706.7 6730.9 6755.8 6942.4 6235.3 6269.2 6311.0 6316.3 6326.7 4681.9 4759.5 4817.4 4874.6 4952.0 4592.9 4685.4 4734.3 4740.3 4759.1 03:05:23 INFO - PROCESS | 6581 | 03:05:23 INFO - PROCESS | 6581 | [#4] prototype.html Cycles:180 Average:4336.76 Median:4848.18 stddev:1260.68 (26.0%) stddev-sans-first:1227.08 03:05:23 INFO - PROCESS | 6581 | Values: 290.3 296.0 302.0 303.6 306.6 4836.7 4945.5 5032.2 5036.7 5050.7 4867.3 4956.6 4982.0 4986.9 5000.9 3951.2 3951.6 3960.5 3966.9 3970.8 3752.0 3954.1 3968.3 3973.9 3977.7 3925.5 3944.1 3948.3 3953.6 3953.8 3936.1 3936.6 3945.4 3953.7 3953.8 3497.2 3506.4 3507.8 3508.7 3516.4 4676.3 4922.7 4928.9 4937.8 4951.8 4512.7 4529.9 4537.2 4551.3 4558.5 5293.0 5306.7 5313.8 5330.5 5338.7 3678.4 3791.5 3813.4 3816.2 3833.4 5502.8 5505.4 5525.5 5526.8 5562.8 3893.6 3909.0 3915.3 3917.8 3930.3 3829.6 3959.5 3976.1 3979.4 3979.9 4469.5 4491.6 4496.1 4496.6 4501.2 5250.6 5300.8 5306.4 5306.5 5308.3 1305.6 1347.7 1363.2 1369.5 1373.9 914.8 934.8 952.9 956.3 958.0 4516.3 4521.6 4527.0 4538.5 4538.9 5369.8 5375.4 5382.5 5406.4 5420.5 4367.6 4517.2 4519.5 4529.0 4537.5 2486.9 2512.3 2525.0 2531.5 2540.8 4461.8 4463.6 4464.3 4473.9 4478.9 4788.5 4829.9 4842.8 4853.6 4879.3 4682.5 5071.2 5083.5 5083.7 5100.4 5465.7 5468.8 5472.7 5485.3 5490.2 5248.7 5379.2 5383.8 5399.9 5410.3 5101.9 5104.9 5111.3 5113.2 5117.5 3765.1 3800.6 3812.2 3820.8 3835.8 5294.3 5444.4 5467.9 5484.0 5484.2 5239.6 5241.4 5243.6 5251.2 5275.4 5249.9 5259.3 5267.5 5302.3 5304.9 5010.8 5206.7 5208.6 5215.9 5235.7 5331.7 5335.7 5339.7 5346.3 5361.8 5116.9 5117.7 5132.3 5138.7 5149.4 03:05:23 INFO - PROCESS | 6581 | 03:05:23 INFO - PROCESS | 6581 | [#5] yui.html Cycles:180 Average:17461.90 Median:513.86 stddev:25872.92 (5035.0%) stddev-sans-first:25914.43 03:05:23 INFO - PROCESS | 6581 | Values: 574.4 582.1 602.1 616.3 646.6 12960.9 13678.2 13828.9 13982.7 14002.0 13424.5 13489.3 13585.6 13593.5 13611.7 743.2 759.5 761.5 762.2 762.8 620.4 729.9 764.3 772.0 774.8 805.5 807.3 808.9 811.1 812.5 793.4 794.8 796.2 801.4 802.3 591.2 593.5 593.6 594.4 595.0 13043.1 13067.8 13089.0 13101.9 13120.6 12598.4 13173.2 13224.7 13253.8 13577.3 8917.9 9126.5 9129.3 9139.5 9288.4 3125.9 3158.8 3184.1 3197.6 3224.6 50878.5 52917.7 53557.5 60095.1 63871.0 9332.7 9590.0 9664.1 9868.8 9883.7 18575.8 18621.5 18718.8 18740.3 19052.7 6529.0 6552.0 6627.3 6692.8 6770.0 3427.9 3474.5 3486.8 3488.4 3581.8 2957.8 3070.2 3070.8 3093.2 3105.6 474.3 476.4 479.7 488.6 489.5 457.3 491.2 509.6 518.2 518.8 7585.8 7669.3 8189.1 8203.0 8308.6 523.1 528.1 537.5 543.6 545.7 3557.9 3648.5 3690.0 3695.5 3718.8 100451.0 103475.0 103915.5 108257.0 108797.0 88070.0 88070.6 90697.0 94160.0 95346.0 56176.4 67654.0 79134.6 79804.0 80006.2 6650.5 6951.7 7144.1 7377.0 7526.9 41203.6 42697.0 44995.3 46053.0 46111.3 40336.0 54131.7 55366.0 56033.7 57661.7 10554.4 10803.4 10918.1 10922.1 11002.6 11418.4 11691.4 12132.8 12404.4 12664.4 10892.3 11121.6 11176.4 11373.5 11773.9 10897.5 10947.6 11036.3 11076.0 11094.9 8955.1 9750.9 9826.5 10747.5 10810.0 9059.4 9318.5 9542.3 9831.6 9922.9 9388.4 10038.5 10078.0 10085.8 10113.8 03:05:23 INFO - PROCESS | 6581 | -------- Summary: end -------- 03:05:23 INFO - PROCESS | 6581 | 03:05:24 INFO - TEST-INFO | 6581: exit 0 03:05:24 INFO - TEST-OK | dromaeo_css | took 1118506ms 03:05:24 INFO - TEST-START | kraken 03:05:24 INFO - operating with platform_type : linux_ 03:05:24 INFO - Initialising browser for kraken test... 03:05:24 INFO - TEST-INFO | started process 6930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeTAPcK/profile http://localhost:42551/getInfo.html) 03:05:30 INFO - PROCESS | 6930 | __metrics Screen width/height:1600/1200 03:05:30 INFO - PROCESS | 6930 | colorDepth:24 03:05:30 INFO - PROCESS | 6930 | Browser inner width/height: 1024/697 03:05:30 INFO - PROCESS | 6930 | __metrics 03:05:30 ERROR - PROCESS | 6930 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 03:05:31 INFO - TEST-INFO | 6930: exit 0 03:05:31 INFO - Browser initialized. 03:05:31 INFO - Running cycle 1/1 for kraken test... 03:05:31 INFO - TEST-INFO | started process 7048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeTAPcK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:43 INFO - PROCESS | 7048 | RSS: Main: 192790528 03:05:43 INFO - PROCESS | 7048 | 03:05:46 INFO - PROCESS | 7048 | Cycle 1(1): loaded http://localhost:42551/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42551/tests/kraken/driver.html?testName=audio-beat-detection) 03:05:47 INFO - PROCESS | 7048 | RSS: Main: 205914112 03:05:47 INFO - PROCESS | 7048 | 03:05:50 INFO - PROCESS | 7048 | Cycle 1(1): loaded http://localhost:42551/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42551/tests/kraken/driver.html?testName=audio-dft) 03:05:51 INFO - PROCESS | 7048 | RSS: Main: 204505088 03:05:51 INFO - PROCESS | 7048 | 03:05:54 INFO - PROCESS | 7048 | Cycle 1(1): loaded http://localhost:42551/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42551/tests/kraken/driver.html?testName=audio-fft) 03:05:54 INFO - PROCESS | 7048 | RSS: Main: 196182016 03:05:54 INFO - PROCESS | 7048 | 03:05:57 INFO - PROCESS | 7048 | Cycle 1(1): loaded http://localhost:42551/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42551/tests/kraken/driver.html?testName=audio-oscillator) 03:05:57 INFO - PROCESS | 7048 | RSS: Main: 196431872 03:05:57 INFO - PROCESS | 7048 | 03:05:59 INFO - PROCESS | 7048 | Cycle 1(1): loaded http://localhost:42551/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42551/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:06:00 INFO - PROCESS | 7048 | RSS: Main: 196841472 03:06:00 INFO - PROCESS | 7048 | 03:06:03 INFO - PROCESS | 7048 | Cycle 1(1): loaded http://localhost:42551/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42551/tests/kraken/driver.html?testName=imaging-darkroom) 03:06:04 INFO - PROCESS | 7048 | RSS: Main: 197627904 03:06:04 INFO - PROCESS | 7048 | 03:06:07 INFO - PROCESS | 7048 | Cycle 1(1): loaded http://localhost:42551/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42551/tests/kraken/driver.html?testName=imaging-desaturate) 03:06:08 INFO - PROCESS | 7048 | RSS: Main: 194375680 03:06:08 INFO - PROCESS | 7048 | 03:06:11 INFO - PROCESS | 7048 | Cycle 1(1): loaded http://localhost:42551/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42551/tests/kraken/driver.html?testName=json-parse-financial) 03:06:12 INFO - PROCESS | 7048 | RSS: Main: 196472832 03:06:12 INFO - PROCESS | 7048 | 03:06:13 INFO - PROCESS | 7048 | Cycle 1(1): loaded http://localhost:42551/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42551/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:06:14 INFO - PROCESS | 7048 | RSS: Main: 196018176 03:06:14 INFO - PROCESS | 7048 | 03:06:16 INFO - PROCESS | 7048 | Cycle 1(1): loaded http://localhost:42551/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42551/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:06:17 INFO - PROCESS | 7048 | RSS: Main: 196210688 03:06:17 INFO - PROCESS | 7048 | 03:06:19 INFO - PROCESS | 7048 | Cycle 1(1): loaded http://localhost:42551/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42551/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:06:20 INFO - PROCESS | 7048 | RSS: Main: 196509696 03:06:20 INFO - PROCESS | 7048 | 03:06:22 INFO - PROCESS | 7048 | Cycle 1(1): loaded http://localhost:42551/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:06:23 INFO - PROCESS | 7048 | RSS: Main: 197058560 03:06:23 INFO - PROCESS | 7048 | 03:06:26 INFO - PROCESS | 7048 | Cycle 1(1): loaded http://localhost:42551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:06:27 INFO - PROCESS | 7048 | RSS: Main: 196947968 03:06:27 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | Cycle 1(1): loaded http://localhost:42551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42551/tests/kraken/driver.html?testName=ai-astar) 03:06:29 INFO - PROCESS | 7048 | RSS: Main: 199729152 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | __start_tp_report 03:06:29 INFO - PROCESS | 7048 | _x_x_mozilla_page_load 03:06:29 INFO - PROCESS | 7048 | _x_x_mozilla_page_load_details 03:06:29 INFO - PROCESS | 7048 | |i|pagename|runs| 03:06:29 INFO - PROCESS | 7048 | |0;ai-astar;111;115;116;117;115;114;115;116;114;133 03:06:29 INFO - PROCESS | 7048 | |1;audio-beat-detection;154;126;153;193;128;156;160;125;193;125 03:06:29 INFO - PROCESS | 7048 | |2;audio-dft;176;163;162;165;164;164;163;163;161;163 03:06:29 INFO - PROCESS | 7048 | |3;audio-fft;77;76;75;178;77;78;81;79;158;78 03:06:29 INFO - PROCESS | 7048 | |4;audio-oscillator;88;91;141;89;89;87;134;92;86;144 03:06:29 INFO - PROCESS | 7048 | |5;imaging-gaussian-blur;119;119;120;119;118;120;120;118;119;119 03:06:29 INFO - PROCESS | 7048 | |6;imaging-darkroom;149;147;148;150;149;148;151;148;148;149 03:06:29 INFO - PROCESS | 7048 | |7;imaging-desaturate;96;96;97;97;96;97;95;97;96;95 03:06:29 INFO - PROCESS | 7048 | |8;json-parse-financial;65;67;67;68;68;71;67;67;67;75 03:06:29 INFO - PROCESS | 7048 | |9;json-stringify-tinderbox;66;67;65;65;66;65;65;66;65;65 03:06:29 INFO - PROCESS | 7048 | |10;stanford-crypto-aes;83;89;83;84;84;86;91;84;83;84 03:06:29 INFO - PROCESS | 7048 | |11;stanford-crypto-ccm;157;131;152;144;154;142;148;145;147;138 03:06:29 INFO - PROCESS | 7048 | |12;stanford-crypto-pbkdf2;174;179;172;172;175;170;173;175;169;176 03:06:29 INFO - PROCESS | 7048 | |13;stanford-crypto-sha256-iterative;71;69;70;72;69;70;71;69;69;68 03:06:29 INFO - PROCESS | 7048 | __end_tp_report 03:06:29 INFO - PROCESS | 7048 | __start_cc_report 03:06:29 INFO - PROCESS | 7048 | _x_x_mozilla_cycle_collect,931 03:06:29 INFO - PROCESS | 7048 | __end_cc_report 03:06:29 INFO - PROCESS | 7048 | __startTimestamp1472119589267__endTimestamp 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | ------- Summary: start ------- 03:06:29 INFO - PROCESS | 7048 | Number of tests: 14 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | [#0] ai-astar Cycles:10 Average:116.60 Median:115.50 stddev:5.99 (5.2%) stddev-sans-first:6.00 03:06:29 INFO - PROCESS | 7048 | Values: 111.0 115.0 116.0 117.0 115.0 114.0 115.0 116.0 114.0 133.0 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:155.00 stddev:26.15 (16.9%) stddev-sans-first:27.71 03:06:29 INFO - PROCESS | 7048 | Values: 154.0 126.0 153.0 193.0 128.0 156.0 160.0 125.0 193.0 125.0 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:4.22 (2.6%) stddev-sans-first:1.17 03:06:29 INFO - PROCESS | 7048 | Values: 176.0 163.0 162.0 165.0 164.0 164.0 163.0 163.0 161.0 163.0 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | [#3] audio-fft Cycles:10 Average:95.70 Median:77.50 stddev:38.43 (49.6%) stddev-sans-first:40.16 03:06:29 INFO - PROCESS | 7048 | Values: 77.0 76.0 75.0 178.0 77.0 78.0 81.0 79.0 158.0 78.0 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:88.50 stddev:24.72 (27.9%) stddev-sans-first:25.53 03:06:29 INFO - PROCESS | 7048 | Values: 88.0 91.0 141.0 89.0 89.0 87.0 134.0 92.0 86.0 144.0 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | [#5] imaging-gaussian-blur Cycles:10 Average:119.10 Median:119.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 03:06:29 INFO - PROCESS | 7048 | Values: 119.0 119.0 120.0 119.0 118.0 120.0 120.0 118.0 119.0 119.0 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 03:06:29 INFO - PROCESS | 7048 | Values: 149.0 147.0 148.0 150.0 149.0 148.0 151.0 148.0 148.0 149.0 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.50 stddev:0.79 (0.8%) stddev-sans-first:0.83 03:06:29 INFO - PROCESS | 7048 | Values: 96.0 96.0 97.0 97.0 96.0 97.0 95.0 97.0 96.0 95.0 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:67.50 stddev:2.82 (4.2%) stddev-sans-first:2.74 03:06:29 INFO - PROCESS | 7048 | Values: 65.0 67.0 67.0 68.0 68.0 71.0 67.0 67.0 67.0 75.0 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 03:06:29 INFO - PROCESS | 7048 | Values: 66.0 67.0 65.0 65.0 66.0 65.0 65.0 66.0 65.0 65.0 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.00 stddev:2.77 (3.3%) stddev-sans-first:2.83 03:06:29 INFO - PROCESS | 7048 | Values: 83.0 89.0 83.0 84.0 84.0 86.0 91.0 84.0 83.0 84.0 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:147.50 stddev:7.71 (5.2%) stddev-sans-first:7.04 03:06:29 INFO - PROCESS | 7048 | Values: 157.0 131.0 152.0 144.0 154.0 142.0 148.0 145.0 147.0 138.0 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:174.50 stddev:2.95 (1.7%) stddev-sans-first:3.13 03:06:29 INFO - PROCESS | 7048 | Values: 174.0 179.0 172.0 172.0 175.0 170.0 173.0 175.0 169.0 176.0 03:06:29 INFO - PROCESS | 7048 | 03:06:29 INFO - PROCESS | 7048 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.23 (1.8%) stddev-sans-first:1.22 03:06:29 INFO - PROCESS | 7048 | Values: 71.0 69.0 70.0 72.0 69.0 70.0 71.0 69.0 69.0 68.0 03:06:29 INFO - PROCESS | 7048 | -------- Summary: end -------- 03:06:29 INFO - PROCESS | 7048 | 03:06:30 INFO - TEST-INFO | 7048: exit 0 03:06:30 INFO - TEST-OK | kraken | took 65744ms 03:06:30 INFO - SUITE-END | took 1184s 03:06:30 INFO - Completed test suite (00:19:44) 03:06:30 INFO - javascript benchmark 03:06:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6301.3227267883385, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2661.4277930245, 2670.6394636724035, 2680.4237089025855, 2705.0667519705703, 2716.7690746286567, 4720.504347043562, 4800.375951126353, 4854.732989685562, 4898.167311557035, 4917.4836642152595, 4745.074710431467, 4807.8798030049265, 4818.445878723948, 4843.418789745236, 4861.756912154387, 4336.6313863321575, 4426.114777044588, 4426.579474949891, 4502.032063106431, 4530.864074077766, 4476.060027394235, 4476.8880777980485, 4477.194105061088, 4518.412606361168, 4570.948681803187, 4346.826126954918, 4398.208322501981, 4398.7580683062415, 4432.224360736858, 4489.865304040852, 4442.777861106964, 4454.866354009385, 4461.665375096881, 4504.391907092533, 4513.413256276663, 4372.103718737651, 4406.250937340627, 4428.357888106207, 4434.046679963823, 4470.038941627533, 4679.9298010529865, 4749.050189962021, 4796.6162706983705, 4797.280407938802, 4803.1114243864995, 5177.974110129463, 5181.1969144782615, 5193.766280517386, 5194.0910340690225, 5217.739113044333, 5211.635185537014, 5215.739213039333, 5223.582113430916, 5226.608004399685, 5291.603129765283, 4712.034033023222, 4773.164696178155, 4813.711177329372, 4826.276058591239, 4854.2718592211095, 5295.073362161606, 5304.787808487617, 5305.36335639718, 5308.575313974873, 5361.785528578813, 5081.568066714371, 5090.465501122403, 5092.6435149539175, 5100.209467532539, 5161.0, 4994.0, 5084.288199652052, 5138.177891537411, 5148.4079330876675, 5167.870803229949, 5134.204198349262, 5151.948480515147, 5155.639105262596, 5156.303898973665, 5156.432792392834, 5133.255677926754, 5147.742612869341, 5149.176131818891, 5150.97424512875, 5199.0641684496395, 4289.849855255051, 4335.436393268855, 4362.062156636339, 4383.693141480129, 4403.515613282536, 3809.8095095245126, 3821.9044523887123, 3822.7897465639658, 3869.1487872667967, 3871.1483473635753, 4347.326164444453, 4434.046679963759, 4435.778211089432, 4476.4180656514445, 4493.0, 5062.848114556569, 5077.8730531737, 5111.0, 5115.846524604268, 5194.3247377840635, 4359.106383191438, 4365.956340436618, 4376.168527979674, 4395.120975804788, 4429.623482004065, 4603.4015577975315, 4613.469451013109, 4615.284630882219, 4617.191991401492, 4638.512956139624, 4740.312654665055, 4791.664583479123, 4811.49479304668, 4844.152273352079, 4859.416869975626, 5186.325777649033, 5199.038177937094, 5207.244949482228, 5207.505286997729, 5264.052470555183, 4836.758162091811, 4846.224604063474, 4851.757412129309, 4852.199387101089, 4913.263010548446, 4976.377952755905, 5067.062593420229, 5076.619253555924, 5079.11115554769, 5201.661891977009, 5190.351206099238, 5223.869403264796, 5224.712640804641, 5225.712585807817, 5226.346706661668, 5074.847754567369, 5079.263506791421, 5084.9745751271, 5087.898242035212, 5117.104506711236, 4936.358273424432, 5001.074801161797, 5017.0, 5051.2423136529815, 5140.948590514047, 4997.225430058346, 5002.099622068063, 5004.374453193351, 5005.224190250517, 5072.213806859942, 5105.821296254613, 5109.20807274873, 5109.259157422227, 5109.8722531937, 5121.129408000724, 4753.881152971203, 4801.351817504592, 4832.323474713473, 4859.07677541266, 4910.21436570147], "value": 4737.748217743712, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.2201074474247, 556.4518948835398, 560.1737437280012, 568.2016766443144, 568.2612603615299, 32971.34057318852, 37036.629633703655, 37062.81468592653, 37080.62919370805, 37143.25713485732, 36766.0, 37368.81315593425, 37411.0, 37470.25059498809, 37483.25033499328, 7535.849283014322, 7630.694772209105, 7676.692932282702, 7677.961610191941, 7684.4236682248775, 7624.885626715603, 7636.809079772995, 7705.306522412981, 7717.72987945422, 7727.61361931904, 7622.771316860503, 7662.003939487887, 7696.191899850519, 7717.151113377524, 7748.070231572191, 7653.732119375795, 7701.80745481359, 7710.804825252038, 7717.768466946, 7746.302832745024, 7595.316421522034, 7597.544147351176, 7624.35193008595, 7633.236676332378, 7634.847303053908, 36116.63883361159, 36606.08484787875, 36659.266814663824, 36686.81656591727, 36722.816385918166, 2768.5431903735857, 2822.9153125406065, 2841.5169421198448, 3015.9246018849485, 3168.9700847224744, 28364.858175709196, 28517.0, 28588.285292867637, 29131.0, 30209.546856797166, 3177.809331440098, 3204.1829333520036, 3207.1020114368016, 3257.5928008998876, 3284.786488878215, 234429.0, 236208.0, 237050.0, 237325.0, 238204.0, 30808.0, 31672.683273167433, 31693.366132677216, 50114.0, 50511.74744126256, 32713.345733085203, 32722.67277327244, 32813.179670507954, 32845.17887052843, 32859.3428131436, 12759.872401275868, 12885.48458061667, 12889.226646401246, 12897.097203195874, 12915.16051456671, 10811.0, 10838.783224335626, 10978.725531861608, 11025.779484410426, 11034.062104721028, 7639.388848892187, 7649.847003059907, 7666.195049519832, 7821.804454888674, 7830.804229894298, 2970.643522777237, 3026.72759451646, 3054.526548385004, 3056.9541456878164, 3062.2803641144314, 836.2306677856386, 848.4103548034057, 881.2289246908955, 890.955452227386, 907.3784457646533, 26696.466070678478, 27631.0, 27963.440731185263, 28278.85860570725, 28405.289867753057, 916.5325683901258, 941.152962333905, 1003.5233264199447, 1004.1063453526367, 1060.2684147937898, 14342.354594043292, 15070.397184112731, 15114.319855606303, 15211.315490802941, 15303.770443443358, 359398.0, 363879.0, 364898.0, 365960.0, 366480.0, 47853.0, 48200.27699584509, 48241.45223299295, 48434.0, 48534.27198592024, 1155.774623948322, 1184.7512022475378, 1204.4339160594682, 1214.489914236023, 1218.987810121905, 25779.484410311314, 26539.469210615294, 27445.588316175672, 27482.0, 27620.723792761815, 41526.37710434286, 41845.581544185385, 41919.0, 41919.7904010478, 41963.0, 307664.0, 307705.0, 307789.0, 307970.0, 309328.0, 24827.751722482542, 25183.748162518874, 25267.494650107263, 25291.0, 25369.74630253748, 40277.0, 40620.0, 40733.79633101816, 40920.79539602402, 41949.161016780105, 34919.47620785741, 35302.646973530966, 35513.0, 35603.465948010286, 36155.45766813447, 35324.823375883985, 35340.64659353373, 35540.289194216486, 35596.82201588975, 35717.46423803593, 30048.098557043322, 34947.330530293955, 36145.27709445744, 36407.0, 36748.0, 34456.827715862266, 36713.81643091767, 37008.444873326385, 37535.0, 38034.429483557215, 28383.716162838933, 29694.851525742233, 30359.241018974702, 30596.0, 30963.225919351295], "value": 16073.026491549235, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.49593073765993, 368.5595713122818, 369.48641388470026, 377.4847333389924, 384.7076222071225, 15745.13401762904, 16223.26995285212, 17154.5711357216, 17179.570510737205, 17190.74213886793, 16019.599510012256, 16427.0, 16570.17149142541, 16627.83372166278, 16650.66698666026, 4888.217885138379, 5159.355080614923, 5161.354830646169, 5171.250168725533, 5176.637635365526, 4898.265260210979, 5009.899802003976, 5077.162268225738, 5077.289179514871, 5078.5175408336145, 5037.5718063964605, 5102.0, 5125.923111153335, 5128.282040514331, 5130.281760553526, 4895.167821470323, 5087.79648814047, 5112.744362781865, 5116.744162791864, 5117.769700363474, 4478.507364189936, 4494.595486406207, 4496.190685676577, 4500.347449619787, 4532.9546704533195, 20316.187352505884, 20992.370228893156, 21057.0, 21117.15531378743, 21132.260370886946, 1877.2772482594164, 1902.5243689077731, 2012.9698054529194, 2217.6119179143584, 2364.9645255321184, 12895.419706113154, 13691.657708557266, 14046.0, 14208.07647502909, 14416.062955907832, 1529.7934778804831, 1558.6648870492897, 1574.9763753543707, 1610.1868556378954, 1641.5321633334443, 67195.0, 67242.0, 68051.31948680549, 68389.0, 68787.31212687859, 9638.241085976475, 9725.0, 9831.75420614476, 9921.114988152229, 10205.642802501878, 13427.731445371039, 13601.659958501117, 13604.387802548908, 13624.114432561852, 13672.794908076386, 7303.01409309747, 7463.8507229855095, 7479.626018699043, 7714.1128770192145, 7724.3434308083315, 7168.0, 7228.566286022856, 7394.889076663854, 7412.740554080581, 7433.962830185815, 6000.249968753906, 6128.233970753656, 6187.390394156382, 6222.12890195373, 6345.555811093179, 1763.3387479695114, 1810.8913465192131, 1866.2534986005705, 1878.4834170603194, 1883.7456943312477, 878.7803049237691, 883.7923088074298, 886.2909672262293, 896.852019416802, 921.7465197070859, 16336.264868080965, 16954.88063992001, 17145.914270428817, 17617.559561011076, 18405.0, 790.9129995700468, 793.7936136604525, 808.6967387229789, 810.9107998120202, 874.776931882366, 7549.320561149523, 9337.346385753068, 9661.565229564687, 9981.550830212658, 10019.298649094493, 169810.0, 170914.14542927453, 171078.0, 374455.0, 374988.0, 82256.70973161126, 82969.58515207506, 83380.0, 83436.0, 83492.0, 911.2983003087586, 918.3479729392072, 938.7324612485409, 939.2767568971854, 939.5349302095507, 15106.54680359591, 15779.0, 16193.02841829494, 16378.262978165772, 16692.081935493177, 38555.6144438552, 38840.0, 39846.800765995984, 40827.7958610205, 40847.79576102101, 46460.30309545292, 47742.5225747752, 49898.75050624869, 50253.246201306276, 51557.96884062223, 5018.698878067327, 6780.457563395015, 7276.308750668678, 7405.666744996596, 7873.0945941215205, 8381.37139714536, 11804.822927656263, 11874.109441791727, 11909.52361905514, 12182.573609923611, 10078.596856125672, 10269.640562580274, 10380.0, 10454.477276136315, 10982.450877456255, 10386.0, 10480.842787358044, 10601.1519078472, 10693.89306106929, 10786.514606842868, 10448.895511044791, 10646.414447205168, 10672.199585030998, 10895.073918716998, 11067.0, 7350.411967042731, 7486.962565187139, 7601.695932162652, 7648.65581048843, 7660.20229825881, 7876.448648594773, 9526.237900967768, 10402.375857448576, 10594.735131621772, 10895.291806032583], "value": 8208.105566336038, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.581319790865, 1373.821403217582, 1461.41543382647, 1638.9918050409747, 1675.4806010136858, 6772.593644381341, 7306.0, 7310.488265821388, 7908.0905695844995, 7992.200779922012, 7351.301626345502, 7537.020187375633, 7692.230776922305, 7697.114831794345, 7701.306882380584, 2158.3093410108772, 2212.358416059341, 2215.7894999975056, 2216.0, 2218.0794970087395, 2127.3405244374217, 2135.722356093713, 2229.732432108141, 2230.888455577223, 2233.352327824929, 2202.6255536558824, 2207.9668804967937, 2213.900374483144, 2215.3907675389314, 2226.521297920947, 2119.8940052997286, 2120.162535798366, 2137.1558234497443, 2149.613069647463, 2149.838762092834, 2133.7546182189094, 2200.449887528118, 2206.900689468962, 2207.0509680837235, 2207.6578130389817, 7772.183920688303, 7795.454318197729, 7854.72508462201, 7865.2134786521465, 7878.881816772753, 4372.978135109336, 4472.798724057425, 4481.148581769454, 4490.550944905516, 4520.615747661453, 2876.3240638449947, 2899.5070837957596, 2965.288330800614, 2978.1214541710247, 2980.3443242486833, 870.8824308718368, 935.864299676543, 940.6378544260441, 946.8248374050822, 965.0542468381026, 10250.179985601135, 10458.163346932228, 10497.475126243657, 10505.9474702626, 10524.31591946521, 3968.940465893014, 4115.900890545843, 4237.703360764778, 4287.742735435884, 4308.719933204332, 9000.954995225113, 9052.049534798884, 9052.728418147466, 9067.410618309788, 9073.863892041625, 4605.332226827091, 4614.561616646413, 4624.699394539344, 4639.164950308977, 4647.140279048387, 3688.575813781396, 4019.4975628046495, 4123.381492776108, 4158.6673066154635, 4164.604362585549, 3622.710183185339, 3681.1533347330264, 3696.390095634244, 3713.4801127842125, 3742.120601658608, 1164.4759858063906, 1186.0, 1186.2052424875353, 1189.4766302826729, 1191.4876603060593, 699.5872435263219, 752.9472936894365, 767.6353731977377, 818.9959050204711, 821.954792486407, 4949.554540091409, 5275.366955965309, 5369.114096174166, 5399.1091469907815, 5442.2108794225405, 407.4031543788305, 408.6648947862724, 413.40056917469786, 415.991680166395, 428.361741005899, 3726.552813662378, 3741.139537906297, 3772.2078363543415, 3793.393057110849, 3836.961630383716, 8990.325725570608, 9139.543022848831, 9514.0, 9515.571799268911, 9525.19035881944, 9301.395409298373, 9407.623695052258, 9409.76475588102, 9419.340646154704, 9419.481928493999, 7112.786616401413, 7128.607926564089, 7157.284271572905, 7184.461165412615, 7208.675609597581, 4962.675217042253, 5016.87457813543, 5023.0, 5074.543291103819, 5168.483151684952, 8655.956720216358, 8664.393492455467, 8744.125587441205, 8839.46963182211, 8883.289336852908, 8722.912770872465, 8881.511516866634, 8907.198352148078, 8951.597178127131, 8978.595963181542, 6037.939620603738, 6497.155369801895, 6702.463802895854, 6793.0, 6860.3139686031, 7544.47188696786, 7555.16893141743, 7560.281773231534, 7574.621268936641, 7604.8479030417975, 6686.83282917931, 6814.488913331421, 6824.829379265558, 6834.658267086526, 7014.824629384306, 6655.933440665725, 6706.6646667665445, 6730.899036514358, 6755.7973260802255, 6942.409895158766, 6235.282942461494, 6269.153664255267, 6310.968445157745, 6316.273628532777, 6326.746930122744, 4681.906361872811, 4759.500252473579, 4817.421909370898, 4874.6344024197615, 4951.9752401237765, 4592.862214133581, 4685.437747470325, 4734.313524538991, 4740.336352910665, 4759.095771803346], "value": 4040.946088507601, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.2887924584768, 295.9674435812061, 301.9516877299632, 303.57954233386766, 306.5968251748951, 4836.685615434994, 4945.505449455052, 5032.245163225518, 5036.697798132105, 5050.671706339085, 4867.3185753994385, 4956.6121485983895, 4981.982297169643, 4986.900261994758, 5000.949990500094, 3951.170254246612, 3951.5653278139525, 3960.544537378195, 3966.8809935701975, 3970.7816070116132, 3751.962480375202, 3954.062509370402, 3968.2658708138943, 3973.8807835764974, 3977.6618987386105, 3925.4896863407716, 3944.126539893556, 3948.269570129521, 3953.62440568147, 3953.7743299577223, 3936.114374265796, 3936.6063393660693, 3945.3884647879627, 3953.683705303569, 3953.822078006468, 3497.2306092659574, 3506.4389697648508, 3507.754457187998, 3508.7368447366293, 3516.384632689295, 4676.275177347517, 4922.704637721748, 4928.926066109011, 4937.827176048857, 4951.762059485129, 4512.706674066208, 4529.909401811979, 4537.183307004738, 4551.317302404633, 4558.544145585448, 5292.988664307577, 5306.681599104066, 5313.840584782462, 5330.494667506305, 5338.733063346817, 3678.3746763050344, 3791.469194312798, 3813.4470501777364, 3816.2367526494536, 3833.386658134685, 5502.80740174096, 5505.357428434374, 5525.475079867406, 5526.834194974117, 5562.7774889004395, 3893.5717071122153, 3909.0, 3915.3164139420323, 3917.8236979335998, 3930.292547341506, 3829.617038296148, 3959.4654721612214, 3976.1252524444576, 3979.3633018716864, 3979.900502487461, 4469.508354081048, 4491.573300536509, 4496.123255965055, 4496.572825581565, 4501.212287849678, 5250.579953603703, 5300.814471493556, 5306.442823503554, 5306.469353064663, 5308.284201059274, 1305.6017914536158, 1347.6900312927885, 1363.243399913038, 1369.4795977528474, 1373.9175649460865, 914.7804526913626, 934.7522906429665, 952.8756067839877, 956.3496822160859, 957.9712608621613, 4516.322551617218, 4521.59305662492, 4527.0, 4538.478075021415, 4538.909221815611, 5369.838904832861, 5375.354957405137, 5382.4886635769535, 5406.405295417501, 5420.457954204548, 4367.58507941745, 4517.232070548015, 4519.502854685982, 4528.977355113203, 4537.523560026216, 2486.925392238236, 2512.32167314824, 2525.0052458557534, 2531.544361991862, 2540.7713305802567, 4461.776911154494, 4463.598276155097, 4464.308032255006, 4473.888152796141, 4478.910421791546, 4788.473267940523, 4829.855104346875, 4842.803749525367, 4853.563179313879, 4879.341288926021, 4682.461516925529, 5071.199724097892, 5083.517065878736, 5083.694978301313, 5100.41887015034, 5465.72671366438, 5468.753906074316, 5472.699001554953, 5485.341758988947, 5490.176473529003, 5248.685078895279, 5379.2469054333205, 5383.784648614168, 5399.868076515533, 5410.266915828066, 5101.8724531887, 5104.9489505104475, 5111.3355263815465, 5113.187746739204, 5117.513836185556, 3765.1151979285396, 3800.56293526248, 3812.237552489458, 3820.7707537547835, 3835.8465661373234, 5294.311739473844, 5444.373897001896, 5467.87908478753, 5483.972580137074, 5484.232207491034, 5239.559121241689, 5241.397239317374, 5243.606729495379, 5251.238570407346, 5275.366955965309, 5249.947500524946, 5259.289995850664, 5267.499587539178, 5302.257683924331, 5304.9204261936875, 5010.799568017239, 5206.661566998133, 5208.557272631869, 5215.869603259949, 5235.65968212065, 5331.680099194061, 5335.653182543122, 5339.662710805746, 5346.331708536433, 5361.839144825662, 5116.948830511647, 5117.744112794271, 5132.307138536399, 5138.691678499302, 5149.403684857706], "value": 3936.5072832082797, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.4399210769499, 582.1471544187765, 602.0938487576198, 616.260487415102, 646.6191552233616, 12960.870391296085, 13678.24769637672, 13828.930855345734, 13982.720345593081, 14001.999999999987, 13424.463021479129, 13489.325533723324, 13585.59243222705, 13593.456261749543, 13611.727765444684, 743.2270438743714, 759.5290919629837, 761.4555592751182, 762.161622215564, 762.7826069570174, 620.435403782558, 729.9306565876233, 764.3121190928154, 771.9691212351499, 774.7598244544181, 805.4965646470955, 807.2532907060975, 808.8827120067616, 811.0632219786127, 812.5165526511717, 793.3970182661191, 794.8291117409727, 796.1600511460407, 801.3709238247976, 802.2739420824164, 591.2402562706944, 593.5162842283526, 593.6230493636572, 594.4174708785415, 594.9970250148722, 13043.08698391113, 13067.803982940264, 13089.0, 13101.868981310161, 13120.60638180856, 12598.37008149598, 13173.209607423585, 13224.677532246698, 13253.801192982113, 13577.321133943362, 8917.910820891837, 9126.543672816399, 9129.269658427309, 9139.451632902048, 9288.442693438416, 3125.859336329848, 3158.7630927680516, 3184.1243657994005, 3197.616286045666, 3224.629167645727, 50878.49121508774, 52917.73541132308, 53557.46442535564, 60095.098573521, 63871.0, 9332.673356432628, 9590.0, 9664.130228279488, 9868.753281168028, 9883.703488895344, 18575.81424185768, 18621.534461638566, 18718.81281187198, 18740.344087957128, 19052.71420928687, 6528.967355163194, 6551.951687730036, 6627.304133065959, 6692.765753198712, 6769.966150169316, 3427.9314413711586, 3474.4788281757938, 3486.7559270850797, 3488.389531831919, 3581.8030008349792, 2957.822530648168, 3070.1557071804987, 3070.815751054944, 3093.1957691000503, 3105.580746599225, 474.28383141456646, 476.3521610609568, 479.7457347605705, 488.6310835319382, 489.49581930611527, 457.31859529301767, 491.19241192411556, 509.5617768718899, 518.1604312047708, 518.800261899164, 7585.772426827204, 7669.309762121436, 8189.1401402853035, 8202.958985205156, 8308.626111824982, 523.0933840575378, 528.1101344234976, 537.4813305160461, 543.5787264869679, 545.6698697288163, 3557.928841423157, 3648.52569166012, 3690.040589446763, 3695.5380577427823, 3718.7768733875514, 100451.0, 103475.0, 103915.48042259741, 108257.0, 108797.0, 88070.0, 88070.55964720136, 90697.0, 94160.0, 95346.0, 56176.43823561794, 67654.0, 79134.6475943817, 79804.0, 80006.19993800104, 6650.534462587572, 6951.6871740770775, 7144.142702875688, 7377.0, 7526.924730752622, 41203.58796411997, 42697.0, 44995.32507012463, 46053.0, 46111.308330375745, 40335.99160021023, 54131.729341354614, 55366.0, 56033.71983140058, 57661.711691441276, 10554.419506926886, 10803.351798892092, 10918.126549875831, 10922.071623912056, 11002.559897604006, 11418.429078546205, 11691.415429228335, 12132.818007729715, 12404.441800119197, 12664.374262978943, 10892.346459212473, 11121.610743623934, 11176.438265838704, 11373.488193031499, 11773.88226117728, 10897.455127243447, 10947.56209751601, 11036.337819730841, 11076.0, 11094.944525277644, 8955.120223431468, 9750.85373719409, 9826.459544725109, 10747.516361763583, 10810.00014997228, 9059.428451502146, 9318.50903855407, 9542.284328675516, 9831.557579908778, 9922.900770992486, 9388.436693798394, 10038.498075096362, 10078.0, 10085.84763294375, 10113.832975164132], "value": 6295.6244346482, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1604.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 116.0, 117.0, 115.0, 114.0, 115.0, 116.0, 114.0, 133.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 153.0, 193.0, 128.0, 156.0, 160.0, 125.0, 193.0, 125.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 163.0, 162.0, 165.0, 164.0, 164.0, 163.0, 163.0, 161.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 178.0, 77.0, 78.0, 81.0, 79.0, 158.0, 78.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 141.0, 89.0, 89.0, 87.0, 134.0, 92.0, 86.0, 144.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 120.0, 119.0, 118.0, 120.0, 120.0, 118.0, 119.0, 119.0], "value": 119.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 150.0, 149.0, 148.0, 151.0, 148.0, 148.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 95.0, 97.0, 96.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 68.0, 68.0, 71.0, 67.0, 67.0, 67.0, 75.0], "value": 68.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 89.0, 83.0, 84.0, 84.0, 86.0, 91.0, 84.0, 83.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 152.0, 144.0, 154.0, 142.0, 148.0, 145.0, 147.0, 138.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 179.0, 172.0, 172.0, 175.0, 170.0, 173.0, 175.0, 169.0, 176.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 70.0, 72.0, 69.0, 70.0, 71.0, 69.0, 69.0, 68.0], "value": 69.8, "unit": "score"}]}]} 03:06:31 INFO - Return code: 0 03:06:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:06:31 ERROR - # TBPL SUCCESS # 03:06:31 INFO - Running post-action listener: _resource_record_post_action 03:06:31 INFO - [mozharness: 2016-08-25 10:06:31.087976Z] Finished run-tests step (success) 03:06:31 INFO - Running post-run listener: _resource_record_post_run 03:06:31 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 419688448; Read time: 128; Write time: 587440 03:06:31 INFO - TinderboxPrint: CPU usage
13.4% 03:06:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 128 03:06:31 INFO - TinderboxPrint: I/O write bytes / time
419,688,448 / 587,440 03:06:31 INFO - TinderboxPrint: CPU idle
8,293.3 (86.6%) 03:06:31 INFO - TinderboxPrint: CPU user
1,219.5 (12.7%) 03:06:31 INFO - TinderboxPrint: Swap in / out
0 / 0 03:06:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 130281472; Read time: 0; Write time: 168040 03:06:31 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288366592; Read time: 128; Write time: 419376 03:06:31 INFO - Running post-run listener: _upload_blobber_files 03:06:31 INFO - Blob upload gear active. 03:06:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:06: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 03:06: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'] 03:06: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 03:06:32 INFO - (blobuploader) - INFO - Open directory for files ... 03:06:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:06:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:06:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:32 INFO - (blobuploader) - INFO - Done attempting. 03:06:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:06:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:06:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:33 INFO - (blobuploader) - INFO - Done attempting. 03:06:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:06:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:06:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:36 INFO - (blobuploader) - INFO - Done attempting. 03:06:36 INFO - (blobuploader) - INFO - Iteration through files over. 03:06:36 INFO - Return code: 0 03:06:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:06:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:06:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fa1709a459ebc27128138eec884f2c38052a7b0acb9efab397ec6c2eedfd8737ce3707234fe0b65635f40dda24b6d4d6e3d6f30ea9213f433d36a96c84b9cc01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e19d18fd3ae35e37e6f845da720de23bc481a2dc5f2ce5f293469a68e70baddc442fe6b11d2ef445f79e03299f7c9b87e5407ff8cdb94ec23adb993dcfdb443e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/db89b9922035cd0583597ea5b1940f692518f634c3aebe84c0682ddc69342004e9feacd5080cf520e65099974b27a01e9383736f4d7117b810f3ea46fc80d501"} 03:06:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:06:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:06:36 INFO - Contents: 03:06:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fa1709a459ebc27128138eec884f2c38052a7b0acb9efab397ec6c2eedfd8737ce3707234fe0b65635f40dda24b6d4d6e3d6f30ea9213f433d36a96c84b9cc01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e19d18fd3ae35e37e6f845da720de23bc481a2dc5f2ce5f293469a68e70baddc442fe6b11d2ef445f79e03299f7c9b87e5407ff8cdb94ec23adb993dcfdb443e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/db89b9922035cd0583597ea5b1940f692518f634c3aebe84c0682ddc69342004e9feacd5080cf520e65099974b27a01e9383736f4d7117b810f3ea46fc80d501"} 03:06:36 INFO - Running post-run listener: copy_logs_to_upload_dir 03:06:36 INFO - Copying logs to upload dir... 03:06:36 INFO - mkdir: /builds/slave/test/build/upload/logs 03:06:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.316435 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-25 03:06:36.596242) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 03:06:36.599700) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fa1709a459ebc27128138eec884f2c38052a7b0acb9efab397ec6c2eedfd8737ce3707234fe0b65635f40dda24b6d4d6e3d6f30ea9213f433d36a96c84b9cc01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e19d18fd3ae35e37e6f845da720de23bc481a2dc5f2ce5f293469a68e70baddc442fe6b11d2ef445f79e03299f7c9b87e5407ff8cdb94ec23adb993dcfdb443e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/db89b9922035cd0583597ea5b1940f692518f634c3aebe84c0682ddc69342004e9feacd5080cf520e65099974b27a01e9383736f4d7117b810f3ea46fc80d501"} build_url:https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/OhYdw6qgTbS_PwHAmeyWpA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fa1709a459ebc27128138eec884f2c38052a7b0acb9efab397ec6c2eedfd8737ce3707234fe0b65635f40dda24b6d4d6e3d6f30ea9213f433d36a96c84b9cc01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e19d18fd3ae35e37e6f845da720de23bc481a2dc5f2ce5f293469a68e70baddc442fe6b11d2ef445f79e03299f7c9b87e5407ff8cdb94ec23adb993dcfdb443e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/db89b9922035cd0583597ea5b1940f692518f634c3aebe84c0682ddc69342004e9feacd5080cf520e65099974b27a01e9383736f4d7117b810f3ea46fc80d501"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 03:06:36.626054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 03:06:36.626402) ========= 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=5cf47e208febbcd81da23b2e0000026f-1472116167.799823-1489997269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 03:06:36.709172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 03:06:36.709583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 03:06:36.710004) ========= ========= Total master_lag: 0.22 =========