builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1470939701.71 results: success (0) buildid: 20160811105621 builduid: 6b3feb3dd5674e0685c72a926a2337ab revision: 61fbf96a2cfa3ce59c48d2fc59d17a3a1fc1372d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 11:21:41.711966) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 11:21:41.712530) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 11:21:41.712811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 11:21:41.727439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:21:41.727791) ========= 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=a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 11:21:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-08-11 11:21:42 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086145 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:21:41.827993) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:21:41.828313) ========= 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=a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017005 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:21:41.878262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 11:21:41.878622) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 61fbf96a2cfa3ce59c48d2fc59d17a3a1fc1372d --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 61fbf96a2cfa3ce59c48d2fc59d17a3a1fc1372d --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=a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 11:21:42,434 truncating revision to first 12 chars 2016-08-11 11:21:42,434 Setting DEBUG logging. 2016-08-11 11:21:42,434 attempt 1/10 2016-08-11 11:21:42,434 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/61fbf96a2cfa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 11:21:43,784 unpacking tar archive at: autoland-61fbf96a2cfa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.662548 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 11:21:43.555418) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 11:21:43.555740) ========= script_repo_revision: 61fbf96a2cfa3ce59c48d2fc59d17a3a1fc1372d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 11:21:43.556121) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 11:21:43.556400) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 11:21:43.567246) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-11 11:21:43.567614) ========= /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=a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:21:44 INFO - MultiFileLogger online at 20160811 11:21:44 in /builds/slave/test 11:21:44 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 11:21:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:21:44 INFO - {'append_to_log': False, 11:21:44 INFO - 'base_work_dir': '/builds/slave/test', 11:21:44 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 11:21:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:21:44 INFO - 'branch': 'Autoland-Non-PGO', 11:21:44 INFO - 'buildbot_json_path': 'buildprops.json', 11:21:44 INFO - 'config_files': ('talos/linux_config.py',), 11:21:44 INFO - 'default_actions': ('clobber', 11:21:44 INFO - 'read-buildbot-config', 11:21:44 INFO - 'download-and-extract', 11:21:44 INFO - 'populate-webroot', 11:21:44 INFO - 'create-virtualenv', 11:21:44 INFO - 'install', 11:21:44 INFO - 'run-tests'), 11:21:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:21:44 INFO - 'download_minidump_stackwalk': True, 11:21:44 INFO - 'download_symbols': 'ondemand', 11:21:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:21:44 INFO - 'tooltool.py': '/tools/tooltool.py', 11:21:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:21:44 INFO - '/tools/misc-python/virtualenv.py')}, 11:21:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:21:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:21:44 INFO - 'installer_path': 'installer.exe', 11:21:44 INFO - 'log_level': 'info', 11:21:44 INFO - 'log_name': 'talos', 11:21:44 INFO - 'log_to_console': True, 11:21:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:21:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:21:44 INFO - 'opt_config_files': (), 11:21:44 INFO - 'pip_index': False, 11:21:44 INFO - 'sps_profile': False, 11:21:44 INFO - 'sps_profile_interval': 0, 11:21:44 INFO - 'suite': 'dromaeojs-e10s', 11:21:44 INFO - 'system_bits': '32', 11:21:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:21:44 INFO - 'title': 'talos-linux64-ix-002', 11:21:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:21:44 INFO - 'use_talos_json': True, 11:21:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:21:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:21:44 INFO - 'work_dir': 'build'} 11:21:44 INFO - [mozharness: 2016-08-11 18:21:44.223211Z] Running clobber step. 11:21:44 INFO - Running pre-action listener: _resource_record_pre_action 11:21:44 INFO - Running main action method: clobber 11:21:44 INFO - rmtree: /builds/slave/test/build 11:21:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:21:45 INFO - Running post-action listener: _resource_record_post_action 11:21:45 INFO - [mozharness: 2016-08-11 18:21:45.205791Z] Finished clobber step (success) 11:21:45 INFO - [mozharness: 2016-08-11 18:21:45.205891Z] Running read-buildbot-config step. 11:21:45 INFO - Running pre-action listener: _resource_record_pre_action 11:21:45 INFO - Running main action method: read_buildbot_config 11:21:45 INFO - Using buildbot properties: 11:21:45 INFO - { 11:21:45 INFO - "project": "", 11:21:45 INFO - "product": "firefox", 11:21:45 INFO - "script_repo_revision": "production", 11:21:45 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 11:21:45 INFO - "repository": "", 11:21:45 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 11:21:45 INFO - "buildid": "20160811105621", 11:21:45 INFO - "pgo_build": "False", 11:21:45 INFO - "basedir": "/builds/slave/test", 11:21:45 INFO - "buildnumber": 302, 11:21:45 INFO - "slavename": "talos-linux64-ix-002", 11:21:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:21:45 INFO - "platform": "ubuntu64_hw", 11:21:45 INFO - "scheduler": "tests-autoland-linux64-talos", 11:21:45 INFO - "branch": "autoland", 11:21:45 INFO - "repo_path": "integration/autoland", 11:21:45 INFO - "revision": "61fbf96a2cfa3ce59c48d2fc59d17a3a1fc1372d", 11:21:45 INFO - "stage_platform": "linux64", 11:21:45 INFO - "builduid": "6b3feb3dd5674e0685c72a926a2337ab", 11:21:45 INFO - "slavebuilddir": "test" 11:21:45 INFO - } 11:21:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:21:45 INFO - Running post-action listener: _resource_record_post_action 11:21:45 INFO - [mozharness: 2016-08-11 18:21:45.208285Z] Finished read-buildbot-config step (success) 11:21:45 INFO - [mozharness: 2016-08-11 18:21:45.208373Z] Running download-and-extract step. 11:21:45 INFO - Running pre-action listener: _resource_record_pre_action 11:21:45 INFO - Running main action method: download_and_extract 11:21:45 INFO - mkdir: /builds/slave/test/build/tests 11:21: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')]} 11:21:45 INFO - trying https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:21:45 INFO - Downloading https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/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 11:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/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 11:21:45 INFO - Downloaded 1361 bytes. 11:21:45 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:21:45 INFO - Using the following test package requirements: 11:21:45 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:21:45 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:21:45 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:21:45 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:45 INFO - u'jsshell-linux-x86_64.zip'], 11:21:45 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:21:45 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:21:45 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:21:45 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:21:45 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:21:45 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:21:45 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:21:45 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:21: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')]} 11:21:45 INFO - trying https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:21:45 INFO - Downloading https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/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 11:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/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 11:21:46 INFO - Downloaded 20262767 bytes. 11:21:46 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 11:21:50 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 11:21:50 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')]} 11:21:50 INFO - trying https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:21:50 INFO - Downloading https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/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 11:21:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/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 11:21:51 INFO - Downloaded 20262767 bytes. 11:21:51 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 11:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:56 INFO - trying https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:21:56 INFO - Downloading https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/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 11:21:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/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 11:21:57 INFO - Downloaded 14413719 bytes. 11:21:57 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 11:21:57 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')]} 11:21:57 INFO - trying https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:21:57 INFO - Downloading https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/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 11:21:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/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 11:21:58 INFO - Downloaded 55627306 bytes. 11:21:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:21:58 INFO - mkdir: /builds/slave/test/properties 11:21:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:21:58 INFO - Writing to file /builds/slave/test/properties/build_url 11:21:58 INFO - Contents: 11:21:58 INFO - build_url:https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:21:59 INFO - Running post-action listener: _resource_record_post_action 11:21:59 INFO - Running post-action listener: set_extra_try_arguments 11:21:59 INFO - [mozharness: 2016-08-11 18:21:59.529304Z] Finished download-and-extract step (success) 11:21:59 INFO - [mozharness: 2016-08-11 18:21:59.529530Z] Running populate-webroot step. 11:21:59 INFO - Running pre-action listener: _resource_record_pre_action 11:21:59 INFO - Running main action method: populate_webroot 11:21:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:21:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:21:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:21:59 INFO - '--tppagecycles', 11:21:59 INFO - '7'], 11:21:59 INFO - 'tests': ['tsvgm']}}, 11:21:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:21:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:21:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:21:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:21:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:21:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:21:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:59 INFO - 'talos_options': ['--disable-e10s'], 11:21:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:21:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:21:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:59 INFO - 'talos_options': ['--disable-e10s'], 11:21:59 INFO - 'tests': ['damp', 'tps']}, 11:21:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:59 INFO - 'tests': ['damp', 'tps']}, 11:21:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:21:59 INFO - 'tests': ['dromaeo_dom']}, 11:21:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:21:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:21:59 INFO - 'tests': ['basic_compositor_video']}, 11:21:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:21:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:21:59 INFO - 'tests': ['a11yr', 11:21:59 INFO - 'ts_paint', 11:21:59 INFO - 'tpaint', 11:21:59 INFO - 'sessionrestore', 11:21:59 INFO - 'sessionrestore_no_auto_restore', 11:21:59 INFO - 'tabpaint']}, 11:21:59 INFO - 'other-e10s': {'tests': ['a11yr', 11:21:59 INFO - 'ts_paint', 11:21:59 INFO - 'tpaint', 11:21:59 INFO - 'sessionrestore', 11:21:59 INFO - 'sessionrestore_no_auto_restore', 11:21:59 INFO - 'tabpaint']}, 11:21:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:21:59 INFO - 'ts_paint', 11:21:59 INFO - 'tpaint', 11:21:59 INFO - 'sessionrestore', 11:21:59 INFO - 'sessionrestore_no_auto_restore', 11:21:59 INFO - 'tabpaint']}, 11:21:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:21:59 INFO - 'ts_paint', 11:21:59 INFO - 'tpaint', 11:21:59 INFO - 'sessionrestore', 11:21:59 INFO - 'sessionrestore_no_auto_restore', 11:21:59 INFO - 'tabpaint']}, 11:21:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:21:59 INFO - 'tests': ['a11yr', 11:21:59 INFO - 'ts_paint', 11:21:59 INFO - 'tpaint', 11:21:59 INFO - 'sessionrestore', 11:21:59 INFO - 'sessionrestore_no_auto_restore', 11:21:59 INFO - 'tabpaint']}, 11:21:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:21:59 INFO - 'tests': ['a11yr', 11:21:59 INFO - 'ts_paint', 11:21:59 INFO - 'tpaint', 11:21:59 INFO - 'sessionrestore', 11:21:59 INFO - 'sessionrestore_no_auto_restore', 11:21:59 INFO - 'tabpaint']}, 11:21:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:21:59 INFO - 'tests': ['tsvgx', 11:21:59 INFO - 'tsvgr_opacity', 11:21:59 INFO - 'tart', 11:21:59 INFO - 'tscrollx', 11:21:59 INFO - 'cart']}, 11:21:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:21:59 INFO - 'tsvgr_opacity', 11:21:59 INFO - 'tart', 11:21:59 INFO - 'tscrollx', 11:21:59 INFO - 'cart']}, 11:21:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:59 INFO - 'talos_options': ['--disable-e10s'], 11:21:59 INFO - 'tests': ['tp5o']}, 11:21:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:59 INFO - 'tests': ['tp5o']}, 11:21:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:59 INFO - 'talos_options': ['--disable-e10s', 11:21:59 INFO - '--xperf_path', 11:21:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:21:59 INFO - 'tests': ['tp5n']}, 11:21:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:59 INFO - 'talos_options': ['--xperf_path', 11:21:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:21:59 INFO - 'tests': ['tp5n']}}, 11:21:59 INFO - 'talos.zip': {'path': '', 11:21:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:21:59 INFO - Running post-action listener: _resource_record_post_action 11:21:59 INFO - [mozharness: 2016-08-11 18:21:59.544897Z] Finished populate-webroot step (success) 11:21:59 INFO - [mozharness: 2016-08-11 18:21:59.544986Z] Running create-virtualenv step. 11:21:59 INFO - Running pre-action listener: _resource_record_pre_action 11:21:59 INFO - Running main action method: create_virtualenv 11:21:59 INFO - Creating virtualenv /builds/slave/test/build/venv 11:21:59 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 11:21:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:21:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:21:59 INFO - Using real prefix '/usr' 11:21:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:22:00 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:02 INFO - Installing pip.................done. 11:22:02 INFO - Return code: 0 11:22:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:22:02 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')]} 11:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:02 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')]} 11:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:02 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 0x7feafd7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', '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 11:22:02 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 11:22:02 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 11:22:02 INFO - Using env: {'DISPLAY': ':0', 11:22:02 INFO - 'HOME': '/home/cltbld', 11:22:02 INFO - 'LANG': 'en_US.UTF-8', 11:22:02 INFO - 'LANGUAGE': 'en_US:en', 11:22:02 INFO - 'LOGNAME': 'cltbld', 11:22:02 INFO - 'MAIL': '/var/mail/cltbld', 11:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:02 INFO - 'MOZ_NO_REMOTE': '1', 11:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:02 INFO - 'NO_EM_RESTART': '1', 11:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:02 INFO - 'PWD': '/builds/slave/test', 11:22:02 INFO - 'SHELL': '/bin/bash', 11:22:02 INFO - 'SHLVL': '1', 11:22:02 INFO - 'TERM': 'linux', 11:22:02 INFO - 'TMOUT': '86400', 11:22:02 INFO - 'USER': 'cltbld', 11:22:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', 11:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:02 INFO - '_': '/tools/buildbot/bin/python'} 11:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:02 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 11:22:02 INFO - Cleaning up... 11:22:02 INFO - Return code: 0 11:22:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:22:02 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')]} 11:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:02 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')]} 11:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:02 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 0x7feafd7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', '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 11:22:02 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 11:22:02 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 11:22:02 INFO - Using env: {'DISPLAY': ':0', 11:22:02 INFO - 'HOME': '/home/cltbld', 11:22:02 INFO - 'LANG': 'en_US.UTF-8', 11:22:02 INFO - 'LANGUAGE': 'en_US:en', 11:22:02 INFO - 'LOGNAME': 'cltbld', 11:22:02 INFO - 'MAIL': '/var/mail/cltbld', 11:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:02 INFO - 'MOZ_NO_REMOTE': '1', 11:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:02 INFO - 'NO_EM_RESTART': '1', 11:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:02 INFO - 'PWD': '/builds/slave/test', 11:22:02 INFO - 'SHELL': '/bin/bash', 11:22:02 INFO - 'SHLVL': '1', 11:22:02 INFO - 'TERM': 'linux', 11:22:02 INFO - 'TMOUT': '86400', 11:22:02 INFO - 'USER': 'cltbld', 11:22:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', 11:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:02 INFO - '_': '/tools/buildbot/bin/python'} 11:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:02 INFO - Downloading/unpacking psutil>=3.1.1 11:22:02 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 11:22:02 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 11:22:02 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 11:22:02 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 11:22:02 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 11:22:02 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 11:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:04 INFO - Installing collected packages: psutil 11:22:04 INFO - Running setup.py install for psutil 11:22:04 INFO - building 'psutil._psutil_linux' extension 11:22:04 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 11:22:04 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 11:22:04 INFO - building 'psutil._psutil_posix' extension 11:22:04 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 11:22:04 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 11:22:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:05 INFO - Successfully installed psutil 11:22:05 INFO - Cleaning up... 11:22:05 INFO - Return code: 0 11:22:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:05 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 0x7feafd7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', '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 11:22:05 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 11:22:05 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 11:22:05 INFO - Using env: {'DISPLAY': ':0', 11:22:05 INFO - 'HOME': '/home/cltbld', 11:22:05 INFO - 'LANG': 'en_US.UTF-8', 11:22:05 INFO - 'LANGUAGE': 'en_US:en', 11:22:05 INFO - 'LOGNAME': 'cltbld', 11:22:05 INFO - 'MAIL': '/var/mail/cltbld', 11:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:05 INFO - 'MOZ_NO_REMOTE': '1', 11:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:05 INFO - 'NO_EM_RESTART': '1', 11:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:05 INFO - 'PWD': '/builds/slave/test', 11:22:05 INFO - 'SHELL': '/bin/bash', 11:22:05 INFO - 'SHLVL': '1', 11:22:05 INFO - 'TERM': 'linux', 11:22:05 INFO - 'TMOUT': '86400', 11:22:05 INFO - 'USER': 'cltbld', 11:22:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', 11:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:05 INFO - '_': '/tools/buildbot/bin/python'} 11:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:22:05 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 11:22:05 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 11:22:05 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 11:22:05 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 11:22:05 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 11:22:05 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 11:22:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:22:07 INFO - Installing collected packages: mozsystemmonitor 11:22:07 INFO - Running setup.py install for mozsystemmonitor 11:22:07 INFO - Successfully installed mozsystemmonitor 11:22:07 INFO - Cleaning up... 11:22:07 INFO - Return code: 0 11:22:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:22:07 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')]} 11:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:07 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')]} 11:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:07 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 0x7feafd7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', '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 11:22:07 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 11:22:07 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 11:22:07 INFO - Using env: {'DISPLAY': ':0', 11:22:07 INFO - 'HOME': '/home/cltbld', 11:22:07 INFO - 'LANG': 'en_US.UTF-8', 11:22:07 INFO - 'LANGUAGE': 'en_US:en', 11:22:07 INFO - 'LOGNAME': 'cltbld', 11:22:07 INFO - 'MAIL': '/var/mail/cltbld', 11:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:07 INFO - 'MOZ_NO_REMOTE': '1', 11:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:07 INFO - 'NO_EM_RESTART': '1', 11:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:07 INFO - 'PWD': '/builds/slave/test', 11:22:07 INFO - 'SHELL': '/bin/bash', 11:22:07 INFO - 'SHLVL': '1', 11:22:07 INFO - 'TERM': 'linux', 11:22:07 INFO - 'TMOUT': '86400', 11:22:07 INFO - 'USER': 'cltbld', 11:22:07 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', 11:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:07 INFO - '_': '/tools/buildbot/bin/python'} 11:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:07 INFO - Downloading/unpacking jsonschema==2.5.1 11:22:07 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 11:22:07 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 11:22:07 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 11:22:07 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 11:22:07 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 11:22:07 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 11:22:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:09 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:09 INFO - warning: no files found matching '*.txt' 11:22:09 INFO - no previously-included directories found matching 'build' 11:22:09 INFO - no previously-included directories found matching 'dist' 11:22:09 INFO - no previously-included directories found matching '.git*' 11:22:09 INFO - Installing collected packages: jsonschema, functools32 11:22:09 INFO - Running setup.py install for functools32 11:22:09 INFO - warning: no files found matching '*.txt' 11:22:09 INFO - no previously-included directories found matching 'build' 11:22:09 INFO - no previously-included directories found matching 'dist' 11:22:09 INFO - no previously-included directories found matching '.git*' 11:22:09 INFO - Successfully installed jsonschema functools32 11:22:09 INFO - Cleaning up... 11:22:09 INFO - Return code: 0 11:22:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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', '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 0x7feafd7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', '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 11:22: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:22: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 functools32==3.2.3-2 11:22:09 INFO - Using env: {'DISPLAY': ':0', 11:22:09 INFO - 'HOME': '/home/cltbld', 11:22:09 INFO - 'LANG': 'en_US.UTF-8', 11:22:09 INFO - 'LANGUAGE': 'en_US:en', 11:22:09 INFO - 'LOGNAME': 'cltbld', 11:22:09 INFO - 'MAIL': '/var/mail/cltbld', 11:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:09 INFO - 'MOZ_NO_REMOTE': '1', 11:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:09 INFO - 'NO_EM_RESTART': '1', 11:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:09 INFO - 'PWD': '/builds/slave/test', 11:22:09 INFO - 'SHELL': '/bin/bash', 11:22:09 INFO - 'SHLVL': '1', 11:22:09 INFO - 'TERM': 'linux', 11:22:09 INFO - 'TMOUT': '86400', 11:22:09 INFO - 'USER': 'cltbld', 11:22:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', 11:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:09 INFO - '_': '/tools/buildbot/bin/python'} 11:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:22:10 INFO - Cleaning up... 11:22:10 INFO - Return code: 0 11:22:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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', '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 0x7feafd7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', '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 11:22: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:22: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 blobuploader==1.2.4 11:22:10 INFO - Using env: {'DISPLAY': ':0', 11:22:10 INFO - 'HOME': '/home/cltbld', 11:22:10 INFO - 'LANG': 'en_US.UTF-8', 11:22:10 INFO - 'LANGUAGE': 'en_US:en', 11:22:10 INFO - 'LOGNAME': 'cltbld', 11:22:10 INFO - 'MAIL': '/var/mail/cltbld', 11:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:10 INFO - 'MOZ_NO_REMOTE': '1', 11:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:10 INFO - 'NO_EM_RESTART': '1', 11:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:10 INFO - 'PWD': '/builds/slave/test', 11:22:10 INFO - 'SHELL': '/bin/bash', 11:22:10 INFO - 'SHLVL': '1', 11:22:10 INFO - 'TERM': 'linux', 11:22:10 INFO - 'TMOUT': '86400', 11:22:10 INFO - 'USER': 'cltbld', 11:22:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', 11:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:10 INFO - '_': '/tools/buildbot/bin/python'} 11:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:10 INFO - Downloading/unpacking blobuploader==1.2.4 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22:12 INFO - Downloading blobuploader-1.2.4.tar.gz 11:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:22:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:12 INFO - Downloading docopt-0.6.1.tar.gz 11:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:12 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:13 INFO - Running setup.py install for blobuploader 11:22:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:22:13 INFO - Running setup.py install for requests 11:22:13 INFO - Running setup.py install for docopt 11:22:13 INFO - Successfully installed blobuploader requests docopt 11:22:13 INFO - Cleaning up... 11:22:13 INFO - Return code: 0 11:22:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:13 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 0x7feafd7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', '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 11:22:13 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 11:22:13 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 11:22:13 INFO - Using env: {'DISPLAY': ':0', 11:22:13 INFO - 'HOME': '/home/cltbld', 11:22:13 INFO - 'LANG': 'en_US.UTF-8', 11:22:13 INFO - 'LANGUAGE': 'en_US:en', 11:22:13 INFO - 'LOGNAME': 'cltbld', 11:22:13 INFO - 'MAIL': '/var/mail/cltbld', 11:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:13 INFO - 'MOZ_NO_REMOTE': '1', 11:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:13 INFO - 'NO_EM_RESTART': '1', 11:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:13 INFO - 'PWD': '/builds/slave/test', 11:22:13 INFO - 'SHELL': '/bin/bash', 11:22:13 INFO - 'SHLVL': '1', 11:22:13 INFO - 'TERM': 'linux', 11:22:13 INFO - 'TMOUT': '86400', 11:22:13 INFO - 'USER': 'cltbld', 11:22:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', 11:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:13 INFO - '_': '/tools/buildbot/bin/python'} 11:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:13 INFO - Running setup.py (path:/tmp/pip-sYpVfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:13 INFO - Running setup.py (path:/tmp/pip-adWGyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:13 INFO - Running setup.py (path:/tmp/pip-KMLZKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:14 INFO - Running setup.py (path:/tmp/pip-cUYhPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:14 INFO - Running setup.py (path:/tmp/pip-CvOUaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:14 INFO - Running setup.py (path:/tmp/pip-hvEIcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:14 INFO - Running setup.py (path:/tmp/pip-w3on1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:14 INFO - Running setup.py (path:/tmp/pip-XFlF4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:14 INFO - Running setup.py (path:/tmp/pip-Lh1YIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:14 INFO - Running setup.py (path:/tmp/pip-7UsHUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:14 INFO - Running setup.py (path:/tmp/pip-E2Si3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:14 INFO - Running setup.py (path:/tmp/pip-ASqYFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:14 INFO - Running setup.py (path:/tmp/pip-i5c3ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:14 INFO - Running setup.py (path:/tmp/pip-PUw1Aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:14 INFO - Running setup.py (path:/tmp/pip-Knupeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:14 INFO - Running setup.py (path:/tmp/pip-TP3n2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:14 INFO - Running setup.py (path:/tmp/pip-BnnsRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:22:15 INFO - Running setup.py install for manifestparser 11:22:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:22:15 INFO - Running setup.py install for mozcrash 11:22:15 INFO - Running setup.py install for mozdebug 11:22:15 INFO - Running setup.py install for mozdevice 11:22:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:22:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:22:15 INFO - Running setup.py install for mozfile 11:22:15 INFO - Running setup.py install for mozhttpd 11:22:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:22:15 INFO - Running setup.py install for mozinfo 11:22:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:22:15 INFO - Running setup.py install for mozInstall 11:22:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:22:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:22:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:22:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:22:15 INFO - Running setup.py install for mozleak 11:22:15 INFO - Running setup.py install for mozlog 11:22:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Running setup.py install for moznetwork 11:22:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Running setup.py install for mozprocess 11:22:16 INFO - Running setup.py install for mozprofile 11:22:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Running setup.py install for mozrunner 11:22:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Running setup.py install for mozscreenshot 11:22:16 INFO - Running setup.py install for moztest 11:22:16 INFO - Running setup.py install for mozversion 11:22:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:22:16 INFO - Cleaning up... 11:22:16 INFO - Return code: 0 11:22:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:16 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 0x7feafd7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', '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 11:22:16 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 11:22:16 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 11:22:16 INFO - Using env: {'DISPLAY': ':0', 11:22:16 INFO - 'HOME': '/home/cltbld', 11:22:16 INFO - 'LANG': 'en_US.UTF-8', 11:22:16 INFO - 'LANGUAGE': 'en_US:en', 11:22:16 INFO - 'LOGNAME': 'cltbld', 11:22:16 INFO - 'MAIL': '/var/mail/cltbld', 11:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:16 INFO - 'MOZ_NO_REMOTE': '1', 11:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:16 INFO - 'NO_EM_RESTART': '1', 11:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:16 INFO - 'PWD': '/builds/slave/test', 11:22:16 INFO - 'SHELL': '/bin/bash', 11:22:16 INFO - 'SHLVL': '1', 11:22:16 INFO - 'TERM': 'linux', 11:22:16 INFO - 'TMOUT': '86400', 11:22:16 INFO - 'USER': 'cltbld', 11:22:16 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', 11:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:16 INFO - '_': '/tools/buildbot/bin/python'} 11:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:17 INFO - Running setup.py (path:/tmp/pip-9j3H6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:17 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)) 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:17 INFO - Running setup.py (path:/tmp/pip-Sl5rjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:17 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)) 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:17 INFO - Running setup.py (path:/tmp/pip-q7C1Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:17 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)) 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:17 INFO - Running setup.py (path:/tmp/pip-hp4VUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:17 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)) 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:17 INFO - Running setup.py (path:/tmp/pip-4F9MSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:17 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)) 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:17 INFO - Running setup.py (path:/tmp/pip-c7ykOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:17 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)) 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:17 INFO - Running setup.py (path:/tmp/pip-r4vRTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:17 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)) 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:17 INFO - Running setup.py (path:/tmp/pip-6gPUol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:17 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)) 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:17 INFO - Running setup.py (path:/tmp/pip-XAvaEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:17 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)) 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:17 INFO - Running setup.py (path:/tmp/pip-O1Bf1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:17 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)) 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:17 INFO - Running setup.py (path:/tmp/pip-LSc4gH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:17 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)) 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:17 INFO - Running setup.py (path:/tmp/pip-tnIUFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:17 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)) 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:17 INFO - Running setup.py (path:/tmp/pip-TRf582-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:17 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)) 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:17 INFO - Running setup.py (path:/tmp/pip-yv0nsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:18 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)) 11:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:18 INFO - Running setup.py (path:/tmp/pip-zprHbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:18 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)) 11:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:18 INFO - Running setup.py (path:/tmp/pip-xnkKEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:18 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)) 11:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:18 INFO - Running setup.py (path:/tmp/pip-8TbKGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:18 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)) 11:22:18 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)) 11:22:18 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)) 11:22:18 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)) 11:22:18 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)) 11:22:18 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)) 11:22:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22:21 INFO - Downloading blessings-1.6.tar.gz 11:22:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:22:21 INFO - Installing collected packages: blessings 11:22:21 INFO - Running setup.py install for blessings 11:22:21 INFO - Successfully installed blessings 11:22:21 INFO - Cleaning up... 11:22:21 INFO - Return code: 0 11:22:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:22:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:21 INFO - Reading from file tmpfile_stdout 11:22:21 INFO - Current package versions: 11:22:21 INFO - argparse == 1.2.1 11:22:21 INFO - blessings == 1.6 11:22:21 INFO - blobuploader == 1.2.4 11:22:21 INFO - docopt == 0.6.1 11:22:21 INFO - functools32 == 3.2.3-2 11:22:21 INFO - jsonschema == 2.5.1 11:22:21 INFO - manifestparser == 1.1 11:22:21 INFO - mozInstall == 1.12 11:22:21 INFO - mozcrash == 0.17 11:22:21 INFO - mozdebug == 0.1 11:22:21 INFO - mozdevice == 0.48 11:22:21 INFO - mozfile == 1.2 11:22:21 INFO - mozhttpd == 0.7 11:22:21 INFO - mozinfo == 0.9 11:22:21 INFO - mozleak == 0.1 11:22:21 INFO - mozlog == 3.3 11:22:21 INFO - moznetwork == 0.27 11:22:21 INFO - mozprocess == 0.23 11:22:21 INFO - mozprofile == 0.28 11:22:21 INFO - mozrunner == 6.12 11:22:21 INFO - mozscreenshot == 0.1 11:22:21 INFO - mozsystemmonitor == 0.3 11:22:21 INFO - moztest == 0.7 11:22:21 INFO - mozversion == 1.4 11:22:21 INFO - psutil == 3.1.1 11:22:21 INFO - requests == 1.2.3 11:22:21 INFO - wsgiref == 0.1.2 11:22:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:21 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 0x7feafd7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', '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 11:22:21 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 11:22:21 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 11:22:21 INFO - Using env: {'DISPLAY': ':0', 11:22:21 INFO - 'HOME': '/home/cltbld', 11:22:21 INFO - 'LANG': 'en_US.UTF-8', 11:22:21 INFO - 'LANGUAGE': 'en_US:en', 11:22:21 INFO - 'LOGNAME': 'cltbld', 11:22:21 INFO - 'MAIL': '/var/mail/cltbld', 11:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:21 INFO - 'MOZ_NO_REMOTE': '1', 11:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:21 INFO - 'NO_EM_RESTART': '1', 11:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:21 INFO - 'PWD': '/builds/slave/test', 11:22:21 INFO - 'SHELL': '/bin/bash', 11:22:21 INFO - 'SHLVL': '1', 11:22:21 INFO - 'TERM': 'linux', 11:22:21 INFO - 'TMOUT': '86400', 11:22:21 INFO - 'USER': 'cltbld', 11:22:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', 11:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:21 INFO - '_': '/tools/buildbot/bin/python'} 11:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:21 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)) 11:22:21 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)) 11:22:21 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)) 11:22:21 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)) 11:22:21 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)) 11:22:21 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)) 11:22:21 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)) 11:22:21 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)) 11:22:21 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)) 11:22:21 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)) 11:22:21 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)) 11:22:21 INFO - Cleaning up... 11:22:21 INFO - Return code: 0 11:22:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:21 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 0x7feafd7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc0090>, '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 0x2bc39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', '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 11:22:21 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 11:22:21 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 11:22:21 INFO - Using env: {'DISPLAY': ':0', 11:22:21 INFO - 'HOME': '/home/cltbld', 11:22:21 INFO - 'LANG': 'en_US.UTF-8', 11:22:21 INFO - 'LANGUAGE': 'en_US:en', 11:22:21 INFO - 'LOGNAME': 'cltbld', 11:22:21 INFO - 'MAIL': '/var/mail/cltbld', 11:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:21 INFO - 'MOZ_NO_REMOTE': '1', 11:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:21 INFO - 'NO_EM_RESTART': '1', 11:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:21 INFO - 'PWD': '/builds/slave/test', 11:22:21 INFO - 'SHELL': '/bin/bash', 11:22:21 INFO - 'SHLVL': '1', 11:22:21 INFO - 'TERM': 'linux', 11:22:21 INFO - 'TMOUT': '86400', 11:22:21 INFO - 'USER': 'cltbld', 11:22:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', 11:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:21 INFO - '_': '/tools/buildbot/bin/python'} 11:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:22:22 INFO - Cleaning up... 11:22:22 INFO - Return code: 0 11:22:22 INFO - Running post-action listener: _resource_record_post_action 11:22:22 INFO - Running post-action listener: _start_resource_monitoring 11:22:22 INFO - Starting resource monitoring. 11:22:22 INFO - [mozharness: 2016-08-11 18:22:22.085434Z] Finished create-virtualenv step (success) 11:22:22 INFO - [mozharness: 2016-08-11 18:22:22.085948Z] Running install step. 11:22:22 INFO - Running pre-action listener: _resource_record_pre_action 11:22:22 INFO - Running main action method: install 11:22:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:22 INFO - Reading from file tmpfile_stdout 11:22:22 INFO - Detecting whether we're running mozinstall >=1.0... 11:22:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:22:22 INFO - Reading from file tmpfile_stdout 11:22:22 INFO - Output received: 11:22:22 INFO - Usage: mozinstall [options] installer 11:22:22 INFO - Options: 11:22:22 INFO - -h, --help show this help message and exit 11:22:22 INFO - -d DEST, --destination=DEST 11:22:22 INFO - Directory to install application into. [default: 11:22:22 INFO - "/builds/slave/test"] 11:22:22 INFO - --app=APP Application being installed. [default: firefox] 11:22:22 INFO - mkdir: /builds/slave/test/build/application 11:22:22 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'] 11:22:22 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 11:22:38 INFO - Reading from file tmpfile_stdout 11:22:38 INFO - Output received: 11:22:38 INFO - /builds/slave/test/build/application/firefox/firefox 11:22:38 INFO - Running post-action listener: _resource_record_post_action 11:22:38 INFO - [mozharness: 2016-08-11 18:22:38.430897Z] Finished install step (success) 11:22:38 INFO - [mozharness: 2016-08-11 18:22:38.431144Z] Running run-tests step. 11:22:38 INFO - Running pre-action listener: _resource_record_pre_action 11:22:38 INFO - Running main action method: run_tests 11:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:22:38 INFO - Python 2.7.3 11:22:38 INFO - Return code: 0 11:22:38 INFO - grabbing minidump binary from tooltool 11:22:38 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')]} 11:22:38 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 0x2bc0090>, '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 0x2bc39b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:22:38 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 11:22:38 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 11:22:38 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 11:22:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:22:38 INFO - Return code: 0 11:22:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:22:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:22:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:22:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:22:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:22:38 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/BV0wKa80TUiHzFkolRKEsQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 11:22:38 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/BV0wKa80TUiHzFkolRKEsQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 11:22:38 INFO - Using env: {'DISPLAY': ':0', 11:22:38 INFO - 'HOME': '/home/cltbld', 11:22:38 INFO - 'LANG': 'en_US.UTF-8', 11:22:38 INFO - 'LANGUAGE': 'en_US:en', 11:22:38 INFO - 'LOGNAME': 'cltbld', 11:22:38 INFO - 'MAIL': '/var/mail/cltbld', 11:22:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:22:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:38 INFO - 'MOZ_NO_REMOTE': '1', 11:22:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:38 INFO - 'NO_EM_RESTART': '1', 11:22:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:38 INFO - 'PWD': '/builds/slave/test', 11:22:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:22:38 INFO - 'SHELL': '/bin/bash', 11:22:38 INFO - 'SHLVL': '1', 11:22:38 INFO - 'TERM': 'linux', 11:22:38 INFO - 'TMOUT': '86400', 11:22:38 INFO - 'USER': 'cltbld', 11:22:38 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772', 11:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:38 INFO - '_': '/tools/buildbot/bin/python'} 11:22:38 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/BV0wKa80TUiHzFkolRKEsQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 11:22:38 INFO - mozversion application_buildid: 20160811105621 11:22:38 INFO - mozversion application_changeset: 61fbf96a2cfa3ce59c48d2fc59d17a3a1fc1372d 11:22:38 INFO - mozversion application_display_name: Nightly 11:22:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:22:38 INFO - mozversion application_name: Firefox 11:22:38 INFO - mozversion application_remotingname: firefox 11:22:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:22:38 INFO - mozversion application_vendor: Mozilla 11:22:38 INFO - mozversion application_version: 51.0a1 11:22:38 INFO - mozversion platform_buildid: 20160811105621 11:22:38 INFO - mozversion platform_changeset: 61fbf96a2cfa3ce59c48d2fc59d17a3a1fc1372d 11:22:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:22:38 INFO - mozversion platform_version: 51.0a1 11:22:38 INFO - using testdate: 1470939758 11:22:38 INFO - actual date: 1470939758 11:22:38 INFO - starting webserver on 'localhost:33570' 11:22:38 INFO - SUITE-START | Running 2 tests 11:22:38 INFO - TEST-START | dromaeo_css 11:22:38 INFO - operating with platform_type : linux_ 11:22:38 INFO - Initialising browser for dromaeo_css test... 11:22:38 INFO - TEST-INFO | started process 3744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOUusaU/profile http://localhost:33570/getInfo.html) 11:22:43 INFO - PROCESS | 3744 | __metrics Screen width/height:1600/1200 11:22:43 INFO - PROCESS | 3744 | colorDepth:24 11:22:43 INFO - PROCESS | 3744 | Browser inner width/height: 1024/697 11:22:43 INFO - PROCESS | 3744 | __metrics 11:22:44 ERROR - PROCESS | 3744 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 11:22:45 INFO - TEST-INFO | 3744: exit 0 11:22:45 INFO - Browser initialized. 11:22:45 INFO - Running cycle 1/1 for dromaeo_css test... 11:22:45 INFO - TEST-INFO | started process 3862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOUusaU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:56 INFO - PROCESS | 3862 | RSS: Main: 164077568 11:22:56 INFO - PROCESS | 3862 | 11:23:46 INFO - PROCESS | 3862 | 1470939826567 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] 11:25:59 INFO - PROCESS | 3862 | Cycle 1(1): loaded http://localhost:33570/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33570/tests/dromaeo/cssquery-ext.html) 11:26:00 INFO - PROCESS | 3862 | RSS: Main: 165965824 11:26:00 INFO - PROCESS | 3862 | 11:29:02 INFO - PROCESS | 3862 | Cycle 1(1): loaded http://localhost:33570/tests/dromaeo/cssquery-ext.html (next: http://localhost:33570/tests/dromaeo/cssquery-jquery.html) 11:29:03 INFO - PROCESS | 3862 | RSS: Main: 166019072 11:29:03 INFO - PROCESS | 3862 | 11:32:05 INFO - PROCESS | 3862 | Cycle 1(1): loaded http://localhost:33570/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33570/tests/dromaeo/cssquery-mootools.html) 11:32:06 INFO - PROCESS | 3862 | RSS: Main: 169762816 11:32:06 INFO - PROCESS | 3862 | 11:35:08 INFO - PROCESS | 3862 | Cycle 1(1): loaded http://localhost:33570/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33570/tests/dromaeo/cssquery-prototype.html) 11:35:08 INFO - PROCESS | 3862 | RSS: Main: 164315136 11:35:08 INFO - PROCESS | 3862 | 11:38:11 INFO - PROCESS | 3862 | Cycle 1(1): loaded http://localhost:33570/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33570/tests/dromaeo/cssquery-yui.html) 11:38:12 INFO - PROCESS | 3862 | RSS: Main: 165949440 11:38:12 INFO - PROCESS | 3862 | 11:41:14 INFO - PROCESS | 3862 | Cycle 1(1): loaded http://localhost:33570/tests/dromaeo/cssquery-yui.html (next: http://localhost:33570/tests/dromaeo/cssquery-dojo.html) 11:41:15 INFO - PROCESS | 3862 | RSS: Main: 169549824 11:41:15 INFO - PROCESS | 3862 | 11:41:15 INFO - PROCESS | 3862 | __start_tp_report 11:41:15 INFO - PROCESS | 3862 | _x_x_mozilla_page_load 11:41:15 INFO - PROCESS | 3862 | _x_x_mozilla_page_load_details 11:41:15 INFO - PROCESS | 3862 | |i|pagename|runs| 11:41:15 INFO - PROCESS | 3862 | |0;dojo.html;2675.759181673649;2686.502996945564;2711.932201694958;2724.5368287391143;2739.068716636343;4718.9056218875685;4947.9257811132775;4948.529889660481;4998.400191976959;5004.999000199961;4882.584980276672;4906.632002599801;4958.553730164284;4963.305137280783;4967.155583550796;4488.214562451566;4583.060472603109;4605.332226827125;4635.466921304042;4712.387389639359;4635.93046104307;4657.51096134906;4672.345871577965;4685.133250348679;4703.764811759415;4329.112531930947;4497.9775101124615;4506.143832671782;4553.817847286121;4562.543745625444;4493.662975276868;4529.230030894756;4564.908701825978;4605.861824145281;4628.190066738307;4543.727376357396;4543.909121817578;4555.362249285103;4562.589366956957;4579.129965306614;4736.407949006374;4818.975905120487;4883.19427294496;4949.034938187055;4950.579200767903;5237.292965449692;5273.419923808378;5297.735113244323;5311.681299122027;5318.893622127574;5274.604404669627;5302.761375738101;5311.309529761145;5321.175217841241;5378.273933019032;4716.151092803259;4842.975785121052;4890.997345544155;4905.950940490549;4915.729634870117;5360.222767698662;5395.62230643859;5397.163439666858;5446.183072539151;5453.427390123979;5160.561352285098;5174.456682048331;5182.53357197854;5185.274061631375;5232.686038837605;5022.723750193702;5101.668391554537;5227.320448341768;5237.450067742832;5242.685438873604;5138.2806407103035;5151.201563757623;5170.457102004236;5221.660592061504;5235.371755389301;5097.260897169889;5104.081265372194;5105.387353517527;5105.846824595268;5188.22176673502;4260.637845783143;4328.48058233014;4397.340398940185;4417.624501917373;4462.44219472566;3801.068738159169;3845.057960799622;3856.2094770571966;3907.199024200089;3951.9527325258828;4464.910701785946;4496.572825581565;4510.436195475566;4528.547145285511;4541.2733962565835;5183.5593974512585;5201.349831271091;5216.869578260498;5218.478152184751;5296.523312901781;4386.298192289219;4470.552944705503;4501.324801279834;4535.659825513034;4549.977250113729;4761.833335833229;4770.189067858472;4770.642201834877;4800.4719480857075;4810.302506136661;4912.828051018198;4935.111679897581;4936.432310284364;4947.628927830499;4982.601391888567;4954.777035033504;5150.201718733602;5203.661761985459;5226.790928362823;5302.496262855023;4846.588040016497;4862.100511405401;4894.437139728834;4931.3589233399425;4933.112039832865;5128.102582048052;5132.409772876167;5134.640575159703;5143.71709555963;5147.742612869416;5017.598592112695;5188.922166167586;5210.166373380241;5219.373675159005;5222.00781851447;5074.289599456005;5099.643024988363;5104.591632669451;5113.7187454688865;5115.411727651368;5081.415637201769;5082.771275292546;5102.1326374515675;5102.2346648003095;5139.948600513947;4770.642201834807;4903.33804936329;4990.625703072212;5011.874703132451;5020.824271150492;5163.070647283525;5169.121249387688;5170.043541944752;5183.948160518346;5219.347581552306;4986.376702912136;5030.4718004608985;5061.316722242597;5063.822766203165;5086.18621020635 11:41:15 INFO - PROCESS | 3862 | |1;ext.html;557.8828446026334;561.2311133746765;567.8693900402907;571.8884817460594;585.3385674188166;33877.66122338776;38443.42334864979;38455.80772096143;38574.42138367927;38585.42121868171;38686.4197037044;39302.606973930255;39313.606863931425;39357.803210983904;39486.21027579454;7581.128170260436;7767.262110099531;7770.261825126604;7772.494787838772;7777.572233527154;7607.505512141721;7656.425768067389;7677.884831727529;7685.577293248869;7690.077190737119;7724.1889601591865;7737.961310193469;7757.379409647243;7759.418043646749;7767.6892924282965;7648.579328136951;7667.079950405959;7674.386049116058;7675.347595454393;7723.459357844925;7742.922570774276;7836.921630783676;7839.333656639135;7856.332211762007;7861.174576669425;36789.080272993124;36814.8159259202;37105.44341834875;37132.07169820749;37134.25731485382;3192.4892017277125;3345.531625572422;3492.4062909305226;3715.2755212733528;3832.7317087803863;28881.42237155245;29149.125526234246;29396.70603293961;29641.110766677033;29724.256893577618;3215.067630387185;3217.404780115686;3246.675332466758;3276.836158192105;3328.9334213315597;256481;256954;257472;257955;259024.9999999981;51642.22536661953;51659.48340516622;51966.22050669243;52227.73886130621;52300.47699522956;54268.72865635646;54390.72804636031;54507.18239226415;54582.45417545774;54635;13602.659933501543;14066.156030638194;14449.422023119168;14456.421743130157;14464.566063018126;11032.669019929415;11081.390523521284;11111.111111111091;11117.555297787998;11147.944260278648;17704.82295177032;17896;17939.73090403645;17954.730679039825;18145.911245325322;6908.5509441886115;6950.79147625572;7046.929530704628;7070.823229419306;7193.676284567207;831.5675848558836;930.1024511346583;958.4009993753904;968.5399435268332;1017.2421545948168;28304.292392689935;29032.11433833174;29168.562471562942;29192.708072919424;29214.269643258664;936.3492372800974;956;960.45958439926;962.5379817687409;983.6901376066517;13700.24648644334;14555;14617.853821461862;14625.707485850437;14732.189729564763;372560;376949;377163;378807;378866;46395;46940.29589556159;47149.292760608616;47188.2921756174;47419.52580474151;1159.5477763672175;1173.6303064534645;1193.4808358364312;1206.9517219311306;1215.2526196389158;25927.092551760597;26404.73595264023;26906.59640105439;27409.451810964067;27486.725132748415;40683;41198.79400602978;41361;41469.377959331236;41557.79221103875;345033;345977;347752;348677;348896;24729.381765456008;25123.497530049663;25400.237992860242;25901.740982589934;25985.35036624024;41243.7937810309;41301.79349103235;41387.7930610345;42018.36972445354;42238.788806055774;35525.28949421049;36314.8184259077;36371.090722732144;36543.63456365402;36578.8171059143;35419.29161416809;35638.465423018155;35681.28637427289;36150.63849361578;36206.637933620324;34686.65313346834;34714.30571388609;35032.82483587566;35051.29897402089;35628.82185589056;30397;32701.345973080883;32923.34153316968;32981.17547061247;33036.17409564684;24869.62695559532;25461.490770184864;25482.617760733232;25551.041920455024;25551.616725748758 11:41:15 INFO - PROCESS | 3862 | |2;jquery.html;350.8140685436718;358.8797752752828;361.5950135847851;371.7490693781697;380.2110620462539;15787.763183552255;16463.341466341346;17463.126843657814;17469.3012279509;17548.82451175488;16632.25154868031;16673.41643042494;17028.404005859797;17235.224414901328;17341.132943352844;4837.879053023685;5067.6452648314635;5084.3136176616235;5086.847394578169;5091.719955402451;3782.7919464429447;4964.950350496485;5909.615874968134;6211.689415529228;6228.252609686821;6199.566030377875;6246.687665616723;6254.9374506255035;6283.02613094971;6294.276158241815;5776.422357764211;5881.617694849821;5912.172295878538;5913.113033045056;5920.615160014607;5103.362079740033;5184.170532714786;5188.870278243036;5191.091558977164;5391.649542779707;20647.89676051625;20664.58670826575;20781.89609051945;20789.272375466786;21111.366659000254;1873.063468265867;1950.8146726061002;2033.6542787726123;2043.4176259765895;2128.616848967201;6246.906296405512;6407.583507072025;6767.120274364351;13471.932640336834;13614.659633509142;1714.7942246930324;1733.7486064520574;1738.400251913088;1801.702719051355;1815.6731788278105;63964.360356396304;64451.35548644547;65539.67230163819;67538.32461675418;67627;9579.13787759105;10187;10238.436885971194;10316.793664126675;10337.586496540205;13684.247366394944;13856.653583660489;13878.306084695725;13896.374663140183;13905.304734763222;7188.813417524866;7303.936898432889;7314.305141011595;7362.226966168582;7502.887456688154;6894.482913781487;7004.124484439445;7248.6738096785775;7276.199618042011;7316.231795661379;4221.156676762178;4295.248331541968;4341.435613370241;4445.711028783118;4458.866234012985;1733.7832770903638;1762.6739053275185;1775.849052830524;1812;1825.4210108256264;331.32905865621825;356.4706410979693;357.65128999225544;365.66906949211005;773.880048592469;9576.521173941414;9812.165965892978;9855.507224638883;10015.549300281506;10124.190064794799;364.7701947772886;374.87441707027904;376.7306375941215;381.1785602027635;381.9942700859489;5116.820911268088;5179.223116532475;5259.606204355849;5300.708461034603;5320.334958130234;376007;376815;395416;407631;420818;81047.59476202581;81874;82422;82902;85276;411.0627768687398;415.3147306943507;416.9749815011109;418.1219439177763;418.17201940158657;9711.9028809711;9970;9979.45113018791;10090.69727908164;10363.378197308186;36696.81651591725;38201.23597528089;38300.23399531938;38588.42117368298;38646.2270754589;49068.50931490639;51049.23426148685;53824.46175538195;54253.18620220621;55335;7594.696212151452;7695.961520192363;7888.84222315539;7906.644201010853;8307.418480706292;9454.95272523633;10121.797564048826;12318.076144289034;12711;13100.213987160801;10243.334183278062;10618.309809862334;10923.399213043358;11112.777744444904;11220.438978051228;9893.505324733878;10180.949095254477;10533.210009249184;10778.89221107779;10805.675829725122;10212.591496340063;10335.638252661121;10636.149108071491;10858.782824343627;11076.39079850616;7629.961850190713;7751.147373788992;7857.16426708767;7875.173106823701;7978.720744773905;9674.177694896012;10823.891761082288;10846.13230941507;10889.074428673652;10979.39613321275 11:41:15 INFO - PROCESS | 3862 | |3;mootools.html;1368.5689007962487;1412.5479846449136;1466.691994681117;1574.3623832347903;1603.6872809802094;6590.472762179026;7183.820404489884;7475.700971961129;7828.921710782884;7833.843323133534;7472.775816725507;7739.458237923348;7745.922540774604;7746.0317460317465;7751.806204844882;2156.827453803696;2188.2341180586827;2188.5513469738667;2189.868607883524;2191.7260342457193;2110.577884423114;2126.2345555599973;2203.294945617403;2209.3371988403414;2210.2927063339657;2169.457635591102;2174.913003479859;2181.334692918659;2188.245055455865;2200.6038912995655;2132.6907598398225;2141.186349187307;2142.368001439579;2142.4322554523064;2142.860714053589;2065.7211276477633;2127.457498337914;2130.446084018151;2133.4879628888957;2136.0387825478597;7674.654640541189;7751.7674469766;7759.418043646692;7773.339266162383;7816.687332506693;4394.538573449806;4536.56902594253;4539.0694907543875;4551.067031258584;4560.224761790503;2875.324298789783;2886.379428422878;2902.274431392152;2976.9851150744107;3051.2676957530257;931.7670582354411;959.9664011759555;990.8959559246248;1006.0693858181227;1007.496251874063;10272.743181420525;10273.589056437733;10278.794424111551;10324.58701651933;10385.273030887842;3791.260704162717;3918.6669133124005;4067.7152599318356;4068.3287257602756;4115.32097203964;8737.344699147588;8803.691870784492;8812.559372031501;8844.248238899765;8853.601587928559;4458.777061146994;4482.7448314472;4492.483364413069;4497.302918047708;4512;3392.4741665041956;3924.9803750981064;4036.858709945138;4069.2268468991388;4070.3283958147167;3519.278547897675;3576.7138628909624;3605.963940360615;3652.7443078984747;3778.2254637799183;1164.0512981919708;1165.6444784340688;1176.1766763265578;1177.8704342522315;1184.7689700508317;796.4066770256196;839.3075712537182;842.0568962761746;853.185208126238;855.9358048146414;5021.72380519075;5148.279240906276;5240.659357141773;5262.684238945675;5265;397.0589702405318;408.7772164170534;422.55420531339115;424.5012110769833;426.3221477850233;3472.791632502058;3511.1924257420937;3520.964790352115;3552.964470355315;3661.5972243053243;8967.327450441113;9381.484018379055;9405.482698451515;9407.764805879771;9408.952955235316;8947.239484643747;9331;9374.390664606915;9404.294677899048;9629.614815407445;7185.209626941032;7354.963225183947;7377.81555461107;7387.741429049957;7419.2209817969415;4959.107360675113;5122.590192784493;5145.331106956071;5197.870053248699;5249.6062795289745;8496.490210587384;8672.913270867211;8740.08229135957;8782.604782784661;8823.558822058743;8677.349198809989;8827.955860220658;8829.69096081634;8935.463872167691;8982.281417486454;5688;6343.143675603735;6575.835604109936;6597.901031484627;6756.391924726601;7184.137903451619;7264.128304603481;7273.418126549969;7296.854062918605;7301.196868344584;6645.235797883305;6760.661966901734;6788.1175447191545;6950.270221626656;6980.930190698231;6626.27111017778;6647.534672573067;6729.596224226562;6816.931830681629;6866.896996544956;6208.751649933952;6294.905576416266;6321.1782468278825;6328.557001009885;6336.7148478319505;4545.818167273272;4557.339185818104;4609.562091601292;4625.121226966866;4633.606143477842;4514.887127821699;4587.61005314552;4603.93094103582;4678.017616300615;4710.764461776829 11:41:15 INFO - PROCESS | 3862 | |4;prototype.html;280.4265277507498;287.32048704813116;287.9352145767203;294.0619424037321;294.54051679380154;4940.56723550171;5068.391792984838;5112.156494178461;5215.374155101388;5256.421793602701;5073.518015788494;5093.847184584469;5101;5106.234064890268;5106.5148810863;4010.6991975601873;4024.1951609678035;4029.066048296819;4054.6756259499316;4055.3308704063793;3961.267165574378;4036.919261614766;4060.2894493463527;4072.36878283865;4074.9185016299657;3992.960070399288;4000.8599699010542;4001.839926402955;4006.4991876015497;4010.418489319047;3988.601139886003;4010.3984402339593;4019.4573732546023;4025.5041874037993;4044.1911617676583;3533.328667553182;3538.4161613333767;3543.3090547343277;3553.875614353511;3572.5355703758346;4772.95227047732;4935.777889994959;4979.253112033188;4992.600591952635;5099.541041306263;4596.448426188846;4599.678022538424;4606.147862645388;4606.562376574254;4619.468761092484;5291.523762861322;5294.735263236823;5321.521063104339;5360.463953604608;5363.410024897258;3716.5168528091176;3830.9616903830884;3841.2893614681093;3861.401482770147;3869.7036492774955;5589.608727389084;5598.748056337475;5613.354464236624;5616.634918730269;5660.433956604306;3964.4647972523917;3973.7615743055508;3980.2238563480423;3982;3983.48214732083;3711.7030637548933;3863.2273545291055;4039.6162364575316;4046.7571945683353;4048.8785336439955;4421.314696222091;4445.9996500787065;4463.085067561142;4478.745951133687;4480.4623445186135;5299.4435584263865;5342.171963345688;5350.91973620396;5400.270963419888;5410.215518749838;1304.7194853106628;1341.818854454636;1347.2051489621172;1365.2286458151113;1377.4490203918313;911.8267529169436;928.6656803550717;954.4130359828655;954.4798085043668;958.91849192818;4619.9076018479445;4630.259158534685;4636.35091087248;4636.562665573683;4657.5575320344515;5417.214503896913;5434.918476222781;5436.864078397993;5463.470228336072;5493.368262649767;4447.777611119431;4619.445666520039;4644.373009643655;4668.719876807402;4680.765961701902;2523.58360870458;2533.4173140177863;2560.385507478192;2576.9355766105623;2590.740925907432;4490.236659767847;4511.413516242867;4516.706414083074;4525.094981003813;4572.416584629674;4655.301704744248;4897.461279259279;4900.093482705711;4910.312556242129;4930.9506904930495;4427.380166776589;4438.556144385536;4451.421315228999;4451.577100175543;4457.531959144373;4740;4741.866160227843;4754.478566858572;4780.378550788514;4853.223484242504;4654.299157850528;4670.524621950236;4676.176291246348;4718.9854181351175;4719.2921061841;4288.549702281341;4422.557744225552;4442.333649952533;4459.862735002554;4463.977680111579;3477.61746207922;3538.4869193967247;3579.6957258633306;3583.9283214336087;3585.3725598020765;4820.325154478306;4827.80334947605;4832.081904438145;4838.395200599925;5261.394939581844;5272.182811664198;5291.470852914677;5375.489328513785;5409.432009638931;5425.267588875451;5270.628217302306;5281.498257665516;5286.656367336111;5295.232191332312;5296.682199068068;5085;5196.558292545024;5203.710367438315;5245.475452454877;5287.57699384056;5359.785608575613;5387.81142660005;5388.299521062237;5397.595180361567;5408.405075441777;5238.76425560843;5283.656562323436;5313.628046036895;5319.787208511616;5327.227552005015 11:41:15 INFO - PROCESS | 3862 | |5;yui.html;657.9078928949947;685.7565564224703;722.9313215244551;746.1568427676724;751.3575892611814;13026.218426894382;13647.795283070736;13720.245386503739;13738.587842364745;13878.444862205512;13327;13348.199108053499;13367.465301387958;13606.659833504142;13761.142245796815;751.3350684644103;778.1207235823512;781.1641543548405;781.6013832945182;782.3662833105203;634.0489266100849;719.8380364418016;730.2150188547333;761.9314261716445;782.5187509681533;813.4346629092753;818.251300060444;820.2371794231362;820.9343252539812;822.8272062866805;808.2079562029215;812.5409143833715;813.1583810755899;814.3932770086294;816.1593558634556;597.7549204826;597.7877853362037;597.8385835824347;599.1342510072947;599.3407252022783;13063.281519516519;13111.082224244306;13145.934270328682;13173.868261317455;13296.26870522121;13349.332533373292;13543.59369218925;13902.721945561032;13910.304484775721;14065.71868562623;10783.46082695862;10783.514741836636;10814.134869210444;10857.294275872044;10871.29336593119;3258.2994656148803;3298.884539041122;3303.273279878447;3313.5361049453095;3404.2340473393538;50424;51721.224181637306;52522.73738631282;69733;71363.64318178428;10427.5828966842;10440.112590429746;10463.581456741797;10508.737281568023;10696.62561810333;17044.14779261032;18455.261789528537;18457;18479.260829566665;18656.813431865507;6828.112345395166;7032.859342813115;7056.400205982549;7071.222165561784;7078.929210707827;3863.690904727615;3872.302985462644;3890;3910.687145028391;3921.941170882439;2811.620431241797;2878.5250433678625;2923.63454568179;2927.443785680714;2932.5307950728206;499.0966350904801;504.6215338496128;505.32034413713495;506.07641055074635;507.79434329096773;584.9766009359663;595.3629616310507;601.8615718384796;612.543654977045;618;8214.712485063113;8239.794005149919;8371.121032291643;8377.120402357787;8513.914860851437;526.6339893773867;562.2409746841731;586.9589128761031;608.3703367015119;609.1289456077762;3911.882643520699;3935.665468435158;3961.3265744823448;4055.4930633670792;4253.213155566168;92586.53706731558;100562.49718751505;101728.49135754422;108211.45894270636;108622;54547;60858;85909.57045214734;87473.1252687465;92288;80695;82768;83074;83113;83535;7622.618869056414;7708.190639982721;7818.687252509836;7878.527288362717;8003.079645840803;43297.35053974256;46810.29784553302;46918.53081469142;47827.28259076047;48199.27701084416;68999.65500172669;71032;72525;72634.63682681553;72764.27235727575;9828.803423931338;9988.151007164182;10037.949810251193;10050.396976181453;10283.588656453658;11511.827322590001;11597.18819682614;11858.051355891335;11973.940130299292;12001.459934303151;10510.474476276002;10696.251262411557;10839.512221949873;11035.889641103486;11194.888051119711;9753.268504862306;9762.36544624597;10436.580469241579;10776.353418794897;11501.252418592765;9896.802063958825;10963.671089867317;11213.383263920563;11243.4378281084;11309.547618095185;8531.274841638531;8844.204021638083;9337;9668.661596844076;9729.9027009729;9176.495292758962;9299.953500232727;9368.57841397125;9374;9575.473348965874 11:41:15 INFO - PROCESS | 3862 | __end_tp_report 11:41:15 INFO - PROCESS | 3862 | __start_cc_report 11:41:15 INFO - PROCESS | 3862 | _x_x_mozilla_cycle_collect,377 11:41:15 INFO - PROCESS | 3862 | __end_cc_report 11:41:15 INFO - PROCESS | 3862 | __startTimestamp1470940875231__endTimestamp 11:41:15 INFO - PROCESS | 3862 | 11:41:15 INFO - PROCESS | 3862 | ------- Summary: start ------- 11:41:15 INFO - PROCESS | 3862 | Number of tests: 6 11:41:15 INFO - PROCESS | 3862 | 11:41:15 INFO - PROCESS | 3862 | [#0] dojo.html Cycles:165 Average:4841.82 Median:4958.55 stddev:505.10 (10.2%) stddev-sans-first:477.21 11:41:15 INFO - PROCESS | 3862 | Values: 2675.8 2686.5 2711.9 2724.5 2739.1 4718.9 4947.9 4948.5 4998.4 5005.0 4882.6 4906.6 4958.6 4963.3 4967.2 4488.2 4583.1 4605.3 4635.5 4712.4 4635.9 4657.5 4672.3 4685.1 4703.8 4329.1 4498.0 4506.1 4553.8 4562.5 4493.7 4529.2 4564.9 4605.9 4628.2 4543.7 4543.9 4555.4 4562.6 4579.1 4736.4 4819.0 4883.2 4949.0 4950.6 5237.3 5273.4 5297.7 5311.7 5318.9 5274.6 5302.8 5311.3 5321.2 5378.3 4716.2 4843.0 4891.0 4906.0 4915.7 5360.2 5395.6 5397.2 5446.2 5453.4 5160.6 5174.5 5182.5 5185.3 5232.7 5022.7 5101.7 5227.3 5237.5 5242.7 5138.3 5151.2 5170.5 5221.7 5235.4 5097.3 5104.1 5105.4 5105.8 5188.2 4260.6 4328.5 4397.3 4417.6 4462.4 3801.1 3845.1 3856.2 3907.2 3952.0 4464.9 4496.6 4510.4 4528.5 4541.3 5183.6 5201.3 5216.9 5218.5 5296.5 4386.3 4470.6 4501.3 4535.7 4550.0 4761.8 4770.2 4770.6 4800.5 4810.3 4912.8 4935.1 4936.4 4947.6 4982.6 4954.8 5150.2 5203.7 5226.8 5302.5 4846.6 4862.1 4894.4 4931.4 4933.1 5128.1 5132.4 5134.6 5143.7 5147.7 5017.6 5188.9 5210.2 5219.4 5222.0 5074.3 5099.6 5104.6 5113.7 5115.4 5081.4 5082.8 5102.1 5102.2 5139.9 4770.6 4903.3 4990.6 5011.9 5020.8 5163.1 5169.1 5170.0 5183.9 5219.3 4986.4 5030.5 5061.3 5063.8 5086.2 11:41:15 INFO - PROCESS | 3862 | 11:41:15 INFO - PROCESS | 3862 | [#1] ext.html Cycles:180 Average:47810.17 Median:36801.95 stddev:87188.92 (236.9%) stddev-sans-first:87361.32 11:41:15 INFO - PROCESS | 3862 | Values: 557.9 561.2 567.9 571.9 585.3 33877.7 38443.4 38455.8 38574.4 38585.4 38686.4 39302.6 39313.6 39357.8 39486.2 7581.1 7767.3 7770.3 7772.5 7777.6 7607.5 7656.4 7677.9 7685.6 7690.1 7724.2 7738.0 7757.4 7759.4 7767.7 7648.6 7667.1 7674.4 7675.3 7723.5 7742.9 7836.9 7839.3 7856.3 7861.2 36789.1 36814.8 37105.4 37132.1 37134.3 3192.5 3345.5 3492.4 3715.3 3832.7 28881.4 29149.1 29396.7 29641.1 29724.3 3215.1 3217.4 3246.7 3276.8 3328.9 256481.0 256954.0 257472.0 257955.0 259025.0 51642.2 51659.5 51966.2 52227.7 52300.5 54268.7 54390.7 54507.2 54582.5 54635.0 13602.7 14066.2 14449.4 14456.4 14464.6 11032.7 11081.4 11111.1 11117.6 11147.9 17704.8 17896.0 17939.7 17954.7 18145.9 6908.6 6950.8 7046.9 7070.8 7193.7 831.6 930.1 958.4 968.5 1017.2 28304.3 29032.1 29168.6 29192.7 29214.3 936.3 956.0 960.5 962.5 983.7 13700.2 14555.0 14617.9 14625.7 14732.2 372560.0 376949.0 377163.0 378807.0 378866.0 46395.0 46940.3 47149.3 47188.3 47419.5 1159.5 1173.6 1193.5 1207.0 1215.3 25927.1 26404.7 26906.6 27409.5 27486.7 40683.0 41198.8 41361.0 41469.4 41557.8 345033.0 345977.0 347752.0 348677.0 348896.0 24729.4 25123.5 25400.2 25901.7 25985.4 41243.8 41301.8 41387.8 42018.4 42238.8 35525.3 36314.8 36371.1 36543.6 36578.8 35419.3 35638.5 35681.3 36150.6 36206.6 34686.7 34714.3 35032.8 35051.3 35628.8 30397.0 32701.3 32923.3 32981.2 33036.2 24869.6 25461.5 25482.6 25551.0 25551.6 11:41:15 INFO - PROCESS | 3862 | 11:41:15 INFO - PROCESS | 3862 | [#2] jquery.html Cycles:180 Average:24204.01 Median:204021.03 stddev:65490.55 (32.1%) stddev-sans-first:65649.77 11:41:15 INFO - PROCESS | 3862 | Values: 350.8 358.9 361.6 371.7 380.2 15787.8 16463.3 17463.1 17469.3 17548.8 16632.3 16673.4 17028.4 17235.2 17341.1 4837.9 5067.6 5084.3 5086.8 5091.7 3782.8 4965.0 5909.6 6211.7 6228.3 6199.6 6246.7 6254.9 6283.0 6294.3 5776.4 5881.6 5912.2 5913.1 5920.6 5103.4 5184.2 5188.9 5191.1 5391.6 20647.9 20664.6 20781.9 20789.3 21111.4 1873.1 1950.8 2033.7 2043.4 2128.6 6246.9 6407.6 6767.1 13471.9 13614.7 1714.8 1733.7 1738.4 1801.7 1815.7 63964.4 64451.4 65539.7 67538.3 67627.0 9579.1 10187.0 10238.4 10316.8 10337.6 13684.2 13856.7 13878.3 13896.4 13905.3 7188.8 7303.9 7314.3 7362.2 7502.9 6894.5 7004.1 7248.7 7276.2 7316.2 4221.2 4295.2 4341.4 4445.7 4458.9 1733.8 1762.7 1775.8 1812.0 1825.4 331.3 356.5 357.7 365.7 773.9 9576.5 9812.2 9855.5 10015.5 10124.2 364.8 374.9 376.7 381.2 382.0 5116.8 5179.2 5259.6 5300.7 5320.3 376007.0 376815.0 395416.0 407631.0 420818.0 81047.6 81874.0 82422.0 82902.0 85276.0 411.1 415.3 417.0 418.1 418.2 9711.9 9970.0 9979.5 10090.7 10363.4 36696.8 38201.2 38300.2 38588.4 38646.2 49068.5 51049.2 53824.5 54253.2 55335.0 7594.7 7696.0 7888.8 7906.6 8307.4 9455.0 10121.8 12318.1 12711.0 13100.2 10243.3 10618.3 10923.4 11112.8 11220.4 9893.5 10180.9 10533.2 10778.9 10805.7 10212.6 10335.6 10636.1 10858.8 11076.4 7630.0 7751.1 7857.2 7875.2 7978.7 9674.2 10823.9 10846.1 10889.1 10979.4 11:41:15 INFO - PROCESS | 3862 | 11:41:15 INFO - PROCESS | 3862 | [#3] mootools.html Cycles:180 Average:5034.50 Median:4694.39 stddev:2814.36 (60.0%) stddev-sans-first:2808.77 11:41:15 INFO - PROCESS | 3862 | Values: 1368.6 1412.5 1466.7 1574.4 1603.7 6590.5 7183.8 7475.7 7828.9 7833.8 7472.8 7739.5 7745.9 7746.0 7751.8 2156.8 2188.2 2188.6 2189.9 2191.7 2110.6 2126.2 2203.3 2209.3 2210.3 2169.5 2174.9 2181.3 2188.2 2200.6 2132.7 2141.2 2142.4 2142.4 2142.9 2065.7 2127.5 2130.4 2133.5 2136.0 7674.7 7751.8 7759.4 7773.3 7816.7 4394.5 4536.6 4539.1 4551.1 4560.2 2875.3 2886.4 2902.3 2977.0 3051.3 931.8 960.0 990.9 1006.1 1007.5 10272.7 10273.6 10278.8 10324.6 10385.3 3791.3 3918.7 4067.7 4068.3 4115.3 8737.3 8803.7 8812.6 8844.2 8853.6 4458.8 4482.7 4492.5 4497.3 4512.0 3392.5 3925.0 4036.9 4069.2 4070.3 3519.3 3576.7 3606.0 3652.7 3778.2 1164.1 1165.6 1176.2 1177.9 1184.8 796.4 839.3 842.1 853.2 855.9 5021.7 5148.3 5240.7 5262.7 5265.0 397.1 408.8 422.6 424.5 426.3 3472.8 3511.2 3521.0 3553.0 3661.6 8967.3 9381.5 9405.5 9407.8 9409.0 8947.2 9331.0 9374.4 9404.3 9629.6 7185.2 7355.0 7377.8 7387.7 7419.2 4959.1 5122.6 5145.3 5197.9 5249.6 8496.5 8672.9 8740.1 8782.6 8823.6 8677.3 8828.0 8829.7 8935.5 8982.3 5688.0 6343.1 6575.8 6597.9 6756.4 7184.1 7264.1 7273.4 7296.9 7301.2 6645.2 6760.7 6788.1 6950.3 6980.9 6626.3 6647.5 6729.6 6816.9 6866.9 6208.8 6294.9 6321.2 6328.6 6336.7 4545.8 4557.3 4609.6 4625.1 4633.6 4514.9 4587.6 4603.9 4678.0 4710.8 11:41:15 INFO - PROCESS | 3862 | 11:41:15 INFO - PROCESS | 3862 | [#4] prototype.html Cycles:180 Average:4290.55 Median:4640.47 stddev:1235.57 (26.6%) stddev-sans-first:1201.82 11:41:15 INFO - PROCESS | 3862 | Values: 280.4 287.3 287.9 294.1 294.5 4940.6 5068.4 5112.2 5215.4 5256.4 5073.5 5093.8 5101.0 5106.2 5106.5 4010.7 4024.2 4029.1 4054.7 4055.3 3961.3 4036.9 4060.3 4072.4 4074.9 3993.0 4000.9 4001.8 4006.5 4010.4 3988.6 4010.4 4019.5 4025.5 4044.2 3533.3 3538.4 3543.3 3553.9 3572.5 4773.0 4935.8 4979.3 4992.6 5099.5 4596.4 4599.7 4606.1 4606.6 4619.5 5291.5 5294.7 5321.5 5360.5 5363.4 3716.5 3831.0 3841.3 3861.4 3869.7 5589.6 5598.7 5613.4 5616.6 5660.4 3964.5 3973.8 3980.2 3982.0 3983.5 3711.7 3863.2 4039.6 4046.8 4048.9 4421.3 4446.0 4463.1 4478.7 4480.5 5299.4 5342.2 5350.9 5400.3 5410.2 1304.7 1341.8 1347.2 1365.2 1377.4 911.8 928.7 954.4 954.5 958.9 4619.9 4630.3 4636.4 4636.6 4657.6 5417.2 5434.9 5436.9 5463.5 5493.4 4447.8 4619.4 4644.4 4668.7 4680.8 2523.6 2533.4 2560.4 2576.9 2590.7 4490.2 4511.4 4516.7 4525.1 4572.4 4655.3 4897.5 4900.1 4910.3 4931.0 4427.4 4438.6 4451.4 4451.6 4457.5 4740.0 4741.9 4754.5 4780.4 4853.2 4654.3 4670.5 4676.2 4719.0 4719.3 4288.5 4422.6 4442.3 4459.9 4464.0 3477.6 3538.5 3579.7 3583.9 3585.4 4820.3 4827.8 4832.1 4838.4 5261.4 5272.2 5291.5 5375.5 5409.4 5425.3 5270.6 5281.5 5286.7 5295.2 5296.7 5085.0 5196.6 5203.7 5245.5 5287.6 5359.8 5387.8 5388.3 5397.6 5408.4 5238.8 5283.7 5313.6 5319.8 5327.2 11:41:15 INFO - PROCESS | 3862 | 11:41:15 INFO - PROCESS | 3862 | [#5] yui.html Cycles:180 Average:18004.05 Median:52121.98 stddev:26366.35 (50.6%) stddev-sans-first:26408.15 11:41:15 INFO - PROCESS | 3862 | Values: 657.9 685.8 722.9 746.2 751.4 13026.2 13647.8 13720.2 13738.6 13878.4 13327.0 13348.2 13367.5 13606.7 13761.1 751.3 778.1 781.2 781.6 782.4 634.0 719.8 730.2 761.9 782.5 813.4 818.3 820.2 820.9 822.8 808.2 812.5 813.2 814.4 816.2 597.8 597.8 597.8 599.1 599.3 13063.3 13111.1 13145.9 13173.9 13296.3 13349.3 13543.6 13902.7 13910.3 14065.7 10783.5 10783.5 10814.1 10857.3 10871.3 3258.3 3298.9 3303.3 3313.5 3404.2 50424.0 51721.2 52522.7 69733.0 71363.6 10427.6 10440.1 10463.6 10508.7 10696.6 17044.1 18455.3 18457.0 18479.3 18656.8 6828.1 7032.9 7056.4 7071.2 7078.9 3863.7 3872.3 3890.0 3910.7 3921.9 2811.6 2878.5 2923.6 2927.4 2932.5 499.1 504.6 505.3 506.1 507.8 585.0 595.4 601.9 612.5 618.0 8214.7 8239.8 8371.1 8377.1 8513.9 526.6 562.2 587.0 608.4 609.1 3911.9 3935.7 3961.3 4055.5 4253.2 92586.5 100562.5 101728.5 108211.5 108622.0 54547.0 60858.0 85909.6 87473.1 92288.0 80695.0 82768.0 83074.0 83113.0 83535.0 7622.6 7708.2 7818.7 7878.5 8003.1 43297.4 46810.3 46918.5 47827.3 48199.3 68999.7 71032.0 72525.0 72634.6 72764.3 9828.8 9988.2 10037.9 10050.4 10283.6 11511.8 11597.2 11858.1 11973.9 12001.5 10510.5 10696.3 10839.5 11035.9 11194.9 9753.3 9762.4 10436.6 10776.4 11501.3 9896.8 10963.7 11213.4 11243.4 11309.5 8531.3 8844.2 9337.0 9668.7 9729.9 9176.5 9300.0 9368.6 9374.0 9575.5 11:41:15 INFO - PROCESS | 3862 | -------- Summary: end -------- 11:41:15 INFO - PROCESS | 3862 | 11:41:16 INFO - TEST-INFO | 3862: exit 0 11:41:16 INFO - TEST-OK | dromaeo_css | took 1117314ms 11:41:16 INFO - TEST-START | kraken 11:41:16 INFO - operating with platform_type : linux_ 11:41:16 INFO - Initialising browser for kraken test... 11:41:16 INFO - TEST-INFO | started process 4217 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5l1nR7/profile http://localhost:33570/getInfo.html) 11:41:20 INFO - PROCESS | 4217 | __metrics Screen width/height:1600/1200 11:41:20 INFO - PROCESS | 4217 | colorDepth:24 11:41:20 INFO - PROCESS | 4217 | Browser inner width/height: 1024/697 11:41:20 INFO - PROCESS | 4217 | __metrics 11:41:21 ERROR - PROCESS | 4217 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 11:41:22 INFO - TEST-INFO | 4217: exit 0 11:41:22 INFO - Browser initialized. 11:41:22 INFO - Running cycle 1/1 for kraken test... 11:41:22 INFO - TEST-INFO | started process 4334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5l1nR7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:34 INFO - PROCESS | 4334 | RSS: Main: 163565568 11:41:34 INFO - PROCESS | 4334 | 11:41:37 INFO - PROCESS | 4334 | Cycle 1(1): loaded http://localhost:33570/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33570/tests/kraken/driver.html?testName=audio-beat-detection) 11:41:38 INFO - PROCESS | 4334 | RSS: Main: 168374272 11:41:38 INFO - PROCESS | 4334 | 11:41:40 INFO - PROCESS | 4334 | Cycle 1(1): loaded http://localhost:33570/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33570/tests/kraken/driver.html?testName=audio-dft) 11:41:41 INFO - PROCESS | 4334 | RSS: Main: 167645184 11:41:41 INFO - PROCESS | 4334 | 11:41:44 INFO - PROCESS | 4334 | Cycle 1(1): loaded http://localhost:33570/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33570/tests/kraken/driver.html?testName=audio-fft) 11:41:45 INFO - PROCESS | 4334 | RSS: Main: 163749888 11:41:45 INFO - PROCESS | 4334 | 11:41:47 INFO - PROCESS | 4334 | Cycle 1(1): loaded http://localhost:33570/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33570/tests/kraken/driver.html?testName=audio-oscillator) 11:41:47 INFO - PROCESS | 4334 | RSS: Main: 164327424 11:41:48 INFO - PROCESS | 4334 | 11:41:50 INFO - PROCESS | 4334 | Cycle 1(1): loaded http://localhost:33570/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33570/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:41:50 INFO - PROCESS | 4334 | RSS: Main: 164462592 11:41:50 INFO - PROCESS | 4334 | 11:41:54 INFO - PROCESS | 4334 | Cycle 1(1): loaded http://localhost:33570/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33570/tests/kraken/driver.html?testName=imaging-darkroom) 11:41:54 INFO - PROCESS | 4334 | RSS: Main: 164671488 11:41:54 INFO - PROCESS | 4334 | 11:41:58 INFO - PROCESS | 4334 | Cycle 1(1): loaded http://localhost:33570/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33570/tests/kraken/driver.html?testName=imaging-desaturate) 11:41:58 INFO - PROCESS | 4334 | RSS: Main: 161972224 11:41:58 INFO - PROCESS | 4334 | 11:42:01 INFO - PROCESS | 4334 | Cycle 1(1): loaded http://localhost:33570/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33570/tests/kraken/driver.html?testName=json-parse-financial) 11:42:02 INFO - PROCESS | 4334 | RSS: Main: 164507648 11:42:02 INFO - PROCESS | 4334 | 11:42:04 INFO - PROCESS | 4334 | Cycle 1(1): loaded http://localhost:33570/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33570/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:04 INFO - PROCESS | 4334 | RSS: Main: 164294656 11:42:04 INFO - PROCESS | 4334 | 11:42:06 INFO - PROCESS | 4334 | Cycle 1(1): loaded http://localhost:33570/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33570/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:42:07 INFO - PROCESS | 4334 | RSS: Main: 164683776 11:42:07 INFO - PROCESS | 4334 | 11:42:09 INFO - PROCESS | 4334 | Cycle 1(1): loaded http://localhost:33570/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33570/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:42:10 INFO - PROCESS | 4334 | RSS: Main: 165433344 11:42:10 INFO - PROCESS | 4334 | 11:42:13 INFO - PROCESS | 4334 | Cycle 1(1): loaded http://localhost:33570/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:42:13 INFO - PROCESS | 4334 | RSS: Main: 165515264 11:42:13 INFO - PROCESS | 4334 | 11:42:16 INFO - PROCESS | 4334 | Cycle 1(1): loaded http://localhost:33570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:42:17 INFO - PROCESS | 4334 | RSS: Main: 165482496 11:42:17 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | Cycle 1(1): loaded http://localhost:33570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33570/tests/kraken/driver.html?testName=ai-astar) 11:42:19 INFO - PROCESS | 4334 | RSS: Main: 165998592 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | __start_tp_report 11:42:19 INFO - PROCESS | 4334 | _x_x_mozilla_page_load 11:42:19 INFO - PROCESS | 4334 | _x_x_mozilla_page_load_details 11:42:19 INFO - PROCESS | 4334 | |i|pagename|runs| 11:42:19 INFO - PROCESS | 4334 | |0;ai-astar;103;114;110;117;115;115;117;116;115;116 11:42:19 INFO - PROCESS | 4334 | |1;audio-beat-detection;158;124;151;190;123;150;146;125;193;122 11:42:19 INFO - PROCESS | 4334 | |2;audio-dft;163;165;166;170;162;163;163;163;161;162 11:42:19 INFO - PROCESS | 4334 | |3;audio-fft;75;77;78;180;78;76;76;77;156;77 11:42:19 INFO - PROCESS | 4334 | |4;audio-oscillator;85;84;153;86;86;86;132;85;86;140 11:42:19 INFO - PROCESS | 4334 | |5;imaging-gaussian-blur;117;119;118;118;118;118;119;118;121;118 11:42:19 INFO - PROCESS | 4334 | |6;imaging-darkroom;151;148;147;148;148;150;147;150;148;147 11:42:19 INFO - PROCESS | 4334 | |7;imaging-desaturate;96;96;96;95;97;96;96;97;97;96 11:42:19 INFO - PROCESS | 4334 | |8;json-parse-financial;68;64;64;65;66;65;64;65;65;64 11:42:19 INFO - PROCESS | 4334 | |9;json-stringify-tinderbox;65;66;66;66;65;66;66;66;66;68 11:42:19 INFO - PROCESS | 4334 | |10;stanford-crypto-aes;81;87;81;80;80;80;79;79;83;80 11:42:19 INFO - PROCESS | 4334 | |11;stanford-crypto-ccm;132;131;138;132;130;140;150;150;151;142 11:42:19 INFO - PROCESS | 4334 | |12;stanford-crypto-pbkdf2;167;170;168;172;168;167;175;171;172;174 11:42:19 INFO - PROCESS | 4334 | |13;stanford-crypto-sha256-iterative;69;70;68;69;74;70;69;69;68;68 11:42:19 INFO - PROCESS | 4334 | __end_tp_report 11:42:19 INFO - PROCESS | 4334 | __start_cc_report 11:42:19 INFO - PROCESS | 4334 | _x_x_mozilla_cycle_collect,941 11:42:19 INFO - PROCESS | 4334 | __end_cc_report 11:42:19 INFO - PROCESS | 4334 | __startTimestamp1470940939357__endTimestamp 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | ------- Summary: start ------- 11:42:19 INFO - PROCESS | 4334 | Number of tests: 14 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.50 stddev:4.29 (3.7%) stddev-sans-first:2.12 11:42:19 INFO - PROCESS | 4334 | Values: 103.0 114.0 110.0 117.0 115.0 115.0 117.0 116.0 115.0 116.0 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:150.50 stddev:26.48 (17.6%) stddev-sans-first:27.85 11:42:19 INFO - PROCESS | 4334 | Values: 158.0 124.0 151.0 190.0 123.0 150.0 146.0 125.0 193.0 122.0 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:2.62 (1.6%) stddev-sans-first:2.76 11:42:19 INFO - PROCESS | 4334 | Values: 163.0 165.0 166.0 170.0 162.0 163.0 163.0 163.0 161.0 162.0 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | [#3] audio-fft Cycles:10 Average:95.00 Median:77.00 stddev:38.90 (50.5%) stddev-sans-first:40.58 11:42:19 INFO - PROCESS | 4334 | Values: 75.0 77.0 78.0 180.0 78.0 76.0 76.0 77.0 156.0 77.0 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:85.50 stddev:27.63 (32.3%) stddev-sans-first:28.59 11:42:19 INFO - PROCESS | 4334 | Values: 85.0 84.0 153.0 86.0 86.0 86.0 132.0 85.0 86.0 140.0 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:1.07 (0.9%) stddev-sans-first:1.01 11:42:19 INFO - PROCESS | 4334 | Values: 117.0 119.0 118.0 118.0 118.0 118.0 119.0 118.0 121.0 118.0 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:1.43 (1.0%) stddev-sans-first:1.17 11:42:19 INFO - PROCESS | 4334 | Values: 151.0 148.0 147.0 148.0 148.0 150.0 147.0 150.0 148.0 147.0 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:42:19 INFO - PROCESS | 4334 | Values: 96.0 96.0 96.0 95.0 97.0 96.0 96.0 97.0 97.0 96.0 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:1.25 (1.9%) stddev-sans-first:0.71 11:42:19 INFO - PROCESS | 4334 | Values: 68.0 64.0 64.0 65.0 66.0 65.0 64.0 65.0 65.0 64.0 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 11:42:19 INFO - PROCESS | 4334 | Values: 65.0 66.0 66.0 66.0 65.0 66.0 66.0 66.0 66.0 68.0 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.50 stddev:2.40 (3.0%) stddev-sans-first:2.55 11:42:19 INFO - PROCESS | 4334 | Values: 81.0 87.0 81.0 80.0 80.0 80.0 79.0 79.0 83.0 80.0 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:141.00 stddev:8.41 (6.0%) stddev-sans-first:8.46 11:42:19 INFO - PROCESS | 4334 | Values: 132.0 131.0 138.0 132.0 130.0 140.0 150.0 150.0 151.0 142.0 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.50 stddev:2.88 (1.7%) stddev-sans-first:2.77 11:42:19 INFO - PROCESS | 4334 | Values: 167.0 170.0 168.0 172.0 168.0 167.0 175.0 171.0 172.0 174.0 11:42:19 INFO - PROCESS | 4334 | 11:42:19 INFO - PROCESS | 4334 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.00 stddev:1.78 (2.6%) stddev-sans-first:1.88 11:42:19 INFO - PROCESS | 4334 | Values: 69.0 70.0 68.0 69.0 74.0 70.0 69.0 69.0 68.0 68.0 11:42:19 INFO - PROCESS | 4334 | -------- Summary: end -------- 11:42:19 INFO - PROCESS | 4334 | 11:42:20 INFO - TEST-INFO | 4334: exit 0 11:42:20 INFO - TEST-OK | kraken | took 64415ms 11:42:20 INFO - SUITE-END | took 1181s 11:42:20 INFO - Completed test suite (00:19:41) 11:42:20 INFO - javascript benchmark 11:42:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6325.708149304904, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2675.759181673649, 2686.502996945564, 2711.932201694958, 2724.5368287391143, 2739.068716636343, 4718.9056218875685, 4947.9257811132775, 4948.529889660481, 4998.400191976959, 5004.999000199961, 4882.584980276672, 4906.632002599801, 4958.553730164284, 4963.305137280783, 4967.155583550796, 4488.214562451566, 4583.060472603109, 4605.332226827125, 4635.466921304042, 4712.387389639359, 4635.93046104307, 4657.51096134906, 4672.345871577965, 4685.133250348679, 4703.764811759415, 4329.112531930947, 4497.9775101124615, 4506.143832671782, 4553.817847286121, 4562.543745625444, 4493.662975276868, 4529.230030894756, 4564.908701825978, 4605.861824145281, 4628.190066738307, 4543.727376357396, 4543.909121817578, 4555.362249285103, 4562.589366956957, 4579.129965306614, 4736.407949006374, 4818.975905120487, 4883.19427294496, 4949.034938187055, 4950.579200767903, 5237.292965449692, 5273.419923808378, 5297.735113244323, 5311.681299122027, 5318.893622127574, 5274.604404669627, 5302.761375738101, 5311.309529761145, 5321.175217841241, 5378.273933019032, 4716.151092803259, 4842.975785121052, 4890.997345544155, 4905.950940490549, 4915.729634870117, 5360.222767698662, 5395.62230643859, 5397.163439666858, 5446.183072539151, 5453.427390123979, 5160.561352285098, 5174.456682048331, 5182.53357197854, 5185.274061631375, 5232.686038837605, 5022.723750193702, 5101.668391554537, 5227.320448341768, 5237.450067742832, 5242.685438873604, 5138.2806407103035, 5151.201563757623, 5170.457102004236, 5221.660592061504, 5235.371755389301, 5097.260897169889, 5104.081265372194, 5105.387353517527, 5105.846824595268, 5188.22176673502, 4260.637845783143, 4328.48058233014, 4397.340398940185, 4417.624501917373, 4462.44219472566, 3801.068738159169, 3845.057960799622, 3856.2094770571966, 3907.199024200089, 3951.9527325258828, 4464.910701785946, 4496.572825581565, 4510.436195475566, 4528.547145285511, 4541.2733962565835, 5183.5593974512585, 5201.349831271091, 5216.869578260498, 5218.478152184751, 5296.523312901781, 4386.298192289219, 4470.552944705503, 4501.324801279834, 4535.659825513034, 4549.977250113729, 4761.833335833229, 4770.189067858472, 4770.642201834877, 4800.4719480857075, 4810.302506136661, 4912.828051018198, 4935.111679897581, 4936.432310284364, 4947.628927830499, 4982.601391888567, 4954.777035033504, 5150.201718733602, 5203.661761985459, 5226.790928362823, 5302.496262855023, 4846.588040016497, 4862.100511405401, 4894.437139728834, 4931.3589233399425, 4933.112039832865, 5128.102582048052, 5132.409772876167, 5134.640575159703, 5143.71709555963, 5147.742612869416, 5017.598592112695, 5188.922166167586, 5210.166373380241, 5219.373675159005, 5222.00781851447, 5074.289599456005, 5099.643024988363, 5104.591632669451, 5113.7187454688865, 5115.411727651368, 5081.415637201769, 5082.771275292546, 5102.1326374515675, 5102.2346648003095, 5139.948600513947, 4770.642201834807, 4903.33804936329, 4990.625703072212, 5011.874703132451, 5020.824271150492, 5163.070647283525, 5169.121249387688, 5170.043541944752, 5183.948160518346, 5219.347581552306, 4986.376702912136, 5030.4718004608985, 5061.316722242597, 5063.822766203165, 5086.18621020635], "value": 4809.428580879823, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.8828446026334, 561.2311133746765, 567.8693900402907, 571.8884817460594, 585.3385674188166, 33877.66122338776, 38443.42334864979, 38455.80772096143, 38574.42138367927, 38585.42121868171, 38686.4197037044, 39302.606973930255, 39313.606863931425, 39357.803210983904, 39486.21027579454, 7581.128170260436, 7767.262110099531, 7770.261825126604, 7772.494787838772, 7777.572233527154, 7607.505512141721, 7656.425768067389, 7677.884831727529, 7685.577293248869, 7690.077190737119, 7724.1889601591865, 7737.961310193469, 7757.379409647243, 7759.418043646749, 7767.6892924282965, 7648.579328136951, 7667.079950405959, 7674.386049116058, 7675.347595454393, 7723.459357844925, 7742.922570774276, 7836.921630783676, 7839.333656639135, 7856.332211762007, 7861.174576669425, 36789.080272993124, 36814.8159259202, 37105.44341834875, 37132.07169820749, 37134.25731485382, 3192.4892017277125, 3345.531625572422, 3492.4062909305226, 3715.2755212733528, 3832.7317087803863, 28881.42237155245, 29149.125526234246, 29396.70603293961, 29641.110766677033, 29724.256893577618, 3215.067630387185, 3217.404780115686, 3246.675332466758, 3276.836158192105, 3328.9334213315597, 256481.0, 256954.0, 257472.0, 257955.0, 259024.9999999981, 51642.22536661953, 51659.48340516622, 51966.22050669243, 52227.73886130621, 52300.47699522956, 54268.72865635646, 54390.72804636031, 54507.18239226415, 54582.45417545774, 54635.0, 13602.659933501543, 14066.156030638194, 14449.422023119168, 14456.421743130157, 14464.566063018126, 11032.669019929415, 11081.390523521284, 11111.111111111091, 11117.555297787998, 11147.944260278648, 17704.82295177032, 17896.0, 17939.73090403645, 17954.730679039825, 18145.911245325322, 6908.5509441886115, 6950.79147625572, 7046.929530704628, 7070.823229419306, 7193.676284567207, 831.5675848558836, 930.1024511346583, 958.4009993753904, 968.5399435268332, 1017.2421545948168, 28304.292392689935, 29032.11433833174, 29168.562471562942, 29192.708072919424, 29214.269643258664, 936.3492372800974, 956.0, 960.45958439926, 962.5379817687409, 983.6901376066517, 13700.24648644334, 14555.0, 14617.853821461862, 14625.707485850437, 14732.189729564763, 372560.0, 376949.0, 377163.0, 378807.0, 378866.0, 46395.0, 46940.29589556159, 47149.292760608616, 47188.2921756174, 47419.52580474151, 1159.5477763672175, 1173.6303064534645, 1193.4808358364312, 1206.9517219311306, 1215.2526196389158, 25927.092551760597, 26404.73595264023, 26906.59640105439, 27409.451810964067, 27486.725132748415, 40683.0, 41198.79400602978, 41361.0, 41469.377959331236, 41557.79221103875, 345033.0, 345977.0, 347752.0, 348677.0, 348896.0, 24729.381765456008, 25123.497530049663, 25400.237992860242, 25901.740982589934, 25985.35036624024, 41243.7937810309, 41301.79349103235, 41387.7930610345, 42018.36972445354, 42238.788806055774, 35525.28949421049, 36314.8184259077, 36371.090722732144, 36543.63456365402, 36578.8171059143, 35419.29161416809, 35638.465423018155, 35681.28637427289, 36150.63849361578, 36206.637933620324, 34686.65313346834, 34714.30571388609, 35032.82483587566, 35051.29897402089, 35628.82185589056, 30397.0, 32701.345973080883, 32923.34153316968, 32981.17547061247, 33036.17409564684, 24869.62695559532, 25461.490770184864, 25482.617760733232, 25551.041920455024, 25551.616725748758], "value": 17452.653537512015, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.8140685436718, 358.8797752752828, 361.5950135847851, 371.7490693781697, 380.2110620462539, 15787.763183552255, 16463.341466341346, 17463.126843657814, 17469.3012279509, 17548.82451175488, 16632.25154868031, 16673.41643042494, 17028.404005859797, 17235.224414901328, 17341.132943352844, 4837.879053023685, 5067.6452648314635, 5084.3136176616235, 5086.847394578169, 5091.719955402451, 3782.7919464429447, 4964.950350496485, 5909.615874968134, 6211.689415529228, 6228.252609686821, 6199.566030377875, 6246.687665616723, 6254.9374506255035, 6283.02613094971, 6294.276158241815, 5776.422357764211, 5881.617694849821, 5912.172295878538, 5913.113033045056, 5920.615160014607, 5103.362079740033, 5184.170532714786, 5188.870278243036, 5191.091558977164, 5391.649542779707, 20647.89676051625, 20664.58670826575, 20781.89609051945, 20789.272375466786, 21111.366659000254, 1873.063468265867, 1950.8146726061002, 2033.6542787726123, 2043.4176259765895, 2128.616848967201, 6246.906296405512, 6407.583507072025, 6767.120274364351, 13471.932640336834, 13614.659633509142, 1714.7942246930324, 1733.7486064520574, 1738.400251913088, 1801.702719051355, 1815.6731788278105, 63964.360356396304, 64451.35548644547, 65539.67230163819, 67538.32461675418, 67627.0, 9579.13787759105, 10187.0, 10238.436885971194, 10316.793664126675, 10337.586496540205, 13684.247366394944, 13856.653583660489, 13878.306084695725, 13896.374663140183, 13905.304734763222, 7188.813417524866, 7303.936898432889, 7314.305141011595, 7362.226966168582, 7502.887456688154, 6894.482913781487, 7004.124484439445, 7248.6738096785775, 7276.199618042011, 7316.231795661379, 4221.156676762178, 4295.248331541968, 4341.435613370241, 4445.711028783118, 4458.866234012985, 1733.7832770903638, 1762.6739053275185, 1775.849052830524, 1812.0, 1825.4210108256264, 331.32905865621825, 356.4706410979693, 357.65128999225544, 365.66906949211005, 773.880048592469, 9576.521173941414, 9812.165965892978, 9855.507224638883, 10015.549300281506, 10124.190064794799, 364.7701947772886, 374.87441707027904, 376.7306375941215, 381.1785602027635, 381.9942700859489, 5116.820911268088, 5179.223116532475, 5259.606204355849, 5300.708461034603, 5320.334958130234, 376007.0, 376815.0, 395416.0, 407631.0, 420818.0, 81047.59476202581, 81874.0, 82422.0, 82902.0, 85276.0, 411.0627768687398, 415.3147306943507, 416.9749815011109, 418.1219439177763, 418.17201940158657, 9711.9028809711, 9970.0, 9979.45113018791, 10090.69727908164, 10363.378197308186, 36696.81651591725, 38201.23597528089, 38300.23399531938, 38588.42117368298, 38646.2270754589, 49068.50931490639, 51049.23426148685, 53824.46175538195, 54253.18620220621, 55335.0, 7594.696212151452, 7695.961520192363, 7888.84222315539, 7906.644201010853, 8307.418480706292, 9454.95272523633, 10121.797564048826, 12318.076144289034, 12711.0, 13100.213987160801, 10243.334183278062, 10618.309809862334, 10923.399213043358, 11112.777744444904, 11220.438978051228, 9893.505324733878, 10180.949095254477, 10533.210009249184, 10778.89221107779, 10805.675829725122, 10212.591496340063, 10335.638252661121, 10636.149108071491, 10858.782824343627, 11076.39079850616, 7629.961850190713, 7751.147373788992, 7857.16426708767, 7875.173106823701, 7978.720744773905, 9674.177694896012, 10823.891761082288, 10846.13230941507, 10889.074428673652, 10979.39613321275], "value": 7488.112869275775, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.5689007962487, 1412.5479846449136, 1466.691994681117, 1574.3623832347903, 1603.6872809802094, 6590.472762179026, 7183.820404489884, 7475.700971961129, 7828.921710782884, 7833.843323133534, 7472.775816725507, 7739.458237923348, 7745.922540774604, 7746.0317460317465, 7751.806204844882, 2156.827453803696, 2188.2341180586827, 2188.5513469738667, 2189.868607883524, 2191.7260342457193, 2110.577884423114, 2126.2345555599973, 2203.294945617403, 2209.3371988403414, 2210.2927063339657, 2169.457635591102, 2174.913003479859, 2181.334692918659, 2188.245055455865, 2200.6038912995655, 2132.6907598398225, 2141.186349187307, 2142.368001439579, 2142.4322554523064, 2142.860714053589, 2065.7211276477633, 2127.457498337914, 2130.446084018151, 2133.4879628888957, 2136.0387825478597, 7674.654640541189, 7751.7674469766, 7759.418043646692, 7773.339266162383, 7816.687332506693, 4394.538573449806, 4536.56902594253, 4539.0694907543875, 4551.067031258584, 4560.224761790503, 2875.324298789783, 2886.379428422878, 2902.274431392152, 2976.9851150744107, 3051.2676957530257, 931.7670582354411, 959.9664011759555, 990.8959559246248, 1006.0693858181227, 1007.496251874063, 10272.743181420525, 10273.589056437733, 10278.794424111551, 10324.58701651933, 10385.273030887842, 3791.260704162717, 3918.6669133124005, 4067.7152599318356, 4068.3287257602756, 4115.32097203964, 8737.344699147588, 8803.691870784492, 8812.559372031501, 8844.248238899765, 8853.601587928559, 4458.777061146994, 4482.7448314472, 4492.483364413069, 4497.302918047708, 4512.0, 3392.4741665041956, 3924.9803750981064, 4036.858709945138, 4069.2268468991388, 4070.3283958147167, 3519.278547897675, 3576.7138628909624, 3605.963940360615, 3652.7443078984747, 3778.2254637799183, 1164.0512981919708, 1165.6444784340688, 1176.1766763265578, 1177.8704342522315, 1184.7689700508317, 796.4066770256196, 839.3075712537182, 842.0568962761746, 853.185208126238, 855.9358048146414, 5021.72380519075, 5148.279240906276, 5240.659357141773, 5262.684238945675, 5265.0, 397.0589702405318, 408.7772164170534, 422.55420531339115, 424.5012110769833, 426.3221477850233, 3472.791632502058, 3511.1924257420937, 3520.964790352115, 3552.964470355315, 3661.5972243053243, 8967.327450441113, 9381.484018379055, 9405.482698451515, 9407.764805879771, 9408.952955235316, 8947.239484643747, 9331.0, 9374.390664606915, 9404.294677899048, 9629.614815407445, 7185.209626941032, 7354.963225183947, 7377.81555461107, 7387.741429049957, 7419.2209817969415, 4959.107360675113, 5122.590192784493, 5145.331106956071, 5197.870053248699, 5249.6062795289745, 8496.490210587384, 8672.913270867211, 8740.08229135957, 8782.604782784661, 8823.558822058743, 8677.349198809989, 8827.955860220658, 8829.69096081634, 8935.463872167691, 8982.281417486454, 5688.0, 6343.143675603735, 6575.835604109936, 6597.901031484627, 6756.391924726601, 7184.137903451619, 7264.128304603481, 7273.418126549969, 7296.854062918605, 7301.196868344584, 6645.235797883305, 6760.661966901734, 6788.1175447191545, 6950.270221626656, 6980.930190698231, 6626.27111017778, 6647.534672573067, 6729.596224226562, 6816.931830681629, 6866.896996544956, 6208.751649933952, 6294.905576416266, 6321.1782468278825, 6328.557001009885, 6336.7148478319505, 4545.818167273272, 4557.339185818104, 4609.562091601292, 4625.121226966866, 4633.606143477842, 4514.887127821699, 4587.61005314552, 4603.93094103582, 4678.017616300615, 4710.764461776829], "value": 4006.178249142979, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.4265277507498, 287.32048704813116, 287.9352145767203, 294.0619424037321, 294.54051679380154, 4940.56723550171, 5068.391792984838, 5112.156494178461, 5215.374155101388, 5256.421793602701, 5073.518015788494, 5093.847184584469, 5101.0, 5106.234064890268, 5106.5148810863, 4010.6991975601873, 4024.1951609678035, 4029.066048296819, 4054.6756259499316, 4055.3308704063793, 3961.267165574378, 4036.919261614766, 4060.2894493463527, 4072.36878283865, 4074.9185016299657, 3992.960070399288, 4000.8599699010542, 4001.839926402955, 4006.4991876015497, 4010.418489319047, 3988.601139886003, 4010.3984402339593, 4019.4573732546023, 4025.5041874037993, 4044.1911617676583, 3533.328667553182, 3538.4161613333767, 3543.3090547343277, 3553.875614353511, 3572.5355703758346, 4772.95227047732, 4935.777889994959, 4979.253112033188, 4992.600591952635, 5099.541041306263, 4596.448426188846, 4599.678022538424, 4606.147862645388, 4606.562376574254, 4619.468761092484, 5291.523762861322, 5294.735263236823, 5321.521063104339, 5360.463953604608, 5363.410024897258, 3716.5168528091176, 3830.9616903830884, 3841.2893614681093, 3861.401482770147, 3869.7036492774955, 5589.608727389084, 5598.748056337475, 5613.354464236624, 5616.634918730269, 5660.433956604306, 3964.4647972523917, 3973.7615743055508, 3980.2238563480423, 3982.0, 3983.48214732083, 3711.7030637548933, 3863.2273545291055, 4039.6162364575316, 4046.7571945683353, 4048.8785336439955, 4421.314696222091, 4445.9996500787065, 4463.085067561142, 4478.745951133687, 4480.4623445186135, 5299.4435584263865, 5342.171963345688, 5350.91973620396, 5400.270963419888, 5410.215518749838, 1304.7194853106628, 1341.818854454636, 1347.2051489621172, 1365.2286458151113, 1377.4490203918313, 911.8267529169436, 928.6656803550717, 954.4130359828655, 954.4798085043668, 958.91849192818, 4619.9076018479445, 4630.259158534685, 4636.35091087248, 4636.562665573683, 4657.5575320344515, 5417.214503896913, 5434.918476222781, 5436.864078397993, 5463.470228336072, 5493.368262649767, 4447.777611119431, 4619.445666520039, 4644.373009643655, 4668.719876807402, 4680.765961701902, 2523.58360870458, 2533.4173140177863, 2560.385507478192, 2576.9355766105623, 2590.740925907432, 4490.236659767847, 4511.413516242867, 4516.706414083074, 4525.094981003813, 4572.416584629674, 4655.301704744248, 4897.461279259279, 4900.093482705711, 4910.312556242129, 4930.9506904930495, 4427.380166776589, 4438.556144385536, 4451.421315228999, 4451.577100175543, 4457.531959144373, 4740.0, 4741.866160227843, 4754.478566858572, 4780.378550788514, 4853.223484242504, 4654.299157850528, 4670.524621950236, 4676.176291246348, 4718.9854181351175, 4719.2921061841, 4288.549702281341, 4422.557744225552, 4442.333649952533, 4459.862735002554, 4463.977680111579, 3477.61746207922, 3538.4869193967247, 3579.6957258633306, 3583.9283214336087, 3585.3725598020765, 4820.325154478306, 4827.80334947605, 4832.081904438145, 4838.395200599925, 5261.394939581844, 5272.182811664198, 5291.470852914677, 5375.489328513785, 5409.432009638931, 5425.267588875451, 5270.628217302306, 5281.498257665516, 5286.656367336111, 5295.232191332312, 5296.682199068068, 5085.0, 5196.558292545024, 5203.710367438315, 5245.475452454877, 5287.57699384056, 5359.785608575613, 5387.81142660005, 5388.299521062237, 5397.595180361567, 5408.405075441777, 5238.76425560843, 5283.656562323436, 5313.628046036895, 5319.787208511616, 5327.227552005015], "value": 3896.831610590117, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.9078928949947, 685.7565564224703, 722.9313215244551, 746.1568427676724, 751.3575892611814, 13026.218426894382, 13647.795283070736, 13720.245386503739, 13738.587842364745, 13878.444862205512, 13327.0, 13348.199108053499, 13367.465301387958, 13606.659833504142, 13761.142245796815, 751.3350684644103, 778.1207235823512, 781.1641543548405, 781.6013832945182, 782.3662833105203, 634.0489266100849, 719.8380364418016, 730.2150188547333, 761.9314261716445, 782.5187509681533, 813.4346629092753, 818.251300060444, 820.2371794231362, 820.9343252539812, 822.8272062866805, 808.2079562029215, 812.5409143833715, 813.1583810755899, 814.3932770086294, 816.1593558634556, 597.7549204826, 597.7877853362037, 597.8385835824347, 599.1342510072947, 599.3407252022783, 13063.281519516519, 13111.082224244306, 13145.934270328682, 13173.868261317455, 13296.26870522121, 13349.332533373292, 13543.59369218925, 13902.721945561032, 13910.304484775721, 14065.71868562623, 10783.46082695862, 10783.514741836636, 10814.134869210444, 10857.294275872044, 10871.29336593119, 3258.2994656148803, 3298.884539041122, 3303.273279878447, 3313.5361049453095, 3404.2340473393538, 50424.0, 51721.224181637306, 52522.73738631282, 69733.0, 71363.64318178428, 10427.5828966842, 10440.112590429746, 10463.581456741797, 10508.737281568023, 10696.62561810333, 17044.14779261032, 18455.261789528537, 18457.0, 18479.260829566665, 18656.813431865507, 6828.112345395166, 7032.859342813115, 7056.400205982549, 7071.222165561784, 7078.929210707827, 3863.690904727615, 3872.302985462644, 3890.0, 3910.687145028391, 3921.941170882439, 2811.620431241797, 2878.5250433678625, 2923.63454568179, 2927.443785680714, 2932.5307950728206, 499.0966350904801, 504.6215338496128, 505.32034413713495, 506.07641055074635, 507.79434329096773, 584.9766009359663, 595.3629616310507, 601.8615718384796, 612.543654977045, 618.0, 8214.712485063113, 8239.794005149919, 8371.121032291643, 8377.120402357787, 8513.914860851437, 526.6339893773867, 562.2409746841731, 586.9589128761031, 608.3703367015119, 609.1289456077762, 3911.882643520699, 3935.665468435158, 3961.3265744823448, 4055.4930633670792, 4253.213155566168, 92586.53706731558, 100562.49718751505, 101728.49135754422, 108211.45894270636, 108622.0, 54547.0, 60858.0, 85909.57045214734, 87473.1252687465, 92288.0, 80695.0, 82768.0, 83074.0, 83113.0, 83535.0, 7622.618869056414, 7708.190639982721, 7818.687252509836, 7878.527288362717, 8003.079645840803, 43297.35053974256, 46810.29784553302, 46918.53081469142, 47827.28259076047, 48199.27701084416, 68999.65500172669, 71032.0, 72525.0, 72634.63682681553, 72764.27235727575, 9828.803423931338, 9988.151007164182, 10037.949810251193, 10050.396976181453, 10283.588656453658, 11511.827322590001, 11597.18819682614, 11858.051355891335, 11973.940130299292, 12001.459934303151, 10510.474476276002, 10696.251262411557, 10839.512221949873, 11035.889641103486, 11194.888051119711, 9753.268504862306, 9762.36544624597, 10436.580469241579, 10776.353418794897, 11501.252418592765, 9896.802063958825, 10963.671089867317, 11213.383263920563, 11243.4378281084, 11309.547618095185, 8531.274841638531, 8844.204021638083, 9337.0, 9668.661596844076, 9729.9027009729, 9176.495292758962, 9299.953500232727, 9368.57841397125, 9374.0, 9575.473348965874], "value": 6528.870569368605, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 110.0, 117.0, 115.0, 115.0, 117.0, 116.0, 115.0, 116.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 151.0, 190.0, 123.0, 150.0, 146.0, 125.0, 193.0, 122.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 166.0, 170.0, 162.0, 163.0, 163.0, 163.0, 161.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 180.0, 78.0, 76.0, 76.0, 77.0, 156.0, 77.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 153.0, 86.0, 86.0, 86.0, 132.0, 85.0, 86.0, 140.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 121.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 147.0, 148.0, 148.0, 150.0, 147.0, 150.0, 148.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 64.0, 65.0, 66.0, 65.0, 64.0, 65.0, 65.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 68.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 87.0, 81.0, 80.0, 80.0, 80.0, 79.0, 79.0, 83.0, 80.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 138.0, 132.0, 130.0, 140.0, 150.0, 150.0, 151.0, 142.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 168.0, 172.0, 168.0, 167.0, 175.0, 171.0, 172.0, 174.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 68.0, 69.0, 74.0, 70.0, 69.0, 69.0, 68.0, 68.0], "value": 69.4, "unit": "score"}]}]} 11:42:20 INFO - Return code: 0 11:42:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:42:20 ERROR - # TBPL SUCCESS # 11:42:20 INFO - Running post-action listener: _resource_record_post_action 11:42:20 INFO - [mozharness: 2016-08-11 18:42:20.663957Z] Finished run-tests step (success) 11:42:20 INFO - Running post-run listener: _resource_record_post_run 11:42:20 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 408793088; Read time: 0; Write time: 346552 11:42:20 INFO - TinderboxPrint: CPU usage
13.4% 11:42:20 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:42:20 INFO - TinderboxPrint: I/O write bytes / time
408,793,088 / 346,552 11:42:20 INFO - TinderboxPrint: CPU idle
8,278.6 (86.6%) 11:42:20 INFO - TinderboxPrint: CPU user
1,224.5 (12.8%) 11:42:20 INFO - TinderboxPrint: Swap in / out
0 / 0 11:42:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114008064; Read time: 0; Write time: 107016 11:42:20 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 294785024; Read time: 0; Write time: 239536 11:42:21 INFO - Running post-run listener: _upload_blobber_files 11:42:21 INFO - Blob upload gear active. 11:42:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:42:21 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 11:42:21 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'] 11:42:21 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 11:42:21 INFO - (blobuploader) - INFO - Open directory for files ... 11:42:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:42:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:42:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:23 INFO - (blobuploader) - INFO - Done attempting. 11:42:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:42:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:42:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:27 INFO - (blobuploader) - INFO - Done attempting. 11:42:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:42:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:42:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:28 INFO - (blobuploader) - INFO - Done attempting. 11:42:28 INFO - (blobuploader) - INFO - Iteration through files over. 11:42:28 INFO - Return code: 0 11:42:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:42:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:42:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8fa4ea7bfc0c4b75c7c03ba38c9b577d7b847958e24b159206975c8b0e6055eace8875cb7048c14251568a7344561bf9c63eead31fc3148cdfdb9e8aa96566b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ad8b0f3a70d3f37752a695913f30c2ae666d68d74cac049a9ae584affee9926b9f9df317ffcbe349b8d069158b0ee0c94c4aee572735afcb6a3f5f0b8e2e1e01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f1213b1b4f988c053d733d2db2d1fe11484be0f90620a28b0a4f7653fc6aba481ad167535b04291834705212d8665988ceadd65fd94cac3475c62a5cf66a3363"} 11:42:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:42:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:42:28 INFO - Contents: 11:42:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8fa4ea7bfc0c4b75c7c03ba38c9b577d7b847958e24b159206975c8b0e6055eace8875cb7048c14251568a7344561bf9c63eead31fc3148cdfdb9e8aa96566b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ad8b0f3a70d3f37752a695913f30c2ae666d68d74cac049a9ae584affee9926b9f9df317ffcbe349b8d069158b0ee0c94c4aee572735afcb6a3f5f0b8e2e1e01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f1213b1b4f988c053d733d2db2d1fe11484be0f90620a28b0a4f7653fc6aba481ad167535b04291834705212d8665988ceadd65fd94cac3475c62a5cf66a3363"} 11:42:28 INFO - Running post-run listener: copy_logs_to_upload_dir 11:42:28 INFO - Copying logs to upload dir... 11:42:28 INFO - mkdir: /builds/slave/test/build/upload/logs 11:42:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.487828 ========= master_lag: 0.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-11 11:42:28.514967) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 11:42:28.518727) ========= 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=a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772 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/8fa4ea7bfc0c4b75c7c03ba38c9b577d7b847958e24b159206975c8b0e6055eace8875cb7048c14251568a7344561bf9c63eead31fc3148cdfdb9e8aa96566b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ad8b0f3a70d3f37752a695913f30c2ae666d68d74cac049a9ae584affee9926b9f9df317ffcbe349b8d069158b0ee0c94c4aee572735afcb6a3f5f0b8e2e1e01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f1213b1b4f988c053d733d2db2d1fe11484be0f90620a28b0a4f7653fc6aba481ad167535b04291834705212d8665988ceadd65fd94cac3475c62a5cf66a3363"} build_url:https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/BV0wKa80TUiHzFkolRKEsQ/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/8fa4ea7bfc0c4b75c7c03ba38c9b577d7b847958e24b159206975c8b0e6055eace8875cb7048c14251568a7344561bf9c63eead31fc3148cdfdb9e8aa96566b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ad8b0f3a70d3f37752a695913f30c2ae666d68d74cac049a9ae584affee9926b9f9df317ffcbe349b8d069158b0ee0c94c4aee572735afcb6a3f5f0b8e2e1e01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f1213b1b4f988c053d733d2db2d1fe11484be0f90620a28b0a4f7653fc6aba481ad167535b04291834705212d8665988ceadd65fd94cac3475c62a5cf66a3363"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 11:42:28.546568) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:42:28.546890) ========= 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=a0d2d2de893abaa8702a9954000001a7-1470939701.519213-315573772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 11:42:28.596398) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 11:42:28.596700) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 11:42:28.599079) ========= ========= Total master_lag: 0.58 =========