builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1471551436.14 results: success (0) buildid: 20160818123355 builduid: fe78a431ec07471699acb0c72bcf5f3b revision: 0c135a70a81ae0c7dd714ea93ff45300f69ad475 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 13:17:16.135895) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 13:17:16.136446) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 13:17:16.136810) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 13:17:16.149053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:17:16.149410) ========= 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=df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 13:17:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-08-18 13:17:16 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108242 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:17:16.270798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:17:16.271198) ========= 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=df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018875 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:17:16.321625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 13:17:16.322031) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0c135a70a81ae0c7dd714ea93ff45300f69ad475 --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 0c135a70a81ae0c7dd714ea93ff45300f69ad475 --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=df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 13:17:16,373 truncating revision to first 12 chars 2016-08-18 13:17:16,374 Setting DEBUG logging. 2016-08-18 13:17:16,374 attempt 1/10 2016-08-18 13:17:16,374 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0c135a70a81a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 13:17:17,741 unpacking tar archive at: autoland-0c135a70a81a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.696214 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 13:17:18.032914) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 13:17:18.033307) ========= script_repo_revision: 0c135a70a81ae0c7dd714ea93ff45300f69ad475 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 13:17:18.033861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 13:17:18.034200) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 13:17:18.043775) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-18 13:17:18.044328) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:17:18 INFO - MultiFileLogger online at 20160818 13:17:18 in /builds/slave/test 13:17:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 13:17:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:17:18 INFO - {'append_to_log': False, 13:17:18 INFO - 'base_work_dir': '/builds/slave/test', 13:17:18 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 13:17:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:17:18 INFO - 'branch': 'Autoland-Non-PGO', 13:17:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:17:18 INFO - 'config_files': ('talos/linux_config.py',), 13:17:18 INFO - 'default_actions': ('clobber', 13:17:18 INFO - 'read-buildbot-config', 13:17:18 INFO - 'download-and-extract', 13:17:18 INFO - 'populate-webroot', 13:17:18 INFO - 'create-virtualenv', 13:17:18 INFO - 'install', 13:17:18 INFO - 'run-tests'), 13:17:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:17:18 INFO - 'download_minidump_stackwalk': True, 13:17:18 INFO - 'download_symbols': 'ondemand', 13:17:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:17:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:17:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:17:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:17:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:17:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:17:18 INFO - 'installer_path': 'installer.exe', 13:17:18 INFO - 'log_level': 'info', 13:17:18 INFO - 'log_name': 'talos', 13:17:18 INFO - 'log_to_console': True, 13:17:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:17:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:17:18 INFO - 'opt_config_files': (), 13:17:18 INFO - 'pip_index': False, 13:17:18 INFO - 'sps_profile': False, 13:17:18 INFO - 'sps_profile_interval': 0, 13:17:18 INFO - 'suite': 'dromaeojs', 13:17:18 INFO - 'system_bits': '32', 13:17:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:17:18 INFO - 'title': 'talos-linux64-ix-021', 13:17:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:17:18 INFO - 'use_talos_json': True, 13:17:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:17:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:17:18 INFO - 'work_dir': 'build'} 13:17:18 INFO - [mozharness: 2016-08-18 20:17:18.198019Z] Running clobber step. 13:17:18 INFO - Running pre-action listener: _resource_record_pre_action 13:17:18 INFO - Running main action method: clobber 13:17:18 INFO - rmtree: /builds/slave/test/build 13:17:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:17:19 INFO - Running post-action listener: _resource_record_post_action 13:17:19 INFO - [mozharness: 2016-08-18 20:17:19.169481Z] Finished clobber step (success) 13:17:19 INFO - [mozharness: 2016-08-18 20:17:19.169583Z] Running read-buildbot-config step. 13:17:19 INFO - Running pre-action listener: _resource_record_pre_action 13:17:19 INFO - Running main action method: read_buildbot_config 13:17:19 INFO - Using buildbot properties: 13:17:19 INFO - { 13:17:19 INFO - "project": "", 13:17:19 INFO - "product": "firefox", 13:17:19 INFO - "script_repo_revision": "production", 13:17:19 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 13:17:19 INFO - "repository": "", 13:17:19 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 13:17:19 INFO - "buildid": "20160818123355", 13:17:19 INFO - "pgo_build": "False", 13:17:19 INFO - "basedir": "/builds/slave/test", 13:17:19 INFO - "buildnumber": 280, 13:17:19 INFO - "slavename": "talos-linux64-ix-021", 13:17:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:17:19 INFO - "platform": "ubuntu64_hw", 13:17:19 INFO - "scheduler": "tests-autoland-linux64-talos", 13:17:19 INFO - "branch": "autoland", 13:17:19 INFO - "repo_path": "integration/autoland", 13:17:19 INFO - "revision": "0c135a70a81ae0c7dd714ea93ff45300f69ad475", 13:17:19 INFO - "stage_platform": "linux64", 13:17:19 INFO - "builduid": "fe78a431ec07471699acb0c72bcf5f3b", 13:17:19 INFO - "slavebuilddir": "test" 13:17:19 INFO - } 13:17:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 13:17:19 INFO - Running post-action listener: _resource_record_post_action 13:17:19 INFO - [mozharness: 2016-08-18 20:17:19.171966Z] Finished read-buildbot-config step (success) 13:17:19 INFO - [mozharness: 2016-08-18 20:17:19.172052Z] Running download-and-extract step. 13:17:19 INFO - Running pre-action listener: _resource_record_pre_action 13:17:19 INFO - Running main action method: download_and_extract 13:17:19 INFO - mkdir: /builds/slave/test/build/tests 13:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:19 INFO - trying https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:17:19 INFO - Downloading https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/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 13:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/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 13:17:19 INFO - Downloaded 1361 bytes. 13:17:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:17:19 INFO - Using the following test package requirements: 13:17:19 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:17:19 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:17:19 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:17:19 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'jsshell-linux-x86_64.zip'], 13:17:19 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:17:19 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:17:19 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:17:19 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:17:19 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:17:19 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:17:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:17:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:19 INFO - trying https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:17:19 INFO - Downloading https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/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 13:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/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 13:17:20 INFO - Downloaded 20317883 bytes. 13:17:20 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 13:17:25 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 13:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:25 INFO - trying https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:17:25 INFO - Downloading https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/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 13:17:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/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 13:17:25 INFO - Downloaded 20317883 bytes. 13:17:25 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 13:17:30 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')]} 13:17:30 INFO - trying https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:17:30 INFO - Downloading https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/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 13:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/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 13:17:31 INFO - Downloaded 14413981 bytes. 13:17:31 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 13:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:31 INFO - trying https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:17:31 INFO - Downloading https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/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 13:17:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/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 13:17:32 INFO - Downloaded 55768878 bytes. 13:17:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:17:32 INFO - mkdir: /builds/slave/test/properties 13:17:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:17:32 INFO - Writing to file /builds/slave/test/properties/build_url 13:17:32 INFO - Contents: 13:17:32 INFO - build_url:https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:17:33 INFO - Running post-action listener: _resource_record_post_action 13:17:33 INFO - Running post-action listener: set_extra_try_arguments 13:17:33 INFO - [mozharness: 2016-08-18 20:17:33.248339Z] Finished download-and-extract step (success) 13:17:33 INFO - [mozharness: 2016-08-18 20:17:33.248562Z] Running populate-webroot step. 13:17:33 INFO - Running pre-action listener: _resource_record_pre_action 13:17:33 INFO - Running main action method: populate_webroot 13:17:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:17:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:17:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:17:33 INFO - '--tppagecycles', 13:17:33 INFO - '7'], 13:17:33 INFO - 'tests': ['tsvgm']}}, 13:17:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:17:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:17:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:17:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:17:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['damp', 'tps']}, 13:17:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'tests': ['damp', 'tps']}, 13:17:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['dromaeo_dom']}, 13:17:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:17:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['basic_compositor_video']}, 13:17:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:17:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['a11yr', 13:17:33 INFO - 'ts_paint', 13:17:33 INFO - 'tpaint', 13:17:33 INFO - 'sessionrestore', 13:17:33 INFO - 'sessionrestore_no_auto_restore', 13:17:33 INFO - 'tabpaint']}, 13:17:33 INFO - 'other-e10s': {'tests': ['a11yr', 13:17:33 INFO - 'ts_paint', 13:17:33 INFO - 'tpaint', 13:17:33 INFO - 'sessionrestore', 13:17:33 INFO - 'sessionrestore_no_auto_restore', 13:17:33 INFO - 'tabpaint']}, 13:17:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:17:33 INFO - 'ts_paint', 13:17:33 INFO - 'tpaint', 13:17:33 INFO - 'sessionrestore', 13:17:33 INFO - 'sessionrestore_no_auto_restore', 13:17:33 INFO - 'tabpaint']}, 13:17:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:17:33 INFO - 'ts_paint', 13:17:33 INFO - 'tpaint', 13:17:33 INFO - 'sessionrestore', 13:17:33 INFO - 'sessionrestore_no_auto_restore', 13:17:33 INFO - 'tabpaint']}, 13:17:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['a11yr', 13:17:33 INFO - 'ts_paint', 13:17:33 INFO - 'tpaint', 13:17:33 INFO - 'sessionrestore', 13:17:33 INFO - 'sessionrestore_no_auto_restore', 13:17:33 INFO - 'tabpaint']}, 13:17:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['a11yr', 13:17:33 INFO - 'ts_paint', 13:17:33 INFO - 'tpaint', 13:17:33 INFO - 'sessionrestore', 13:17:33 INFO - 'sessionrestore_no_auto_restore', 13:17:33 INFO - 'tabpaint']}, 13:17:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['tsvgx', 13:17:33 INFO - 'tsvgr_opacity', 13:17:33 INFO - 'tart', 13:17:33 INFO - 'tscrollx', 13:17:33 INFO - 'cart']}, 13:17:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:17:33 INFO - 'tsvgr_opacity', 13:17:33 INFO - 'tart', 13:17:33 INFO - 'tscrollx', 13:17:33 INFO - 'cart']}, 13:17:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'talos_options': ['--disable-e10s'], 13:17:33 INFO - 'tests': ['tp5o']}, 13:17:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'tests': ['tp5o']}, 13:17:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'talos_options': ['--disable-e10s', 13:17:33 INFO - '--xperf_path', 13:17:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:33 INFO - 'tests': ['tp5n']}, 13:17:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:33 INFO - 'talos_options': ['--xperf_path', 13:17:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:33 INFO - 'tests': ['tp5n']}}, 13:17:33 INFO - 'talos.zip': {'path': '', 13:17:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:17:33 INFO - Running post-action listener: _resource_record_post_action 13:17:33 INFO - [mozharness: 2016-08-18 20:17:33.267371Z] Finished populate-webroot step (success) 13:17:33 INFO - [mozharness: 2016-08-18 20:17:33.267458Z] Running create-virtualenv step. 13:17:33 INFO - Running pre-action listener: _resource_record_pre_action 13:17:33 INFO - Running main action method: create_virtualenv 13:17:33 INFO - Creating virtualenv /builds/slave/test/build/venv 13:17:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:17:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:17:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:17:33 INFO - Using real prefix '/usr' 13:17:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:17:33 INFO - Installing distribute.............................................................................................................................................................................................done. 13:17:35 INFO - Installing pip.................done. 13:17:35 INFO - Return code: 0 13:17:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:17:35 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')]} 13:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:35 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')]} 13:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:35 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 0x7f7e6e08ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde090>, '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 0x1be19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1e40>, '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': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', '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 13:17:35 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 13:17:35 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 13:17:35 INFO - Using env: {'DISPLAY': ':0', 13:17:35 INFO - 'HOME': '/home/cltbld', 13:17:35 INFO - 'LANG': 'en_US.UTF-8', 13:17:35 INFO - 'LANGUAGE': 'en_US:en', 13:17:35 INFO - 'LOGNAME': 'cltbld', 13:17:35 INFO - 'MAIL': '/var/mail/cltbld', 13:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:35 INFO - 'MOZ_NO_REMOTE': '1', 13:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:35 INFO - 'NO_EM_RESTART': '1', 13:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:35 INFO - 'PWD': '/builds/slave/test', 13:17:35 INFO - 'SHELL': '/bin/bash', 13:17:35 INFO - 'SHLVL': '1', 13:17:35 INFO - 'TERM': 'linux', 13:17:35 INFO - 'TMOUT': '86400', 13:17:35 INFO - 'USER': 'cltbld', 13:17:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', 13:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:35 INFO - '_': '/tools/buildbot/bin/python'} 13:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:17:36 INFO - Cleaning up... 13:17:36 INFO - Return code: 0 13:17:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e6e08ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde090>, '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 0x1be19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1e40>, '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': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', '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 13:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:17:36 INFO - Using env: {'DISPLAY': ':0', 13:17:36 INFO - 'HOME': '/home/cltbld', 13:17:36 INFO - 'LANG': 'en_US.UTF-8', 13:17:36 INFO - 'LANGUAGE': 'en_US:en', 13:17:36 INFO - 'LOGNAME': 'cltbld', 13:17:36 INFO - 'MAIL': '/var/mail/cltbld', 13:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:36 INFO - 'MOZ_NO_REMOTE': '1', 13:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:36 INFO - 'NO_EM_RESTART': '1', 13:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:36 INFO - 'PWD': '/builds/slave/test', 13:17:36 INFO - 'SHELL': '/bin/bash', 13:17:36 INFO - 'SHLVL': '1', 13:17:36 INFO - 'TERM': 'linux', 13:17:36 INFO - 'TMOUT': '86400', 13:17:36 INFO - 'USER': 'cltbld', 13:17:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', 13:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:36 INFO - '_': '/tools/buildbot/bin/python'} 13:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:36 INFO - Downloading/unpacking psutil>=3.1.1 13:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:17:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:38 INFO - Installing collected packages: psutil 13:17:38 INFO - Running setup.py install for psutil 13:17:38 INFO - building 'psutil._psutil_linux' extension 13:17:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:17:38 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 13:17:38 INFO - building 'psutil._psutil_posix' extension 13:17:38 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 13:17:38 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 13:17:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:38 INFO - Successfully installed psutil 13:17:38 INFO - Cleaning up... 13:17:38 INFO - Return code: 0 13:17:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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')]} 13:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:38 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 0x7f7e6e08ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde090>, '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 0x1be19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1e40>, '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': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', '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 13:17:38 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 13:17:38 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 13:17:38 INFO - Using env: {'DISPLAY': ':0', 13:17:38 INFO - 'HOME': '/home/cltbld', 13:17:38 INFO - 'LANG': 'en_US.UTF-8', 13:17:38 INFO - 'LANGUAGE': 'en_US:en', 13:17:38 INFO - 'LOGNAME': 'cltbld', 13:17:38 INFO - 'MAIL': '/var/mail/cltbld', 13:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:38 INFO - 'MOZ_NO_REMOTE': '1', 13:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:38 INFO - 'NO_EM_RESTART': '1', 13:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:38 INFO - 'PWD': '/builds/slave/test', 13:17:38 INFO - 'SHELL': '/bin/bash', 13:17:38 INFO - 'SHLVL': '1', 13:17:38 INFO - 'TERM': 'linux', 13:17:38 INFO - 'TMOUT': '86400', 13:17:38 INFO - 'USER': 'cltbld', 13:17:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', 13:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:38 INFO - '_': '/tools/buildbot/bin/python'} 13:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:17:40 INFO - Installing collected packages: mozsystemmonitor 13:17:40 INFO - Running setup.py install for mozsystemmonitor 13:17:41 INFO - Successfully installed mozsystemmonitor 13:17:41 INFO - Cleaning up... 13:17:41 INFO - Return code: 0 13:17:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e6e08ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde090>, '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 0x1be19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1e40>, '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': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', '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 13:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:17:41 INFO - Using env: {'DISPLAY': ':0', 13:17:41 INFO - 'HOME': '/home/cltbld', 13:17:41 INFO - 'LANG': 'en_US.UTF-8', 13:17:41 INFO - 'LANGUAGE': 'en_US:en', 13:17:41 INFO - 'LOGNAME': 'cltbld', 13:17:41 INFO - 'MAIL': '/var/mail/cltbld', 13:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:41 INFO - 'MOZ_NO_REMOTE': '1', 13:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:41 INFO - 'NO_EM_RESTART': '1', 13:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:41 INFO - 'PWD': '/builds/slave/test', 13:17:41 INFO - 'SHELL': '/bin/bash', 13:17:41 INFO - 'SHLVL': '1', 13:17:41 INFO - 'TERM': 'linux', 13:17:41 INFO - 'TMOUT': '86400', 13:17:41 INFO - 'USER': 'cltbld', 13:17:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', 13:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:41 INFO - '_': '/tools/buildbot/bin/python'} 13:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:41 INFO - Downloading/unpacking jsonschema==2.5.1 13:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:17:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:43 INFO - Downloading functools32-3.2.3-2.tar.gz 13:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:17:43 INFO - warning: no files found matching '*.txt' 13:17:43 INFO - no previously-included directories found matching 'build' 13:17:43 INFO - no previously-included directories found matching 'dist' 13:17:43 INFO - no previously-included directories found matching '.git*' 13:17:43 INFO - Installing collected packages: jsonschema, functools32 13:17:43 INFO - Running setup.py install for functools32 13:17:43 INFO - warning: no files found matching '*.txt' 13:17:43 INFO - no previously-included directories found matching 'build' 13:17:43 INFO - no previously-included directories found matching 'dist' 13:17:43 INFO - no previously-included directories found matching '.git*' 13:17:43 INFO - Successfully installed jsonschema functools32 13:17:43 INFO - Cleaning up... 13:17:43 INFO - Return code: 0 13:17:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:17:43 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')]} 13:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:43 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')]} 13:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:43 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 0x7f7e6e08ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde090>, '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 0x1be19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1e40>, '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': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', '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 13:17:43 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 13:17:43 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 13:17:43 INFO - Using env: {'DISPLAY': ':0', 13:17:43 INFO - 'HOME': '/home/cltbld', 13:17:43 INFO - 'LANG': 'en_US.UTF-8', 13:17:43 INFO - 'LANGUAGE': 'en_US:en', 13:17:43 INFO - 'LOGNAME': 'cltbld', 13:17:43 INFO - 'MAIL': '/var/mail/cltbld', 13:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:43 INFO - 'MOZ_NO_REMOTE': '1', 13:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:43 INFO - 'NO_EM_RESTART': '1', 13:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:43 INFO - 'PWD': '/builds/slave/test', 13:17:43 INFO - 'SHELL': '/bin/bash', 13:17:43 INFO - 'SHLVL': '1', 13:17:43 INFO - 'TERM': 'linux', 13:17:43 INFO - 'TMOUT': '86400', 13:17:43 INFO - 'USER': 'cltbld', 13:17:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', 13:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:43 INFO - '_': '/tools/buildbot/bin/python'} 13:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:17:43 INFO - Cleaning up... 13:17:43 INFO - Return code: 0 13:17:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:17:43 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')]} 13:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:43 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')]} 13:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:43 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 0x7f7e6e08ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde090>, '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 0x1be19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1e40>, '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': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', '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 13:17:43 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 13:17:43 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 13:17:43 INFO - Using env: {'DISPLAY': ':0', 13:17:43 INFO - 'HOME': '/home/cltbld', 13:17:43 INFO - 'LANG': 'en_US.UTF-8', 13:17:43 INFO - 'LANGUAGE': 'en_US:en', 13:17:43 INFO - 'LOGNAME': 'cltbld', 13:17:43 INFO - 'MAIL': '/var/mail/cltbld', 13:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:43 INFO - 'MOZ_NO_REMOTE': '1', 13:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:43 INFO - 'NO_EM_RESTART': '1', 13:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:43 INFO - 'PWD': '/builds/slave/test', 13:17:43 INFO - 'SHELL': '/bin/bash', 13:17:43 INFO - 'SHLVL': '1', 13:17:43 INFO - 'TERM': 'linux', 13:17:43 INFO - 'TMOUT': '86400', 13:17:43 INFO - 'USER': 'cltbld', 13:17:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', 13:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:43 INFO - '_': '/tools/buildbot/bin/python'} 13:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:44 INFO - Downloading/unpacking blobuploader==1.2.4 13:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:45 INFO - Downloading blobuploader-1.2.4.tar.gz 13:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:17:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:17:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:46 INFO - Downloading docopt-0.6.1.tar.gz 13:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:17:46 INFO - Installing collected packages: blobuploader, requests, docopt 13:17:46 INFO - Running setup.py install for blobuploader 13:17:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:17:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:17:46 INFO - Running setup.py install for requests 13:17:47 INFO - Running setup.py install for docopt 13:17:47 INFO - Successfully installed blobuploader requests docopt 13:17:47 INFO - Cleaning up... 13:17:47 INFO - Return code: 0 13:17:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e6e08ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde090>, '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 0x1be19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1e40>, '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': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', '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 13:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:17:47 INFO - Using env: {'DISPLAY': ':0', 13:17:47 INFO - 'HOME': '/home/cltbld', 13:17:47 INFO - 'LANG': 'en_US.UTF-8', 13:17:47 INFO - 'LANGUAGE': 'en_US:en', 13:17:47 INFO - 'LOGNAME': 'cltbld', 13:17:47 INFO - 'MAIL': '/var/mail/cltbld', 13:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:47 INFO - 'MOZ_NO_REMOTE': '1', 13:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:47 INFO - 'NO_EM_RESTART': '1', 13:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:47 INFO - 'PWD': '/builds/slave/test', 13:17:47 INFO - 'SHELL': '/bin/bash', 13:17:47 INFO - 'SHLVL': '1', 13:17:47 INFO - 'TERM': 'linux', 13:17:47 INFO - 'TMOUT': '86400', 13:17:47 INFO - 'USER': 'cltbld', 13:17:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', 13:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:47 INFO - '_': '/tools/buildbot/bin/python'} 13:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:47 INFO - Running setup.py (path:/tmp/pip-9J2dIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:47 INFO - Running setup.py (path:/tmp/pip-gPmPp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:47 INFO - Running setup.py (path:/tmp/pip-gsYaVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:47 INFO - Running setup.py (path:/tmp/pip-tbXJgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:47 INFO - Running setup.py (path:/tmp/pip-FZWH6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:47 INFO - Running setup.py (path:/tmp/pip-BIIwkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:48 INFO - Running setup.py (path:/tmp/pip-jRFQDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:48 INFO - Running setup.py (path:/tmp/pip-NH51lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:48 INFO - Running setup.py (path:/tmp/pip-fL4TcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:48 INFO - Running setup.py (path:/tmp/pip-TBL8lT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:48 INFO - Running setup.py (path:/tmp/pip-Vhc2g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:48 INFO - Running setup.py (path:/tmp/pip-vlKO3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:48 INFO - Running setup.py (path:/tmp/pip-_DVvST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:48 INFO - Running setup.py (path:/tmp/pip-ehTDX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:48 INFO - Running setup.py (path:/tmp/pip-I9QrNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:48 INFO - Running setup.py (path:/tmp/pip-_j0nyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:48 INFO - Running setup.py (path:/tmp/pip-W9kMWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:17:48 INFO - Running setup.py install for manifestparser 13:17:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:17:48 INFO - Running setup.py install for mozcrash 13:17:49 INFO - Running setup.py install for mozdebug 13:17:49 INFO - Running setup.py install for mozdevice 13:17:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:17:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:17:49 INFO - Running setup.py install for mozfile 13:17:49 INFO - Running setup.py install for mozhttpd 13:17:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:17:49 INFO - Running setup.py install for mozinfo 13:17:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:17:49 INFO - Running setup.py install for mozInstall 13:17:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:17:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:17:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:17:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:17:49 INFO - Running setup.py install for mozleak 13:17:49 INFO - Running setup.py install for mozlog 13:17:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:17:49 INFO - Running setup.py install for moznetwork 13:17:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:17:49 INFO - Running setup.py install for mozprocess 13:17:50 INFO - Running setup.py install for mozprofile 13:17:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:17:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:17:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:17:50 INFO - Running setup.py install for mozrunner 13:17:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:17:50 INFO - Running setup.py install for mozscreenshot 13:17:50 INFO - Running setup.py install for moztest 13:17:50 INFO - Running setup.py install for mozversion 13:17:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:17:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:17:50 INFO - Cleaning up... 13:17:50 INFO - Return code: 0 13:17:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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')]} 13:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:50 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 0x7f7e6e08ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde090>, '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 0x1be19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1e40>, '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': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', '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 13:17:50 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 13:17:50 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 13:17:50 INFO - Using env: {'DISPLAY': ':0', 13:17:50 INFO - 'HOME': '/home/cltbld', 13:17:50 INFO - 'LANG': 'en_US.UTF-8', 13:17:50 INFO - 'LANGUAGE': 'en_US:en', 13:17:50 INFO - 'LOGNAME': 'cltbld', 13:17:50 INFO - 'MAIL': '/var/mail/cltbld', 13:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:50 INFO - 'MOZ_NO_REMOTE': '1', 13:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:50 INFO - 'NO_EM_RESTART': '1', 13:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:50 INFO - 'PWD': '/builds/slave/test', 13:17:50 INFO - 'SHELL': '/bin/bash', 13:17:50 INFO - 'SHLVL': '1', 13:17:50 INFO - 'TERM': 'linux', 13:17:50 INFO - 'TMOUT': '86400', 13:17:50 INFO - 'USER': 'cltbld', 13:17:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', 13:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:50 INFO - '_': '/tools/buildbot/bin/python'} 13:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:50 INFO - Running setup.py (path:/tmp/pip-usdPAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:50 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)) 13:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:50 INFO - Running setup.py (path:/tmp/pip-Fc4V2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:50 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)) 13:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:50 INFO - Running setup.py (path:/tmp/pip-tYWJeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:51 INFO - Running setup.py (path:/tmp/pip-lHtluc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:51 INFO - Running setup.py (path:/tmp/pip-wfdwk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:51 INFO - Running setup.py (path:/tmp/pip-W7_ByL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:51 INFO - Running setup.py (path:/tmp/pip-hkAUUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:51 INFO - Running setup.py (path:/tmp/pip-4qrUj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:51 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)) 13:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:51 INFO - Running setup.py (path:/tmp/pip-zNgFIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:51 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)) 13:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:51 INFO - Running setup.py (path:/tmp/pip-VeWO2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:51 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)) 13:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:51 INFO - Running setup.py (path:/tmp/pip-h7yqTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:51 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)) 13:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:51 INFO - Running setup.py (path:/tmp/pip-j_XL4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:51 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)) 13:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:51 INFO - Running setup.py (path:/tmp/pip-FwKidF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:51 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)) 13:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:51 INFO - Running setup.py (path:/tmp/pip-4s6bzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:51 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)) 13:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:51 INFO - Running setup.py (path:/tmp/pip-3KhRim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:51 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)) 13:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:51 INFO - Running setup.py (path:/tmp/pip-mvnxTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:51 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)) 13:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:52 INFO - Running setup.py (path:/tmp/pip-3HaN3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:17:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:53 INFO - Downloading blessings-1.6.tar.gz 13:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:17:54 INFO - Installing collected packages: blessings 13:17:54 INFO - Running setup.py install for blessings 13:17:54 INFO - Successfully installed blessings 13:17:54 INFO - Cleaning up... 13:17:54 INFO - Return code: 0 13:17:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:17:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:54 INFO - Reading from file tmpfile_stdout 13:17:54 INFO - Current package versions: 13:17:54 INFO - argparse == 1.2.1 13:17:54 INFO - blessings == 1.6 13:17:54 INFO - blobuploader == 1.2.4 13:17:54 INFO - docopt == 0.6.1 13:17:54 INFO - functools32 == 3.2.3-2 13:17:54 INFO - jsonschema == 2.5.1 13:17:54 INFO - manifestparser == 1.1 13:17:54 INFO - mozInstall == 1.12 13:17:54 INFO - mozcrash == 0.17 13:17:54 INFO - mozdebug == 0.1 13:17:54 INFO - mozdevice == 0.48 13:17:54 INFO - mozfile == 1.2 13:17:54 INFO - mozhttpd == 0.7 13:17:54 INFO - mozinfo == 0.9 13:17:54 INFO - mozleak == 0.1 13:17:54 INFO - mozlog == 3.3 13:17:54 INFO - moznetwork == 0.27 13:17:54 INFO - mozprocess == 0.23 13:17:54 INFO - mozprofile == 0.28 13:17:54 INFO - mozrunner == 6.12 13:17:54 INFO - mozscreenshot == 0.1 13:17:54 INFO - mozsystemmonitor == 0.3 13:17:54 INFO - moztest == 0.7 13:17:54 INFO - mozversion == 1.4 13:17:54 INFO - psutil == 3.1.1 13:17:54 INFO - requests == 1.2.3 13:17:54 INFO - wsgiref == 0.1.2 13:17:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:54 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 0x7f7e6e08ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde090>, '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 0x1be19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1e40>, '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': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', '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 13:17:54 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 13:17:54 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 13:17:54 INFO - Using env: {'DISPLAY': ':0', 13:17:54 INFO - 'HOME': '/home/cltbld', 13:17:54 INFO - 'LANG': 'en_US.UTF-8', 13:17:54 INFO - 'LANGUAGE': 'en_US:en', 13:17:54 INFO - 'LOGNAME': 'cltbld', 13:17:54 INFO - 'MAIL': '/var/mail/cltbld', 13:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:54 INFO - 'MOZ_NO_REMOTE': '1', 13:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:54 INFO - 'NO_EM_RESTART': '1', 13:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:54 INFO - 'PWD': '/builds/slave/test', 13:17:54 INFO - 'SHELL': '/bin/bash', 13:17:54 INFO - 'SHLVL': '1', 13:17:54 INFO - 'TERM': 'linux', 13:17:54 INFO - 'TMOUT': '86400', 13:17:54 INFO - 'USER': 'cltbld', 13:17:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', 13:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:54 INFO - '_': '/tools/buildbot/bin/python'} 13:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:54 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)) 13:17:54 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)) 13:17:54 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)) 13:17:54 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)) 13:17:54 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)) 13:17:54 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)) 13:17:54 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)) 13:17:54 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)) 13:17:54 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)) 13:17:54 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)) 13:17:54 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)) 13:17:54 INFO - Cleaning up... 13:17:54 INFO - Return code: 0 13:17:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:54 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 0x7f7e6e08ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde090>, '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 0x1be19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1e40>, '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': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', '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 13:17:54 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 13:17:54 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 13:17:54 INFO - Using env: {'DISPLAY': ':0', 13:17:54 INFO - 'HOME': '/home/cltbld', 13:17:54 INFO - 'LANG': 'en_US.UTF-8', 13:17:54 INFO - 'LANGUAGE': 'en_US:en', 13:17:54 INFO - 'LOGNAME': 'cltbld', 13:17:54 INFO - 'MAIL': '/var/mail/cltbld', 13:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:54 INFO - 'MOZ_NO_REMOTE': '1', 13:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:54 INFO - 'NO_EM_RESTART': '1', 13:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:54 INFO - 'PWD': '/builds/slave/test', 13:17:54 INFO - 'SHELL': '/bin/bash', 13:17:54 INFO - 'SHLVL': '1', 13:17:54 INFO - 'TERM': 'linux', 13:17:54 INFO - 'TMOUT': '86400', 13:17:54 INFO - 'USER': 'cltbld', 13:17:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', 13:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:54 INFO - '_': '/tools/buildbot/bin/python'} 13:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:17:54 INFO - Cleaning up... 13:17:54 INFO - Return code: 0 13:17:54 INFO - Running post-action listener: _resource_record_post_action 13:17:54 INFO - Running post-action listener: _start_resource_monitoring 13:17:54 INFO - Starting resource monitoring. 13:17:54 INFO - [mozharness: 2016-08-18 20:17:54.921276Z] Finished create-virtualenv step (success) 13:17:54 INFO - [mozharness: 2016-08-18 20:17:54.921866Z] Running install step. 13:17:54 INFO - Running pre-action listener: _resource_record_pre_action 13:17:54 INFO - Running main action method: install 13:17:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:55 INFO - Reading from file tmpfile_stdout 13:17:55 INFO - Detecting whether we're running mozinstall >=1.0... 13:17:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:17:55 INFO - Reading from file tmpfile_stdout 13:17:55 INFO - Output received: 13:17:55 INFO - Usage: mozinstall [options] installer 13:17:55 INFO - Options: 13:17:55 INFO - -h, --help show this help message and exit 13:17:55 INFO - -d DEST, --destination=DEST 13:17:55 INFO - Directory to install application into. [default: 13:17:55 INFO - "/builds/slave/test"] 13:17:55 INFO - --app=APP Application being installed. [default: firefox] 13:17:55 INFO - mkdir: /builds/slave/test/build/application 13:17:55 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'] 13:17:55 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 13:18:11 INFO - Reading from file tmpfile_stdout 13:18:11 INFO - Output received: 13:18:11 INFO - /builds/slave/test/build/application/firefox/firefox 13:18:11 INFO - Running post-action listener: _resource_record_post_action 13:18:11 INFO - [mozharness: 2016-08-18 20:18:11.301542Z] Finished install step (success) 13:18:11 INFO - [mozharness: 2016-08-18 20:18:11.301793Z] Running run-tests step. 13:18:11 INFO - Running pre-action listener: _resource_record_pre_action 13:18:11 INFO - Running main action method: run_tests 13:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:18:11 INFO - Python 2.7.3 13:18:11 INFO - Return code: 0 13:18:11 INFO - grabbing minidump binary from tooltool 13:18:11 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')]} 13:18:11 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 0x1bde090>, '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 0x1be19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be1e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:18:11 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 13:18:11 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 13:18:11 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 13:18:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:18:11 INFO - Return code: 0 13:18:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:18:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:18:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:18:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:18:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:18:11 INFO - Using env: {'DISPLAY': ':0', 13:18:11 INFO - 'HOME': '/home/cltbld', 13:18:11 INFO - 'LANG': 'en_US.UTF-8', 13:18:11 INFO - 'LANGUAGE': 'en_US:en', 13:18:11 INFO - 'LOGNAME': 'cltbld', 13:18:11 INFO - 'MAIL': '/var/mail/cltbld', 13:18:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:18:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:11 INFO - 'MOZ_NO_REMOTE': '1', 13:18:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:18:11 INFO - 'NO_EM_RESTART': '1', 13:18:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:11 INFO - 'PWD': '/builds/slave/test', 13:18:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:18:11 INFO - 'SHELL': '/bin/bash', 13:18:11 INFO - 'SHLVL': '1', 13:18:11 INFO - 'TERM': 'linux', 13:18:11 INFO - 'TMOUT': '86400', 13:18:11 INFO - 'USER': 'cltbld', 13:18:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607', 13:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:11 INFO - '_': '/tools/buildbot/bin/python'} 13:18:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:18:11 INFO - mozversion application_buildid: 20160818123355 13:18:11 INFO - mozversion application_changeset: 0c135a70a81ae0c7dd714ea93ff45300f69ad475 13:18:11 INFO - mozversion application_display_name: Nightly 13:18:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:18:11 INFO - mozversion application_name: Firefox 13:18:11 INFO - mozversion application_remotingname: firefox 13:18:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 13:18:11 INFO - mozversion application_vendor: Mozilla 13:18:11 INFO - mozversion application_version: 51.0a1 13:18:11 INFO - mozversion platform_buildid: 20160818123355 13:18:11 INFO - mozversion platform_changeset: 0c135a70a81ae0c7dd714ea93ff45300f69ad475 13:18:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 13:18:11 INFO - mozversion platform_version: 51.0a1 13:18:11 INFO - using testdate: 1471551491 13:18:11 INFO - actual date: 1471551491 13:18:11 INFO - starting webserver on 'localhost:42351' 13:18:11 INFO - SUITE-START | Running 2 tests 13:18:11 INFO - TEST-START | dromaeo_css 13:18:11 INFO - operating with platform_type : linux_ 13:18:11 INFO - Initialising browser for dromaeo_css test... 13:18:11 INFO - TEST-INFO | started process 32641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN0ztoK/profile http://localhost:42351/getInfo.html) 13:18:16 INFO - PROCESS | 32641 | __metrics Screen width/height:1600/1200 13:18:16 INFO - PROCESS | 32641 | colorDepth:24 13:18:16 INFO - PROCESS | 32641 | Browser inner width/height: 1024/697 13:18:16 INFO - PROCESS | 32641 | __metrics 13:18:17 INFO - PROCESS | 32641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:18:17 INFO - PROCESS | 32641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:18:19 INFO - PROCESS | 32641 | console.error: PushService: 13:18:19 INFO - PROCESS | 32641 | stateChangeProcessEnqueue: Error transitioning state 13:18:19 INFO - PROCESS | 32641 | UnknownError 13:18:19 INFO - TEST-INFO | 32641: exit 0 13:18:19 INFO - Browser initialized. 13:18:19 INFO - Running cycle 1/1 for dromaeo_css test... 13:18:19 INFO - TEST-INFO | started process 32726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN0ztoK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:31 INFO - PROCESS | 32726 | RSS: Main: 157024256 13:18:31 INFO - PROCESS | 32726 | 13:19:22 INFO - PROCESS | 32726 | 1471551562613 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] 13:21:36 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:42351/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42351/tests/dromaeo/cssquery-ext.html) 13:21:37 INFO - PROCESS | 32726 | RSS: Main: 233783296 13:21:37 INFO - PROCESS | 32726 | 13:24:40 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:42351/tests/dromaeo/cssquery-ext.html (next: http://localhost:42351/tests/dromaeo/cssquery-jquery.html) 13:24:40 INFO - PROCESS | 32726 | RSS: Main: 246145024 13:24:40 INFO - PROCESS | 32726 | 13:27:42 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:42351/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42351/tests/dromaeo/cssquery-mootools.html) 13:27:43 INFO - PROCESS | 32726 | RSS: Main: 232800256 13:27:43 INFO - PROCESS | 32726 | 13:30:45 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:42351/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42351/tests/dromaeo/cssquery-prototype.html) 13:30:46 INFO - PROCESS | 32726 | RSS: Main: 187977728 13:30:46 INFO - PROCESS | 32726 | 13:33:49 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:42351/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42351/tests/dromaeo/cssquery-yui.html) 13:33:50 INFO - PROCESS | 32726 | RSS: Main: 189526016 13:33:50 INFO - PROCESS | 32726 | 13:36:53 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:42351/tests/dromaeo/cssquery-yui.html (next: http://localhost:42351/tests/dromaeo/cssquery-dojo.html) 13:36:53 INFO - PROCESS | 32726 | RSS: Main: 271097856 13:36:53 INFO - PROCESS | 32726 | 13:36:53 INFO - PROCESS | 32726 | __start_tp_report 13:36:53 INFO - PROCESS | 32726 | _x_x_mozilla_page_load 13:36:53 INFO - PROCESS | 32726 | _x_x_mozilla_page_load_details 13:36:53 INFO - PROCESS | 32726 | |i|pagename|runs| 13:36:53 INFO - PROCESS | 32726 | |0;dojo.html;2573.3052075939495;2596.532624127656;2612.229392329263;2618.7774039206665;2638.340414896276;4578.061497393035;4624.953750462494;4659.860204193871;4665.533446655333;4671.789769460374;4644.210484217682;4684.344191813149;4694.131585656656;4713.9057218855605;4747.382840230774;4208.263553878074;4289.6353809926195;4329.047609525915;4352.912941741163;4373.103513779667;4300.763458009808;4307;4320.935185972197;4327.0913108247305;4370.104128653618;4418.359337896003;4472.843450479234;4486.259767138418;4495;4496.842610508633;4223.092035212413;4263.126059157865;4331.956680433218;4378.605925466723;4379.846705365297;4185.434966279544;4193.853215137486;4222.641075508585;4231.555686652919;4243.745375277494;4641.141388843075;4657.371254880582;4694.014257005999;4731.8580442586435;4734.55021772931;4899.093667671456;4970.826021089245;5050.949490505084;5058.898822023576;5058.974705126488;5006.098902197603;5067.797288108472;5071.670341427795;5142.4600416956055;5145.279660847447;4744.620430365562;4755.453122890877;4772.689775164603;4786.1863483207935;4802.327674125625;5014.122528557561;5244.056069907377;5245.947540524622;5253.553447956967;5258.894822103536;4877.6829506081995;4906.288588154769;4912.164931961575;4976.776045077981;4999.150144475448;5039.622028347889;5051.116054690415;5061.873453163626;5082.644214904921;5085.593152547787;4806.182948898696;4991.625628077909;5000.449950505442;5007.273945277987;5012.54887060159;4810.845397104739;4857.344258525124;4873.537013983666;4878.268259760993;4889.902201955941;4164.3961625564725;4199.349100889367;4200.075983283673;4203.600657937491;4204.936925946114;3671.541057367829;3702.204026134394;3703.148275896559;3714.257148570297;3726.8136593170234;4428.667849911205;4431.601155895984;4436.0462500562535;4459.7547134907245;4461.085477477174;5079.1365467870555;5089.51649593288;5089.643724939293;5094.835802573815;5121.2574176744165;4279.379489973936;4342.066455712037;4384.7369157850635;4413.713108647928;4427.490838553607;4571.245744452194;4573.222552166139;4573.817047318136;4600.815967361268;4620.052889157714;4854.320395144682;4856.684315519621;4861.805527778849;4865.172920603577;4911.189653707098;4823.27650852375;5003.049420610072;5007.674501157413;5088.2876397305145;5103.209002604603;4803.663743537919;4806.903861922812;4829.66192366531;4834.7824347903725;4841.8547443576745;4918.43438004634;4951.876203094951;4960.900781984268;4981.875453113701;4990.775415106402;4889.535494128052;4976.751162441936;4997.400311962588;5056.403318544556;5092.567131793839;4916.606671466203;4923.704577725348;4930.457649658606;4952.851414457572;4954.157793175241;4922;4931.284963680175;4942.975285123552;4951.801927922843;4980.427250866197;4658.0218154188;4727.101850648366;4758.381410416762;4864.513548645107;4928.162212423825;4785.306130610972;4846.927296090632;4859.562639362474;4868.464468908346;4891.706497610155;4711.055276381948;4716.905661886674;4717.056588682346;4723.480417154179;4738 13:36:53 INFO - PROCESS | 32726 | |1;ext.html;568.9004424225759;577.9739911703973;578.7887421091302;581.3140494216827;581.5928849805136;29223.707762922364;39632.80183599082;40810.795946020306;40959.38560921588;44675.32987005197;40961.59038409615;41167;41332.173356532854;41358.79320603393;41396.58603413965;7601.315881570657;7737.806554836146;7741.806454838646;7744.49660772048;7762.650680719353;7463.589502577356;7535.171131175566;7553.055868016498;7558.168601453835;7558.886616700754;7560.168381478061;7588.658510367047;7594.5063570867715;7600.163981962008;7605;7545.320921117099;7568.318851303354;7570;7578.242175782378;7580.583067931261;7660.885086723648;7724.459287849852;7728.536287822749;7731.961340193319;7732.729354472566;38302.80848595767;39045.414318784955;39138.80430597857;39143;39197.41203881944;3129.5462157986963;3158.684131586846;3159.2259896325318;3398.303347813692;3565.180008598011;28870.566941495894;28914.13257602254;28967.56548651772;29146.271343216376;30288.091357259316;3432.9828350858334;3462.3594634992605;3497.283056973314;3508.859645614172;3536.504889315498;238352;238549;239032;239439.99999999825;240247;31395.215119622193;52156.47843521516;52337.47662523326;52354.47645523496;52476;31934.361312773613;33429.164270892936;33457;33467.33065338728;33527.49708754371;12628;12689.555865544662;12707;12749.553765618159;12751.107422480523;10711.196660250513;10749.83875241872;10750.139988800876;10750.139988800876;10767.946160269148;7615.847683046308;7808.531488110618;7816.53100813953;7876.291133797871;7882.172371900982;3026.8183908965534;3043.178341847689;3049.573059771634;3054.1601059708314;3086.6450358208645;798.7444017914212;831.7463173731949;844.2444012608681;868.8783570300163;970.4080510888493;26557.601635975476;27171.86414067917;27660.58509122365;27985.720142798313;28591.714082859322;793.9682412703427;932.3240650528448;936.3164889630608;967.1102585621105;990.3612170150212;13503.32483375847;14515.491957781427;14634.219438367325;14843;14854.777178342334;364569;365392;366225;366832;368292;48430;48917.266241006415;48969.510304896496;48992;49065.509344906095;1021.1983592879702;1116.5757012335262;1127.1996882213557;1138.555963174346;1139.8176291793272;27642.723572764015;28556.286092847015;29139.708602914547;29670.554941675462;29691.554626680187;41734.373984389655;42179;42355.576444235165;42364.36453453139;42364.576354236066;278520;278627;280164;280741;281452.44749301026;25331.493370132863;26418.339541511617;26445.33886652849;27333;27527.86236068807;41930.790346048074;42142.01869214488;42165.15669686651;43145.35281970836;43237.78381108074;35129.29741405209;35353.82323088368;35420.822895886384;35726.28547428985;35827.462588060676;35418.8229058853;35551;35860.92417227487;35868.64131358653;35884.461733074546;34487;34823;35253.47119793154;35425.82287088548;35898.28203435969;31019.84490077535;33029.50455743214;33224.66775332216;33373.49939750954;33574.83212583922;24314.63528047116;25047.87476062608;25111;25129.371765706004;25531.74468255368 13:36:53 INFO - PROCESS | 32726 | |2;jquery.html;341.63757616084774;355.9163596554809;367.1885133854181;367.351624382964;382.60591590661613;12526.624201273953;16067.678646427079;16470.917645411755;17806.910965445153;18004.369847055357;15861;16331.428400006002;16362.590935226624;16497.505074847744;17045.403410880623;4947.01059788042;4979.352684151056;5050.974745126269;5115.258287548303;5124.538791508763;3736.8692095776655;4937.456879743226;5064.873378165557;5658.122990936391;6071.908921366183;5994.46049855513;6118.0822876568645;6126.816195514141;6131.325554189036;6135.693215339237;5954.940450595482;6001.12983617373;6026.789062382817;6028.0355143176885;6054.091886217058;5170.431252562215;5368.651037682577;5373.247745315659;5377.677339359651;5386.757595908193;21318.46703832401;21521.784782152292;21962.231321903655;21968.560628787494;22092.447688807748;1848.6302739452162;1910.360029390156;2009.6784514477613;2044;2454.12878428159;12753.107282490137;13260.469581216836;13968.720625587432;14227.28863556818;14339.42642294307;1768.3545505890386;1776.404904357042;1777.25355350753;1786.5712229065061;1810.2125575374623;69571;70313.64843175803;70877.2912270881;71887;71893.2810671897;8977.820443591092;8979.14698103679;9142.81714365709;9178.541072946326;9618.278629102846;13403.463861445432;13403.932980335036;13418.731625367438;13425.328733563283;13440.395182216824;7099.911538480777;7243.384312333511;7307.5980821055355;7462.701491940262;7481.139668938033;6861.108055952794;6876.381125698711;7125.216226215216;7133.750318738819;7133.785986420416;6205.627662340274;6306.549493616402;6312.147860038836;6331.430171284606;6391.776287829996;1552.2161308539116;1558.4545409106722;1565.1313520995957;1574.8976316539388;1616.4908053962963;708.3624737735976;785.8271180340316;810.2545657994659;933.9553057034118;942.2556180617372;16444.75332870008;17176.742348864776;17314.913425433046;17512.21195046226;17602.655495456078;807.4549678966674;849.9885136687323;855.4439614250787;859.5616235719702;869.5695630662863;9201.539923003824;9751.951240243896;9784.51077446139;9817.165540929102;9919.702408927744;342961;350356;350652;351350;354012;78872;79751.20248797553;80347.59826200831;80434;81906;902.9458232506071;904.5025236120108;905.7373361725026;927.8700981862545;943.2972435535432;15038;15284.235788210322;15546.9222653886;15840.524784256491;16002.279897404878;37232.25535489329;38364.80817596006;38684.6131538681;38878.805605971786;39145.6085439142;50052.49947500624;50619;52470;52799.73600131975;53247.46752532425;7541.886871697038;7627.23727627255;7731.922680773345;7809.804754880946;8139.348852091937;9917.752056198653;12244.877551224374;12278;12314.630561083182;12350.197237179555;7288.708451661874;7408.740334198122;7659.272369124924;7867.724629637935;10405.27163098606;7340.70637174507;7554.093508778982;7828.373730101464;7920.960395197987;7961.40289478303;7602.163761986067;7817.257360550739;7825.960870195612;7855.5286682799215;8284.08875023759;11047.779044419227;11241;11320;11517.769644607228;11604.709882252673;10666;10879.347239165676;10969.780604388026;11265.662030139109;11843.940780296043 13:36:53 INFO - PROCESS | 32726 | |3;mootools.html;1225.724212052289;1313.5599574142661;1363.8499765025845;1376.3668712392298;1628.9918550407253;6665.200175978884;7642.121156067054;8005.759827205193;8006.279434850862;8015.839683206333;7832.295093441589;7889.723859664899;7890.132085470594;7891.881621775678;7893.447458677895;2176.5211653436218;2200.867947923122;2203.4711669199437;2205.9889700551553;2206.680031395447;2116.597846409185;2157.870527768331;2184.4102092435032;2186.726659167604;2190.222471022788;2143.19630138698;2166.3825809644254;2170.077716970289;2170.5007848194923;2183;2131.0942849289067;2140.1546389176187;2141.1221399226242;2141.3468891987936;2142.1645558232303;2088.3108574170487;2145.495808485005;2146.358036102383;2151.0535364439597;2170.739511258659;7709.113451952985;7752.457327987043;7774.222577742237;7804.765857024298;7852.489588176751;4530.501644819067;4660.464046634646;4669.813207471697;4670.019295947855;4672.0889426561835;2788.958165627497;2918.1829087855435;2948.5871977923107;2962.5408061750463;2964.318206812424;929.6560272699145;931.180561106229;944.1455482788087;949.5157469690439;959.3764053365369;10912.618058367998;11013.339199648046;11013.559457621686;11018.779624407547;11019.83470247947;3943.526776786804;3987.6211759882763;4024.939625905614;4027.556968733437;4208.410822484854;8397.412181147383;8552.144785521523;8555.871661925075;8560.61477233526;8561.957190214009;4463.642908567307;4472.105578884236;4472.709273897186;4475;4480.126375356839;3707.258548290353;3994.6404823566018;4122.752634841859;4136.21411931732;4158.168366326747;3348.5814273215847;3385.762996590215;3476.3221171871746;3501.702355299828;3506.4389697648253;1014.573878970834;1040.2718097331897;1042.598599539183;1045.0281238448315;1053.757635743783;800.7517669522466;821.6959724901825;823.2138307916046;824.8226631274305;827.0902007791501;5164.483551644806;5194.818181363634;5221.164613661796;5234.790608375699;5387.649802762886;415.4578275350696;420.4492115328929;430.4855697441527;431.59214542257894;435.17534272553337;3457.1529975155745;3461.394256005189;3606.8016259105475;3694.261147770457;3727.4967879336486;9091.863622045674;9521.143097121154;9546.236301095896;9626.085521875411;9633.518324083769;8989.595468203946;9435.386699864486;9488.762780930532;9759.560819763128;9769.853452198222;7094.396976256973;7174.461915356369;7242.565446073252;7295.2340004298785;7304.598247096461;5188.507091826271;5311.867203319948;5326.09456392422;5337.172738225581;5378.865528361822;8567.657293708182;8639.654413823377;8687.174718401742;8755.605997730245;8892.68875589377;8813.250873675554;9002.369834111549;9118.996910339725;9172.587233574639;9197.632094716137;5950.16697662319;6548.148740663683;6630.602163870183;6778.254392016973;6784.898226526705;7352.595607241653;7537.510061845963;7563.092428908566;7568.243175682388;7579.317861392501;6323.873522529616;6340.9365906340345;6452.935470645421;6504.512161587994;6593.142891424084;6396.680165991775;6478.3197764235965;6504.967475162784;6534.379233972765;6545.5090868184125;6181.598196117238;6290.968545157245;6291.716872740646;6295.244570651368;6302.338254483397;4344.674149438868;4427.712198707074;4453.487848897418;4533.410656614619;4562.110388474216;4401.427814384109;4417.447819022622;4579.473360563577;4589.495155532822;4590.265557510782 13:36:53 INFO - PROCESS | 32726 | |4;prototype.html;292.9882804687813;302.21725730358366;302.8924731720239;306.1428001595532;307.5647958139232;4824.8793780155465;4832.8791780205465;4838.75806209689;4850.830220942268;4878.926636140052;4736.597389221912;4765.952340476603;4819.397575303087;4822.97588512057;4858.51414858514;3552.822358882052;3673.3938900081453;3692.2246328271094;3761.887143385703;3788.6211378862167;3763.849446022156;3767.3972164453694;3769.396896496561;3784.489093972306;3798.385686083417;3735;3740.541188936317;3749.837550359384;3754.3805272130066;3768.021788561;3519.331327047853;3617.9095522611883;3729.4965179700935;3731.869384571527;3734.421164719473;3308.9669103308897;3314.850831712579;3316.303576248991;3324.905309654926;3326.866925322984;4648.372469716579;4659.930101048487;4676.649251306131;4681.344611754357;4688.929666055012;4183.247015537202;4302.569743025703;4307.104873855525;4314.115606300701;4323.4163387942535;4972.627052971042;4976.959446626865;4978.5270399312;5014.824481143142;5019.573336266421;3615.6926661233565;3629.2922880038404;3636.1091532574424;3652.2330310634798;3660.2679464107287;5124.028063723069;5194.766235519411;5231.60762942777;5251.872991438436;5281.603879708999;3691.8523259069875;3723.9627603724157;3728.0120767996505;3728.105254738897;3728.5525736911745;3750.981245093757;3765.5669597996034;3769.6607305342104;3771.528558930134;3781.3193625147737;4276.230278549829;4284.721493102938;4285.657147428198;4290.227759003347;4301.763403012802;4772.212584923449;4931.9753401232765;4968.354113965162;4978.950210497921;5015.673981191211;1297.2346315673797;1316.2694704439127;1316.4602512969636;1317.1504379675057;1320.9273489957952;817.7996390884272;843.5107637570195;850.3537311643196;860.0496451421214;862.8050150541545;4272.850450234289;4393.428854248928;4495.662825288116;4515.63874890008;4526.275795872644;5126.436092029874;5170.767315470813;5180.8963820723375;5186.507281808223;5198.558122559625;4498.8425405110665;4504.234280172379;4506.1663592235545;4540.8637740867825;4554.407926969473;2572.113348381338;2703.6755589329405;2717.4836781011545;2721.360480287131;2754.986225068902;4890.046440944053;4891.214706632054;4918.360613120343;4938.654294199443;4950.25746138075;5086;5305.893882122413;5323.30796996388;5323.840284791462;5344.225087362311;4835.8065677372515;4865.343178670834;4879.268109783561;4888.2178851383605;4894.339264199359;5104.774854035079;5132.8460146195675;5140.922886156636;5146.408163061146;5187.377514698261;4923.236898280772;4968.0312339093525;5059.620528460307;5073.898522029613;5099.92350114756;4866.831960329566;4874.341963834837;4883.975580122219;4884.63365247615;4884.801839172458;3699.204670995749;3700.370936940673;3703.037390183207;3741.1769410729594;3747.4566187902055;4944.629152813625;5151.278820965143;5166.586673066221;5170.948290517047;5192.169252919514;4937.925931111108;4940.456549779449;4949.57928576075;4960.900781984268;5028.748562571784;4935.371327462;4979.925301120558;4997.475265097112;4999.525045120708;5028.346314979176;4685.5782979532005;4914.287428322802;4918.754062296799;4924.901501969869;4959.941624225906;4807.687500312469;4833.4441539223435;5006.724630145377;5019.297298378303;5049.258005987928;4812.831550895702;4856.635752318661;4900.901981960412;4903.436104847846;4906.650671065486 13:36:53 INFO - PROCESS | 32726 | |5;yui.html;647.0391468669022;653.2683394598051;719.2519779429393;727.9636018199091;750.2272659161063;11383.943080284598;11984.161108722394;12016.639500814968;12036.81944770828;12048.518059277618;12162.601300850405;12290.56983005595;12530.060245481602;12617.495300188004;12630.1790383625;622.7446746833799;748.0873334531863;750.9324160825538;764.5756605084176;773.8220209351853;762.5272331154691;773.3774311679097;773.8452309538087;774.6785084190054;774.8721460958935;815.5269943432795;819.2667562531531;820.8563501387263;821.2608652212996;821.3552361396305;653.9313372095957;785.6543121026787;811.6915572082571;815.7471183933;815.7634286057037;590.7282649981014;592.3839207224481;592.582229528186;592.6592209479523;592.9110633404981;12249.448774805156;12272.693182670415;12310.26138431697;12345;12374.876251237552;11742.236754610924;11910.464029118624;12244.571439999647;12426.813597796041;12637.2417654941;9753.122219000325;9975.152112070482;10011.899881001242;11801.94099029508;11977.101717371232;4107.876763697094;4108.91782164358;4141.461609990712;4239.8092085856215;4260.595243451867;62774.37225627731;62900;62983;63036;64134;9857.802843943224;10060.446675432922;10087.142592879542;10153.543090560943;10216.642417515352;17513.824861751218;19225.13486893093;19229;19238.422847314603;19360.93514856668;6469.708863101172;6510.153680021567;6554.901676474857;6672.232693240242;6936.2023367312395;3895.2988462077096;3968.3849003404516;3992.301347264217;4021.91956160881;4070.7354021989067;2919.6934321895897;3000.4749168895355;3040.148758347666;3042.3306872488015;3042.771792115556;511.48595661360093;514.2466286889725;519.5064688545821;522.0967725834328;526.4893053737868;538.9811356602501;617.0158597037718;620.7796232337546;621.2141640824361;622;7663.693452261847;7991.320737737357;7993.6802527898235;8103.554304513308;8412.369072319601;509.3861896414811;519.1796960801923;564.9491545760901;588.6989752646699;595.3332267860025;3346.8828590999196;3703.185299234164;3788.8673896414043;3929.8428062877165;3976.4234186042863;66569;78166;91919.54040229756;92741.53629231811;92851.5357423222;66475.33524664691;78946.60526697445;79632.60183699045;79735;80453.19546804574;44336.77831610886;53611;68772.656136719;68868.3113168872;70992.93510597345;7962.7213047543055;8270;8420.526657672563;8556.10160933093;8596.140385961355;43705;43791;43972;44291.33562996622;45115.77442112769;57379.42620573741;61871;62357;62990.68504657447;63289.68355158195;10096.596136154765;10231;10346.896531034594;10364.170866330525;10707.250492465764;12095.092868035108;12419.37903104823;12525;12642.115051946275;12968.935155324163;11774.764504709687;12036.699082523008;12573.87426125727;12659.177153484994;12970.675733106747;11862.940685296518;12580.685482863002;12747.49010039588;12780.233186008869;12801.871981280441;11277.492512837107;11473;11696.649100526998;12335.074869385011;12501.24992500453;8852.867206992029;9664.951675241578;9727.756806079904;9762.658306959222;10173.84739228927;9395.201407880133;9538.713838584854;9631;9840.753981150243;9951.601935922772 13:36:53 INFO - PROCESS | 32726 | __end_tp_report 13:36:53 INFO - PROCESS | 32726 | __start_cc_report 13:36:53 INFO - PROCESS | 32726 | _x_x_mozilla_cycle_collect,904 13:36:53 INFO - PROCESS | 32726 | __end_cc_report 13:36:53 INFO - PROCESS | 32726 | __startTimestamp1471552613560__endTimestamp 13:36:53 INFO - PROCESS | 32726 | 13:36:53 INFO - PROCESS | 32726 | ------- Summary: start ------- 13:36:53 INFO - PROCESS | 32726 | Number of tests: 6 13:36:53 INFO - PROCESS | 32726 | 13:36:53 INFO - PROCESS | 32726 | [#0] dojo.html Cycles:165 Average:4650.50 Median:4786.19 stddev:491.33 (10.3%) stddev-sans-first:465.03 13:36:53 INFO - PROCESS | 32726 | Values: 2573.3 2596.5 2612.2 2618.8 2638.3 4578.1 4625.0 4659.9 4665.5 4671.8 4644.2 4684.3 4694.1 4713.9 4747.4 4208.3 4289.6 4329.0 4352.9 4373.1 4300.8 4307.0 4320.9 4327.1 4370.1 4418.4 4472.8 4486.3 4495.0 4496.8 4223.1 4263.1 4332.0 4378.6 4379.8 4185.4 4193.9 4222.6 4231.6 4243.7 4641.1 4657.4 4694.0 4731.9 4734.6 4899.1 4970.8 5050.9 5058.9 5059.0 5006.1 5067.8 5071.7 5142.5 5145.3 4744.6 4755.5 4772.7 4786.2 4802.3 5014.1 5244.1 5245.9 5253.6 5258.9 4877.7 4906.3 4912.2 4976.8 4999.2 5039.6 5051.1 5061.9 5082.6 5085.6 4806.2 4991.6 5000.4 5007.3 5012.5 4810.8 4857.3 4873.5 4878.3 4889.9 4164.4 4199.3 4200.1 4203.6 4204.9 3671.5 3702.2 3703.1 3714.3 3726.8 4428.7 4431.6 4436.0 4459.8 4461.1 5079.1 5089.5 5089.6 5094.8 5121.3 4279.4 4342.1 4384.7 4413.7 4427.5 4571.2 4573.2 4573.8 4600.8 4620.1 4854.3 4856.7 4861.8 4865.2 4911.2 4823.3 5003.0 5007.7 5088.3 5103.2 4803.7 4806.9 4829.7 4834.8 4841.9 4918.4 4951.9 4960.9 4981.9 4990.8 4889.5 4976.8 4997.4 5056.4 5092.6 4916.6 4923.7 4930.5 4952.9 4954.2 4922.0 4931.3 4943.0 4951.8 4980.4 4658.0 4727.1 4758.4 4864.5 4928.2 4785.3 4846.9 4859.6 4868.5 4891.7 4711.1 4716.9 4717.1 4723.5 4738.0 13:36:53 INFO - PROCESS | 32726 | 13:36:53 INFO - PROCESS | 32726 | [#1] ext.html Cycles:180 Average:44256.73 Median:19645.73 stddev:78910.13 (401.7%) stddev-sans-first:79063.31 13:36:53 INFO - PROCESS | 32726 | Values: 568.9 578.0 578.8 581.3 581.6 29223.7 39632.8 40810.8 40959.4 44675.3 40961.6 41167.0 41332.2 41358.8 41396.6 7601.3 7737.8 7741.8 7744.5 7762.7 7463.6 7535.2 7553.1 7558.2 7558.9 7560.2 7588.7 7594.5 7600.2 7605.0 7545.3 7568.3 7570.0 7578.2 7580.6 7660.9 7724.5 7728.5 7732.0 7732.7 38302.8 39045.4 39138.8 39143.0 39197.4 3129.5 3158.7 3159.2 3398.3 3565.2 28870.6 28914.1 28967.6 29146.3 30288.1 3433.0 3462.4 3497.3 3508.9 3536.5 238352.0 238549.0 239032.0 239440.0 240247.0 31395.2 52156.5 52337.5 52354.5 52476.0 31934.4 33429.2 33457.0 33467.3 33527.5 12628.0 12689.6 12707.0 12749.6 12751.1 10711.2 10749.8 10750.1 10750.1 10767.9 7615.8 7808.5 7816.5 7876.3 7882.2 3026.8 3043.2 3049.6 3054.2 3086.6 798.7 831.7 844.2 868.9 970.4 26557.6 27171.9 27660.6 27985.7 28591.7 794.0 932.3 936.3 967.1 990.4 13503.3 14515.5 14634.2 14843.0 14854.8 364569.0 365392.0 366225.0 366832.0 368292.0 48430.0 48917.3 48969.5 48992.0 49065.5 1021.2 1116.6 1127.2 1138.6 1139.8 27642.7 28556.3 29139.7 29670.6 29691.6 41734.4 42179.0 42355.6 42364.4 42364.6 278520.0 278627.0 280164.0 280741.0 281452.4 25331.5 26418.3 26445.3 27333.0 27527.9 41930.8 42142.0 42165.2 43145.4 43237.8 35129.3 35353.8 35420.8 35726.3 35827.5 35418.8 35551.0 35860.9 35868.6 35884.5 34487.0 34823.0 35253.5 35425.8 35898.3 31019.8 33029.5 33224.7 33373.5 33574.8 24314.6 25047.9 25111.0 25129.4 25531.7 13:36:53 INFO - PROCESS | 32726 | 13:36:53 INFO - PROCESS | 32726 | [#2] jquery.html Cycles:180 Average:23523.92 Median:28820.22 stddev:58181.19 (201.9%) stddev-sans-first:58318.37 13:36:53 INFO - PROCESS | 32726 | Values: 341.6 355.9 367.2 367.4 382.6 12526.6 16067.7 16470.9 17806.9 18004.4 15861.0 16331.4 16362.6 16497.5 17045.4 4947.0 4979.4 5051.0 5115.3 5124.5 3736.9 4937.5 5064.9 5658.1 6071.9 5994.5 6118.1 6126.8 6131.3 6135.7 5954.9 6001.1 6026.8 6028.0 6054.1 5170.4 5368.7 5373.2 5377.7 5386.8 21318.5 21521.8 21962.2 21968.6 22092.4 1848.6 1910.4 2009.7 2044.0 2454.1 12753.1 13260.5 13968.7 14227.3 14339.4 1768.4 1776.4 1777.3 1786.6 1810.2 69571.0 70313.6 70877.3 71887.0 71893.3 8977.8 8979.1 9142.8 9178.5 9618.3 13403.5 13403.9 13418.7 13425.3 13440.4 7099.9 7243.4 7307.6 7462.7 7481.1 6861.1 6876.4 7125.2 7133.8 7133.8 6205.6 6306.5 6312.1 6331.4 6391.8 1552.2 1558.5 1565.1 1574.9 1616.5 708.4 785.8 810.3 934.0 942.3 16444.8 17176.7 17314.9 17512.2 17602.7 807.5 850.0 855.4 859.6 869.6 9201.5 9752.0 9784.5 9817.2 9919.7 342961.0 350356.0 350652.0 351350.0 354012.0 78872.0 79751.2 80347.6 80434.0 81906.0 902.9 904.5 905.7 927.9 943.3 15038.0 15284.2 15546.9 15840.5 16002.3 37232.3 38364.8 38684.6 38878.8 39145.6 50052.5 50619.0 52470.0 52799.7 53247.5 7541.9 7627.2 7731.9 7809.8 8139.3 9917.8 12244.9 12278.0 12314.6 12350.2 7288.7 7408.7 7659.3 7867.7 10405.3 7340.7 7554.1 7828.4 7921.0 7961.4 7602.2 7817.3 7826.0 7855.5 8284.1 11047.8 11241.0 11320.0 11517.8 11604.7 10666.0 10879.3 10969.8 11265.7 11843.9 13:36:53 INFO - PROCESS | 32726 | 13:36:53 INFO - PROCESS | 32726 | [#3] mootools.html Cycles:180 Average:5059.80 Median:5176.50 stddev:2883.79 (55.7%) stddev-sans-first:2877.49 13:36:53 INFO - PROCESS | 32726 | Values: 1225.7 1313.6 1363.8 1376.4 1629.0 6665.2 7642.1 8005.8 8006.3 8015.8 7832.3 7889.7 7890.1 7891.9 7893.4 2176.5 2200.9 2203.5 2206.0 2206.7 2116.6 2157.9 2184.4 2186.7 2190.2 2143.2 2166.4 2170.1 2170.5 2183.0 2131.1 2140.2 2141.1 2141.3 2142.2 2088.3 2145.5 2146.4 2151.1 2170.7 7709.1 7752.5 7774.2 7804.8 7852.5 4530.5 4660.5 4669.8 4670.0 4672.1 2789.0 2918.2 2948.6 2962.5 2964.3 929.7 931.2 944.1 949.5 959.4 10912.6 11013.3 11013.6 11018.8 11019.8 3943.5 3987.6 4024.9 4027.6 4208.4 8397.4 8552.1 8555.9 8560.6 8562.0 4463.6 4472.1 4472.7 4475.0 4480.1 3707.3 3994.6 4122.8 4136.2 4158.2 3348.6 3385.8 3476.3 3501.7 3506.4 1014.6 1040.3 1042.6 1045.0 1053.8 800.8 821.7 823.2 824.8 827.1 5164.5 5194.8 5221.2 5234.8 5387.6 415.5 420.4 430.5 431.6 435.2 3457.2 3461.4 3606.8 3694.3 3727.5 9091.9 9521.1 9546.2 9626.1 9633.5 8989.6 9435.4 9488.8 9759.6 9769.9 7094.4 7174.5 7242.6 7295.2 7304.6 5188.5 5311.9 5326.1 5337.2 5378.9 8567.7 8639.7 8687.2 8755.6 8892.7 8813.3 9002.4 9119.0 9172.6 9197.6 5950.2 6548.1 6630.6 6778.3 6784.9 7352.6 7537.5 7563.1 7568.2 7579.3 6323.9 6340.9 6452.9 6504.5 6593.1 6396.7 6478.3 6505.0 6534.4 6545.5 6181.6 6291.0 6291.7 6295.2 6302.3 4344.7 4427.7 4453.5 4533.4 4562.1 4401.4 4417.4 4579.5 4589.5 4590.3 13:36:53 INFO - PROCESS | 32726 | 13:36:53 INFO - PROCESS | 32726 | [#4] prototype.html Cycles:180 Average:4174.02 Median:4816.11 stddev:1202.63 (25.0%) stddev-sans-first:1170.19 13:36:53 INFO - PROCESS | 32726 | Values: 293.0 302.2 302.9 306.1 307.6 4824.9 4832.9 4838.8 4850.8 4878.9 4736.6 4766.0 4819.4 4823.0 4858.5 3552.8 3673.4 3692.2 3761.9 3788.6 3763.8 3767.4 3769.4 3784.5 3798.4 3735.0 3740.5 3749.8 3754.4 3768.0 3519.3 3617.9 3729.5 3731.9 3734.4 3309.0 3314.9 3316.3 3324.9 3326.9 4648.4 4659.9 4676.6 4681.3 4688.9 4183.2 4302.6 4307.1 4314.1 4323.4 4972.6 4977.0 4978.5 5014.8 5019.6 3615.7 3629.3 3636.1 3652.2 3660.3 5124.0 5194.8 5231.6 5251.9 5281.6 3691.9 3724.0 3728.0 3728.1 3728.6 3751.0 3765.6 3769.7 3771.5 3781.3 4276.2 4284.7 4285.7 4290.2 4301.8 4772.2 4932.0 4968.4 4979.0 5015.7 1297.2 1316.3 1316.5 1317.2 1320.9 817.8 843.5 850.4 860.0 862.8 4272.9 4393.4 4495.7 4515.6 4526.3 5126.4 5170.8 5180.9 5186.5 5198.6 4498.8 4504.2 4506.2 4540.9 4554.4 2572.1 2703.7 2717.5 2721.4 2755.0 4890.0 4891.2 4918.4 4938.7 4950.3 5086.0 5305.9 5323.3 5323.8 5344.2 4835.8 4865.3 4879.3 4888.2 4894.3 5104.8 5132.8 5140.9 5146.4 5187.4 4923.2 4968.0 5059.6 5073.9 5099.9 4866.8 4874.3 4884.0 4884.6 4884.8 3699.2 3700.4 3703.0 3741.2 3747.5 4944.6 5151.3 5166.6 5170.9 5192.2 4937.9 4940.5 4949.6 4960.9 5028.7 4935.4 4979.9 4997.5 4999.5 5028.3 4685.6 4914.3 4918.8 4924.9 4959.9 4807.7 4833.4 5006.7 5019.3 5049.3 4812.8 4856.6 4900.9 4903.4 4906.7 13:36:53 INFO - PROCESS | 32726 | 13:36:53 INFO - PROCESS | 32726 | [#5] yui.html Cycles:180 Average:16757.83 Median:27068.74 stddev:23050.21 (85.2%) stddev-sans-first:23083.13 13:36:53 INFO - PROCESS | 32726 | Values: 647.0 653.3 719.3 728.0 750.2 11383.9 11984.2 12016.6 12036.8 12048.5 12162.6 12290.6 12530.1 12617.5 12630.2 622.7 748.1 750.9 764.6 773.8 762.5 773.4 773.8 774.7 774.9 815.5 819.3 820.9 821.3 821.4 653.9 785.7 811.7 815.7 815.8 590.7 592.4 592.6 592.7 592.9 12249.4 12272.7 12310.3 12345.0 12374.9 11742.2 11910.5 12244.6 12426.8 12637.2 9753.1 9975.2 10011.9 11801.9 11977.1 4107.9 4108.9 4141.5 4239.8 4260.6 62774.4 62900.0 62983.0 63036.0 64134.0 9857.8 10060.4 10087.1 10153.5 10216.6 17513.8 19225.1 19229.0 19238.4 19360.9 6469.7 6510.2 6554.9 6672.2 6936.2 3895.3 3968.4 3992.3 4021.9 4070.7 2919.7 3000.5 3040.1 3042.3 3042.8 511.5 514.2 519.5 522.1 526.5 539.0 617.0 620.8 621.2 622.0 7663.7 7991.3 7993.7 8103.6 8412.4 509.4 519.2 564.9 588.7 595.3 3346.9 3703.2 3788.9 3929.8 3976.4 66569.0 78166.0 91919.5 92741.5 92851.5 66475.3 78946.6 79632.6 79735.0 80453.2 44336.8 53611.0 68772.7 68868.3 70992.9 7962.7 8270.0 8420.5 8556.1 8596.1 43705.0 43791.0 43972.0 44291.3 45115.8 57379.4 61871.0 62357.0 62990.7 63289.7 10096.6 10231.0 10346.9 10364.2 10707.3 12095.1 12419.4 12525.0 12642.1 12968.9 11774.8 12036.7 12573.9 12659.2 12970.7 11862.9 12580.7 12747.5 12780.2 12801.9 11277.5 11473.0 11696.6 12335.1 12501.2 8852.9 9665.0 9727.8 9762.7 10173.8 9395.2 9538.7 9631.0 9840.8 9951.6 13:36:53 INFO - PROCESS | 32726 | -------- Summary: end -------- 13:36:53 INFO - PROCESS | 32726 | 13:36:54 INFO - TEST-INFO | 32726: exit 0 13:36:54 INFO - TEST-OK | dromaeo_css | took 1122880ms 13:36:54 INFO - TEST-START | kraken 13:36:54 INFO - operating with platform_type : linux_ 13:36:54 INFO - Initialising browser for kraken test... 13:36:54 INFO - TEST-INFO | started process 565 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwjV8JE/profile http://localhost:42351/getInfo.html) 13:36:59 INFO - PROCESS | 565 | __metrics Screen width/height:1600/1200 13:36:59 INFO - PROCESS | 565 | colorDepth:24 13:36:59 INFO - PROCESS | 565 | Browser inner width/height: 1024/697 13:36:59 INFO - PROCESS | 565 | __metrics 13:37:00 INFO - PROCESS | 565 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:37:00 INFO - PROCESS | 565 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:37:01 INFO - PROCESS | 565 | console.error: PushService: 13:37:01 INFO - PROCESS | 565 | stateChangeProcessEnqueue: Error transitioning state 13:37:01 INFO - PROCESS | 565 | UnknownError 13:37:01 INFO - TEST-INFO | 565: exit 0 13:37:01 INFO - Browser initialized. 13:37:01 INFO - Running cycle 1/1 for kraken test... 13:37:01 INFO - TEST-INFO | started process 648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwjV8JE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:13 INFO - PROCESS | 648 | RSS: Main: 157339648 13:37:13 INFO - PROCESS | 648 | 13:37:16 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:42351/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42351/tests/kraken/driver.html?testName=audio-beat-detection) 13:37:17 INFO - PROCESS | 648 | RSS: Main: 205074432 13:37:17 INFO - PROCESS | 648 | 13:37:20 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:42351/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42351/tests/kraken/driver.html?testName=audio-dft) 13:37:20 INFO - PROCESS | 648 | RSS: Main: 195964928 13:37:20 INFO - PROCESS | 648 | 13:37:23 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:42351/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42351/tests/kraken/driver.html?testName=audio-fft) 13:37:24 INFO - PROCESS | 648 | RSS: Main: 276680704 13:37:24 INFO - PROCESS | 648 | 13:37:26 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:42351/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42351/tests/kraken/driver.html?testName=audio-oscillator) 13:37:27 INFO - PROCESS | 648 | RSS: Main: 187101184 13:37:27 INFO - PROCESS | 648 | 13:37:29 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:42351/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42351/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:37:30 INFO - PROCESS | 648 | RSS: Main: 192217088 13:37:30 INFO - PROCESS | 648 | 13:37:33 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:42351/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42351/tests/kraken/driver.html?testName=imaging-darkroom) 13:37:34 INFO - PROCESS | 648 | RSS: Main: 228696064 13:37:34 INFO - PROCESS | 648 | 13:37:37 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:42351/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42351/tests/kraken/driver.html?testName=imaging-desaturate) 13:37:38 INFO - PROCESS | 648 | RSS: Main: 221646848 13:37:38 INFO - PROCESS | 648 | 13:37:41 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:42351/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42351/tests/kraken/driver.html?testName=json-parse-financial) 13:37:41 INFO - PROCESS | 648 | RSS: Main: 225595392 13:37:41 INFO - PROCESS | 648 | 13:37:43 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:42351/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42351/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:37:44 INFO - PROCESS | 648 | RSS: Main: 189329408 13:37:44 INFO - PROCESS | 648 | 13:37:45 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:42351/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42351/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:37:46 INFO - PROCESS | 648 | RSS: Main: 197316608 13:37:46 INFO - PROCESS | 648 | 13:37:48 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:42351/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42351/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:37:49 INFO - PROCESS | 648 | RSS: Main: 194510848 13:37:49 INFO - PROCESS | 648 | 13:37:52 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:42351/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:37:52 INFO - PROCESS | 648 | RSS: Main: 188805120 13:37:52 INFO - PROCESS | 648 | 13:37:55 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:42351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:37:56 INFO - PROCESS | 648 | RSS: Main: 191950848 13:37:56 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | Cycle 1(1): loaded http://localhost:42351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42351/tests/kraken/driver.html?testName=ai-astar) 13:37:58 INFO - PROCESS | 648 | RSS: Main: 242966528 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | __start_tp_report 13:37:58 INFO - PROCESS | 648 | _x_x_mozilla_page_load 13:37:58 INFO - PROCESS | 648 | _x_x_mozilla_page_load_details 13:37:58 INFO - PROCESS | 648 | |i|pagename|runs| 13:37:58 INFO - PROCESS | 648 | |0;ai-astar;106;114;116;113;110;114;114;114;114;114 13:37:58 INFO - PROCESS | 648 | |1;audio-beat-detection;145;125;122;179;124;125;155;123;167;128 13:37:58 INFO - PROCESS | 648 | |2;audio-dft;161;160;161;160;161;162;163;161;163;159 13:37:58 INFO - PROCESS | 648 | |3;audio-fft;77;76;77;108;77;79;74;76;106;76 13:37:58 INFO - PROCESS | 648 | |4;audio-oscillator;86;86;134;86;86;86;123;85;87;123 13:37:58 INFO - PROCESS | 648 | |5;imaging-gaussian-blur;116;116;117;117;118;117;117;117;117;117 13:37:58 INFO - PROCESS | 648 | |6;imaging-darkroom;145;146;146;146;147;146;146;147;146;146 13:37:58 INFO - PROCESS | 648 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;96;95 13:37:58 INFO - PROCESS | 648 | |8;json-parse-financial;75;63;66;64;64;66;66;65;67;70 13:37:58 INFO - PROCESS | 648 | |9;json-stringify-tinderbox;65;66;65;66;66;66;66;65;65;65 13:37:58 INFO - PROCESS | 648 | |10;stanford-crypto-aes;83;83;82;82;91;83;81;81;81;92 13:37:58 INFO - PROCESS | 648 | |11;stanford-crypto-ccm;134;133;131;130;137;132;131;136;163;147 13:37:58 INFO - PROCESS | 648 | |12;stanford-crypto-pbkdf2;171;173;172;181;171;170;171;168;171;169 13:37:58 INFO - PROCESS | 648 | |13;stanford-crypto-sha256-iterative;67;70;70;67;67;67;67;68;65;66 13:37:58 INFO - PROCESS | 648 | __end_tp_report 13:37:58 INFO - PROCESS | 648 | __start_cc_report 13:37:58 INFO - PROCESS | 648 | _x_x_mozilla_cycle_collect,1997 13:37:58 INFO - PROCESS | 648 | __end_cc_report 13:37:58 INFO - PROCESS | 648 | __startTimestamp1471552678423__endTimestamp 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | ------- Summary: start ------- 13:37:58 INFO - PROCESS | 648 | Number of tests: 14 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:2.85 (2.5%) stddev-sans-first:1.58 13:37:58 INFO - PROCESS | 648 | Values: 106.0 114.0 116.0 113.0 110.0 114.0 114.0 114.0 114.0 114.0 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:136.50 stddev:20.97 (15.4%) stddev-sans-first:22.14 13:37:58 INFO - PROCESS | 648 | Values: 145.0 125.0 122.0 179.0 124.0 125.0 155.0 123.0 167.0 128.0 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 13:37:58 INFO - PROCESS | 648 | Values: 161.0 160.0 161.0 160.0 161.0 162.0 163.0 161.0 163.0 159.0 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.50 stddev:12.93 (16.9%) stddev-sans-first:13.55 13:37:58 INFO - PROCESS | 648 | Values: 77.0 76.0 77.0 108.0 77.0 79.0 74.0 76.0 106.0 76.0 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:86.00 stddev:19.88 (23.1%) stddev-sans-first:20.59 13:37:58 INFO - PROCESS | 648 | Values: 86.0 86.0 134.0 86.0 86.0 86.0 123.0 85.0 87.0 123.0 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 13:37:58 INFO - PROCESS | 648 | Values: 116.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 13:37:58 INFO - PROCESS | 648 | Values: 145.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:37:58 INFO - PROCESS | 648 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:66.00 stddev:3.53 (5.4%) stddev-sans-first:2.06 13:37:58 INFO - PROCESS | 648 | Values: 75.0 63.0 66.0 64.0 64.0 66.0 66.0 65.0 67.0 70.0 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 13:37:58 INFO - PROCESS | 648 | Values: 65.0 66.0 65.0 66.0 66.0 66.0 66.0 65.0 65.0 65.0 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:4.09 (4.9%) stddev-sans-first:4.33 13:37:58 INFO - PROCESS | 648 | Values: 83.0 83.0 82.0 82.0 91.0 83.0 81.0 81.0 81.0 92.0 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:135.00 stddev:10.25 (7.6%) stddev-sans-first:10.80 13:37:58 INFO - PROCESS | 648 | Values: 134.0 133.0 131.0 130.0 137.0 132.0 131.0 136.0 163.0 147.0 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:171.00 stddev:3.56 (2.1%) stddev-sans-first:3.77 13:37:58 INFO - PROCESS | 648 | Values: 171.0 173.0 172.0 181.0 171.0 170.0 171.0 168.0 171.0 169.0 13:37:58 INFO - PROCESS | 648 | 13:37:58 INFO - PROCESS | 648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:1.58 (2.4%) stddev-sans-first:1.67 13:37:58 INFO - PROCESS | 648 | Values: 67.0 70.0 70.0 67.0 67.0 67.0 67.0 68.0 65.0 66.0 13:37:58 INFO - PROCESS | 648 | -------- Summary: end -------- 13:37:58 INFO - PROCESS | 648 | 13:37:59 INFO - TEST-INFO | 648: exit 0 13:37:59 INFO - TEST-OK | kraken | took 65276ms 13:37:59 INFO - SUITE-END | took 1188s 13:38:00 INFO - Completed test suite (00:19:48) 13:38:00 INFO - javascript benchmark 13:38:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2573.3052075939495, 2596.532624127656, 2612.229392329263, 2618.7774039206665, 2638.340414896276, 4578.061497393035, 4624.953750462494, 4659.860204193871, 4665.533446655333, 4671.789769460374, 4644.210484217682, 4684.344191813149, 4694.131585656656, 4713.9057218855605, 4747.382840230774, 4208.263553878074, 4289.6353809926195, 4329.047609525915, 4352.912941741163, 4373.103513779667, 4300.763458009808, 4307.0, 4320.935185972197, 4327.0913108247305, 4370.104128653618, 4418.359337896003, 4472.843450479234, 4486.259767138418, 4495.0, 4496.842610508633, 4223.092035212413, 4263.126059157865, 4331.956680433218, 4378.605925466723, 4379.846705365297, 4185.434966279544, 4193.853215137486, 4222.641075508585, 4231.555686652919, 4243.745375277494, 4641.141388843075, 4657.371254880582, 4694.014257005999, 4731.8580442586435, 4734.55021772931, 4899.093667671456, 4970.826021089245, 5050.949490505084, 5058.898822023576, 5058.974705126488, 5006.098902197603, 5067.797288108472, 5071.670341427795, 5142.4600416956055, 5145.279660847447, 4744.620430365562, 4755.453122890877, 4772.689775164603, 4786.1863483207935, 4802.327674125625, 5014.122528557561, 5244.056069907377, 5245.947540524622, 5253.553447956967, 5258.894822103536, 4877.6829506081995, 4906.288588154769, 4912.164931961575, 4976.776045077981, 4999.150144475448, 5039.622028347889, 5051.116054690415, 5061.873453163626, 5082.644214904921, 5085.593152547787, 4806.182948898696, 4991.625628077909, 5000.449950505442, 5007.273945277987, 5012.54887060159, 4810.845397104739, 4857.344258525124, 4873.537013983666, 4878.268259760993, 4889.902201955941, 4164.3961625564725, 4199.349100889367, 4200.075983283673, 4203.600657937491, 4204.936925946114, 3671.541057367829, 3702.204026134394, 3703.148275896559, 3714.257148570297, 3726.8136593170234, 4428.667849911205, 4431.601155895984, 4436.0462500562535, 4459.7547134907245, 4461.085477477174, 5079.1365467870555, 5089.51649593288, 5089.643724939293, 5094.835802573815, 5121.2574176744165, 4279.379489973936, 4342.066455712037, 4384.7369157850635, 4413.713108647928, 4427.490838553607, 4571.245744452194, 4573.222552166139, 4573.817047318136, 4600.815967361268, 4620.052889157714, 4854.320395144682, 4856.684315519621, 4861.805527778849, 4865.172920603577, 4911.189653707098, 4823.27650852375, 5003.049420610072, 5007.674501157413, 5088.2876397305145, 5103.209002604603, 4803.663743537919, 4806.903861922812, 4829.66192366531, 4834.7824347903725, 4841.8547443576745, 4918.43438004634, 4951.876203094951, 4960.900781984268, 4981.875453113701, 4990.775415106402, 4889.535494128052, 4976.751162441936, 4997.400311962588, 5056.403318544556, 5092.567131793839, 4916.606671466203, 4923.704577725348, 4930.457649658606, 4952.851414457572, 4954.157793175241, 4922.0, 4931.284963680175, 4942.975285123552, 4951.801927922843, 4980.427250866197, 4658.0218154188, 4727.101850648366, 4758.381410416762, 4864.513548645107, 4928.162212423825, 4785.306130610972, 4846.927296090632, 4859.562639362474, 4868.464468908346, 4891.706497610155, 4711.055276381948, 4716.905661886674, 4717.056588682346, 4723.480417154179, 4738.0], "value": 4618.708374831083, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.9004424225759, 577.9739911703973, 578.7887421091302, 581.3140494216827, 581.5928849805136, 29223.707762922364, 39632.80183599082, 40810.795946020306, 40959.38560921588, 44675.32987005197, 40961.59038409615, 41167.0, 41332.173356532854, 41358.79320603393, 41396.58603413965, 7601.315881570657, 7737.806554836146, 7741.806454838646, 7744.49660772048, 7762.650680719353, 7463.589502577356, 7535.171131175566, 7553.055868016498, 7558.168601453835, 7558.886616700754, 7560.168381478061, 7588.658510367047, 7594.5063570867715, 7600.163981962008, 7605.0, 7545.320921117099, 7568.318851303354, 7570.0, 7578.242175782378, 7580.583067931261, 7660.885086723648, 7724.459287849852, 7728.536287822749, 7731.961340193319, 7732.729354472566, 38302.80848595767, 39045.414318784955, 39138.80430597857, 39143.0, 39197.41203881944, 3129.5462157986963, 3158.684131586846, 3159.2259896325318, 3398.303347813692, 3565.180008598011, 28870.566941495894, 28914.13257602254, 28967.56548651772, 29146.271343216376, 30288.091357259316, 3432.9828350858334, 3462.3594634992605, 3497.283056973314, 3508.859645614172, 3536.504889315498, 238352.0, 238549.0, 239032.0, 239439.99999999825, 240247.0, 31395.215119622193, 52156.47843521516, 52337.47662523326, 52354.47645523496, 52476.0, 31934.361312773613, 33429.164270892936, 33457.0, 33467.33065338728, 33527.49708754371, 12628.0, 12689.555865544662, 12707.0, 12749.553765618159, 12751.107422480523, 10711.196660250513, 10749.83875241872, 10750.139988800876, 10750.139988800876, 10767.946160269148, 7615.847683046308, 7808.531488110618, 7816.53100813953, 7876.291133797871, 7882.172371900982, 3026.8183908965534, 3043.178341847689, 3049.573059771634, 3054.1601059708314, 3086.6450358208645, 798.7444017914212, 831.7463173731949, 844.2444012608681, 868.8783570300163, 970.4080510888493, 26557.601635975476, 27171.86414067917, 27660.58509122365, 27985.720142798313, 28591.714082859322, 793.9682412703427, 932.3240650528448, 936.3164889630608, 967.1102585621105, 990.3612170150212, 13503.32483375847, 14515.491957781427, 14634.219438367325, 14843.0, 14854.777178342334, 364569.0, 365392.0, 366225.0, 366832.0, 368292.0, 48430.0, 48917.266241006415, 48969.510304896496, 48992.0, 49065.509344906095, 1021.1983592879702, 1116.5757012335262, 1127.1996882213557, 1138.555963174346, 1139.8176291793272, 27642.723572764015, 28556.286092847015, 29139.708602914547, 29670.554941675462, 29691.554626680187, 41734.373984389655, 42179.0, 42355.576444235165, 42364.36453453139, 42364.576354236066, 278520.0, 278627.0, 280164.0, 280741.0, 281452.44749301026, 25331.493370132863, 26418.339541511617, 26445.33886652849, 27333.0, 27527.86236068807, 41930.790346048074, 42142.01869214488, 42165.15669686651, 43145.35281970836, 43237.78381108074, 35129.29741405209, 35353.82323088368, 35420.822895886384, 35726.28547428985, 35827.462588060676, 35418.8229058853, 35551.0, 35860.92417227487, 35868.64131358653, 35884.461733074546, 34487.0, 34823.0, 35253.47119793154, 35425.82287088548, 35898.28203435969, 31019.84490077535, 33029.50455743214, 33224.66775332216, 33373.49939750954, 33574.83212583922, 24314.63528047116, 25047.87476062608, 25111.0, 25129.371765706004, 25531.74468255368], "value": 16200.834025125818, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.63757616084774, 355.9163596554809, 367.1885133854181, 367.351624382964, 382.60591590661613, 12526.624201273953, 16067.678646427079, 16470.917645411755, 17806.910965445153, 18004.369847055357, 15861.0, 16331.428400006002, 16362.590935226624, 16497.505074847744, 17045.403410880623, 4947.01059788042, 4979.352684151056, 5050.974745126269, 5115.258287548303, 5124.538791508763, 3736.8692095776655, 4937.456879743226, 5064.873378165557, 5658.122990936391, 6071.908921366183, 5994.46049855513, 6118.0822876568645, 6126.816195514141, 6131.325554189036, 6135.693215339237, 5954.940450595482, 6001.12983617373, 6026.789062382817, 6028.0355143176885, 6054.091886217058, 5170.431252562215, 5368.651037682577, 5373.247745315659, 5377.677339359651, 5386.757595908193, 21318.46703832401, 21521.784782152292, 21962.231321903655, 21968.560628787494, 22092.447688807748, 1848.6302739452162, 1910.360029390156, 2009.6784514477613, 2044.0, 2454.12878428159, 12753.107282490137, 13260.469581216836, 13968.720625587432, 14227.28863556818, 14339.42642294307, 1768.3545505890386, 1776.404904357042, 1777.25355350753, 1786.5712229065061, 1810.2125575374623, 69571.0, 70313.64843175803, 70877.2912270881, 71887.0, 71893.2810671897, 8977.820443591092, 8979.14698103679, 9142.81714365709, 9178.541072946326, 9618.278629102846, 13403.463861445432, 13403.932980335036, 13418.731625367438, 13425.328733563283, 13440.395182216824, 7099.911538480777, 7243.384312333511, 7307.5980821055355, 7462.701491940262, 7481.139668938033, 6861.108055952794, 6876.381125698711, 7125.216226215216, 7133.750318738819, 7133.785986420416, 6205.627662340274, 6306.549493616402, 6312.147860038836, 6331.430171284606, 6391.776287829996, 1552.2161308539116, 1558.4545409106722, 1565.1313520995957, 1574.8976316539388, 1616.4908053962963, 708.3624737735976, 785.8271180340316, 810.2545657994659, 933.9553057034118, 942.2556180617372, 16444.75332870008, 17176.742348864776, 17314.913425433046, 17512.21195046226, 17602.655495456078, 807.4549678966674, 849.9885136687323, 855.4439614250787, 859.5616235719702, 869.5695630662863, 9201.539923003824, 9751.951240243896, 9784.51077446139, 9817.165540929102, 9919.702408927744, 342961.0, 350356.0, 350652.0, 351350.0, 354012.0, 78872.0, 79751.20248797553, 80347.59826200831, 80434.0, 81906.0, 902.9458232506071, 904.5025236120108, 905.7373361725026, 927.8700981862545, 943.2972435535432, 15038.0, 15284.235788210322, 15546.9222653886, 15840.524784256491, 16002.279897404878, 37232.25535489329, 38364.80817596006, 38684.6131538681, 38878.805605971786, 39145.6085439142, 50052.49947500624, 50619.0, 52470.0, 52799.73600131975, 53247.46752532425, 7541.886871697038, 7627.23727627255, 7731.922680773345, 7809.804754880946, 8139.348852091937, 9917.752056198653, 12244.877551224374, 12278.0, 12314.630561083182, 12350.197237179555, 7288.708451661874, 7408.740334198122, 7659.272369124924, 7867.724629637935, 10405.27163098606, 7340.70637174507, 7554.093508778982, 7828.373730101464, 7920.960395197987, 7961.40289478303, 7602.163761986067, 7817.257360550739, 7825.960870195612, 7855.5286682799215, 8284.08875023759, 11047.779044419227, 11241.0, 11320.0, 11517.769644607228, 11604.709882252673, 10666.0, 10879.347239165676, 10969.780604388026, 11265.662030139109, 11843.940780296043], "value": 8312.054907690803, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.724212052289, 1313.5599574142661, 1363.8499765025845, 1376.3668712392298, 1628.9918550407253, 6665.200175978884, 7642.121156067054, 8005.759827205193, 8006.279434850862, 8015.839683206333, 7832.295093441589, 7889.723859664899, 7890.132085470594, 7891.881621775678, 7893.447458677895, 2176.5211653436218, 2200.867947923122, 2203.4711669199437, 2205.9889700551553, 2206.680031395447, 2116.597846409185, 2157.870527768331, 2184.4102092435032, 2186.726659167604, 2190.222471022788, 2143.19630138698, 2166.3825809644254, 2170.077716970289, 2170.5007848194923, 2183.0, 2131.0942849289067, 2140.1546389176187, 2141.1221399226242, 2141.3468891987936, 2142.1645558232303, 2088.3108574170487, 2145.495808485005, 2146.358036102383, 2151.0535364439597, 2170.739511258659, 7709.113451952985, 7752.457327987043, 7774.222577742237, 7804.765857024298, 7852.489588176751, 4530.501644819067, 4660.464046634646, 4669.813207471697, 4670.019295947855, 4672.0889426561835, 2788.958165627497, 2918.1829087855435, 2948.5871977923107, 2962.5408061750463, 2964.318206812424, 929.6560272699145, 931.180561106229, 944.1455482788087, 949.5157469690439, 959.3764053365369, 10912.618058367998, 11013.339199648046, 11013.559457621686, 11018.779624407547, 11019.83470247947, 3943.526776786804, 3987.6211759882763, 4024.939625905614, 4027.556968733437, 4208.410822484854, 8397.412181147383, 8552.144785521523, 8555.871661925075, 8560.61477233526, 8561.957190214009, 4463.642908567307, 4472.105578884236, 4472.709273897186, 4475.0, 4480.126375356839, 3707.258548290353, 3994.6404823566018, 4122.752634841859, 4136.21411931732, 4158.168366326747, 3348.5814273215847, 3385.762996590215, 3476.3221171871746, 3501.702355299828, 3506.4389697648253, 1014.573878970834, 1040.2718097331897, 1042.598599539183, 1045.0281238448315, 1053.757635743783, 800.7517669522466, 821.6959724901825, 823.2138307916046, 824.8226631274305, 827.0902007791501, 5164.483551644806, 5194.818181363634, 5221.164613661796, 5234.790608375699, 5387.649802762886, 415.4578275350696, 420.4492115328929, 430.4855697441527, 431.59214542257894, 435.17534272553337, 3457.1529975155745, 3461.394256005189, 3606.8016259105475, 3694.261147770457, 3727.4967879336486, 9091.863622045674, 9521.143097121154, 9546.236301095896, 9626.085521875411, 9633.518324083769, 8989.595468203946, 9435.386699864486, 9488.762780930532, 9759.560819763128, 9769.853452198222, 7094.396976256973, 7174.461915356369, 7242.565446073252, 7295.2340004298785, 7304.598247096461, 5188.507091826271, 5311.867203319948, 5326.09456392422, 5337.172738225581, 5378.865528361822, 8567.657293708182, 8639.654413823377, 8687.174718401742, 8755.605997730245, 8892.68875589377, 8813.250873675554, 9002.369834111549, 9118.996910339725, 9172.587233574639, 9197.632094716137, 5950.16697662319, 6548.148740663683, 6630.602163870183, 6778.254392016973, 6784.898226526705, 7352.595607241653, 7537.510061845963, 7563.092428908566, 7568.243175682388, 7579.317861392501, 6323.873522529616, 6340.9365906340345, 6452.935470645421, 6504.512161587994, 6593.142891424084, 6396.680165991775, 6478.3197764235965, 6504.967475162784, 6534.379233972765, 6545.5090868184125, 6181.598196117238, 6290.968545157245, 6291.716872740646, 6295.244570651368, 6302.338254483397, 4344.674149438868, 4427.712198707074, 4453.487848897418, 4533.410656614619, 4562.110388474216, 4401.427814384109, 4417.447819022622, 4579.473360563577, 4589.495155532822, 4590.265557510782], "value": 3993.783702565216, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.9882804687813, 302.21725730358366, 302.8924731720239, 306.1428001595532, 307.5647958139232, 4824.8793780155465, 4832.8791780205465, 4838.75806209689, 4850.830220942268, 4878.926636140052, 4736.597389221912, 4765.952340476603, 4819.397575303087, 4822.97588512057, 4858.51414858514, 3552.822358882052, 3673.3938900081453, 3692.2246328271094, 3761.887143385703, 3788.6211378862167, 3763.849446022156, 3767.3972164453694, 3769.396896496561, 3784.489093972306, 3798.385686083417, 3735.0, 3740.541188936317, 3749.837550359384, 3754.3805272130066, 3768.021788561, 3519.331327047853, 3617.9095522611883, 3729.4965179700935, 3731.869384571527, 3734.421164719473, 3308.9669103308897, 3314.850831712579, 3316.303576248991, 3324.905309654926, 3326.866925322984, 4648.372469716579, 4659.930101048487, 4676.649251306131, 4681.344611754357, 4688.929666055012, 4183.247015537202, 4302.569743025703, 4307.104873855525, 4314.115606300701, 4323.4163387942535, 4972.627052971042, 4976.959446626865, 4978.5270399312, 5014.824481143142, 5019.573336266421, 3615.6926661233565, 3629.2922880038404, 3636.1091532574424, 3652.2330310634798, 3660.2679464107287, 5124.028063723069, 5194.766235519411, 5231.60762942777, 5251.872991438436, 5281.603879708999, 3691.8523259069875, 3723.9627603724157, 3728.0120767996505, 3728.105254738897, 3728.5525736911745, 3750.981245093757, 3765.5669597996034, 3769.6607305342104, 3771.528558930134, 3781.3193625147737, 4276.230278549829, 4284.721493102938, 4285.657147428198, 4290.227759003347, 4301.763403012802, 4772.212584923449, 4931.9753401232765, 4968.354113965162, 4978.950210497921, 5015.673981191211, 1297.2346315673797, 1316.2694704439127, 1316.4602512969636, 1317.1504379675057, 1320.9273489957952, 817.7996390884272, 843.5107637570195, 850.3537311643196, 860.0496451421214, 862.8050150541545, 4272.850450234289, 4393.428854248928, 4495.662825288116, 4515.63874890008, 4526.275795872644, 5126.436092029874, 5170.767315470813, 5180.8963820723375, 5186.507281808223, 5198.558122559625, 4498.8425405110665, 4504.234280172379, 4506.1663592235545, 4540.8637740867825, 4554.407926969473, 2572.113348381338, 2703.6755589329405, 2717.4836781011545, 2721.360480287131, 2754.986225068902, 4890.046440944053, 4891.214706632054, 4918.360613120343, 4938.654294199443, 4950.25746138075, 5086.0, 5305.893882122413, 5323.30796996388, 5323.840284791462, 5344.225087362311, 4835.8065677372515, 4865.343178670834, 4879.268109783561, 4888.2178851383605, 4894.339264199359, 5104.774854035079, 5132.8460146195675, 5140.922886156636, 5146.408163061146, 5187.377514698261, 4923.236898280772, 4968.0312339093525, 5059.620528460307, 5073.898522029613, 5099.92350114756, 4866.831960329566, 4874.341963834837, 4883.975580122219, 4884.63365247615, 4884.801839172458, 3699.204670995749, 3700.370936940673, 3703.037390183207, 3741.1769410729594, 3747.4566187902055, 4944.629152813625, 5151.278820965143, 5166.586673066221, 5170.948290517047, 5192.169252919514, 4937.925931111108, 4940.456549779449, 4949.57928576075, 4960.900781984268, 5028.748562571784, 4935.371327462, 4979.925301120558, 4997.475265097112, 4999.525045120708, 5028.346314979176, 4685.5782979532005, 4914.287428322802, 4918.754062296799, 4924.901501969869, 4959.941624225906, 4807.687500312469, 4833.4441539223435, 5006.724630145377, 5019.297298378303, 5049.258005987928, 4812.831550895702, 4856.635752318661, 4900.901981960412, 4903.436104847846, 4906.650671065486], "value": 3792.769027555361, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.0391468669022, 653.2683394598051, 719.2519779429393, 727.9636018199091, 750.2272659161063, 11383.943080284598, 11984.161108722394, 12016.639500814968, 12036.81944770828, 12048.518059277618, 12162.601300850405, 12290.56983005595, 12530.060245481602, 12617.495300188004, 12630.1790383625, 622.7446746833799, 748.0873334531863, 750.9324160825538, 764.5756605084176, 773.8220209351853, 762.5272331154691, 773.3774311679097, 773.8452309538087, 774.6785084190054, 774.8721460958935, 815.5269943432795, 819.2667562531531, 820.8563501387263, 821.2608652212996, 821.3552361396305, 653.9313372095957, 785.6543121026787, 811.6915572082571, 815.7471183933, 815.7634286057037, 590.7282649981014, 592.3839207224481, 592.582229528186, 592.6592209479523, 592.9110633404981, 12249.448774805156, 12272.693182670415, 12310.26138431697, 12345.0, 12374.876251237552, 11742.236754610924, 11910.464029118624, 12244.571439999647, 12426.813597796041, 12637.2417654941, 9753.122219000325, 9975.152112070482, 10011.899881001242, 11801.94099029508, 11977.101717371232, 4107.876763697094, 4108.91782164358, 4141.461609990712, 4239.8092085856215, 4260.595243451867, 62774.37225627731, 62900.0, 62983.0, 63036.0, 64134.0, 9857.802843943224, 10060.446675432922, 10087.142592879542, 10153.543090560943, 10216.642417515352, 17513.824861751218, 19225.13486893093, 19229.0, 19238.422847314603, 19360.93514856668, 6469.708863101172, 6510.153680021567, 6554.901676474857, 6672.232693240242, 6936.2023367312395, 3895.2988462077096, 3968.3849003404516, 3992.301347264217, 4021.91956160881, 4070.7354021989067, 2919.6934321895897, 3000.4749168895355, 3040.148758347666, 3042.3306872488015, 3042.771792115556, 511.48595661360093, 514.2466286889725, 519.5064688545821, 522.0967725834328, 526.4893053737868, 538.9811356602501, 617.0158597037718, 620.7796232337546, 621.2141640824361, 622.0, 7663.693452261847, 7991.320737737357, 7993.6802527898235, 8103.554304513308, 8412.369072319601, 509.3861896414811, 519.1796960801923, 564.9491545760901, 588.6989752646699, 595.3332267860025, 3346.8828590999196, 3703.185299234164, 3788.8673896414043, 3929.8428062877165, 3976.4234186042863, 66569.0, 78166.0, 91919.54040229756, 92741.53629231811, 92851.5357423222, 66475.33524664691, 78946.60526697445, 79632.60183699045, 79735.0, 80453.19546804574, 44336.77831610886, 53611.0, 68772.656136719, 68868.3113168872, 70992.93510597345, 7962.7213047543055, 8270.0, 8420.526657672563, 8556.10160933093, 8596.140385961355, 43705.0, 43791.0, 43972.0, 44291.33562996622, 45115.77442112769, 57379.42620573741, 61871.0, 62357.0, 62990.68504657447, 63289.68355158195, 10096.596136154765, 10231.0, 10346.896531034594, 10364.170866330525, 10707.250492465764, 12095.092868035108, 12419.37903104823, 12525.0, 12642.115051946275, 12968.935155324163, 11774.764504709687, 12036.699082523008, 12573.87426125727, 12659.177153484994, 12970.675733106747, 11862.940685296518, 12580.685482863002, 12747.49010039588, 12780.233186008869, 12801.871981280441, 11277.492512837107, 11473.0, 11696.649100526998, 12335.074869385011, 12501.24992500453, 8852.867206992029, 9664.951675241578, 9727.756806079904, 9762.658306959222, 10173.84739228927, 9395.201407880133, 9538.713838584854, 9631.0, 9840.753981150243, 9951.601935922772], "value": 6465.493127928003, "unit": "score"}], "name": "dromaeo_css", "value": 6272.771941283056, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 116.0, 113.0, 110.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 125.0, 122.0, 179.0, 124.0, 125.0, 155.0, 123.0, 167.0, 128.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 161.0, 162.0, 163.0, 161.0, 163.0, 159.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 108.0, 77.0, 79.0, 74.0, 76.0, 106.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 134.0, 86.0, 86.0, 86.0, 123.0, 85.0, 87.0, 123.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 63.0, 66.0, 64.0, 64.0, 66.0, 66.0, 65.0, 67.0, 70.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 82.0, 91.0, 83.0, 81.0, 81.0, 81.0, 92.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 131.0, 130.0, 137.0, 132.0, 131.0, 136.0, 163.0, 147.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 172.0, 181.0, 171.0, 170.0, 171.0, 168.0, 171.0, 169.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 70.0, 67.0, 67.0, 67.0, 67.0, 68.0, 65.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1544.8000000000004, "alertThreshold": 2.0}]} 13:38:00 INFO - Return code: 0 13:38:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:38:00 INFO - # TBPL SUCCESS # 13:38:00 INFO - Running post-action listener: _resource_record_post_action 13:38:00 INFO - [mozharness: 2016-08-18 20:38:00.242571Z] Finished run-tests step (success) 13:38:00 INFO - Running post-run listener: _resource_record_post_run 13:38:00 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407052288; Read time: 4; Write time: 752260 13:38:00 INFO - TinderboxPrint: CPU usage
13.0% 13:38:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 13:38:00 INFO - TinderboxPrint: I/O write bytes / time
407,052,288 / 752,260 13:38:00 INFO - TinderboxPrint: CPU idle
8,365.0 (87.0%) 13:38:00 INFO - TinderboxPrint: CPU user
1,201.1 (12.5%) 13:38:00 INFO - TinderboxPrint: Swap in / out
0 / 0 13:38:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113668096; Read time: 0; Write time: 186728 13:38:00 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 293384192; Read time: 0; Write time: 565532 13:38:00 INFO - Running post-run listener: _upload_blobber_files 13:38:00 INFO - Blob upload gear active. 13:38:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:38:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:38:01 INFO - (blobuploader) - INFO - Open directory for files ... 13:38:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:38:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:38:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:06 INFO - (blobuploader) - INFO - Done attempting. 13:38:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:38:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:38:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:07 INFO - (blobuploader) - INFO - Done attempting. 13:38:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:38:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:38:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:08 INFO - (blobuploader) - INFO - Done attempting. 13:38:08 INFO - (blobuploader) - INFO - Iteration through files over. 13:38:08 INFO - Return code: 0 13:38:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:38:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:38:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/15244c8f432c5eacf3df5ae4ec2cf63123b896aeb3a9c7fa7f85ea34b8cd7aa94349ebe9330eaeb3a15a1c7c25cf189deea67b4acb5c637858d44964cf56a568", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6540db810dae691d6a832a82c97174e3e093a3d68cfbf13554133a7e9c9d888dbdbe578b65290c67b4485bc7ae4f98a62668a0a866a2120c5291084a974972c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/adba343df18f420054d8eb2746f29b66d983caa05f3359757c3f8c0eaf1dc659172722541a159992ddc8199a76c45a26380d539b8b33069e32e576655d5d7b98"} 13:38:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:38:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:38:08 INFO - Contents: 13:38:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/15244c8f432c5eacf3df5ae4ec2cf63123b896aeb3a9c7fa7f85ea34b8cd7aa94349ebe9330eaeb3a15a1c7c25cf189deea67b4acb5c637858d44964cf56a568", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6540db810dae691d6a832a82c97174e3e093a3d68cfbf13554133a7e9c9d888dbdbe578b65290c67b4485bc7ae4f98a62668a0a866a2120c5291084a974972c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/adba343df18f420054d8eb2746f29b66d983caa05f3359757c3f8c0eaf1dc659172722541a159992ddc8199a76c45a26380d539b8b33069e32e576655d5d7b98"} 13:38:08 INFO - Running post-run listener: copy_logs_to_upload_dir 13:38:08 INFO - Copying logs to upload dir... 13:38:08 INFO - mkdir: /builds/slave/test/build/upload/logs 13:38:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.254938 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-18 13:38:08.325073) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 13:38:08.328730) ========= 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=df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/15244c8f432c5eacf3df5ae4ec2cf63123b896aeb3a9c7fa7f85ea34b8cd7aa94349ebe9330eaeb3a15a1c7c25cf189deea67b4acb5c637858d44964cf56a568", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6540db810dae691d6a832a82c97174e3e093a3d68cfbf13554133a7e9c9d888dbdbe578b65290c67b4485bc7ae4f98a62668a0a866a2120c5291084a974972c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/adba343df18f420054d8eb2746f29b66d983caa05f3359757c3f8c0eaf1dc659172722541a159992ddc8199a76c45a26380d539b8b33069e32e576655d5d7b98"} build_url:https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/cLVBRnArQTG4PRcnJ0Nthg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/15244c8f432c5eacf3df5ae4ec2cf63123b896aeb3a9c7fa7f85ea34b8cd7aa94349ebe9330eaeb3a15a1c7c25cf189deea67b4acb5c637858d44964cf56a568", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6540db810dae691d6a832a82c97174e3e093a3d68cfbf13554133a7e9c9d888dbdbe578b65290c67b4485bc7ae4f98a62668a0a866a2120c5291084a974972c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/adba343df18f420054d8eb2746f29b66d983caa05f3359757c3f8c0eaf1dc659172722541a159992ddc8199a76c45a26380d539b8b33069e32e576655d5d7b98"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 13:38:08.356593) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:38:08.357102) ========= 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=df17445c3590ff7897617a0e00000225-1471551435.14102-2005799607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:38:08.440236) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 13:38:08.440569) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 13:38:08.440900) ========= ========= Total master_lag: 0.18 =========