builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1470969590.84 results: success (0) buildid: 20160811182417 builduid: 3c39bc91929442a5aca309d0d742b655 revision: 0c68d5900cce52d31a9dfe2d53f81742dba21ad0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 19:39:50.837166) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 19:39:50.838989) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 19:39:50.839333) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 19:39:50.854482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 19:39:50.854864) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 19:39: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-08-11 19:39:51 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144259 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 19:39:51.013463) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 19:39:51.013783) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019602 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 19:39:51.062851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 19:39:51.063237) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0c68d5900cce52d31a9dfe2d53f81742dba21ad0 --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 0c68d5900cce52d31a9dfe2d53f81742dba21ad0 --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=e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 19:39:51,772 truncating revision to first 12 chars 2016-08-11 19:39:51,772 Setting DEBUG logging. 2016-08-11 19:39:51,772 attempt 1/10 2016-08-11 19:39:51,772 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0c68d5900cce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 19:39:52,069 unpacking tar archive at: autoland-0c68d5900cce/testing/mozharness/ program finished with exit code 0 elapsedTime=0.707606 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 19:39:51.785527) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 19:39:51.786052) ========= script_repo_revision: 0c68d5900cce52d31a9dfe2d53f81742dba21ad0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 19:39:51.786616) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 19:39:51.786927) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 19:39:51.802755) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-11 19:39:51.803094) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:39:52 INFO - MultiFileLogger online at 20160811 19:39:52 in /builds/slave/test 19:39: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 19:39:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:39:52 INFO - {'append_to_log': False, 19:39:52 INFO - 'base_work_dir': '/builds/slave/test', 19:39:52 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 19:39:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:39:52 INFO - 'branch': 'Autoland-Non-PGO', 19:39:52 INFO - 'buildbot_json_path': 'buildprops.json', 19:39:52 INFO - 'config_files': ('talos/linux_config.py',), 19:39:52 INFO - 'default_actions': ('clobber', 19:39:52 INFO - 'read-buildbot-config', 19:39:52 INFO - 'download-and-extract', 19:39:52 INFO - 'populate-webroot', 19:39:52 INFO - 'create-virtualenv', 19:39:52 INFO - 'install', 19:39:52 INFO - 'run-tests'), 19:39:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:39:52 INFO - 'download_minidump_stackwalk': True, 19:39:52 INFO - 'download_symbols': 'ondemand', 19:39:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:39:52 INFO - 'tooltool.py': '/tools/tooltool.py', 19:39:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:39:52 INFO - '/tools/misc-python/virtualenv.py')}, 19:39:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:39:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:39:52 INFO - 'installer_path': 'installer.exe', 19:39:52 INFO - 'log_level': 'info', 19:39:52 INFO - 'log_name': 'talos', 19:39:52 INFO - 'log_to_console': True, 19:39:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:39:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:39:52 INFO - 'opt_config_files': (), 19:39:52 INFO - 'pip_index': False, 19:39:52 INFO - 'sps_profile': False, 19:39:52 INFO - 'sps_profile_interval': 0, 19:39:52 INFO - 'suite': 'dromaeojs-e10s', 19:39:52 INFO - 'system_bits': '32', 19:39:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:39:52 INFO - 'title': 'talos-linux64-ix-067', 19:39:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:39:52 INFO - 'use_talos_json': True, 19:39:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:39:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:39:52 INFO - 'work_dir': 'build'} 19:39:52 INFO - [mozharness: 2016-08-12 02:39:52.606328Z] Running clobber step. 19:39:52 INFO - Running pre-action listener: _resource_record_pre_action 19:39:52 INFO - Running main action method: clobber 19:39:52 INFO - rmtree: /builds/slave/test/build 19:39:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:39:53 INFO - Running post-action listener: _resource_record_post_action 19:39:53 INFO - [mozharness: 2016-08-12 02:39:53.067883Z] Finished clobber step (success) 19:39:53 INFO - [mozharness: 2016-08-12 02:39:53.067984Z] Running read-buildbot-config step. 19:39:53 INFO - Running pre-action listener: _resource_record_pre_action 19:39:53 INFO - Running main action method: read_buildbot_config 19:39:53 INFO - Using buildbot properties: 19:39:53 INFO - { 19:39:53 INFO - "project": "", 19:39:53 INFO - "product": "firefox", 19:39:53 INFO - "script_repo_revision": "production", 19:39:53 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 19:39:53 INFO - "repository": "", 19:39:53 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 19:39:53 INFO - "buildid": "20160811182417", 19:39:53 INFO - "pgo_build": "False", 19:39:53 INFO - "basedir": "/builds/slave/test", 19:39:53 INFO - "buildnumber": 286, 19:39:53 INFO - "slavename": "talos-linux64-ix-067", 19:39:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:39:53 INFO - "platform": "ubuntu64_hw", 19:39:53 INFO - "scheduler": "tests-autoland-linux64-talos", 19:39:53 INFO - "branch": "autoland", 19:39:53 INFO - "repo_path": "integration/autoland", 19:39:53 INFO - "revision": "0c68d5900cce52d31a9dfe2d53f81742dba21ad0", 19:39:53 INFO - "stage_platform": "linux64", 19:39:53 INFO - "builduid": "3c39bc91929442a5aca309d0d742b655", 19:39:53 INFO - "slavebuilddir": "test" 19:39:53 INFO - } 19:39:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:39:53 INFO - Running post-action listener: _resource_record_post_action 19:39:53 INFO - [mozharness: 2016-08-12 02:39:53.070413Z] Finished read-buildbot-config step (success) 19:39:53 INFO - [mozharness: 2016-08-12 02:39:53.070501Z] Running download-and-extract step. 19:39:53 INFO - Running pre-action listener: _resource_record_pre_action 19:39:53 INFO - Running main action method: download_and_extract 19:39:53 INFO - mkdir: /builds/slave/test/build/tests 19:39: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')]} 19:39:53 INFO - trying https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:39:53 INFO - Downloading https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/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 19:39:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/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 19:39:53 INFO - Downloaded 1361 bytes. 19:39:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:39:53 INFO - Using the following test package requirements: 19:39:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:39:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:39:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:39:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:53 INFO - u'jsshell-linux-x86_64.zip'], 19:39:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:39:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:39:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:39:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:39:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:39:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:39:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:39:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:39: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')]} 19:39:53 INFO - trying https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:39:53 INFO - Downloading https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/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 19:39:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/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 19:39:54 INFO - Downloaded 20262692 bytes. 19:39: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 19:39:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:58 INFO - trying https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:39:58 INFO - Downloading https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/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 19:39:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/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 19:39:59 INFO - Downloaded 20262692 bytes. 19:39:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 19:40: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')]} 19:40:04 INFO - trying https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:40:04 INFO - Downloading https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/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 19:40:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/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 19:40:05 INFO - Downloaded 14413719 bytes. 19:40: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 19:40: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')]} 19:40:05 INFO - trying https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:40:05 INFO - Downloading https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/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 19:40:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/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 19:40:06 INFO - Downloaded 55645384 bytes. 19:40:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:40:06 INFO - mkdir: /builds/slave/test/properties 19:40:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:40:06 INFO - Writing to file /builds/slave/test/properties/build_url 19:40:06 INFO - Contents: 19:40:06 INFO - build_url:https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:40:07 INFO - Running post-action listener: _resource_record_post_action 19:40:07 INFO - Running post-action listener: set_extra_try_arguments 19:40:07 INFO - [mozharness: 2016-08-12 02:40:07.335047Z] Finished download-and-extract step (success) 19:40:07 INFO - [mozharness: 2016-08-12 02:40:07.335272Z] Running populate-webroot step. 19:40:07 INFO - Running pre-action listener: _resource_record_pre_action 19:40:07 INFO - Running main action method: populate_webroot 19:40:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:40:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:40:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:40:07 INFO - '--tppagecycles', 19:40:07 INFO - '7'], 19:40:07 INFO - 'tests': ['tsvgm']}}, 19:40:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:40:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:40:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:40:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:40:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:40:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:40:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:07 INFO - 'talos_options': ['--disable-e10s'], 19:40:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:40:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:40:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:07 INFO - 'talos_options': ['--disable-e10s'], 19:40:07 INFO - 'tests': ['damp', 'tps']}, 19:40:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:07 INFO - 'tests': ['damp', 'tps']}, 19:40:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:40:07 INFO - 'tests': ['dromaeo_dom']}, 19:40:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:40:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:40:07 INFO - 'tests': ['basic_compositor_video']}, 19:40:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:40:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:40:07 INFO - 'tests': ['a11yr', 19:40:07 INFO - 'ts_paint', 19:40:07 INFO - 'tpaint', 19:40:07 INFO - 'sessionrestore', 19:40:07 INFO - 'sessionrestore_no_auto_restore', 19:40:07 INFO - 'tabpaint']}, 19:40:07 INFO - 'other-e10s': {'tests': ['a11yr', 19:40:07 INFO - 'ts_paint', 19:40:07 INFO - 'tpaint', 19:40:07 INFO - 'sessionrestore', 19:40:07 INFO - 'sessionrestore_no_auto_restore', 19:40:07 INFO - 'tabpaint']}, 19:40:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:40:07 INFO - 'ts_paint', 19:40:07 INFO - 'tpaint', 19:40:07 INFO - 'sessionrestore', 19:40:07 INFO - 'sessionrestore_no_auto_restore', 19:40:07 INFO - 'tabpaint']}, 19:40:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:40:07 INFO - 'ts_paint', 19:40:07 INFO - 'tpaint', 19:40:07 INFO - 'sessionrestore', 19:40:07 INFO - 'sessionrestore_no_auto_restore', 19:40:07 INFO - 'tabpaint']}, 19:40:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:40:07 INFO - 'tests': ['a11yr', 19:40:07 INFO - 'ts_paint', 19:40:07 INFO - 'tpaint', 19:40:07 INFO - 'sessionrestore', 19:40:07 INFO - 'sessionrestore_no_auto_restore', 19:40:07 INFO - 'tabpaint']}, 19:40:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:40:07 INFO - 'tests': ['a11yr', 19:40:07 INFO - 'ts_paint', 19:40:07 INFO - 'tpaint', 19:40:07 INFO - 'sessionrestore', 19:40:07 INFO - 'sessionrestore_no_auto_restore', 19:40:07 INFO - 'tabpaint']}, 19:40:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:40:07 INFO - 'tests': ['tsvgx', 19:40:07 INFO - 'tsvgr_opacity', 19:40:07 INFO - 'tart', 19:40:07 INFO - 'tscrollx', 19:40:07 INFO - 'cart']}, 19:40:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:40:07 INFO - 'tsvgr_opacity', 19:40:07 INFO - 'tart', 19:40:07 INFO - 'tscrollx', 19:40:07 INFO - 'cart']}, 19:40:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:07 INFO - 'talos_options': ['--disable-e10s'], 19:40:07 INFO - 'tests': ['tp5o']}, 19:40:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:07 INFO - 'tests': ['tp5o']}, 19:40:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:07 INFO - 'talos_options': ['--disable-e10s', 19:40:07 INFO - '--xperf_path', 19:40:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:40:07 INFO - 'tests': ['tp5n']}, 19:40:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:07 INFO - 'talos_options': ['--xperf_path', 19:40:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:40:07 INFO - 'tests': ['tp5n']}}, 19:40:07 INFO - 'talos.zip': {'path': '', 19:40:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:40:07 INFO - Running post-action listener: _resource_record_post_action 19:40:07 INFO - [mozharness: 2016-08-12 02:40:07.357385Z] Finished populate-webroot step (success) 19:40:07 INFO - [mozharness: 2016-08-12 02:40:07.357473Z] Running create-virtualenv step. 19:40:07 INFO - Running pre-action listener: _resource_record_pre_action 19:40:07 INFO - Running main action method: create_virtualenv 19:40:07 INFO - Creating virtualenv /builds/slave/test/build/venv 19:40: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 19:40:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:40:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:40:07 INFO - Using real prefix '/usr' 19:40:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:40:07 INFO - Installing distribute.............................................................................................................................................................................................done. 19:40:09 INFO - Installing pip.................done. 19:40:09 INFO - Return code: 0 19:40:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb7a86cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449090>, '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 0x144c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144ce40>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', '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 19:40:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:40:09 INFO - Using env: {'DISPLAY': ':0', 19:40:09 INFO - 'HOME': '/home/cltbld', 19:40:09 INFO - 'LANG': 'en_US.UTF-8', 19:40:09 INFO - 'LANGUAGE': 'en_US:en', 19:40:09 INFO - 'LOGNAME': 'cltbld', 19:40:09 INFO - 'MAIL': '/var/mail/cltbld', 19:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:09 INFO - 'MOZ_NO_REMOTE': '1', 19:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:09 INFO - 'NO_EM_RESTART': '1', 19:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:09 INFO - 'PWD': '/builds/slave/test', 19:40:09 INFO - 'SHELL': '/bin/bash', 19:40:09 INFO - 'SHLVL': '1', 19:40:09 INFO - 'TERM': 'linux', 19:40:09 INFO - 'TMOUT': '86400', 19:40:09 INFO - 'USER': 'cltbld', 19:40:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', 19:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:09 INFO - '_': '/tools/buildbot/bin/python'} 19:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40: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 19:40:10 INFO - Cleaning up... 19:40:10 INFO - Return code: 0 19:40:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:40: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')]} 19:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40: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')]} 19:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40: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 0x7fcb7a86cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449090>, '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 0x144c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144ce40>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', '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 19:40: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 19:40: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 19:40:10 INFO - Using env: {'DISPLAY': ':0', 19:40:10 INFO - 'HOME': '/home/cltbld', 19:40:10 INFO - 'LANG': 'en_US.UTF-8', 19:40:10 INFO - 'LANGUAGE': 'en_US:en', 19:40:10 INFO - 'LOGNAME': 'cltbld', 19:40:10 INFO - 'MAIL': '/var/mail/cltbld', 19:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:10 INFO - 'MOZ_NO_REMOTE': '1', 19:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:10 INFO - 'NO_EM_RESTART': '1', 19:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:10 INFO - 'PWD': '/builds/slave/test', 19:40:10 INFO - 'SHELL': '/bin/bash', 19:40:10 INFO - 'SHLVL': '1', 19:40:10 INFO - 'TERM': 'linux', 19:40:10 INFO - 'TMOUT': '86400', 19:40:10 INFO - 'USER': 'cltbld', 19:40:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', 19:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:10 INFO - '_': '/tools/buildbot/bin/python'} 19:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:10 INFO - Downloading/unpacking psutil>=3.1.1 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:40:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:40:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:40:12 INFO - Installing collected packages: psutil 19:40:12 INFO - Running setup.py install for psutil 19:40:12 INFO - building 'psutil._psutil_linux' extension 19:40:12 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 19:40:12 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 19:40:12 INFO - building 'psutil._psutil_posix' extension 19:40:12 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 19:40:12 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 19:40:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:40:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:40:12 INFO - Successfully installed psutil 19:40:12 INFO - Cleaning up... 19:40:12 INFO - Return code: 0 19:40:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb7a86cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449090>, '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 0x144c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144ce40>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', '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 19:40:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:40:12 INFO - Using env: {'DISPLAY': ':0', 19:40:12 INFO - 'HOME': '/home/cltbld', 19:40:12 INFO - 'LANG': 'en_US.UTF-8', 19:40:12 INFO - 'LANGUAGE': 'en_US:en', 19:40:12 INFO - 'LOGNAME': 'cltbld', 19:40:12 INFO - 'MAIL': '/var/mail/cltbld', 19:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:12 INFO - 'MOZ_NO_REMOTE': '1', 19:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:12 INFO - 'NO_EM_RESTART': '1', 19:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:12 INFO - 'PWD': '/builds/slave/test', 19:40:12 INFO - 'SHELL': '/bin/bash', 19:40:12 INFO - 'SHLVL': '1', 19:40:12 INFO - 'TERM': 'linux', 19:40:12 INFO - 'TMOUT': '86400', 19:40:12 INFO - 'USER': 'cltbld', 19:40:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', 19:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:12 INFO - '_': '/tools/buildbot/bin/python'} 19:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:40:15 INFO - Installing collected packages: mozsystemmonitor 19:40:15 INFO - Running setup.py install for mozsystemmonitor 19:40:15 INFO - Successfully installed mozsystemmonitor 19:40:15 INFO - Cleaning up... 19:40:15 INFO - Return code: 0 19:40:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:40: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')]} 19:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40: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')]} 19:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40: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 0x7fcb7a86cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449090>, '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 0x144c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144ce40>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', '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 19:40: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 19:40: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 19:40:15 INFO - Using env: {'DISPLAY': ':0', 19:40:15 INFO - 'HOME': '/home/cltbld', 19:40:15 INFO - 'LANG': 'en_US.UTF-8', 19:40:15 INFO - 'LANGUAGE': 'en_US:en', 19:40:15 INFO - 'LOGNAME': 'cltbld', 19:40:15 INFO - 'MAIL': '/var/mail/cltbld', 19:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:15 INFO - 'MOZ_NO_REMOTE': '1', 19:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:15 INFO - 'NO_EM_RESTART': '1', 19:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:15 INFO - 'PWD': '/builds/slave/test', 19:40:15 INFO - 'SHELL': '/bin/bash', 19:40:15 INFO - 'SHLVL': '1', 19:40:15 INFO - 'TERM': 'linux', 19:40:15 INFO - 'TMOUT': '86400', 19:40:15 INFO - 'USER': 'cltbld', 19:40:15 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', 19:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:15 INFO - '_': '/tools/buildbot/bin/python'} 19:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:15 INFO - Downloading/unpacking jsonschema==2.5.1 19:40:15 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 19:40:15 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 19:40:15 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 19:40:15 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 19:40:15 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 19:40:15 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 19:40:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:40:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40:17 INFO - Downloading functools32-3.2.3-2.tar.gz 19:40:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:40:17 INFO - warning: no files found matching '*.txt' 19:40:17 INFO - no previously-included directories found matching 'build' 19:40:17 INFO - no previously-included directories found matching 'dist' 19:40:17 INFO - no previously-included directories found matching '.git*' 19:40:17 INFO - Installing collected packages: jsonschema, functools32 19:40:17 INFO - Running setup.py install for functools32 19:40:17 INFO - warning: no files found matching '*.txt' 19:40:17 INFO - no previously-included directories found matching 'build' 19:40:17 INFO - no previously-included directories found matching 'dist' 19:40:17 INFO - no previously-included directories found matching '.git*' 19:40:17 INFO - Successfully installed jsonschema functools32 19:40:17 INFO - Cleaning up... 19:40:17 INFO - Return code: 0 19:40:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcb7a86cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449090>, '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 0x144c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144ce40>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', '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 19:40:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:40:17 INFO - Using env: {'DISPLAY': ':0', 19:40:17 INFO - 'HOME': '/home/cltbld', 19:40:17 INFO - 'LANG': 'en_US.UTF-8', 19:40:17 INFO - 'LANGUAGE': 'en_US:en', 19:40:17 INFO - 'LOGNAME': 'cltbld', 19:40:17 INFO - 'MAIL': '/var/mail/cltbld', 19:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:17 INFO - 'MOZ_NO_REMOTE': '1', 19:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:17 INFO - 'NO_EM_RESTART': '1', 19:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:17 INFO - 'PWD': '/builds/slave/test', 19:40:17 INFO - 'SHELL': '/bin/bash', 19:40:17 INFO - 'SHLVL': '1', 19:40:17 INFO - 'TERM': 'linux', 19:40:17 INFO - 'TMOUT': '86400', 19:40:17 INFO - 'USER': 'cltbld', 19:40:17 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', 19:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:17 INFO - '_': '/tools/buildbot/bin/python'} 19:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:40:17 INFO - Cleaning up... 19:40:17 INFO - Return code: 0 19:40:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb7a86cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449090>, '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 0x144c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144ce40>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', '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 19:40:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:40:17 INFO - Using env: {'DISPLAY': ':0', 19:40:17 INFO - 'HOME': '/home/cltbld', 19:40:17 INFO - 'LANG': 'en_US.UTF-8', 19:40:17 INFO - 'LANGUAGE': 'en_US:en', 19:40:17 INFO - 'LOGNAME': 'cltbld', 19:40:17 INFO - 'MAIL': '/var/mail/cltbld', 19:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:17 INFO - 'MOZ_NO_REMOTE': '1', 19:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:17 INFO - 'NO_EM_RESTART': '1', 19:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:17 INFO - 'PWD': '/builds/slave/test', 19:40:17 INFO - 'SHELL': '/bin/bash', 19:40:17 INFO - 'SHLVL': '1', 19:40:17 INFO - 'TERM': 'linux', 19:40:17 INFO - 'TMOUT': '86400', 19:40:17 INFO - 'USER': 'cltbld', 19:40:17 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', 19:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:17 INFO - '_': '/tools/buildbot/bin/python'} 19:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:18 INFO - Downloading/unpacking blobuploader==1.2.4 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40:20 INFO - Downloading blobuploader-1.2.4.tar.gz 19:40:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:40:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:40:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40:20 INFO - Downloading docopt-0.6.1.tar.gz 19:40:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:40:20 INFO - Installing collected packages: blobuploader, requests, docopt 19:40:20 INFO - Running setup.py install for blobuploader 19:40:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:40:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:40:20 INFO - Running setup.py install for requests 19:40:21 INFO - Running setup.py install for docopt 19:40:21 INFO - Successfully installed blobuploader requests docopt 19:40:21 INFO - Cleaning up... 19:40:21 INFO - Return code: 0 19:40:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:40:21 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')]} 19:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:21 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')]} 19:40:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:21 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 0x7fcb7a86cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449090>, '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 0x144c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144ce40>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', '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 19:40:21 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 19:40:21 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 19:40:21 INFO - Using env: {'DISPLAY': ':0', 19:40:21 INFO - 'HOME': '/home/cltbld', 19:40:21 INFO - 'LANG': 'en_US.UTF-8', 19:40:21 INFO - 'LANGUAGE': 'en_US:en', 19:40:21 INFO - 'LOGNAME': 'cltbld', 19:40:21 INFO - 'MAIL': '/var/mail/cltbld', 19:40:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:21 INFO - 'MOZ_NO_REMOTE': '1', 19:40:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:21 INFO - 'NO_EM_RESTART': '1', 19:40:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:21 INFO - 'PWD': '/builds/slave/test', 19:40:21 INFO - 'SHELL': '/bin/bash', 19:40:21 INFO - 'SHLVL': '1', 19:40:21 INFO - 'TERM': 'linux', 19:40:21 INFO - 'TMOUT': '86400', 19:40:21 INFO - 'USER': 'cltbld', 19:40:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', 19:40:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:21 INFO - '_': '/tools/buildbot/bin/python'} 19:40:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:40:21 INFO - Running setup.py (path:/tmp/pip-T2GNMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:40:21 INFO - Running setup.py (path:/tmp/pip-ZrQieN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:40:21 INFO - Running setup.py (path:/tmp/pip-Lf1gOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:40:21 INFO - Running setup.py (path:/tmp/pip-OhPNao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:40:21 INFO - Running setup.py (path:/tmp/pip-mPXqhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:40:22 INFO - Running setup.py (path:/tmp/pip-euy2_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:40:22 INFO - Running setup.py (path:/tmp/pip-CKGRiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:40:22 INFO - Running setup.py (path:/tmp/pip-D37i4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:40:22 INFO - Running setup.py (path:/tmp/pip-z_uZR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:40:22 INFO - Running setup.py (path:/tmp/pip-EqM5WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:40:22 INFO - Running setup.py (path:/tmp/pip-o2HI3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:40:22 INFO - Running setup.py (path:/tmp/pip-jbTlrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:40:22 INFO - Running setup.py (path:/tmp/pip-ZNvwqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:40:22 INFO - Running setup.py (path:/tmp/pip-v2tjFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:22 INFO - Running setup.py (path:/tmp/pip-hucmpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:40:22 INFO - Running setup.py (path:/tmp/pip-6IMx2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:40:22 INFO - Running setup.py (path:/tmp/pip-S1dJts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:40:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:40:22 INFO - Running setup.py install for manifestparser 19:40:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:40:22 INFO - Running setup.py install for mozcrash 19:40:23 INFO - Running setup.py install for mozdebug 19:40:23 INFO - Running setup.py install for mozdevice 19:40:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:40:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:40:23 INFO - Running setup.py install for mozfile 19:40:23 INFO - Running setup.py install for mozhttpd 19:40:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:40:23 INFO - Running setup.py install for mozinfo 19:40:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:40:23 INFO - Running setup.py install for mozInstall 19:40:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:40:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:40:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:40:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:40:23 INFO - Running setup.py install for mozleak 19:40:23 INFO - Running setup.py install for mozlog 19:40:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:40:23 INFO - Running setup.py install for moznetwork 19:40:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:40:24 INFO - Running setup.py install for mozprocess 19:40:24 INFO - Running setup.py install for mozprofile 19:40:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:40:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:40:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:40:24 INFO - Running setup.py install for mozrunner 19:40:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:40:24 INFO - Running setup.py install for mozscreenshot 19:40:24 INFO - Running setup.py install for moztest 19:40:24 INFO - Running setup.py install for mozversion 19:40:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:40:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:40:24 INFO - Cleaning up... 19:40:24 INFO - Return code: 0 19:40:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:40:24 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')]} 19:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:24 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')]} 19:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:24 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 0x7fcb7a86cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449090>, '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 0x144c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144ce40>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', '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 19:40:24 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 19:40:24 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 19:40:24 INFO - Using env: {'DISPLAY': ':0', 19:40:24 INFO - 'HOME': '/home/cltbld', 19:40:24 INFO - 'LANG': 'en_US.UTF-8', 19:40:24 INFO - 'LANGUAGE': 'en_US:en', 19:40:24 INFO - 'LOGNAME': 'cltbld', 19:40:24 INFO - 'MAIL': '/var/mail/cltbld', 19:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:24 INFO - 'MOZ_NO_REMOTE': '1', 19:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:24 INFO - 'NO_EM_RESTART': '1', 19:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:24 INFO - 'PWD': '/builds/slave/test', 19:40:24 INFO - 'SHELL': '/bin/bash', 19:40:24 INFO - 'SHLVL': '1', 19:40:24 INFO - 'TERM': 'linux', 19:40:24 INFO - 'TMOUT': '86400', 19:40:24 INFO - 'USER': 'cltbld', 19:40:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', 19:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:24 INFO - '_': '/tools/buildbot/bin/python'} 19:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:40:24 INFO - Running setup.py (path:/tmp/pip-j3SS81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:40:24 INFO - Running setup.py (path:/tmp/pip-0GOBGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:40: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)) 19:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:40:25 INFO - Running setup.py (path:/tmp/pip-vb5fdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:40: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)) 19:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:40:25 INFO - Running setup.py (path:/tmp/pip-JcC0mQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:40: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)) 19:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:40:25 INFO - Running setup.py (path:/tmp/pip-q9IUcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:40: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)) 19:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:40:25 INFO - Running setup.py (path:/tmp/pip-_ivdV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:40: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)) 19:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:40:25 INFO - Running setup.py (path:/tmp/pip-nNumAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:40:25 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)) 19:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:40:25 INFO - Running setup.py (path:/tmp/pip-7nvBxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:40:25 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)) 19:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:40:25 INFO - Running setup.py (path:/tmp/pip-kUXEcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:40:25 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)) 19:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:40:25 INFO - Running setup.py (path:/tmp/pip-_epXg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:40:25 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)) 19:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:40:25 INFO - Running setup.py (path:/tmp/pip-xSaXJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:40:25 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)) 19:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:40:25 INFO - Running setup.py (path:/tmp/pip-Il79jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:40:25 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)) 19:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:40:25 INFO - Running setup.py (path:/tmp/pip-09EJdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:40:25 INFO - Running setup.py (path:/tmp/pip-ku16ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:25 INFO - Running setup.py (path:/tmp/pip-V1slAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:40: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)) 19:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:40:26 INFO - Running setup.py (path:/tmp/pip-rKzlld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:40: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)) 19:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:40:26 INFO - Running setup.py (path:/tmp/pip-0DMD7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:40: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)) 19:40: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)) 19:40: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)) 19:40: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)) 19:40: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)) 19:40: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)) 19:40:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40:28 INFO - Downloading blessings-1.6.tar.gz 19:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:40:28 INFO - Installing collected packages: blessings 19:40:28 INFO - Running setup.py install for blessings 19:40:28 INFO - Successfully installed blessings 19:40:28 INFO - Cleaning up... 19:40:28 INFO - Return code: 0 19:40:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:40:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:40:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:40:28 INFO - Reading from file tmpfile_stdout 19:40:28 INFO - Current package versions: 19:40:28 INFO - argparse == 1.2.1 19:40:28 INFO - blessings == 1.6 19:40:28 INFO - blobuploader == 1.2.4 19:40:28 INFO - docopt == 0.6.1 19:40:28 INFO - functools32 == 3.2.3-2 19:40:28 INFO - jsonschema == 2.5.1 19:40:28 INFO - manifestparser == 1.1 19:40:28 INFO - mozInstall == 1.12 19:40:28 INFO - mozcrash == 0.17 19:40:28 INFO - mozdebug == 0.1 19:40:28 INFO - mozdevice == 0.48 19:40:28 INFO - mozfile == 1.2 19:40:28 INFO - mozhttpd == 0.7 19:40:28 INFO - mozinfo == 0.9 19:40:28 INFO - mozleak == 0.1 19:40:28 INFO - mozlog == 3.3 19:40:28 INFO - moznetwork == 0.27 19:40:28 INFO - mozprocess == 0.23 19:40:28 INFO - mozprofile == 0.28 19:40:28 INFO - mozrunner == 6.12 19:40:28 INFO - mozscreenshot == 0.1 19:40:28 INFO - mozsystemmonitor == 0.3 19:40:28 INFO - moztest == 0.7 19:40:28 INFO - mozversion == 1.4 19:40:28 INFO - psutil == 3.1.1 19:40:28 INFO - requests == 1.2.3 19:40:28 INFO - wsgiref == 0.1.2 19:40:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:40:28 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')]} 19:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:28 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')]} 19:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:28 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 0x7fcb7a86cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449090>, '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 0x144c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144ce40>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', '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 19:40:28 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 19:40:28 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 19:40:28 INFO - Using env: {'DISPLAY': ':0', 19:40:28 INFO - 'HOME': '/home/cltbld', 19:40:28 INFO - 'LANG': 'en_US.UTF-8', 19:40:28 INFO - 'LANGUAGE': 'en_US:en', 19:40:28 INFO - 'LOGNAME': 'cltbld', 19:40:28 INFO - 'MAIL': '/var/mail/cltbld', 19:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:28 INFO - 'MOZ_NO_REMOTE': '1', 19:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:28 INFO - 'NO_EM_RESTART': '1', 19:40:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:28 INFO - 'PWD': '/builds/slave/test', 19:40:28 INFO - 'SHELL': '/bin/bash', 19:40:28 INFO - 'SHLVL': '1', 19:40:28 INFO - 'TERM': 'linux', 19:40:28 INFO - 'TMOUT': '86400', 19:40:28 INFO - 'USER': 'cltbld', 19:40:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', 19:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:28 INFO - '_': '/tools/buildbot/bin/python'} 19:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:28 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)) 19:40:28 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)) 19:40:28 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)) 19:40:28 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)) 19:40:28 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)) 19:40:28 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)) 19:40:28 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)) 19:40:28 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)) 19:40:28 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)) 19:40:28 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)) 19:40:28 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)) 19:40:28 INFO - Cleaning up... 19:40:28 INFO - Return code: 0 19:40:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:40:28 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')]} 19:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:28 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')]} 19:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:28 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 0x7fcb7a86cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449090>, '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 0x144c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144ce40>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', '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 19:40:28 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 19:40:28 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 19:40:28 INFO - Using env: {'DISPLAY': ':0', 19:40:28 INFO - 'HOME': '/home/cltbld', 19:40:28 INFO - 'LANG': 'en_US.UTF-8', 19:40:28 INFO - 'LANGUAGE': 'en_US:en', 19:40:28 INFO - 'LOGNAME': 'cltbld', 19:40:28 INFO - 'MAIL': '/var/mail/cltbld', 19:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:28 INFO - 'MOZ_NO_REMOTE': '1', 19:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:28 INFO - 'NO_EM_RESTART': '1', 19:40:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:28 INFO - 'PWD': '/builds/slave/test', 19:40:28 INFO - 'SHELL': '/bin/bash', 19:40:28 INFO - 'SHLVL': '1', 19:40:28 INFO - 'TERM': 'linux', 19:40:28 INFO - 'TMOUT': '86400', 19:40:28 INFO - 'USER': 'cltbld', 19:40:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', 19:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:28 INFO - '_': '/tools/buildbot/bin/python'} 19:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:40:28 INFO - Cleaning up... 19:40:28 INFO - Return code: 0 19:40:28 INFO - Running post-action listener: _resource_record_post_action 19:40:28 INFO - Running post-action listener: _start_resource_monitoring 19:40:28 INFO - Starting resource monitoring. 19:40:28 INFO - [mozharness: 2016-08-12 02:40:28.990974Z] Finished create-virtualenv step (success) 19:40:28 INFO - [mozharness: 2016-08-12 02:40:28.991490Z] Running install step. 19:40:28 INFO - Running pre-action listener: _resource_record_pre_action 19:40:28 INFO - Running main action method: install 19:40:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:40:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:40:29 INFO - Reading from file tmpfile_stdout 19:40:29 INFO - Detecting whether we're running mozinstall >=1.0... 19:40:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:40:29 INFO - Reading from file tmpfile_stdout 19:40:29 INFO - Output received: 19:40:29 INFO - Usage: mozinstall [options] installer 19:40:29 INFO - Options: 19:40:29 INFO - -h, --help show this help message and exit 19:40:29 INFO - -d DEST, --destination=DEST 19:40:29 INFO - Directory to install application into. [default: 19:40:29 INFO - "/builds/slave/test"] 19:40:29 INFO - --app=APP Application being installed. [default: firefox] 19:40:29 INFO - mkdir: /builds/slave/test/build/application 19:40: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'] 19:40: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 19:40:45 INFO - Reading from file tmpfile_stdout 19:40:45 INFO - Output received: 19:40:45 INFO - /builds/slave/test/build/application/firefox/firefox 19:40:45 INFO - Running post-action listener: _resource_record_post_action 19:40:45 INFO - [mozharness: 2016-08-12 02:40:45.348544Z] Finished install step (success) 19:40:45 INFO - [mozharness: 2016-08-12 02:40:45.348794Z] Running run-tests step. 19:40:45 INFO - Running pre-action listener: _resource_record_pre_action 19:40:45 INFO - Running main action method: run_tests 19:40:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:40:45 INFO - Python 2.7.3 19:40:45 INFO - Return code: 0 19:40:45 INFO - grabbing minidump binary from tooltool 19:40:45 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')]} 19:40:45 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 0x1449090>, '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 0x144c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144ce40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:40:45 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 19:40:45 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 19:40:45 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 19:40:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:40:45 INFO - Return code: 0 19:40:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:40:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:40:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:40:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:40:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:40:45 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/M6VgNI3VQTaKQwJS8uQtRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 19:40:45 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/M6VgNI3VQTaKQwJS8uQtRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 19:40:45 INFO - Using env: {'DISPLAY': ':0', 19:40:45 INFO - 'HOME': '/home/cltbld', 19:40:45 INFO - 'LANG': 'en_US.UTF-8', 19:40:45 INFO - 'LANGUAGE': 'en_US:en', 19:40:45 INFO - 'LOGNAME': 'cltbld', 19:40:45 INFO - 'MAIL': '/var/mail/cltbld', 19:40:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:40:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:45 INFO - 'MOZ_NO_REMOTE': '1', 19:40:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:45 INFO - 'NO_EM_RESTART': '1', 19:40:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:45 INFO - 'PWD': '/builds/slave/test', 19:40:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:40:45 INFO - 'SHELL': '/bin/bash', 19:40:45 INFO - 'SHLVL': '1', 19:40:45 INFO - 'TERM': 'linux', 19:40:45 INFO - 'TMOUT': '86400', 19:40:45 INFO - 'USER': 'cltbld', 19:40:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478', 19:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:45 INFO - '_': '/tools/buildbot/bin/python'} 19:40:45 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/M6VgNI3VQTaKQwJS8uQtRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 19:40:45 INFO - mozversion application_buildid: 20160811182417 19:40:45 INFO - mozversion application_changeset: 0c68d5900cce52d31a9dfe2d53f81742dba21ad0 19:40:45 INFO - mozversion application_display_name: Nightly 19:40:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:40:45 INFO - mozversion application_name: Firefox 19:40:45 INFO - mozversion application_remotingname: firefox 19:40:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:40:45 INFO - mozversion application_vendor: Mozilla 19:40:45 INFO - mozversion application_version: 51.0a1 19:40:45 INFO - mozversion platform_buildid: 20160811182417 19:40:45 INFO - mozversion platform_changeset: 0c68d5900cce52d31a9dfe2d53f81742dba21ad0 19:40:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:40:45 INFO - mozversion platform_version: 51.0a1 19:40:45 INFO - using testdate: 1470969645 19:40:45 INFO - actual date: 1470969645 19:40:45 INFO - starting webserver on 'localhost:60494' 19:40:45 INFO - SUITE-START | Running 2 tests 19:40:45 INFO - TEST-START | dromaeo_css 19:40:45 INFO - operating with platform_type : linux_ 19:40:45 INFO - Initialising browser for dromaeo_css test... 19:40:45 INFO - TEST-INFO | started process 9136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaTkg4U/profile http://localhost:60494/getInfo.html) 19:40:49 INFO - PROCESS | 9136 | __metrics Screen width/height:1600/1200 19:40:49 INFO - PROCESS | 9136 | colorDepth:24 19:40:49 INFO - PROCESS | 9136 | Browser inner width/height: 1024/697 19:40:49 INFO - PROCESS | 9136 | __metrics 19:40:50 ERROR - PROCESS | 9136 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 19:40:51 INFO - TEST-INFO | 9136: exit 0 19:40:51 INFO - Browser initialized. 19:40:51 INFO - Running cycle 1/1 for dromaeo_css test... 19:40:51 INFO - TEST-INFO | started process 9257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaTkg4U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:41:03 INFO - PROCESS | 9257 | RSS: Main: 163708928 19:41:03 INFO - PROCESS | 9257 | 19:41:52 INFO - PROCESS | 9257 | 1470969712744 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] 19:44:05 INFO - PROCESS | 9257 | Cycle 1(1): loaded http://localhost:60494/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60494/tests/dromaeo/cssquery-ext.html) 19:44:06 INFO - PROCESS | 9257 | RSS: Main: 165490688 19:44:06 INFO - PROCESS | 9257 | 19:47:09 INFO - PROCESS | 9257 | Cycle 1(1): loaded http://localhost:60494/tests/dromaeo/cssquery-ext.html (next: http://localhost:60494/tests/dromaeo/cssquery-jquery.html) 19:47:09 INFO - PROCESS | 9257 | RSS: Main: 166502400 19:47:09 INFO - PROCESS | 9257 | 19:50:11 INFO - PROCESS | 9257 | Cycle 1(1): loaded http://localhost:60494/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60494/tests/dromaeo/cssquery-mootools.html) 19:50:12 INFO - PROCESS | 9257 | RSS: Main: 169480192 19:50:12 INFO - PROCESS | 9257 | 19:53:14 INFO - PROCESS | 9257 | Cycle 1(1): loaded http://localhost:60494/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60494/tests/dromaeo/cssquery-prototype.html) 19:53:15 INFO - PROCESS | 9257 | RSS: Main: 163573760 19:53:15 INFO - PROCESS | 9257 | 19:56:18 INFO - PROCESS | 9257 | Cycle 1(1): loaded http://localhost:60494/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60494/tests/dromaeo/cssquery-yui.html) 19:56:18 INFO - PROCESS | 9257 | RSS: Main: 165605376 19:56:18 INFO - PROCESS | 9257 | 19:59:21 INFO - PROCESS | 9257 | Cycle 1(1): loaded http://localhost:60494/tests/dromaeo/cssquery-yui.html (next: http://localhost:60494/tests/dromaeo/cssquery-dojo.html) 19:59:21 INFO - PROCESS | 9257 | RSS: Main: 169947136 19:59:21 INFO - PROCESS | 9257 | 19:59:21 INFO - PROCESS | 9257 | __start_tp_report 19:59:21 INFO - PROCESS | 9257 | _x_x_mozilla_page_load 19:59:21 INFO - PROCESS | 9257 | _x_x_mozilla_page_load_details 19:59:21 INFO - PROCESS | 9257 | |i|pagename|runs| 19:59:21 INFO - PROCESS | 9257 | |0;dojo.html;2671.612616170655;2673.8663066846652;2693.8653067346627;2707.404371038372;2725.577535482001;4747.026859493804;4890.486498917611;4928.531789480003;4941.431735350436;4976.67651602646;4863.756812159396;4864.586510146642;4875.341828853104;4927.433345165307;4938.283948827418;4476.171908196978;4519.638428925695;4534.478534968488;4641.489436162036;4680.555347242023;4560.407147070892;4602.631789456852;4618.56123668251;4630.2360110581885;4651.581357677808;4322.956770432287;4426.623736982328;4441.777911104464;4566.474855391639;4586.7477288749105;4415.536368681274;4418.094290670437;4421.712588681726;4543.5002149763495;4557.612602928755;4439.467263928317;4455.264881294583;4474.619657329131;4491.169133710274;4513.413256276663;4814.807407703687;4833.806647734086;4855.101806165835;4857.68425052374;4880.877978050542;5286.81496147633;5287.920681189786;5306.681599104066;5309.867253318659;5331.733413329357;5319.281896943901;5322.467753224647;5328.49379308965;5347.7058761768085;5372.489613486751;4631.999999999966;4817.759112044384;4841.757912104381;4854.927176092361;4887.560119589254;5307.310049693515;5316.388615309289;5331.280277162534;5331.5201631853315;5341.732913354317;5106.259592359162;5117.641765076409;5119.232115182753;5131.307273518102;5142.691438513626;5036.244563315532;5259.552938000313;5290.31225940633;5294.258803767476;5361.276227709287;5270.92093618596;5275.630705850554;5282.260483532308;5282.471752824764;5294.258803767476;5236.869078273074;5253.054450199001;5255.264263003182;5267.209918512254;5307.336582927134;4357.847475338348;4478.9552104478535;4511.842085526991;4523.547645235516;4574.885627859264;3906.277338692351;3920.9019774505864;3927.136030073379;3968.583298753647;3972.463717398114;4567.063751930847;4589.196890544142;4589.196890544142;4601.24079526881;4657.46439159501;5099.5410413063;5231.816886409034;5244.816431424958;5269.57843372537;5355.866103347447;4530.932036019462;4547.431571053618;4558.0428110097255;4558.954410455919;4605.8848528786375;4754.096721622881;4757.95242047582;4765.475797662254;4767.404074490689;4801.303810947463;4766.070616229802;4845.830395936126;4891.51084891508;4905.730184839868;4961.627877909099;5224.320838290998;5229.764660590206;5251.52736253739;5263.73681315925;5279.815206467755;4927.852164435073;4927.965127323159;4930.975345123252;4943.728094954812;4964.280179374043;4976.303317535476;5037.219231019198;5045.31888195089;5099.36257967754;5121.743912804271;5231.686098834082;5303.655262407931;5311.973440132774;5356.5982551308025;5361.276227709365;5126.051680439131;5130.97434512825;5133.589312854888;5153.123968925367;5165.405978312542;4852.272159176152;5090.618203634816;5092.134337162617;5115.335006449138;5131.25596788471;5070.721110338966;5076.18780995039;5083.415407228216;5091.490850914879;5096.898062038665;5133.589312854888;5143.570289517806;5145.151050076695;5158.38099428071;5188.118019936695;4829.203181475017;4931.778069986787;4968.503149685002;5034.471380504994;5044.293798868235 19:59:21 INFO - PROCESS | 9257 | |1;ext.html;548.1421575234757;553.1122548309962;561.7387914619701;562.2802812400126;576.8759716660917;35655;38929;39056;39094;39282.214355712866;39214.41178382326;39622.40566391499;39638.60361396385;39906.201875962535;39911.208435198685;7549.735759248428;7624.085109786805;7684.193159718233;7701.614919254043;7717.536947783123;7649.311561959423;7713.460057795956;7734.187910269425;7747.573883436408;7752.651130699132;7692.7692169235015;7710.730124445646;7725.072991241059;7773.96113019437;7778.649960751752;7728.961355193216;7732.884006739903;7751.961240193763;7758.185390534026;7783.961080194591;7546.396288296923;7565.470417070807;7573.053368328959;7592.924070759333;7631.580263085528;35492.46761298583;35804.46293305603;35835.104122396886;35869.46195807065;35888.64111358879;2362.692849929498;2818.661760588722;3069.7083777041144;3079.7536197104178;3307.6196237432764;27140.592891106648;27347.453050939068;27710.86144569264;28097.578536321973;28521.71478285232;3180.9840950795096;3257.1694217974264;3278.278778668689;3291.983540082308;3328.1845947742718;160143;160223.198884006;161078;161114;161123;31805.363892722016;54627.81035801592;54755;54867.45132548623;55388.723056385264;32500.187495312333;33787;33843.66156338405;33938.830305848314;34000;13381.598552043455;13486.662833429047;13488.258145802076;13526.053176277763;13527.188368697909;10938;10954.616588419367;11069.05912997388;11071.335719856834;11074.058705010004;7630.38956883448;7724.6523906424345;7865.095514015847;7920.405969552191;7937.920620793833;3070.9846450767604;3097.4424603571124;3097.581826453445;3102.441560519083;3106.5340198970334;848.2069265237024;942.5475771629656;958.5542722633869;961.3654987708079;981.4503877828439;27706.258198703974;28463.715362846106;28672.713272867422;29038.709612904022;29202.123936281947;970.4662435660358;982.3418309732497;1008.4151192308443;1032.850236715672;1048.486241741541;14597.12417254968;15280.694386112216;15429.459968901034;15457.458988935334;15468.303926323342;405754;408215;412016;413434;413992;48279.75860120677;48542.75728621405;48607.51392486101;48879.51120488821;48900.755496223006;1126.8929451702074;1181.1436708386352;1193.1051711216587;1195.0021731853826;1206.6500714792787;27039.45921081607;27620.585691214244;28235.71764282331;28997.275068123465;29033.419331613673;42347.15305693931;42398.788006059774;42415.7879210602;42676.359854601586;42677.57322426736;308389;313032;313343;313781;313934;25236.873815630803;25678.101266455586;25827.870860645577;25958.74041259563;26122.608160877982;41320.79339603283;41786.1642767149;41828.58171418247;42152.78923605485;43091.353629696205;35912.64087359093;35938.28123437464;36067.81966090153;36839;36991.81504092462;35996;36011.27977440384;36468.45297320595;36494.27011459703;36892;35053;35336.46995295021;35583.46624800578;36370;36684.63315366919;31524.52713209258;33577.328453431284;34053.48919766156;34054.82972585121;34108.82945585256;25590.61614075753;26138.86930565335;26172.476550469266;26342.341441464116;26884.731152689004 19:59:21 INFO - PROCESS | 9257 | |2;jquery.html;330.13998533819387;350.5390411608736;354.61701362528464;357.1838349371685;372.45249483259613;15997.84002159978;17112;17327.740083898752;17483.213255403505;17549.298028078894;16428.507144785646;17004.574885627866;17376.131193440342;17473.03898285594;17605.11974401278;5019.749012549376;5302.840914772563;5303.549198318128;5308.5487733542695;5312.150055991042;3748.456473811296;5180.456052114511;6016.789412370568;6277.340879207686;6305.6216627002295;6110;6320.146780184685;6337.809865704036;6349.111124442558;6376.330485299047;6120.57155999078;6220.937790622081;6228.906566401508;6250.874982500347;6260.499160067184;5254.894902101974;5274.604404669665;5399.2980912481125;5439.156930675752;5447.891042179174;21093.15627374903;21154.471138221666;21184.470388240265;21230.681539776917;21234.362969110953;2089.7910208979133;2147.892605369725;2208.812250958654;2445.339758265276;2497.8501289922665;6583.967080164569;13179.472821087145;13801.86071158962;14047.64880877976;14322.427102915872;1757.6045389787196;1834.6972749496317;1948.2596613287003;1978.9703154452695;2005.0776642744356;69155.96266055963;69477.30522694759;69612.6519367405;69623.30376696218;70681;9929.255305851946;9949.701508954742;10040.196784257241;10193;10254.6410875619;13376.331183440789;13385.464581416829;13420.597382078553;13422.328883555783;13432.529861454803;7115.5730656160795;7317.597532135677;7447.739329123455;7635.580043097571;7640.013596464959;7006.4745144114395;7051.682674279669;7232.602206878567;7319.487635865545;7368.226336234726;4102.241085399151;4120.979395103005;4192.727472714264;4199.307114326163;4303.827846886152;1650.306871114135;1692.297696455957;1800.6848801459691;1821.8733481862964;1879.8026207248315;786.9179877668206;813.3737022492766;855.7903313688062;897.0491279244022;949.8933742190271;16669.416570419977;16718.83281167197;16884.662306753795;17089.91455042717;17177.398791042255;809.9109097999216;856.6316483911853;859.4671303791564;862.1766213266316;871.4509858788922;8500;9476.241900647932;9517.381370211053;9540.427574345562;9593.376430531993;415549;422179;435321;442682;443354;77219.61390193013;78328.608356959;78556.60721696354;78618.21381786223;80944;931.5481991234246;935.2751617496359;943.9622415103319;954.5847556312888;958.9280803939732;14779.556613301618;15025.52078906968;15062.472813451477;15113;15542.611434714223;35485.82257088801;35831.64168358283;36187;36627.633723662424;37312.81343593264;51828.74085629699;53742.46257537375;53945.20234548726;54974.17538737002;55127.173092404446;7447.702091916262;7635.656395462329;7725.266099720518;7791.104023037196;8191.385646076687;9429.764255893657;12359.62921112368;12382;12804.551840685532;12813.807792882928;10200.948995254976;10858.239923205616;11025.779484410426;11257.549698011988;11373;5557.916631250615;6594.307597702172;9292.860607091034;10281.434521101412;10862.34825910448;10441.634542790965;10811.13510919109;10877;10925.890741092488;11137.387443690352;6650.9667451662435;6882.380585747307;7049.894251586128;7092.822679433056;7219.566825990458;7881;10372.740681483023;10798.892011079788;10852.891471085188;11126.888731112585 19:59:21 INFO - PROCESS | 9257 | |3;mootools.html;1380.0201856681756;1431.08410617205;1512.8033355663763;1663.3346661335472;1713.8971661700307;6441.130447389601;7290.963545182273;7446.515976461526;7927.088384835738;7947.2847443730125;7495.625218739055;7746.883796743054;7749.225077492248;7757.146713861471;7765.301122898938;2117.6929345244966;2160;2161.7513985891665;2175.5866385386803;2177.520945392011;2121.946951326214;2144.6997420361163;2172.0877231562704;2173.4892300309493;2180.7819218078225;2142.1110239250693;2148.9570208595896;2157.6979222908803;2166.360923527563;2193.6270833958265;2087.3424871165535;2114.2917122763815;2114.2917122763893;2118.0998075817715;2124.415785658941;2032.1566549881782;2096.3920463065692;2100.0444797617047;2104.295061154515;2108.9050992705365;7753.185915478906;7779.105402878685;7780.105287891908;7790.961045194795;7791.181925897756;4343.261645520269;4512;4523.592876641085;4524.29873369625;4553.089382123589;2873.468408344463;2876.7698584113223;2916.9270768230754;2918.3433727411375;2960.7927445078853;948.5399581203111;967.1344146988476;969.9854502182473;970.2771435280761;1019.1591936652218;10212.693619191436;10244.02681745233;10264.076233139054;10294.3823370598;10307.84538231927;3820.446035324918;3916.6670832979516;4110.17796440713;4111.60939710727;4115.773632450244;8851.513166775889;8861;8862.069482704352;8865.423747456394;8886.022537520868;4474.731516109044;4478.305862591238;4505.752183629932;4506.098780243964;4515.68390212682;3315.535824984504;3965.464662270614;4116.732412393185;4119.237940980928;4119.588041195856;3505.8422370993367;3553.200529880756;3659.451082337617;3674.7873201843863;3690.630936906288;1169.1523645357217;1190.1193117093462;1190.2025642819333;1190.9344986025678;1199.6341115959717;658.8733266114997;664.8238216872533;700.98007399234;804.3243675312649;831.5343407691712;4910.631702622318;4960.330355402047;4977.477364876709;4982.701037937735;5024.070546948826;405.3473907009712;417.4864916153088;421.0652351779046;422.204145186326;423.686472010716;3596.478510615946;3600.937723371612;3805.809709514513;3863;3891.4357418174773;9396.67111651089;9447.480388578557;9561.713148605553;9566.56950437232;9773.85339219898;9473.147416732389;9506.857397139049;9524.095210954949;9528.761780955392;9542.52287385628;7119.1457025157315;7252.274772522811;7283.963580182065;7288.489805713549;7301.342879141009;5367.865803354947;5391;5443.482869127427;5484.314460692413;5548.611597188319;8680.869786953326;8877.24543413817;8943.105689431004;9013.098690130935;9032.232260257952;8512.74461766148;8920.420172688755;8922.55387230649;8987.775305617412;9187.08129187076;5497.697626630574;6593.472522198309;6717.92513197886;6719.865602687821;6847.657617119224;7511.887321690069;7604.657790399335;7617.5048621839405;7655.46411751172;7669.501482403626;6654.83362915931;6670.499712521678;6677.732890684319;6848;7081.221065682667;6644.501662375244;6698.866022679616;6733.966330168318;6875.828104297432;6951.860962780817;6336.271328797063;6344.68276586178;6379.266384365672;6411.358864113738;6417.486601071996;4529.433820772403;4532.501424843331;4558.726476411426;4621.237495813153;4691.1555919934735;4474.328850672425;4551.68138230334;4570.337301091389;4626.421697287839;4742.596879265301 19:59:21 INFO - PROCESS | 9257 | |4;prototype.html;278.31950880098157;288.85845935491614;290.86184062570277;295.99657162220063;297.74542765935126;4899.496859745282;4953.876153096175;5077.365329333833;5106.565941894934;5117.667351622142;4960.503949605038;5030.84907452776;5030.874228144298;5035.269885866547;5042.82350117746;3974.7615143091507;3977.4232736253225;3987.262356464049;3989.36170212766;3993.9201215975663;3860.613938606145;3984.3425834737377;3989.2021595680835;3991.540972788123;4004.359302511599;3911.7532448068037;3942.881713548584;3946.6645335146545;3982.084120652252;3992.5608183099835;3929.4851295171115;3959.366501359769;3964.147708242742;3968.9085501487034;3994.980025099856;3512.9824350878084;3516.2791627716256;3524.1365865362895;3551.751377403583;3552.182997910495;4874.878777881072;4909.803607855682;4947.975260123712;4965.155923492979;5038.168702164138;4528.456585209763;4538.8865278367975;4543.636509079266;4545.613622842063;4548.499665036843;5308.575313974873;5324.866878328034;5330.3742358581;5333.066713325153;5335.973320133375;3455.3262113887804;3642.7085833133287;3657.6708096271464;3855.6722678572355;3868.3810590305416;5504.174373843915;5513.3108361454815;5527.806526771584;5529.30883639545;5532.585056120807;3735.159589092487;3747.437884317374;3749.1002159481527;3749.1189570450924;3751.6060813614176;3593.3711600469815;3811.790351530637;3831.885043448701;3835.1562656215588;3839.827207775657;4373.365861949999;4383.320585309282;4383.452068491439;4392.099619577979;4402.823887044482;5282.577393808486;5293.153095504701;5303.761330740126;5306.177542480922;5313.309269794902;1247.058470854499;1258.4211262819206;1281.6667666406802;1302.1926405628572;1315.7368526294779;833.5040650812757;847.1909326593212;863.3481721300503;873.6898401067657;875.6689831456151;4599.6771630326475;4600.838970636011;4607.424071991001;4618.630509559227;4644.558766917137;5370.167624018283;5399.217113518596;5423.918641220384;5426.538744206708;5441.945580544223;4521.59305662492;4613.284940834176;4617.191991401492;4622.422197225347;4632.2125238709505;2487.751224877498;2503.9374015649755;2523.3565440812476;2543.4658721668657;2546.108861898321;4480.798364073625;4483.928508971365;4521.299198624219;4529.9547004530195;4543.409356783597;4670.8365207217585;4809.302651115569;4862.82980095695;4865.513448655106;4914.852554423373;4364.297923809717;4398.934015989763;4427.40230068943;4505.63954883615;4518.819247230074;4789.653069995747;4815.218369203417;4826.734529600905;4830.7826147822725;4863.367762190893;4688.320193571844;4714.646401519968;4756.619470442425;4766;4772.117158325721;4166.562535925101;4430.734155950653;4431.158079964796;4461.442319710036;4472.843450479218;3351.463765797461;3382.255903701182;3385.1875549868346;3425.845836937394;3446.5174875516946;4801.399825021872;4809.663323567317;4828.837111691848;4837.733924634179;5238.76425560843;5179.741012949413;5268.76290566933;5287.339082614673;5329.253904453457;5331;5248.422673505835;5265.578293860713;5280.20796880471;5289.68261904287;5323.281357016753;4902.8774280643265;5144.6398752087;5148.819791307286;5172.508611681884;5190.532852043334;5304.257403963526;5308.787648494017;5311.920321195263;5317.787288508571;5322.946770532245;5188.22176673502;5194.870128246824;5222.294990176278;5227.738613069408;5230.790768369223 19:59:21 INFO - PROCESS | 9257 | |5;yui.html;669.2738378858937;684.2678334182427;688.3391943734015;743.6281859070465;759.4076620236216;12304.38478076096;13461.125026873271;13507.324633768321;13572.185668859864;13615.659608509779;13128.081034327577;13265.535706250283;13291.069625126245;13295.734085318289;13412.329383530834;625.8278973282361;760.5512747478972;769.6421164158666;776.2625505769513;776.5767656627152;781.3866115099648;781.7303030454513;782.2334112569686;782.5774081995716;782.81212508998;829.8049958259804;832.8875601793771;835.6448509383488;835.8119423129808;836.2933321343455;823.0534884882433;826.3389288569151;827.4910929778204;827.6565225431439;829.8298848736025;598.8981873081586;600.5075837812996;602.5270162922129;605.4187979539647;605.5246631394378;12413.627591172279;12418.316992565406;12448.128630995834;12467.189632673848;12483.812742808865;13239.669008274774;13303.733925321536;13385.397657105355;13511.121777084458;13706.588802335946;10782;10822.188335874762;10857.077148442313;11021.504032318566;11035.39305338206;3314.7016768490953;3332.6000879894327;3370.1237678203597;3374.5106959490736;3382.7632065755406;63802.3619763801;63876.36123638751;64669.67665161691;65683.67158164227;65692.34307656958;10418.68743937683;10460.064887995593;10537.315074520131;10565;10639.361638301727;19832.20671173166;19866.304679336154;19891.60216795656;20001.899990500246;20415.183392664127;6727.831804204934;6761;6816.216135144522;6863.764522386018;6895.75864844728;3553.8400771965325;3663.06583334999;3741.794201318899;3769.264993326275;3852.3643598805884;2771.1547977866944;2868.612737280482;2879.5392737161956;2884.567314902781;2891.1471116020825;457.6819110718019;466.442601091699;466.84827431085034;478.9856304310876;479.1471181297296;496.11938808614275;514.4495389932736;558.9077802162598;575.815738963536;620.4725982914487;8238.752837414768;8347.916520834835;8648.567571621394;8910.688125915562;9063.909360906306;604.5224272824507;610.3012051201438;610.8442347201435;621.6922623301494;624.4036944717784;4154.480689913761;4185.560516145761;4412.426384569985;4441.444819397575;4464.285714285698;53083.73458132762;78580;101361;105260.47369763102;105628;83703.16296836954;84019.15980840236;85412;86403;86633;47012.7649361751;77764.61117694376;80458.5977070111;80666;82036;8171.305439037511;8432.747017589481;8446.493210407396;8473.067962523994;8589.914100859161;46575;47003.294950576455;47009.76495117503;47547.28679069886;48581.75709121432;47396.289055664885;59034.40965590461;60392;61951;63937.36062639314;11197.72005699864;11498.54005839757;11526.654200374001;11630;11792.41037948082;12871;13232.536861209812;13451.058425910092;13671.248081355223;14094.50669226572;9355.906440935503;10064.345817521838;12816.795801049737;13194.604161875159;13495.865041349462;10026.498675066363;10046.54790534413;10340.327878687862;10422.739431514272;12645.683857903627;12287.87712122903;12983.221006739626;13067;13263.66840828987;13389.866101339252;10109.19126469866;10189.694309170736;10516.211284153565;10548.419836909045;10971.670849874517;9951.402915825074;10213.519039739345;10895.509702063267;11144.777104457704;11150.776984460103 19:59:21 INFO - PROCESS | 9257 | __end_tp_report 19:59:21 INFO - PROCESS | 9257 | __start_cc_report 19:59:21 INFO - PROCESS | 9257 | _x_x_mozilla_cycle_collect,370 19:59:21 INFO - PROCESS | 9257 | __end_cc_report 19:59:21 INFO - PROCESS | 9257 | __startTimestamp1470970761839__endTimestamp 19:59:21 INFO - PROCESS | 9257 | 19:59:21 INFO - PROCESS | 9257 | ------- Summary: start ------- 19:59:21 INFO - PROCESS | 9257 | Number of tests: 6 19:59:21 INFO - PROCESS | 9257 | 19:59:21 INFO - PROCESS | 9257 | [#0] dojo.html Cycles:165 Average:4850.07 Median:4938.28 stddev:510.51 (10.3%) stddev-sans-first:482.63 19:59:21 INFO - PROCESS | 9257 | Values: 2671.6 2673.9 2693.9 2707.4 2725.6 4747.0 4890.5 4928.5 4941.4 4976.7 4863.8 4864.6 4875.3 4927.4 4938.3 4476.2 4519.6 4534.5 4641.5 4680.6 4560.4 4602.6 4618.6 4630.2 4651.6 4323.0 4426.6 4441.8 4566.5 4586.7 4415.5 4418.1 4421.7 4543.5 4557.6 4439.5 4455.3 4474.6 4491.2 4513.4 4814.8 4833.8 4855.1 4857.7 4880.9 5286.8 5287.9 5306.7 5309.9 5331.7 5319.3 5322.5 5328.5 5347.7 5372.5 4632.0 4817.8 4841.8 4854.9 4887.6 5307.3 5316.4 5331.3 5331.5 5341.7 5106.3 5117.6 5119.2 5131.3 5142.7 5036.2 5259.6 5290.3 5294.3 5361.3 5270.9 5275.6 5282.3 5282.5 5294.3 5236.9 5253.1 5255.3 5267.2 5307.3 4357.8 4479.0 4511.8 4523.5 4574.9 3906.3 3920.9 3927.1 3968.6 3972.5 4567.1 4589.2 4589.2 4601.2 4657.5 5099.5 5231.8 5244.8 5269.6 5355.9 4530.9 4547.4 4558.0 4559.0 4605.9 4754.1 4758.0 4765.5 4767.4 4801.3 4766.1 4845.8 4891.5 4905.7 4961.6 5224.3 5229.8 5251.5 5263.7 5279.8 4927.9 4928.0 4931.0 4943.7 4964.3 4976.3 5037.2 5045.3 5099.4 5121.7 5231.7 5303.7 5312.0 5356.6 5361.3 5126.1 5131.0 5133.6 5153.1 5165.4 4852.3 5090.6 5092.1 5115.3 5131.3 5070.7 5076.2 5083.4 5091.5 5096.9 5133.6 5143.6 5145.2 5158.4 5188.1 4829.2 4931.8 4968.5 5034.5 5044.3 19:59:21 INFO - PROCESS | 9257 | 19:59:21 INFO - PROCESS | 9257 | [#1] ext.html Cycles:180 Average:44232.60 Median:35852.28 stddev:82802.49 (231.0%) stddev-sans-first:82969.81 19:59:21 INFO - PROCESS | 9257 | Values: 548.1 553.1 561.7 562.3 576.9 35655.0 38929.0 39056.0 39094.0 39282.2 39214.4 39622.4 39638.6 39906.2 39911.2 7549.7 7624.1 7684.2 7701.6 7717.5 7649.3 7713.5 7734.2 7747.6 7752.7 7692.8 7710.7 7725.1 7774.0 7778.6 7729.0 7732.9 7752.0 7758.2 7784.0 7546.4 7565.5 7573.1 7592.9 7631.6 35492.5 35804.5 35835.1 35869.5 35888.6 2362.7 2818.7 3069.7 3079.8 3307.6 27140.6 27347.5 27710.9 28097.6 28521.7 3181.0 3257.2 3278.3 3292.0 3328.2 160143.0 160223.2 161078.0 161114.0 161123.0 31805.4 54627.8 54755.0 54867.5 55388.7 32500.2 33787.0 33843.7 33938.8 34000.0 13381.6 13486.7 13488.3 13526.1 13527.2 10938.0 10954.6 11069.1 11071.3 11074.1 7630.4 7724.7 7865.1 7920.4 7937.9 3071.0 3097.4 3097.6 3102.4 3106.5 848.2 942.5 958.6 961.4 981.5 27706.3 28463.7 28672.7 29038.7 29202.1 970.5 982.3 1008.4 1032.9 1048.5 14597.1 15280.7 15429.5 15457.5 15468.3 405754.0 408215.0 412016.0 413434.0 413992.0 48279.8 48542.8 48607.5 48879.5 48900.8 1126.9 1181.1 1193.1 1195.0 1206.7 27039.5 27620.6 28235.7 28997.3 29033.4 42347.2 42398.8 42415.8 42676.4 42677.6 308389.0 313032.0 313343.0 313781.0 313934.0 25236.9 25678.1 25827.9 25958.7 26122.6 41320.8 41786.2 41828.6 42152.8 43091.4 35912.6 35938.3 36067.8 36839.0 36991.8 35996.0 36011.3 36468.5 36494.3 36892.0 35053.0 35336.5 35583.5 36370.0 36684.6 31524.5 33577.3 34053.5 34054.8 34108.8 25590.6 26138.9 26172.5 26342.3 26884.7 19:59:21 INFO - PROCESS | 9257 | 19:59:21 INFO - PROCESS | 9257 | [#2] jquery.html Cycles:180 Average:25742.71 Median:439001.50 stddev:71120.20 (16.2%) stddev-sans-first:71294.12 19:59:21 INFO - PROCESS | 9257 | Values: 330.1 350.5 354.6 357.2 372.5 15997.8 17112.0 17327.7 17483.2 17549.3 16428.5 17004.6 17376.1 17473.0 17605.1 5019.7 5302.8 5303.5 5308.5 5312.2 3748.5 5180.5 6016.8 6277.3 6305.6 6110.0 6320.1 6337.8 6349.1 6376.3 6120.6 6220.9 6228.9 6250.9 6260.5 5254.9 5274.6 5399.3 5439.2 5447.9 21093.2 21154.5 21184.5 21230.7 21234.4 2089.8 2147.9 2208.8 2445.3 2497.9 6584.0 13179.5 13801.9 14047.6 14322.4 1757.6 1834.7 1948.3 1979.0 2005.1 69156.0 69477.3 69612.7 69623.3 70681.0 9929.3 9949.7 10040.2 10193.0 10254.6 13376.3 13385.5 13420.6 13422.3 13432.5 7115.6 7317.6 7447.7 7635.6 7640.0 7006.5 7051.7 7232.6 7319.5 7368.2 4102.2 4121.0 4192.7 4199.3 4303.8 1650.3 1692.3 1800.7 1821.9 1879.8 786.9 813.4 855.8 897.0 949.9 16669.4 16718.8 16884.7 17089.9 17177.4 809.9 856.6 859.5 862.2 871.5 8500.0 9476.2 9517.4 9540.4 9593.4 415549.0 422179.0 435321.0 442682.0 443354.0 77219.6 78328.6 78556.6 78618.2 80944.0 931.5 935.3 944.0 954.6 958.9 14779.6 15025.5 15062.5 15113.0 15542.6 35485.8 35831.6 36187.0 36627.6 37312.8 51828.7 53742.5 53945.2 54974.2 55127.2 7447.7 7635.7 7725.3 7791.1 8191.4 9429.8 12359.6 12382.0 12804.6 12813.8 10200.9 10858.2 11025.8 11257.5 11373.0 5557.9 6594.3 9292.9 10281.4 10862.3 10441.6 10811.1 10877.0 10925.9 11137.4 6651.0 6882.4 7049.9 7092.8 7219.6 7881.0 10372.7 10798.9 10852.9 11126.9 19:59:21 INFO - PROCESS | 9257 | 19:59:21 INFO - PROCESS | 9257 | [#3] mootools.html Cycles:180 Average:5070.02 Median:4826.61 stddev:2856.34 (59.2%) stddev-sans-first:2850.89 19:59:21 INFO - PROCESS | 9257 | Values: 1380.0 1431.1 1512.8 1663.3 1713.9 6441.1 7291.0 7446.5 7927.1 7947.3 7495.6 7746.9 7749.2 7757.1 7765.3 2117.7 2160.0 2161.8 2175.6 2177.5 2121.9 2144.7 2172.1 2173.5 2180.8 2142.1 2149.0 2157.7 2166.4 2193.6 2087.3 2114.3 2114.3 2118.1 2124.4 2032.2 2096.4 2100.0 2104.3 2108.9 7753.2 7779.1 7780.1 7791.0 7791.2 4343.3 4512.0 4523.6 4524.3 4553.1 2873.5 2876.8 2916.9 2918.3 2960.8 948.5 967.1 970.0 970.3 1019.2 10212.7 10244.0 10264.1 10294.4 10307.8 3820.4 3916.7 4110.2 4111.6 4115.8 8851.5 8861.0 8862.1 8865.4 8886.0 4474.7 4478.3 4505.8 4506.1 4515.7 3315.5 3965.5 4116.7 4119.2 4119.6 3505.8 3553.2 3659.5 3674.8 3690.6 1169.2 1190.1 1190.2 1190.9 1199.6 658.9 664.8 701.0 804.3 831.5 4910.6 4960.3 4977.5 4982.7 5024.1 405.3 417.5 421.1 422.2 423.7 3596.5 3600.9 3805.8 3863.0 3891.4 9396.7 9447.5 9561.7 9566.6 9773.9 9473.1 9506.9 9524.1 9528.8 9542.5 7119.1 7252.3 7284.0 7288.5 7301.3 5367.9 5391.0 5443.5 5484.3 5548.6 8680.9 8877.2 8943.1 9013.1 9032.2 8512.7 8920.4 8922.6 8987.8 9187.1 5497.7 6593.5 6717.9 6719.9 6847.7 7511.9 7604.7 7617.5 7655.5 7669.5 6654.8 6670.5 6677.7 6848.0 7081.2 6644.5 6698.9 6734.0 6875.8 6951.9 6336.3 6344.7 6379.3 6411.4 6417.5 4529.4 4532.5 4558.7 4621.2 4691.2 4474.3 4551.7 4570.3 4626.4 4742.6 19:59:21 INFO - PROCESS | 9257 | 19:59:21 INFO - PROCESS | 9257 | [#4] prototype.html Cycles:180 Average:4236.53 Median:4617.91 stddev:1240.57 (26.9%) stddev-sans-first:1207.95 19:59:21 INFO - PROCESS | 9257 | Values: 278.3 288.9 290.9 296.0 297.7 4899.5 4953.9 5077.4 5106.6 5117.7 4960.5 5030.8 5030.9 5035.3 5042.8 3974.8 3977.4 3987.3 3989.4 3993.9 3860.6 3984.3 3989.2 3991.5 4004.4 3911.8 3942.9 3946.7 3982.1 3992.6 3929.5 3959.4 3964.1 3968.9 3995.0 3513.0 3516.3 3524.1 3551.8 3552.2 4874.9 4909.8 4948.0 4965.2 5038.2 4528.5 4538.9 4543.6 4545.6 4548.5 5308.6 5324.9 5330.4 5333.1 5336.0 3455.3 3642.7 3657.7 3855.7 3868.4 5504.2 5513.3 5527.8 5529.3 5532.6 3735.2 3747.4 3749.1 3749.1 3751.6 3593.4 3811.8 3831.9 3835.2 3839.8 4373.4 4383.3 4383.5 4392.1 4402.8 5282.6 5293.2 5303.8 5306.2 5313.3 1247.1 1258.4 1281.7 1302.2 1315.7 833.5 847.2 863.3 873.7 875.7 4599.7 4600.8 4607.4 4618.6 4644.6 5370.2 5399.2 5423.9 5426.5 5441.9 4521.6 4613.3 4617.2 4622.4 4632.2 2487.8 2503.9 2523.4 2543.5 2546.1 4480.8 4483.9 4521.3 4530.0 4543.4 4670.8 4809.3 4862.8 4865.5 4914.9 4364.3 4398.9 4427.4 4505.6 4518.8 4789.7 4815.2 4826.7 4830.8 4863.4 4688.3 4714.6 4756.6 4766.0 4772.1 4166.6 4430.7 4431.2 4461.4 4472.8 3351.5 3382.3 3385.2 3425.8 3446.5 4801.4 4809.7 4828.8 4837.7 5238.8 5179.7 5268.8 5287.3 5329.3 5331.0 5248.4 5265.6 5280.2 5289.7 5323.3 4902.9 5144.6 5148.8 5172.5 5190.5 5304.3 5308.8 5311.9 5317.8 5322.9 5188.2 5194.9 5222.3 5227.7 5230.8 19:59:21 INFO - PROCESS | 9257 | 19:59:21 INFO - PROCESS | 9257 | [#5] yui.html Cycles:180 Average:17722.08 Median:2460.98 stddev:24947.31 (1013.7%) stddev-sans-first:24984.44 19:59:21 INFO - PROCESS | 9257 | Values: 669.3 684.3 688.3 743.6 759.4 12304.4 13461.1 13507.3 13572.2 13615.7 13128.1 13265.5 13291.1 13295.7 13412.3 625.8 760.6 769.6 776.3 776.6 781.4 781.7 782.2 782.6 782.8 829.8 832.9 835.6 835.8 836.3 823.1 826.3 827.5 827.7 829.8 598.9 600.5 602.5 605.4 605.5 12413.6 12418.3 12448.1 12467.2 12483.8 13239.7 13303.7 13385.4 13511.1 13706.6 10782.0 10822.2 10857.1 11021.5 11035.4 3314.7 3332.6 3370.1 3374.5 3382.8 63802.4 63876.4 64669.7 65683.7 65692.3 10418.7 10460.1 10537.3 10565.0 10639.4 19832.2 19866.3 19891.6 20001.9 20415.2 6727.8 6761.0 6816.2 6863.8 6895.8 3553.8 3663.1 3741.8 3769.3 3852.4 2771.2 2868.6 2879.5 2884.6 2891.1 457.7 466.4 466.8 479.0 479.1 496.1 514.4 558.9 575.8 620.5 8238.8 8347.9 8648.6 8910.7 9063.9 604.5 610.3 610.8 621.7 624.4 4154.5 4185.6 4412.4 4441.4 4464.3 53083.7 78580.0 101361.0 105260.5 105628.0 83703.2 84019.2 85412.0 86403.0 86633.0 47012.8 77764.6 80458.6 80666.0 82036.0 8171.3 8432.7 8446.5 8473.1 8589.9 46575.0 47003.3 47009.8 47547.3 48581.8 47396.3 59034.4 60392.0 61951.0 63937.4 11197.7 11498.5 11526.7 11630.0 11792.4 12871.0 13232.5 13451.1 13671.2 14094.5 9355.9 10064.3 12816.8 13194.6 13495.9 10026.5 10046.5 10340.3 10422.7 12645.7 12287.9 12983.2 13067.0 13263.7 13389.9 10109.2 10189.7 10516.2 10548.4 10971.7 9951.4 10213.5 10895.5 11144.8 11150.8 19:59:21 INFO - PROCESS | 9257 | -------- Summary: end -------- 19:59:21 INFO - PROCESS | 9257 | 19:59:22 INFO - TEST-INFO | 9257: exit 0 19:59:22 INFO - TEST-OK | dromaeo_css | took 1117014ms 19:59:22 INFO - TEST-START | kraken 19:59:22 INFO - operating with platform_type : linux_ 19:59:22 INFO - Initialising browser for kraken test... 19:59:22 INFO - TEST-INFO | started process 9614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaLcdP9/profile http://localhost:60494/getInfo.html) 19:59:26 INFO - PROCESS | 9614 | __metrics Screen width/height:1600/1200 19:59:26 INFO - PROCESS | 9614 | colorDepth:24 19:59:26 INFO - PROCESS | 9614 | Browser inner width/height: 1024/697 19:59:26 INFO - PROCESS | 9614 | __metrics 19:59:27 ERROR - PROCESS | 9614 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 19:59:28 INFO - TEST-INFO | 9614: exit 0 19:59:28 INFO - Browser initialized. 19:59:28 INFO - Running cycle 1/1 for kraken test... 19:59:28 INFO - TEST-INFO | started process 9733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaLcdP9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:40 INFO - PROCESS | 9733 | RSS: Main: 163725312 19:59:40 INFO - PROCESS | 9733 | 19:59:43 INFO - PROCESS | 9733 | Cycle 1(1): loaded http://localhost:60494/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60494/tests/kraken/driver.html?testName=audio-beat-detection) 19:59:44 INFO - PROCESS | 9733 | RSS: Main: 169242624 19:59:44 INFO - PROCESS | 9733 | 19:59:46 INFO - PROCESS | 9733 | Cycle 1(1): loaded http://localhost:60494/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60494/tests/kraken/driver.html?testName=audio-dft) 19:59:47 INFO - PROCESS | 9733 | RSS: Main: 168374272 19:59:47 INFO - PROCESS | 9733 | 19:59:50 INFO - PROCESS | 9733 | Cycle 1(1): loaded http://localhost:60494/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60494/tests/kraken/driver.html?testName=audio-fft) 19:59:51 INFO - PROCESS | 9733 | RSS: Main: 164089856 19:59:51 INFO - PROCESS | 9733 | 19:59:53 INFO - PROCESS | 9733 | Cycle 1(1): loaded http://localhost:60494/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60494/tests/kraken/driver.html?testName=audio-oscillator) 19:59:53 INFO - PROCESS | 9733 | RSS: Main: 164769792 19:59:53 INFO - PROCESS | 9733 | 19:59:56 INFO - PROCESS | 9733 | Cycle 1(1): loaded http://localhost:60494/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60494/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:59:56 INFO - PROCESS | 9733 | RSS: Main: 165187584 19:59:56 INFO - PROCESS | 9733 | 19:59:59 INFO - PROCESS | 9733 | Cycle 1(1): loaded http://localhost:60494/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60494/tests/kraken/driver.html?testName=imaging-darkroom) 20:00:00 INFO - PROCESS | 9733 | RSS: Main: 165576704 20:00:00 INFO - PROCESS | 9733 | 20:00:04 INFO - PROCESS | 9733 | Cycle 1(1): loaded http://localhost:60494/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60494/tests/kraken/driver.html?testName=imaging-desaturate) 20:00:04 INFO - PROCESS | 9733 | RSS: Main: 162746368 20:00:04 INFO - PROCESS | 9733 | 20:00:07 INFO - PROCESS | 9733 | Cycle 1(1): loaded http://localhost:60494/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60494/tests/kraken/driver.html?testName=json-parse-financial) 20:00:08 INFO - PROCESS | 9733 | RSS: Main: 164814848 20:00:08 INFO - PROCESS | 9733 | 20:00:10 INFO - PROCESS | 9733 | Cycle 1(1): loaded http://localhost:60494/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60494/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:00:10 INFO - PROCESS | 9733 | RSS: Main: 164601856 20:00:10 INFO - PROCESS | 9733 | 20:00:12 INFO - PROCESS | 9733 | Cycle 1(1): loaded http://localhost:60494/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60494/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:00:13 INFO - PROCESS | 9733 | RSS: Main: 164597760 20:00:13 INFO - PROCESS | 9733 | 20:00:15 INFO - PROCESS | 9733 | Cycle 1(1): loaded http://localhost:60494/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60494/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:00:16 INFO - PROCESS | 9733 | RSS: Main: 165990400 20:00:16 INFO - PROCESS | 9733 | 20:00:19 INFO - PROCESS | 9733 | Cycle 1(1): loaded http://localhost:60494/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:00:19 INFO - PROCESS | 9733 | RSS: Main: 165810176 20:00:19 INFO - PROCESS | 9733 | 20:00:22 INFO - PROCESS | 9733 | Cycle 1(1): loaded http://localhost:60494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:00:23 INFO - PROCESS | 9733 | RSS: Main: 165949440 20:00:23 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | Cycle 1(1): loaded http://localhost:60494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60494/tests/kraken/driver.html?testName=ai-astar) 20:00:25 INFO - PROCESS | 9733 | RSS: Main: 166805504 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | __start_tp_report 20:00:25 INFO - PROCESS | 9733 | _x_x_mozilla_page_load 20:00:25 INFO - PROCESS | 9733 | _x_x_mozilla_page_load_details 20:00:25 INFO - PROCESS | 9733 | |i|pagename|runs| 20:00:25 INFO - PROCESS | 9733 | |0;ai-astar;104;116;109;117;117;115;115;115;115;114 20:00:25 INFO - PROCESS | 9733 | |1;audio-beat-detection;161;123;149;190;125;147;157;125;190;123 20:00:25 INFO - PROCESS | 9733 | |2;audio-dft;164;166;171;167;165;164;164;164;162;161 20:00:25 INFO - PROCESS | 9733 | |3;audio-fft;76;79;76;164;79;77;76;76;154;78 20:00:25 INFO - PROCESS | 9733 | |4;audio-oscillator;87;86;148;91;86;85;150;86;86;146 20:00:25 INFO - PROCESS | 9733 | |5;imaging-gaussian-blur;117;118;117;117;118;118;118;119;118;119 20:00:25 INFO - PROCESS | 9733 | |6;imaging-darkroom;147;148;148;148;152;150;148;150;148;148 20:00:25 INFO - PROCESS | 9733 | |7;imaging-desaturate;95;97;100;96;95;97;95;95;96;96 20:00:25 INFO - PROCESS | 9733 | |8;json-parse-financial;72;65;64;64;66;64;69;63;64;63 20:00:25 INFO - PROCESS | 9733 | |9;json-stringify-tinderbox;66;67;68;67;67;68;67;65;67;66 20:00:25 INFO - PROCESS | 9733 | |10;stanford-crypto-aes;83;80;86;83;96;80;81;81;85;83 20:00:25 INFO - PROCESS | 9733 | |11;stanford-crypto-ccm;140;142;132;133;142;134;137;141;163;141 20:00:25 INFO - PROCESS | 9733 | |12;stanford-crypto-pbkdf2;172;168;169;171;170;173;172;174;170;174 20:00:25 INFO - PROCESS | 9733 | |13;stanford-crypto-sha256-iterative;68;82;72;70;67;71;67;67;68;68 20:00:25 INFO - PROCESS | 9733 | __end_tp_report 20:00:25 INFO - PROCESS | 9733 | __start_cc_report 20:00:25 INFO - PROCESS | 9733 | _x_x_mozilla_cycle_collect,989 20:00:25 INFO - PROCESS | 9733 | __end_cc_report 20:00:25 INFO - PROCESS | 9733 | __startTimestamp1470970825324__endTimestamp 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | ------- Summary: start ------- 20:00:25 INFO - PROCESS | 9733 | Number of tests: 14 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:4.08 (3.6%) stddev-sans-first:2.39 20:00:25 INFO - PROCESS | 9733 | Values: 104.0 116.0 109.0 117.0 117.0 115.0 115.0 115.0 115.0 114.0 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:153.00 stddev:25.99 (17.0%) stddev-sans-first:27.20 20:00:25 INFO - PROCESS | 9733 | Values: 161.0 123.0 149.0 190.0 125.0 147.0 157.0 125.0 190.0 123.0 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:2.78 (1.7%) stddev-sans-first:2.93 20:00:25 INFO - PROCESS | 9733 | Values: 164.0 166.0 171.0 167.0 165.0 164.0 164.0 164.0 162.0 161.0 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.50 stddev:34.62 (45.3%) stddev-sans-first:36.14 20:00:25 INFO - PROCESS | 9733 | Values: 76.0 79.0 76.0 164.0 79.0 77.0 76.0 76.0 154.0 78.0 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:86.00 stddev:29.66 (34.5%) stddev-sans-first:30.73 20:00:25 INFO - PROCESS | 9733 | Values: 87.0 86.0 148.0 91.0 86.0 85.0 150.0 86.0 86.0 146.0 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 20:00:25 INFO - PROCESS | 9733 | Values: 117.0 118.0 117.0 117.0 118.0 118.0 118.0 119.0 118.0 119.0 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.00 stddev:1.49 (1.0%) stddev-sans-first:1.45 20:00:25 INFO - PROCESS | 9733 | Values: 147.0 148.0 148.0 148.0 152.0 150.0 148.0 150.0 148.0 148.0 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.55 (1.6%) stddev-sans-first:1.58 20:00:25 INFO - PROCESS | 9733 | Values: 95.0 97.0 100.0 96.0 95.0 97.0 95.0 95.0 96.0 96.0 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:64.50 stddev:2.91 (4.5%) stddev-sans-first:1.87 20:00:25 INFO - PROCESS | 9733 | Values: 72.0 65.0 64.0 64.0 66.0 64.0 69.0 63.0 64.0 63.0 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 20:00:25 INFO - PROCESS | 9733 | Values: 66.0 67.0 68.0 67.0 67.0 68.0 67.0 65.0 67.0 66.0 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.00 stddev:4.73 (5.7%) stddev-sans-first:5.01 20:00:25 INFO - PROCESS | 9733 | Values: 83.0 80.0 86.0 83.0 96.0 80.0 81.0 81.0 85.0 83.0 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:141.00 stddev:8.78 (6.2%) stddev-sans-first:9.32 20:00:25 INFO - PROCESS | 9733 | Values: 140.0 142.0 132.0 133.0 142.0 134.0 137.0 141.0 163.0 141.0 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:172.00 stddev:2.06 (1.2%) stddev-sans-first:2.17 20:00:25 INFO - PROCESS | 9733 | Values: 172.0 168.0 169.0 171.0 170.0 173.0 172.0 174.0 170.0 174.0 20:00:25 INFO - PROCESS | 9733 | 20:00:25 INFO - PROCESS | 9733 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:69.00 stddev:4.57 (6.6%) stddev-sans-first:4.79 20:00:25 INFO - PROCESS | 9733 | Values: 68.0 82.0 72.0 70.0 67.0 71.0 67.0 67.0 68.0 68.0 20:00:25 INFO - PROCESS | 9733 | -------- Summary: end -------- 20:00:25 INFO - PROCESS | 9733 | 20:00:26 INFO - TEST-INFO | 9733: exit 0 20:00:26 INFO - TEST-OK | kraken | took 63755ms 20:00:26 INFO - SUITE-END | took 1180s 20:00:26 INFO - Completed test suite (00:19:40) 20:00:26 INFO - javascript benchmark 20:00:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6375.817095518821, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2671.612616170655, 2673.8663066846652, 2693.8653067346627, 2707.404371038372, 2725.577535482001, 4747.026859493804, 4890.486498917611, 4928.531789480003, 4941.431735350436, 4976.67651602646, 4863.756812159396, 4864.586510146642, 4875.341828853104, 4927.433345165307, 4938.283948827418, 4476.171908196978, 4519.638428925695, 4534.478534968488, 4641.489436162036, 4680.555347242023, 4560.407147070892, 4602.631789456852, 4618.56123668251, 4630.2360110581885, 4651.581357677808, 4322.956770432287, 4426.623736982328, 4441.777911104464, 4566.474855391639, 4586.7477288749105, 4415.536368681274, 4418.094290670437, 4421.712588681726, 4543.5002149763495, 4557.612602928755, 4439.467263928317, 4455.264881294583, 4474.619657329131, 4491.169133710274, 4513.413256276663, 4814.807407703687, 4833.806647734086, 4855.101806165835, 4857.68425052374, 4880.877978050542, 5286.81496147633, 5287.920681189786, 5306.681599104066, 5309.867253318659, 5331.733413329357, 5319.281896943901, 5322.467753224647, 5328.49379308965, 5347.7058761768085, 5372.489613486751, 4631.999999999966, 4817.759112044384, 4841.757912104381, 4854.927176092361, 4887.560119589254, 5307.310049693515, 5316.388615309289, 5331.280277162534, 5331.5201631853315, 5341.732913354317, 5106.259592359162, 5117.641765076409, 5119.232115182753, 5131.307273518102, 5142.691438513626, 5036.244563315532, 5259.552938000313, 5290.31225940633, 5294.258803767476, 5361.276227709287, 5270.92093618596, 5275.630705850554, 5282.260483532308, 5282.471752824764, 5294.258803767476, 5236.869078273074, 5253.054450199001, 5255.264263003182, 5267.209918512254, 5307.336582927134, 4357.847475338348, 4478.9552104478535, 4511.842085526991, 4523.547645235516, 4574.885627859264, 3906.277338692351, 3920.9019774505864, 3927.136030073379, 3968.583298753647, 3972.463717398114, 4567.063751930847, 4589.196890544142, 4589.196890544142, 4601.24079526881, 4657.46439159501, 5099.5410413063, 5231.816886409034, 5244.816431424958, 5269.57843372537, 5355.866103347447, 4530.932036019462, 4547.431571053618, 4558.0428110097255, 4558.954410455919, 4605.8848528786375, 4754.096721622881, 4757.95242047582, 4765.475797662254, 4767.404074490689, 4801.303810947463, 4766.070616229802, 4845.830395936126, 4891.51084891508, 4905.730184839868, 4961.627877909099, 5224.320838290998, 5229.764660590206, 5251.52736253739, 5263.73681315925, 5279.815206467755, 4927.852164435073, 4927.965127323159, 4930.975345123252, 4943.728094954812, 4964.280179374043, 4976.303317535476, 5037.219231019198, 5045.31888195089, 5099.36257967754, 5121.743912804271, 5231.686098834082, 5303.655262407931, 5311.973440132774, 5356.5982551308025, 5361.276227709365, 5126.051680439131, 5130.97434512825, 5133.589312854888, 5153.123968925367, 5165.405978312542, 4852.272159176152, 5090.618203634816, 5092.134337162617, 5115.335006449138, 5131.25596788471, 5070.721110338966, 5076.18780995039, 5083.415407228216, 5091.490850914879, 5096.898062038665, 5133.589312854888, 5143.570289517806, 5145.151050076695, 5158.38099428071, 5188.118019936695, 4829.203181475017, 4931.778069986787, 4968.503149685002, 5034.471380504994, 5044.293798868235], "value": 4817.06084491179, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.1421575234757, 553.1122548309962, 561.7387914619701, 562.2802812400126, 576.8759716660917, 35655.0, 38929.0, 39056.0, 39094.0, 39282.214355712866, 39214.41178382326, 39622.40566391499, 39638.60361396385, 39906.201875962535, 39911.208435198685, 7549.735759248428, 7624.085109786805, 7684.193159718233, 7701.614919254043, 7717.536947783123, 7649.311561959423, 7713.460057795956, 7734.187910269425, 7747.573883436408, 7752.651130699132, 7692.7692169235015, 7710.730124445646, 7725.072991241059, 7773.96113019437, 7778.649960751752, 7728.961355193216, 7732.884006739903, 7751.961240193763, 7758.185390534026, 7783.961080194591, 7546.396288296923, 7565.470417070807, 7573.053368328959, 7592.924070759333, 7631.580263085528, 35492.46761298583, 35804.46293305603, 35835.104122396886, 35869.46195807065, 35888.64111358879, 2362.692849929498, 2818.661760588722, 3069.7083777041144, 3079.7536197104178, 3307.6196237432764, 27140.592891106648, 27347.453050939068, 27710.86144569264, 28097.578536321973, 28521.71478285232, 3180.9840950795096, 3257.1694217974264, 3278.278778668689, 3291.983540082308, 3328.1845947742718, 160143.0, 160223.198884006, 161078.0, 161114.0, 161123.0, 31805.363892722016, 54627.81035801592, 54755.0, 54867.45132548623, 55388.723056385264, 32500.187495312333, 33787.0, 33843.66156338405, 33938.830305848314, 34000.0, 13381.598552043455, 13486.662833429047, 13488.258145802076, 13526.053176277763, 13527.188368697909, 10938.0, 10954.616588419367, 11069.05912997388, 11071.335719856834, 11074.058705010004, 7630.38956883448, 7724.6523906424345, 7865.095514015847, 7920.405969552191, 7937.920620793833, 3070.9846450767604, 3097.4424603571124, 3097.581826453445, 3102.441560519083, 3106.5340198970334, 848.2069265237024, 942.5475771629656, 958.5542722633869, 961.3654987708079, 981.4503877828439, 27706.258198703974, 28463.715362846106, 28672.713272867422, 29038.709612904022, 29202.123936281947, 970.4662435660358, 982.3418309732497, 1008.4151192308443, 1032.850236715672, 1048.486241741541, 14597.12417254968, 15280.694386112216, 15429.459968901034, 15457.458988935334, 15468.303926323342, 405754.0, 408215.0, 412016.0, 413434.0, 413992.0, 48279.75860120677, 48542.75728621405, 48607.51392486101, 48879.51120488821, 48900.755496223006, 1126.8929451702074, 1181.1436708386352, 1193.1051711216587, 1195.0021731853826, 1206.6500714792787, 27039.45921081607, 27620.585691214244, 28235.71764282331, 28997.275068123465, 29033.419331613673, 42347.15305693931, 42398.788006059774, 42415.7879210602, 42676.359854601586, 42677.57322426736, 308389.0, 313032.0, 313343.0, 313781.0, 313934.0, 25236.873815630803, 25678.101266455586, 25827.870860645577, 25958.74041259563, 26122.608160877982, 41320.79339603283, 41786.1642767149, 41828.58171418247, 42152.78923605485, 43091.353629696205, 35912.64087359093, 35938.28123437464, 36067.81966090153, 36839.0, 36991.81504092462, 35996.0, 36011.27977440384, 36468.45297320595, 36494.27011459703, 36892.0, 35053.0, 35336.46995295021, 35583.46624800578, 36370.0, 36684.63315366919, 31524.52713209258, 33577.328453431284, 34053.48919766156, 34054.82972585121, 34108.82945585256, 25590.61614075753, 26138.86930565335, 26172.476550469266, 26342.341441464116, 26884.731152689004], "value": 16202.633424637603, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.13998533819387, 350.5390411608736, 354.61701362528464, 357.1838349371685, 372.45249483259613, 15997.84002159978, 17112.0, 17327.740083898752, 17483.213255403505, 17549.298028078894, 16428.507144785646, 17004.574885627866, 17376.131193440342, 17473.03898285594, 17605.11974401278, 5019.749012549376, 5302.840914772563, 5303.549198318128, 5308.5487733542695, 5312.150055991042, 3748.456473811296, 5180.456052114511, 6016.789412370568, 6277.340879207686, 6305.6216627002295, 6110.0, 6320.146780184685, 6337.809865704036, 6349.111124442558, 6376.330485299047, 6120.57155999078, 6220.937790622081, 6228.906566401508, 6250.874982500347, 6260.499160067184, 5254.894902101974, 5274.604404669665, 5399.2980912481125, 5439.156930675752, 5447.891042179174, 21093.15627374903, 21154.471138221666, 21184.470388240265, 21230.681539776917, 21234.362969110953, 2089.7910208979133, 2147.892605369725, 2208.812250958654, 2445.339758265276, 2497.8501289922665, 6583.967080164569, 13179.472821087145, 13801.86071158962, 14047.64880877976, 14322.427102915872, 1757.6045389787196, 1834.6972749496317, 1948.2596613287003, 1978.9703154452695, 2005.0776642744356, 69155.96266055963, 69477.30522694759, 69612.6519367405, 69623.30376696218, 70681.0, 9929.255305851946, 9949.701508954742, 10040.196784257241, 10193.0, 10254.6410875619, 13376.331183440789, 13385.464581416829, 13420.597382078553, 13422.328883555783, 13432.529861454803, 7115.5730656160795, 7317.597532135677, 7447.739329123455, 7635.580043097571, 7640.013596464959, 7006.4745144114395, 7051.682674279669, 7232.602206878567, 7319.487635865545, 7368.226336234726, 4102.241085399151, 4120.979395103005, 4192.727472714264, 4199.307114326163, 4303.827846886152, 1650.306871114135, 1692.297696455957, 1800.6848801459691, 1821.8733481862964, 1879.8026207248315, 786.9179877668206, 813.3737022492766, 855.7903313688062, 897.0491279244022, 949.8933742190271, 16669.416570419977, 16718.83281167197, 16884.662306753795, 17089.91455042717, 17177.398791042255, 809.9109097999216, 856.6316483911853, 859.4671303791564, 862.1766213266316, 871.4509858788922, 8500.0, 9476.241900647932, 9517.381370211053, 9540.427574345562, 9593.376430531993, 415549.0, 422179.0, 435321.0, 442682.0, 443354.0, 77219.61390193013, 78328.608356959, 78556.60721696354, 78618.21381786223, 80944.0, 931.5481991234246, 935.2751617496359, 943.9622415103319, 954.5847556312888, 958.9280803939732, 14779.556613301618, 15025.52078906968, 15062.472813451477, 15113.0, 15542.611434714223, 35485.82257088801, 35831.64168358283, 36187.0, 36627.633723662424, 37312.81343593264, 51828.74085629699, 53742.46257537375, 53945.20234548726, 54974.17538737002, 55127.173092404446, 7447.702091916262, 7635.656395462329, 7725.266099720518, 7791.104023037196, 8191.385646076687, 9429.764255893657, 12359.62921112368, 12382.0, 12804.551840685532, 12813.807792882928, 10200.948995254976, 10858.239923205616, 11025.779484410426, 11257.549698011988, 11373.0, 5557.916631250615, 6594.307597702172, 9292.860607091034, 10281.434521101412, 10862.34825910448, 10441.634542790965, 10811.13510919109, 10877.0, 10925.890741092488, 11137.387443690352, 6650.9667451662435, 6882.380585747307, 7049.894251586128, 7092.822679433056, 7219.566825990458, 7881.0, 10372.740681483023, 10798.892011079788, 10852.891471085188, 11126.888731112585], "value": 8410.721051311995, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.0201856681756, 1431.08410617205, 1512.8033355663763, 1663.3346661335472, 1713.8971661700307, 6441.130447389601, 7290.963545182273, 7446.515976461526, 7927.088384835738, 7947.2847443730125, 7495.625218739055, 7746.883796743054, 7749.225077492248, 7757.146713861471, 7765.301122898938, 2117.6929345244966, 2160.0, 2161.7513985891665, 2175.5866385386803, 2177.520945392011, 2121.946951326214, 2144.6997420361163, 2172.0877231562704, 2173.4892300309493, 2180.7819218078225, 2142.1110239250693, 2148.9570208595896, 2157.6979222908803, 2166.360923527563, 2193.6270833958265, 2087.3424871165535, 2114.2917122763815, 2114.2917122763893, 2118.0998075817715, 2124.415785658941, 2032.1566549881782, 2096.3920463065692, 2100.0444797617047, 2104.295061154515, 2108.9050992705365, 7753.185915478906, 7779.105402878685, 7780.105287891908, 7790.961045194795, 7791.181925897756, 4343.261645520269, 4512.0, 4523.592876641085, 4524.29873369625, 4553.089382123589, 2873.468408344463, 2876.7698584113223, 2916.9270768230754, 2918.3433727411375, 2960.7927445078853, 948.5399581203111, 967.1344146988476, 969.9854502182473, 970.2771435280761, 1019.1591936652218, 10212.693619191436, 10244.02681745233, 10264.076233139054, 10294.3823370598, 10307.84538231927, 3820.446035324918, 3916.6670832979516, 4110.17796440713, 4111.60939710727, 4115.773632450244, 8851.513166775889, 8861.0, 8862.069482704352, 8865.423747456394, 8886.022537520868, 4474.731516109044, 4478.305862591238, 4505.752183629932, 4506.098780243964, 4515.68390212682, 3315.535824984504, 3965.464662270614, 4116.732412393185, 4119.237940980928, 4119.588041195856, 3505.8422370993367, 3553.200529880756, 3659.451082337617, 3674.7873201843863, 3690.630936906288, 1169.1523645357217, 1190.1193117093462, 1190.2025642819333, 1190.9344986025678, 1199.6341115959717, 658.8733266114997, 664.8238216872533, 700.98007399234, 804.3243675312649, 831.5343407691712, 4910.631702622318, 4960.330355402047, 4977.477364876709, 4982.701037937735, 5024.070546948826, 405.3473907009712, 417.4864916153088, 421.0652351779046, 422.204145186326, 423.686472010716, 3596.478510615946, 3600.937723371612, 3805.809709514513, 3863.0, 3891.4357418174773, 9396.67111651089, 9447.480388578557, 9561.713148605553, 9566.56950437232, 9773.85339219898, 9473.147416732389, 9506.857397139049, 9524.095210954949, 9528.761780955392, 9542.52287385628, 7119.1457025157315, 7252.274772522811, 7283.963580182065, 7288.489805713549, 7301.342879141009, 5367.865803354947, 5391.0, 5443.482869127427, 5484.314460692413, 5548.611597188319, 8680.869786953326, 8877.24543413817, 8943.105689431004, 9013.098690130935, 9032.232260257952, 8512.74461766148, 8920.420172688755, 8922.55387230649, 8987.775305617412, 9187.08129187076, 5497.697626630574, 6593.472522198309, 6717.92513197886, 6719.865602687821, 6847.657617119224, 7511.887321690069, 7604.657790399335, 7617.5048621839405, 7655.46411751172, 7669.501482403626, 6654.83362915931, 6670.499712521678, 6677.732890684319, 6848.0, 7081.221065682667, 6644.501662375244, 6698.866022679616, 6733.966330168318, 6875.828104297432, 6951.860962780817, 6336.271328797063, 6344.68276586178, 6379.266384365672, 6411.358864113738, 6417.486601071996, 4529.433820772403, 4532.501424843331, 4558.726476411426, 4621.237495813153, 4691.1555919934735, 4474.328850672425, 4551.68138230334, 4570.337301091389, 4626.421697287839, 4742.596879265301], "value": 4013.5478735204883, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.31950880098157, 288.85845935491614, 290.86184062570277, 295.99657162220063, 297.74542765935126, 4899.496859745282, 4953.876153096175, 5077.365329333833, 5106.565941894934, 5117.667351622142, 4960.503949605038, 5030.84907452776, 5030.874228144298, 5035.269885866547, 5042.82350117746, 3974.7615143091507, 3977.4232736253225, 3987.262356464049, 3989.36170212766, 3993.9201215975663, 3860.613938606145, 3984.3425834737377, 3989.2021595680835, 3991.540972788123, 4004.359302511599, 3911.7532448068037, 3942.881713548584, 3946.6645335146545, 3982.084120652252, 3992.5608183099835, 3929.4851295171115, 3959.366501359769, 3964.147708242742, 3968.9085501487034, 3994.980025099856, 3512.9824350878084, 3516.2791627716256, 3524.1365865362895, 3551.751377403583, 3552.182997910495, 4874.878777881072, 4909.803607855682, 4947.975260123712, 4965.155923492979, 5038.168702164138, 4528.456585209763, 4538.8865278367975, 4543.636509079266, 4545.613622842063, 4548.499665036843, 5308.575313974873, 5324.866878328034, 5330.3742358581, 5333.066713325153, 5335.973320133375, 3455.3262113887804, 3642.7085833133287, 3657.6708096271464, 3855.6722678572355, 3868.3810590305416, 5504.174373843915, 5513.3108361454815, 5527.806526771584, 5529.30883639545, 5532.585056120807, 3735.159589092487, 3747.437884317374, 3749.1002159481527, 3749.1189570450924, 3751.6060813614176, 3593.3711600469815, 3811.790351530637, 3831.885043448701, 3835.1562656215588, 3839.827207775657, 4373.365861949999, 4383.320585309282, 4383.452068491439, 4392.099619577979, 4402.823887044482, 5282.577393808486, 5293.153095504701, 5303.761330740126, 5306.177542480922, 5313.309269794902, 1247.058470854499, 1258.4211262819206, 1281.6667666406802, 1302.1926405628572, 1315.7368526294779, 833.5040650812757, 847.1909326593212, 863.3481721300503, 873.6898401067657, 875.6689831456151, 4599.6771630326475, 4600.838970636011, 4607.424071991001, 4618.630509559227, 4644.558766917137, 5370.167624018283, 5399.217113518596, 5423.918641220384, 5426.538744206708, 5441.945580544223, 4521.59305662492, 4613.284940834176, 4617.191991401492, 4622.422197225347, 4632.2125238709505, 2487.751224877498, 2503.9374015649755, 2523.3565440812476, 2543.4658721668657, 2546.108861898321, 4480.798364073625, 4483.928508971365, 4521.299198624219, 4529.9547004530195, 4543.409356783597, 4670.8365207217585, 4809.302651115569, 4862.82980095695, 4865.513448655106, 4914.852554423373, 4364.297923809717, 4398.934015989763, 4427.40230068943, 4505.63954883615, 4518.819247230074, 4789.653069995747, 4815.218369203417, 4826.734529600905, 4830.7826147822725, 4863.367762190893, 4688.320193571844, 4714.646401519968, 4756.619470442425, 4766.0, 4772.117158325721, 4166.562535925101, 4430.734155950653, 4431.158079964796, 4461.442319710036, 4472.843450479218, 3351.463765797461, 3382.255903701182, 3385.1875549868346, 3425.845836937394, 3446.5174875516946, 4801.399825021872, 4809.663323567317, 4828.837111691848, 4837.733924634179, 5238.76425560843, 5179.741012949413, 5268.76290566933, 5287.339082614673, 5329.253904453457, 5331.0, 5248.422673505835, 5265.578293860713, 5280.20796880471, 5289.68261904287, 5323.281357016753, 4902.8774280643265, 5144.6398752087, 5148.819791307286, 5172.508611681884, 5190.532852043334, 5304.257403963526, 5308.787648494017, 5311.920321195263, 5317.787288508571, 5322.946770532245, 5188.22176673502, 5194.870128246824, 5222.294990176278, 5227.738613069408, 5230.790768369223], "value": 3836.8581258635295, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.2738378858937, 684.2678334182427, 688.3391943734015, 743.6281859070465, 759.4076620236216, 12304.38478076096, 13461.125026873271, 13507.324633768321, 13572.185668859864, 13615.659608509779, 13128.081034327577, 13265.535706250283, 13291.069625126245, 13295.734085318289, 13412.329383530834, 625.8278973282361, 760.5512747478972, 769.6421164158666, 776.2625505769513, 776.5767656627152, 781.3866115099648, 781.7303030454513, 782.2334112569686, 782.5774081995716, 782.81212508998, 829.8049958259804, 832.8875601793771, 835.6448509383488, 835.8119423129808, 836.2933321343455, 823.0534884882433, 826.3389288569151, 827.4910929778204, 827.6565225431439, 829.8298848736025, 598.8981873081586, 600.5075837812996, 602.5270162922129, 605.4187979539647, 605.5246631394378, 12413.627591172279, 12418.316992565406, 12448.128630995834, 12467.189632673848, 12483.812742808865, 13239.669008274774, 13303.733925321536, 13385.397657105355, 13511.121777084458, 13706.588802335946, 10782.0, 10822.188335874762, 10857.077148442313, 11021.504032318566, 11035.39305338206, 3314.7016768490953, 3332.6000879894327, 3370.1237678203597, 3374.5106959490736, 3382.7632065755406, 63802.3619763801, 63876.36123638751, 64669.67665161691, 65683.67158164227, 65692.34307656958, 10418.68743937683, 10460.064887995593, 10537.315074520131, 10565.0, 10639.361638301727, 19832.20671173166, 19866.304679336154, 19891.60216795656, 20001.899990500246, 20415.183392664127, 6727.831804204934, 6761.0, 6816.216135144522, 6863.764522386018, 6895.75864844728, 3553.8400771965325, 3663.06583334999, 3741.794201318899, 3769.264993326275, 3852.3643598805884, 2771.1547977866944, 2868.612737280482, 2879.5392737161956, 2884.567314902781, 2891.1471116020825, 457.6819110718019, 466.442601091699, 466.84827431085034, 478.9856304310876, 479.1471181297296, 496.11938808614275, 514.4495389932736, 558.9077802162598, 575.815738963536, 620.4725982914487, 8238.752837414768, 8347.916520834835, 8648.567571621394, 8910.688125915562, 9063.909360906306, 604.5224272824507, 610.3012051201438, 610.8442347201435, 621.6922623301494, 624.4036944717784, 4154.480689913761, 4185.560516145761, 4412.426384569985, 4441.444819397575, 4464.285714285698, 53083.73458132762, 78580.0, 101361.0, 105260.47369763102, 105628.0, 83703.16296836954, 84019.15980840236, 85412.0, 86403.0, 86633.0, 47012.7649361751, 77764.61117694376, 80458.5977070111, 80666.0, 82036.0, 8171.305439037511, 8432.747017589481, 8446.493210407396, 8473.067962523994, 8589.914100859161, 46575.0, 47003.294950576455, 47009.76495117503, 47547.28679069886, 48581.75709121432, 47396.289055664885, 59034.40965590461, 60392.0, 61951.0, 63937.36062639314, 11197.72005699864, 11498.54005839757, 11526.654200374001, 11630.0, 11792.41037948082, 12871.0, 13232.536861209812, 13451.058425910092, 13671.248081355223, 14094.50669226572, 9355.906440935503, 10064.345817521838, 12816.795801049737, 13194.604161875159, 13495.865041349462, 10026.498675066363, 10046.54790534413, 10340.327878687862, 10422.739431514272, 12645.683857903627, 12287.87712122903, 12983.221006739626, 13067.0, 13263.66840828987, 13389.866101339252, 10109.19126469866, 10189.694309170736, 10516.211284153565, 10548.419836909045, 10971.670849874517, 9951.402915825074, 10213.519039739345, 10895.509702063267, 11144.777104457704, 11150.776984460103], "value": 6644.515161313846, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 109.0, 117.0, 117.0, 115.0, 115.0, 115.0, 115.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 123.0, 149.0, 190.0, 125.0, 147.0, 157.0, 125.0, 190.0, 123.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 171.0, 167.0, 165.0, 164.0, 164.0, 164.0, 162.0, 161.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 164.0, 79.0, 77.0, 76.0, 76.0, 154.0, 78.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 148.0, 91.0, 86.0, 85.0, 150.0, 86.0, 86.0, 146.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 119.0, 118.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 152.0, 150.0, 148.0, 150.0, 148.0, 148.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 100.0, 96.0, 95.0, 97.0, 95.0, 95.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 65.0, 64.0, 64.0, 66.0, 64.0, 69.0, 63.0, 64.0, 63.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 65.0, 67.0, 66.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 86.0, 83.0, 96.0, 80.0, 81.0, 81.0, 85.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 132.0, 133.0, 142.0, 134.0, 137.0, 141.0, 163.0, 141.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 169.0, 171.0, 170.0, 173.0, 172.0, 174.0, 170.0, 174.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 82.0, 72.0, 70.0, 67.0, 71.0, 67.0, 67.0, 68.0, 68.0], "value": 70.0, "unit": "score"}]}]} 20:00:26 INFO - Return code: 0 20:00:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:00:26 ERROR - # TBPL SUCCESS # 20:00:26 INFO - Running post-action listener: _resource_record_post_action 20:00:26 INFO - [mozharness: 2016-08-12 03:00:26.647078Z] Finished run-tests step (success) 20:00:26 INFO - Running post-run listener: _resource_record_post_run 20:00:26 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407298048; Read time: 12; Write time: 268632 20:00:26 INFO - TinderboxPrint: CPU usage
13.4% 20:00:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:00:26 INFO - TinderboxPrint: I/O write bytes / time
407,298,048 / 268,632 20:00:26 INFO - TinderboxPrint: CPU idle
8,272.7 (86.6%) 20:00:26 INFO - TinderboxPrint: CPU user
1,223.9 (12.8%) 20:00:26 INFO - TinderboxPrint: Swap in / out
0 / 0 20:00:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124715008; Read time: 0; Write time: 77208 20:00:26 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 282583040; Read time: 0; Write time: 191424 20:00:27 INFO - Running post-run listener: _upload_blobber_files 20:00:27 INFO - Blob upload gear active. 20:00:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:00:27 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 20:00:27 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'] 20:00:27 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 20:00:27 INFO - (blobuploader) - INFO - Open directory for files ... 20:00:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:00:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:00:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:28 INFO - (blobuploader) - INFO - Done attempting. 20:00:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:00:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:00:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:32 INFO - (blobuploader) - INFO - Done attempting. 20:00:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:00:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:00:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:33 INFO - (blobuploader) - INFO - Done attempting. 20:00:33 INFO - (blobuploader) - INFO - Iteration through files over. 20:00:33 INFO - Return code: 0 20:00:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:00:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:00:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d7e13cf5b288bbd9287a37b27ae0b5939da8fc733d0c3c9ba6c7b96d88cdad84f6055ff205fa4fe6383dfb45c3ae10d736998f414b3c4dba558e8d651d314e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4cc4b188717663899d3aa77555f928a0eff2725f90928cd1caa12a071c68beb5247ba96d07c476750de392bda7da4a1fcdd95d39fc7ca2674d914078c4933d70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79f247b6e20f680805a6e9572dffb5626650c8cf0d4588de3f2c7acfcd68bca0fdd485d86cec1aa3c2e59226f5e83b2827882df0292a94ffffb71a422acd9116"} 20:00:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:00:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:00:33 INFO - Contents: 20:00:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d7e13cf5b288bbd9287a37b27ae0b5939da8fc733d0c3c9ba6c7b96d88cdad84f6055ff205fa4fe6383dfb45c3ae10d736998f414b3c4dba558e8d651d314e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4cc4b188717663899d3aa77555f928a0eff2725f90928cd1caa12a071c68beb5247ba96d07c476750de392bda7da4a1fcdd95d39fc7ca2674d914078c4933d70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79f247b6e20f680805a6e9572dffb5626650c8cf0d4588de3f2c7acfcd68bca0fdd485d86cec1aa3c2e59226f5e83b2827882df0292a94ffffb71a422acd9116"} 20:00:33 INFO - Running post-run listener: copy_logs_to_upload_dir 20:00:33 INFO - Copying logs to upload dir... 20:00:33 INFO - mkdir: /builds/slave/test/build/upload/logs 20:00:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.595355 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-11 20:00:32.410350) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 20:00:32.413593) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478 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/1d7e13cf5b288bbd9287a37b27ae0b5939da8fc733d0c3c9ba6c7b96d88cdad84f6055ff205fa4fe6383dfb45c3ae10d736998f414b3c4dba558e8d651d314e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4cc4b188717663899d3aa77555f928a0eff2725f90928cd1caa12a071c68beb5247ba96d07c476750de392bda7da4a1fcdd95d39fc7ca2674d914078c4933d70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79f247b6e20f680805a6e9572dffb5626650c8cf0d4588de3f2c7acfcd68bca0fdd485d86cec1aa3c2e59226f5e83b2827882df0292a94ffffb71a422acd9116"} build_url:https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/M6VgNI3VQTaKQwJS8uQtRQ/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/1d7e13cf5b288bbd9287a37b27ae0b5939da8fc733d0c3c9ba6c7b96d88cdad84f6055ff205fa4fe6383dfb45c3ae10d736998f414b3c4dba558e8d651d314e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4cc4b188717663899d3aa77555f928a0eff2725f90928cd1caa12a071c68beb5247ba96d07c476750de392bda7da4a1fcdd95d39fc7ca2674d914078c4933d70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/79f247b6e20f680805a6e9572dffb5626650c8cf0d4588de3f2c7acfcd68bca0fdd485d86cec1aa3c2e59226f5e83b2827882df0292a94ffffb71a422acd9116"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 20:00:32.442128) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 20:00:32.442472) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470969405.627532-1934856478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 20:00:32.525006) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 20:00:32.525338) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 20:00:32.525637) ========= ========= Total master_lag: 0.17 =========