builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1471976437.09 results: success (0) buildid: 20160823103158 builduid: e7ad5bb2e07247acbd0c49dad2da4c4b revision: 77feb82d759277f4085fd2d4e53ed98bdacd1565 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 11:20:37.093997) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 11:20:37.094535) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 11:20:37.094880) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 11:20:37.109985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:20:37.110291) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 11:20:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-08-23 11:20:37 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095504 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:20:37.220482) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:20:37.220855) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018340 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:20:37.270898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:20:37.271303) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 77feb82d759277f4085fd2d4e53ed98bdacd1565 --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 77feb82d759277f4085fd2d4e53ed98bdacd1565 --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=edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 11:20:37,512 truncating revision to first 12 chars 2016-08-23 11:20:37,512 Setting DEBUG logging. 2016-08-23 11:20:37,512 attempt 1/10 2016-08-23 11:20:37,512 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/77feb82d7592?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 11:20:38,025 unpacking tar archive at: autoland-77feb82d7592/testing/mozharness/ program finished with exit code 0 elapsedTime=0.842234 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:20:38.128086) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 11:20:38.128464) ========= script_repo_revision: 77feb82d759277f4085fd2d4e53ed98bdacd1565 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 11:20:38.128947) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 11:20:38.129266) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 11:20:38.138995) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-23 11:20:38.139396) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:38 INFO - MultiFileLogger online at 20160823 11:20:38 in /builds/slave/test 11:20:38 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 11:20:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:38 INFO - {'append_to_log': False, 11:20:38 INFO - 'base_work_dir': '/builds/slave/test', 11:20:38 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 11:20:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:38 INFO - 'branch': 'Autoland-Non-PGO', 11:20:38 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:38 INFO - 'config_files': ('talos/linux_config.py',), 11:20:38 INFO - 'default_actions': ('clobber', 11:20:38 INFO - 'read-buildbot-config', 11:20:38 INFO - 'download-and-extract', 11:20:38 INFO - 'populate-webroot', 11:20:38 INFO - 'create-virtualenv', 11:20:38 INFO - 'install', 11:20:38 INFO - 'run-tests'), 11:20:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:38 INFO - 'download_minidump_stackwalk': True, 11:20:38 INFO - 'download_symbols': 'ondemand', 11:20:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:20:38 INFO - 'tooltool.py': '/tools/tooltool.py', 11:20:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:20:38 INFO - '/tools/misc-python/virtualenv.py')}, 11:20:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:38 INFO - 'installer_path': 'installer.exe', 11:20:38 INFO - 'log_level': 'info', 11:20:38 INFO - 'log_name': 'talos', 11:20:38 INFO - 'log_to_console': True, 11:20:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:38 INFO - 'opt_config_files': (), 11:20:38 INFO - 'pip_index': False, 11:20:38 INFO - 'sps_profile': False, 11:20:38 INFO - 'sps_profile_interval': 0, 11:20:38 INFO - 'suite': 'dromaeojs', 11:20:38 INFO - 'system_bits': '32', 11:20:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:38 INFO - 'title': 'talos-linux64-ix-033', 11:20:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:38 INFO - 'use_talos_json': True, 11:20:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:38 INFO - 'work_dir': 'build'} 11:20:38 INFO - [mozharness: 2016-08-23 18:20:38.473938Z] Running clobber step. 11:20:38 INFO - Running pre-action listener: _resource_record_pre_action 11:20:38 INFO - Running main action method: clobber 11:20:38 INFO - rmtree: /builds/slave/test/build 11:20:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:38 INFO - Running post-action listener: _resource_record_post_action 11:20:38 INFO - [mozharness: 2016-08-23 18:20:38.921247Z] Finished clobber step (success) 11:20:38 INFO - [mozharness: 2016-08-23 18:20:38.921348Z] Running read-buildbot-config step. 11:20:38 INFO - Running pre-action listener: _resource_record_pre_action 11:20:38 INFO - Running main action method: read_buildbot_config 11:20:38 INFO - Using buildbot properties: 11:20:38 INFO - { 11:20:38 INFO - "project": "", 11:20:38 INFO - "product": "firefox", 11:20:38 INFO - "script_repo_revision": "production", 11:20:38 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 11:20:38 INFO - "repository": "", 11:20:38 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 11:20:38 INFO - "buildid": "20160823103158", 11:20:38 INFO - "pgo_build": "False", 11:20:38 INFO - "basedir": "/builds/slave/test", 11:20:38 INFO - "buildnumber": 351, 11:20:38 INFO - "slavename": "talos-linux64-ix-033", 11:20:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:20:38 INFO - "platform": "ubuntu64_hw", 11:20:38 INFO - "scheduler": "tests-autoland-linux64-talos", 11:20:38 INFO - "branch": "autoland", 11:20:38 INFO - "repo_path": "integration/autoland", 11:20:38 INFO - "revision": "77feb82d759277f4085fd2d4e53ed98bdacd1565", 11:20:38 INFO - "stage_platform": "linux64", 11:20:38 INFO - "builduid": "e7ad5bb2e07247acbd0c49dad2da4c4b", 11:20:38 INFO - "slavebuilddir": "test" 11:20:38 INFO - } 11:20:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:20:38 INFO - Running post-action listener: _resource_record_post_action 11:20:38 INFO - [mozharness: 2016-08-23 18:20:38.923794Z] Finished read-buildbot-config step (success) 11:20:38 INFO - [mozharness: 2016-08-23 18:20:38.923881Z] Running download-and-extract step. 11:20:38 INFO - Running pre-action listener: _resource_record_pre_action 11:20:38 INFO - Running main action method: download_and_extract 11:20:38 INFO - mkdir: /builds/slave/test/build/tests 11:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:38 INFO - trying https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:20:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:20:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:20:39 INFO - Downloaded 1361 bytes. 11:20:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:20:39 INFO - Using the following test package requirements: 11:20:39 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:20:39 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:20:39 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:20:39 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:39 INFO - u'jsshell-linux-x86_64.zip'], 11:20:39 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:20:39 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:20:39 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:20:39 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:20:39 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:20:39 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:20:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:39 INFO - trying https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:20:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:20:40 INFO - Downloaded 20325088 bytes. 11:20:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:20:44 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:44 INFO - trying https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:20:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:20:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:20:45 INFO - Downloaded 20325088 bytes. 11:20:45 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:50 INFO - trying https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:20:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:20:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:20:50 INFO - Downloaded 14413981 bytes. 11:20:50 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:51 INFO - trying https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:20:51 INFO - Downloading https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:20:52 INFO - Downloaded 55745006 bytes. 11:20:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:20:52 INFO - mkdir: /builds/slave/test/properties 11:20:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:52 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:52 INFO - Contents: 11:20:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:20:53 INFO - Running post-action listener: _resource_record_post_action 11:20:53 INFO - Running post-action listener: set_extra_try_arguments 11:20:53 INFO - [mozharness: 2016-08-23 18:20:53.130878Z] Finished download-and-extract step (success) 11:20:53 INFO - [mozharness: 2016-08-23 18:20:53.131141Z] Running populate-webroot step. 11:20:53 INFO - Running pre-action listener: _resource_record_pre_action 11:20:53 INFO - Running main action method: populate_webroot 11:20:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:20:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:20:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:20:53 INFO - '--tppagecycles', 11:20:53 INFO - '7'], 11:20:53 INFO - 'tests': ['tsvgm']}}, 11:20:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:20:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:20:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:20:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:53 INFO - 'talos_options': ['--disable-e10s'], 11:20:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:53 INFO - 'talos_options': ['--disable-e10s'], 11:20:53 INFO - 'tests': ['damp', 'tps']}, 11:20:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:53 INFO - 'tests': ['damp', 'tps']}, 11:20:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:20:53 INFO - 'tests': ['dromaeo_dom']}, 11:20:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:20:53 INFO - 'tests': ['basic_compositor_video']}, 11:20:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:20:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:20:53 INFO - 'tests': ['a11yr', 11:20:53 INFO - 'ts_paint', 11:20:53 INFO - 'tpaint', 11:20:53 INFO - 'sessionrestore', 11:20:53 INFO - 'sessionrestore_no_auto_restore', 11:20:53 INFO - 'tabpaint']}, 11:20:53 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:53 INFO - 'ts_paint', 11:20:53 INFO - 'tpaint', 11:20:53 INFO - 'sessionrestore', 11:20:53 INFO - 'sessionrestore_no_auto_restore', 11:20:53 INFO - 'tabpaint']}, 11:20:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:20:53 INFO - 'ts_paint', 11:20:53 INFO - 'tpaint', 11:20:53 INFO - 'sessionrestore', 11:20:53 INFO - 'sessionrestore_no_auto_restore', 11:20:53 INFO - 'tabpaint']}, 11:20:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:20:53 INFO - 'ts_paint', 11:20:53 INFO - 'tpaint', 11:20:53 INFO - 'sessionrestore', 11:20:53 INFO - 'sessionrestore_no_auto_restore', 11:20:53 INFO - 'tabpaint']}, 11:20:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:20:53 INFO - 'tests': ['a11yr', 11:20:53 INFO - 'ts_paint', 11:20:53 INFO - 'tpaint', 11:20:53 INFO - 'sessionrestore', 11:20:53 INFO - 'sessionrestore_no_auto_restore', 11:20:53 INFO - 'tabpaint']}, 11:20:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:20:53 INFO - 'tests': ['a11yr', 11:20:53 INFO - 'ts_paint', 11:20:53 INFO - 'tpaint', 11:20:53 INFO - 'sessionrestore', 11:20:53 INFO - 'sessionrestore_no_auto_restore', 11:20:53 INFO - 'tabpaint']}, 11:20:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:20:53 INFO - 'tests': ['tsvgx', 11:20:53 INFO - 'tsvgr_opacity', 11:20:53 INFO - 'tart', 11:20:53 INFO - 'tscrollx', 11:20:53 INFO - 'cart']}, 11:20:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:53 INFO - 'tsvgr_opacity', 11:20:53 INFO - 'tart', 11:20:53 INFO - 'tscrollx', 11:20:53 INFO - 'cart']}, 11:20:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:53 INFO - 'talos_options': ['--disable-e10s'], 11:20:53 INFO - 'tests': ['tp5o']}, 11:20:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:53 INFO - 'tests': ['tp5o']}, 11:20:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:53 INFO - 'talos_options': ['--disable-e10s', 11:20:53 INFO - '--xperf_path', 11:20:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:53 INFO - 'tests': ['tp5n']}, 11:20:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:53 INFO - 'talos_options': ['--xperf_path', 11:20:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:53 INFO - 'tests': ['tp5n']}}, 11:20:53 INFO - 'talos.zip': {'path': '', 11:20:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:20:53 INFO - Running post-action listener: _resource_record_post_action 11:20:53 INFO - [mozharness: 2016-08-23 18:20:53.147022Z] Finished populate-webroot step (success) 11:20:53 INFO - [mozharness: 2016-08-23 18:20:53.147127Z] Running create-virtualenv step. 11:20:53 INFO - Running pre-action listener: _resource_record_pre_action 11:20:53 INFO - Running main action method: create_virtualenv 11:20:53 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:20:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:20:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:53 INFO - Using real prefix '/usr' 11:20:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:53 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:55 INFO - Installing pip.................done. 11:20:55 INFO - Return code: 0 11:20:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:55 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 0x7f9f569a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c090>, '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 0x105f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fe40>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:20:55 INFO - Using env: {'DISPLAY': ':0', 11:20:55 INFO - 'HOME': '/home/cltbld', 11:20:55 INFO - 'LANG': 'en_US.UTF-8', 11:20:55 INFO - 'LANGUAGE': 'en_US:en', 11:20:55 INFO - 'LOGNAME': 'cltbld', 11:20:55 INFO - 'MAIL': '/var/mail/cltbld', 11:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:55 INFO - 'MOZ_NO_REMOTE': '1', 11:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:55 INFO - 'NO_EM_RESTART': '1', 11:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:55 INFO - 'PWD': '/builds/slave/test', 11:20:55 INFO - 'SHELL': '/bin/bash', 11:20:55 INFO - 'SHLVL': '1', 11:20:55 INFO - 'TERM': 'linux', 11:20:55 INFO - 'TMOUT': '86400', 11:20:55 INFO - 'USER': 'cltbld', 11:20:55 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 11:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:55 INFO - '_': '/tools/buildbot/bin/python'} 11:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:20:55 INFO - Cleaning up... 11:20:55 INFO - Return code: 0 11:20:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:55 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 0x7f9f569a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c090>, '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 0x105f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fe40>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:20:55 INFO - Using env: {'DISPLAY': ':0', 11:20:55 INFO - 'HOME': '/home/cltbld', 11:20:55 INFO - 'LANG': 'en_US.UTF-8', 11:20:55 INFO - 'LANGUAGE': 'en_US:en', 11:20:55 INFO - 'LOGNAME': 'cltbld', 11:20:55 INFO - 'MAIL': '/var/mail/cltbld', 11:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:55 INFO - 'MOZ_NO_REMOTE': '1', 11:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:55 INFO - 'NO_EM_RESTART': '1', 11:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:55 INFO - 'PWD': '/builds/slave/test', 11:20:55 INFO - 'SHELL': '/bin/bash', 11:20:55 INFO - 'SHLVL': '1', 11:20:55 INFO - 'TERM': 'linux', 11:20:55 INFO - 'TMOUT': '86400', 11:20:55 INFO - 'USER': 'cltbld', 11:20:55 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 11:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:55 INFO - '_': '/tools/buildbot/bin/python'} 11:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:56 INFO - Downloading/unpacking psutil>=3.1.1 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:58 INFO - Installing collected packages: psutil 11:20:58 INFO - Running setup.py install for psutil 11:20:58 INFO - building 'psutil._psutil_linux' extension 11:20:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:20:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:20:58 INFO - building 'psutil._psutil_posix' extension 11:20:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:20:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:20:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:58 INFO - Successfully installed psutil 11:20:58 INFO - Cleaning up... 11:20:58 INFO - Return code: 0 11:20:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:58 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 0x7f9f569a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c090>, '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 0x105f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fe40>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:20:58 INFO - Using env: {'DISPLAY': ':0', 11:20:58 INFO - 'HOME': '/home/cltbld', 11:20:58 INFO - 'LANG': 'en_US.UTF-8', 11:20:58 INFO - 'LANGUAGE': 'en_US:en', 11:20:58 INFO - 'LOGNAME': 'cltbld', 11:20:58 INFO - 'MAIL': '/var/mail/cltbld', 11:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:58 INFO - 'MOZ_NO_REMOTE': '1', 11:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:58 INFO - 'NO_EM_RESTART': '1', 11:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:58 INFO - 'PWD': '/builds/slave/test', 11:20:58 INFO - 'SHELL': '/bin/bash', 11:20:58 INFO - 'SHLVL': '1', 11:20:58 INFO - 'TERM': 'linux', 11:20:58 INFO - 'TMOUT': '86400', 11:20:58 INFO - 'USER': 'cltbld', 11:20:58 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 11:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:58 INFO - '_': '/tools/buildbot/bin/python'} 11:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:21:00 INFO - Installing collected packages: mozsystemmonitor 11:21:00 INFO - Running setup.py install for mozsystemmonitor 11:21:01 INFO - Successfully installed mozsystemmonitor 11:21:01 INFO - Cleaning up... 11:21:01 INFO - Return code: 0 11:21:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:01 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 0x7f9f569a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c090>, '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 0x105f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fe40>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:21:01 INFO - Using env: {'DISPLAY': ':0', 11:21:01 INFO - 'HOME': '/home/cltbld', 11:21:01 INFO - 'LANG': 'en_US.UTF-8', 11:21:01 INFO - 'LANGUAGE': 'en_US:en', 11:21:01 INFO - 'LOGNAME': 'cltbld', 11:21:01 INFO - 'MAIL': '/var/mail/cltbld', 11:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:01 INFO - 'MOZ_NO_REMOTE': '1', 11:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:01 INFO - 'NO_EM_RESTART': '1', 11:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:01 INFO - 'PWD': '/builds/slave/test', 11:21:01 INFO - 'SHELL': '/bin/bash', 11:21:01 INFO - 'SHLVL': '1', 11:21:01 INFO - 'TERM': 'linux', 11:21:01 INFO - 'TMOUT': '86400', 11:21:01 INFO - 'USER': 'cltbld', 11:21:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 11:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:01 INFO - '_': '/tools/buildbot/bin/python'} 11:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:01 INFO - Downloading/unpacking jsonschema==2.5.1 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:21:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:03 INFO - Downloading functools32-3.2.3-2.tar.gz 11:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:21:03 INFO - warning: no files found matching '*.txt' 11:21:03 INFO - no previously-included directories found matching 'build' 11:21:03 INFO - no previously-included directories found matching 'dist' 11:21:03 INFO - no previously-included directories found matching '.git*' 11:21:03 INFO - Installing collected packages: jsonschema, functools32 11:21:03 INFO - Running setup.py install for functools32 11:21:03 INFO - warning: no files found matching '*.txt' 11:21:03 INFO - no previously-included directories found matching 'build' 11:21:03 INFO - no previously-included directories found matching 'dist' 11:21:03 INFO - no previously-included directories found matching '.git*' 11:21:03 INFO - Successfully installed jsonschema functools32 11:21:03 INFO - Cleaning up... 11:21:03 INFO - Return code: 0 11:21:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:03 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 0x7f9f569a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c090>, '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 0x105f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fe40>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:21:03 INFO - Using env: {'DISPLAY': ':0', 11:21:03 INFO - 'HOME': '/home/cltbld', 11:21:03 INFO - 'LANG': 'en_US.UTF-8', 11:21:03 INFO - 'LANGUAGE': 'en_US:en', 11:21:03 INFO - 'LOGNAME': 'cltbld', 11:21:03 INFO - 'MAIL': '/var/mail/cltbld', 11:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:03 INFO - 'MOZ_NO_REMOTE': '1', 11:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:03 INFO - 'NO_EM_RESTART': '1', 11:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:03 INFO - 'PWD': '/builds/slave/test', 11:21:03 INFO - 'SHELL': '/bin/bash', 11:21:03 INFO - 'SHLVL': '1', 11:21:03 INFO - 'TERM': 'linux', 11:21:03 INFO - 'TMOUT': '86400', 11:21:03 INFO - 'USER': 'cltbld', 11:21:03 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 11:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:03 INFO - '_': '/tools/buildbot/bin/python'} 11:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:21:03 INFO - Cleaning up... 11:21:03 INFO - Return code: 0 11:21:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:03 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 0x7f9f569a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c090>, '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 0x105f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fe40>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:21:03 INFO - Using env: {'DISPLAY': ':0', 11:21:03 INFO - 'HOME': '/home/cltbld', 11:21:03 INFO - 'LANG': 'en_US.UTF-8', 11:21:03 INFO - 'LANGUAGE': 'en_US:en', 11:21:03 INFO - 'LOGNAME': 'cltbld', 11:21:03 INFO - 'MAIL': '/var/mail/cltbld', 11:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:03 INFO - 'MOZ_NO_REMOTE': '1', 11:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:03 INFO - 'NO_EM_RESTART': '1', 11:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:03 INFO - 'PWD': '/builds/slave/test', 11:21:03 INFO - 'SHELL': '/bin/bash', 11:21:03 INFO - 'SHLVL': '1', 11:21:03 INFO - 'TERM': 'linux', 11:21:03 INFO - 'TMOUT': '86400', 11:21:03 INFO - 'USER': 'cltbld', 11:21:03 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 11:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:03 INFO - '_': '/tools/buildbot/bin/python'} 11:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:04 INFO - Downloading/unpacking blobuploader==1.2.4 11:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:06 INFO - Downloading blobuploader-1.2.4.tar.gz 11:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:21:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:21:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:06 INFO - Downloading docopt-0.6.1.tar.gz 11:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:21:06 INFO - Installing collected packages: blobuploader, requests, docopt 11:21:06 INFO - Running setup.py install for blobuploader 11:21:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:21:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:21:06 INFO - Running setup.py install for requests 11:21:07 INFO - Running setup.py install for docopt 11:21:07 INFO - Successfully installed blobuploader requests docopt 11:21:07 INFO - Cleaning up... 11:21:07 INFO - Return code: 0 11:21:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:07 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 0x7f9f569a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c090>, '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 0x105f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fe40>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:07 INFO - Using env: {'DISPLAY': ':0', 11:21:07 INFO - 'HOME': '/home/cltbld', 11:21:07 INFO - 'LANG': 'en_US.UTF-8', 11:21:07 INFO - 'LANGUAGE': 'en_US:en', 11:21:07 INFO - 'LOGNAME': 'cltbld', 11:21:07 INFO - 'MAIL': '/var/mail/cltbld', 11:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:07 INFO - 'MOZ_NO_REMOTE': '1', 11:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:07 INFO - 'NO_EM_RESTART': '1', 11:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:07 INFO - 'PWD': '/builds/slave/test', 11:21:07 INFO - 'SHELL': '/bin/bash', 11:21:07 INFO - 'SHLVL': '1', 11:21:07 INFO - 'TERM': 'linux', 11:21:07 INFO - 'TMOUT': '86400', 11:21:07 INFO - 'USER': 'cltbld', 11:21:07 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 11:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:07 INFO - '_': '/tools/buildbot/bin/python'} 11:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:07 INFO - Running setup.py (path:/tmp/pip-LeTGaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:07 INFO - Running setup.py (path:/tmp/pip-dyVo3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:07 INFO - Running setup.py (path:/tmp/pip-VtiQNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:07 INFO - Running setup.py (path:/tmp/pip-fDQj5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:07 INFO - Running setup.py (path:/tmp/pip-HZnfR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:07 INFO - Running setup.py (path:/tmp/pip-gtOkGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:08 INFO - Running setup.py (path:/tmp/pip-28MdIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:08 INFO - Running setup.py (path:/tmp/pip-Pw5THX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:08 INFO - Running setup.py (path:/tmp/pip-bh3dt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:08 INFO - Running setup.py (path:/tmp/pip-63xyA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:08 INFO - Running setup.py (path:/tmp/pip-HFAUYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:08 INFO - Running setup.py (path:/tmp/pip-gStNOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:08 INFO - Running setup.py (path:/tmp/pip-FQYynC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:08 INFO - Running setup.py (path:/tmp/pip-3li_Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:08 INFO - Running setup.py (path:/tmp/pip-EuyQrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:08 INFO - Running setup.py (path:/tmp/pip-zC9BhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:08 INFO - Running setup.py (path:/tmp/pip-ZwwInf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:21:08 INFO - Running setup.py install for manifestparser 11:21:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:21:08 INFO - Running setup.py install for mozcrash 11:21:09 INFO - Running setup.py install for mozdebug 11:21:09 INFO - Running setup.py install for mozdevice 11:21:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Running setup.py install for mozfile 11:21:09 INFO - Running setup.py install for mozhttpd 11:21:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Running setup.py install for mozinfo 11:21:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Running setup.py install for mozInstall 11:21:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Running setup.py install for mozleak 11:21:09 INFO - Running setup.py install for mozlog 11:21:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Running setup.py install for moznetwork 11:21:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Running setup.py install for mozprocess 11:21:10 INFO - Running setup.py install for mozprofile 11:21:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:21:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:21:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:21:10 INFO - Running setup.py install for mozrunner 11:21:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:21:10 INFO - Running setup.py install for mozscreenshot 11:21:10 INFO - Running setup.py install for moztest 11:21:10 INFO - Running setup.py install for mozversion 11:21:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:21:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:10 INFO - Cleaning up... 11:21:10 INFO - Return code: 0 11:21:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:10 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 0x7f9f569a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c090>, '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 0x105f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fe40>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:10 INFO - Using env: {'DISPLAY': ':0', 11:21:10 INFO - 'HOME': '/home/cltbld', 11:21:10 INFO - 'LANG': 'en_US.UTF-8', 11:21:10 INFO - 'LANGUAGE': 'en_US:en', 11:21:10 INFO - 'LOGNAME': 'cltbld', 11:21:10 INFO - 'MAIL': '/var/mail/cltbld', 11:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:10 INFO - 'MOZ_NO_REMOTE': '1', 11:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:10 INFO - 'NO_EM_RESTART': '1', 11:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:10 INFO - 'PWD': '/builds/slave/test', 11:21:10 INFO - 'SHELL': '/bin/bash', 11:21:10 INFO - 'SHLVL': '1', 11:21:10 INFO - 'TERM': 'linux', 11:21:10 INFO - 'TMOUT': '86400', 11:21:10 INFO - 'USER': 'cltbld', 11:21:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 11:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:10 INFO - '_': '/tools/buildbot/bin/python'} 11:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:10 INFO - Running setup.py (path:/tmp/pip-pqHgP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:10 INFO - Running setup.py (path:/tmp/pip-dwP49u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:11 INFO - Running setup.py (path:/tmp/pip-UxfqwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:11 INFO - Running setup.py (path:/tmp/pip-dnpGAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:11 INFO - Running setup.py (path:/tmp/pip-kuLlge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:11 INFO - Running setup.py (path:/tmp/pip-T2O0Mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:11 INFO - Running setup.py (path:/tmp/pip-UCRZZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:11 INFO - Running setup.py (path:/tmp/pip-yGLcXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:11 INFO - Running setup.py (path:/tmp/pip-_weneH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:11 INFO - Running setup.py (path:/tmp/pip-d3Gm0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:11 INFO - Running setup.py (path:/tmp/pip-TgujMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:11 INFO - Running setup.py (path:/tmp/pip-K3uPR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:11 INFO - Running setup.py (path:/tmp/pip-ckCIai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:11 INFO - Running setup.py (path:/tmp/pip-q7MzGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:11 INFO - Running setup.py (path:/tmp/pip-7CcBGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:11 INFO - Running setup.py (path:/tmp/pip-H4UI2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:12 INFO - Running setup.py (path:/tmp/pip-p9AqQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:13 INFO - Downloading blessings-1.6.tar.gz 11:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:14 INFO - Installing collected packages: blessings 11:21:14 INFO - Running setup.py install for blessings 11:21:14 INFO - Successfully installed blessings 11:21:14 INFO - Cleaning up... 11:21:14 INFO - Return code: 0 11:21:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:14 INFO - Reading from file tmpfile_stdout 11:21:14 INFO - Current package versions: 11:21:14 INFO - argparse == 1.2.1 11:21:14 INFO - blessings == 1.6 11:21:14 INFO - blobuploader == 1.2.4 11:21:14 INFO - docopt == 0.6.1 11:21:14 INFO - functools32 == 3.2.3-2 11:21:14 INFO - jsonschema == 2.5.1 11:21:14 INFO - manifestparser == 1.1 11:21:14 INFO - mozInstall == 1.12 11:21:14 INFO - mozcrash == 0.17 11:21:14 INFO - mozdebug == 0.1 11:21:14 INFO - mozdevice == 0.48 11:21:14 INFO - mozfile == 1.2 11:21:14 INFO - mozhttpd == 0.7 11:21:14 INFO - mozinfo == 0.9 11:21:14 INFO - mozleak == 0.1 11:21:14 INFO - mozlog == 3.3 11:21:14 INFO - moznetwork == 0.27 11:21:14 INFO - mozprocess == 0.23 11:21:14 INFO - mozprofile == 0.28 11:21:14 INFO - mozrunner == 6.12 11:21:14 INFO - mozscreenshot == 0.1 11:21:14 INFO - mozsystemmonitor == 0.3 11:21:14 INFO - moztest == 0.7 11:21:14 INFO - mozversion == 1.4 11:21:14 INFO - psutil == 3.1.1 11:21:14 INFO - requests == 1.2.3 11:21:14 INFO - wsgiref == 0.1.2 11:21:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:14 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 0x7f9f569a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c090>, '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 0x105f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fe40>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:14 INFO - Using env: {'DISPLAY': ':0', 11:21:14 INFO - 'HOME': '/home/cltbld', 11:21:14 INFO - 'LANG': 'en_US.UTF-8', 11:21:14 INFO - 'LANGUAGE': 'en_US:en', 11:21:14 INFO - 'LOGNAME': 'cltbld', 11:21:14 INFO - 'MAIL': '/var/mail/cltbld', 11:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:14 INFO - 'MOZ_NO_REMOTE': '1', 11:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:14 INFO - 'NO_EM_RESTART': '1', 11:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:14 INFO - 'PWD': '/builds/slave/test', 11:21:14 INFO - 'SHELL': '/bin/bash', 11:21:14 INFO - 'SHLVL': '1', 11:21:14 INFO - 'TERM': 'linux', 11:21:14 INFO - 'TMOUT': '86400', 11:21:14 INFO - 'USER': 'cltbld', 11:21:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 11:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:14 INFO - '_': '/tools/buildbot/bin/python'} 11:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:14 INFO - Cleaning up... 11:21:14 INFO - Return code: 0 11:21:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f569a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c090>, '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 0x105f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fe40>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:21:14 INFO - Using env: {'DISPLAY': ':0', 11:21:14 INFO - 'HOME': '/home/cltbld', 11:21:14 INFO - 'LANG': 'en_US.UTF-8', 11:21:14 INFO - 'LANGUAGE': 'en_US:en', 11:21:14 INFO - 'LOGNAME': 'cltbld', 11:21:14 INFO - 'MAIL': '/var/mail/cltbld', 11:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:14 INFO - 'MOZ_NO_REMOTE': '1', 11:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:14 INFO - 'NO_EM_RESTART': '1', 11:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:14 INFO - 'PWD': '/builds/slave/test', 11:21:14 INFO - 'SHELL': '/bin/bash', 11:21:14 INFO - 'SHLVL': '1', 11:21:14 INFO - 'TERM': 'linux', 11:21:14 INFO - 'TMOUT': '86400', 11:21:14 INFO - 'USER': 'cltbld', 11:21:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 11:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:14 INFO - '_': '/tools/buildbot/bin/python'} 11:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:21:14 INFO - Cleaning up... 11:21:14 INFO - Return code: 0 11:21:14 INFO - Running post-action listener: _resource_record_post_action 11:21:14 INFO - Running post-action listener: _start_resource_monitoring 11:21:14 INFO - Starting resource monitoring. 11:21:14 INFO - [mozharness: 2016-08-23 18:21:14.943599Z] Finished create-virtualenv step (success) 11:21:14 INFO - [mozharness: 2016-08-23 18:21:14.944108Z] Running install step. 11:21:14 INFO - Running pre-action listener: _resource_record_pre_action 11:21:14 INFO - Running main action method: install 11:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:15 INFO - Reading from file tmpfile_stdout 11:21:15 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:15 INFO - Reading from file tmpfile_stdout 11:21:15 INFO - Output received: 11:21:15 INFO - Usage: mozinstall [options] installer 11:21:15 INFO - Options: 11:21:15 INFO - -h, --help show this help message and exit 11:21:15 INFO - -d DEST, --destination=DEST 11:21:15 INFO - Directory to install application into. [default: 11:21:15 INFO - "/builds/slave/test"] 11:21:15 INFO - --app=APP Application being installed. [default: firefox] 11:21:15 INFO - mkdir: /builds/slave/test/build/application 11:21:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:21:31 INFO - Reading from file tmpfile_stdout 11:21:31 INFO - Output received: 11:21:31 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:31 INFO - Running post-action listener: _resource_record_post_action 11:21:31 INFO - [mozharness: 2016-08-23 18:21:31.320441Z] Finished install step (success) 11:21:31 INFO - [mozharness: 2016-08-23 18:21:31.320692Z] Running run-tests step. 11:21:31 INFO - Running pre-action listener: _resource_record_pre_action 11:21:31 INFO - Running main action method: run_tests 11:21:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:31 INFO - Python 2.7.3 11:21:31 INFO - Return code: 0 11:21:31 INFO - grabbing minidump binary from tooltool 11:21: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')]} 11:21:31 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 0x105c090>, '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 0x105f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105fe40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:21:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:21:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:21:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:31 INFO - Return code: 0 11:21:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:31 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/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 11:21:31 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/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 11:21:31 INFO - Using env: {'DISPLAY': ':0', 11:21:31 INFO - 'HOME': '/home/cltbld', 11:21:31 INFO - 'LANG': 'en_US.UTF-8', 11:21:31 INFO - 'LANGUAGE': 'en_US:en', 11:21:31 INFO - 'LOGNAME': 'cltbld', 11:21:31 INFO - 'MAIL': '/var/mail/cltbld', 11:21:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:31 INFO - 'MOZ_NO_REMOTE': '1', 11:21:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:31 INFO - 'NO_EM_RESTART': '1', 11:21:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:31 INFO - 'PWD': '/builds/slave/test', 11:21:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:31 INFO - 'SHELL': '/bin/bash', 11:21:31 INFO - 'SHLVL': '1', 11:21:31 INFO - 'TERM': 'linux', 11:21:31 INFO - 'TMOUT': '86400', 11:21:31 INFO - 'USER': 'cltbld', 11:21:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036', 11:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:31 INFO - '_': '/tools/buildbot/bin/python'} 11:21:31 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/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 11:21:31 INFO - mozversion application_buildid: 20160823103158 11:21:31 INFO - mozversion application_changeset: 77feb82d759277f4085fd2d4e53ed98bdacd1565 11:21:31 INFO - mozversion application_display_name: Nightly 11:21:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:31 INFO - mozversion application_name: Firefox 11:21:31 INFO - mozversion application_remotingname: firefox 11:21:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:21:31 INFO - mozversion application_vendor: Mozilla 11:21:31 INFO - mozversion application_version: 51.0a1 11:21:31 INFO - mozversion platform_buildid: 20160823103158 11:21:31 INFO - mozversion platform_changeset: 77feb82d759277f4085fd2d4e53ed98bdacd1565 11:21:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:21:31 INFO - mozversion platform_version: 51.0a1 11:21:31 INFO - using testdate: 1471976491 11:21:31 INFO - actual date: 1471976491 11:21:31 INFO - starting webserver on 'localhost:57358' 11:21:31 INFO - SUITE-START | Running 2 tests 11:21:31 INFO - TEST-START | dromaeo_css 11:21:31 INFO - operating with platform_type : linux_ 11:21:31 INFO - Initialising browser for dromaeo_css test... 11:21:31 INFO - TEST-INFO | started process 13095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBSEh98/profile http://localhost:57358/getInfo.html) 11:21:36 INFO - PROCESS | 13095 | __metrics Screen width/height:1600/1200 11:21:36 INFO - PROCESS | 13095 | colorDepth:24 11:21:36 INFO - PROCESS | 13095 | Browser inner width/height: 1024/697 11:21:36 INFO - PROCESS | 13095 | __metrics 11:21:37 INFO - PROCESS | 13095 | 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" 11:21:37 INFO - PROCESS | 13095 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:21:37 INFO - PROCESS | 13095 | console.error: PushService: 11:21:37 INFO - PROCESS | 13095 | stateChangeProcessEnqueue: Error transitioning state 11:21:37 INFO - PROCESS | 13095 | UnknownError 11:21:38 INFO - TEST-INFO | 13095: exit 0 11:21:38 INFO - Browser initialized. 11:21:38 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:38 INFO - TEST-INFO | started process 13178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBSEh98/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:50 INFO - PROCESS | 13178 | RSS: Main: 182767616 11:21:50 INFO - PROCESS | 13178 | 11:22:41 INFO - PROCESS | 13178 | 1471976561729 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:24:55 INFO - PROCESS | 13178 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57358/tests/dromaeo/cssquery-ext.html) 11:24:56 INFO - PROCESS | 13178 | RSS: Main: 309235712 11:24:56 INFO - PROCESS | 13178 | 11:27:59 INFO - PROCESS | 13178 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-ext.html (next: http://localhost:57358/tests/dromaeo/cssquery-jquery.html) 11:28:00 INFO - PROCESS | 13178 | RSS: Main: 277774336 11:28:00 INFO - PROCESS | 13178 | 11:31:02 INFO - PROCESS | 13178 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57358/tests/dromaeo/cssquery-mootools.html) 11:31:03 INFO - PROCESS | 13178 | RSS: Main: 220364800 11:31:03 INFO - PROCESS | 13178 | 11:34:05 INFO - PROCESS | 13178 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57358/tests/dromaeo/cssquery-prototype.html) 11:34:06 INFO - PROCESS | 13178 | RSS: Main: 246247424 11:34:06 INFO - PROCESS | 13178 | 11:37:09 INFO - PROCESS | 13178 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57358/tests/dromaeo/cssquery-yui.html) 11:37:10 INFO - PROCESS | 13178 | RSS: Main: 219000832 11:37:10 INFO - PROCESS | 13178 | 11:40:12 INFO - PROCESS | 13178 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-yui.html (next: http://localhost:57358/tests/dromaeo/cssquery-dojo.html) 11:40:13 INFO - PROCESS | 13178 | RSS: Main: 308944896 11:40:13 INFO - PROCESS | 13178 | 11:40:13 INFO - PROCESS | 13178 | __start_tp_report 11:40:13 INFO - PROCESS | 13178 | _x_x_mozilla_page_load 11:40:13 INFO - PROCESS | 13178 | _x_x_mozilla_page_load_details 11:40:13 INFO - PROCESS | 13178 | |i|pagename|runs| 11:40:13 INFO - PROCESS | 13178 | |0;dojo.html;2587.4695687384083;2596.727343628918;2597.0164048173665;2626.4747050589885;2642.630031795549;4611.884702882429;4619.076184763053;4676.625869930406;4730.266808644666;4746.691465054773;4650.627949764019;4678.836240731566;4702.811887524504;4725.598324142452;4757.357756702844;4244;4276.401303817468;4305.268104422255;4372.606465418112;4466.865994020169;4337.197618440583;4400.669949753766;4427.690061695683;4443.089166720814;4454.933176002346;4293.3130699088;4315.762633055181;4325.307950727868;4340.871373442896;4355.281378572532;4296.226679197744;4302.698811083225;4392.407025051641;4393.165298593257;4415.580519850609;4263.616274535276;4269.444972153631;4295.828166873322;4369.890752731176;4376.978115109436;4656.557627025461;4663.930041049387;4664.626829853603;4671.346011558385;4693.436787585478;4839.249916262985;4993.0263598598285;5016.849494515171;5020.171671674169;5071.670341427833;5032.295478632995;5069.315642388304;5077.873053173664;5081.745912704387;5134.024535338311;4723.716577005322;4727.125481785881;4729.881752956135;4731.432228132578;4748.857534273978;5077.974610126999;5122.1804511278015;5131;5156.149235376196;5181.3782346118705;4922.360093187863;4929.827456039022;4939.209726443752;4980.078685443204;4989.750512474435;5000.474950130257;5008.874778130503;5010.549050585465;5011.674241174312;5083.974580127076;4828.806847726122;4928.48250933654;4957.454679985199;4973.651844370932;5036.420811606712;4964.652474326763;4996.200607902718;4997.575206107522;5050.898982020339;5060.671056381323;4247.97876010618;4256.7445953242905;4257.425247591597;4306.870793876189;4309.719868208556;3686.465462507975;3696.2977034363385;3729.1609387887506;3748.475213470116;3796.1648437343742;4353.455818022747;4372.519022907478;4408.801603927831;4429.512753597101;4446.2663660495655;5146.665466744649;5147.867469156779;5148.459411761786;5158.432572417031;5217.0870097733505;4397.252467080604;4406.537313582092;4411.8014689338415;4459.420275364182;4467.039586488921;4404.185225733249;4459.799309031101;4484.775761211927;4595.241785105487;4598.0803839232285;4714.104320179155;4714.5992590630185;4717.693349932243;4746.121967436035;4776.498467660846;5017.147084995632;5018.598512119095;5020.422651395136;5022.773975171053;5052.065367906949;4605.654575906753;4722.1028004679;4732.550407711262;4734.715917044989;4755.405574303212;4999.500049994971;5008.223725322581;5014.87462813418;5017.724025178651;5062.493750624908;5084.059449001947;5085.821996230262;5086.465921078234;5091.13450713387;5133.948660513496;4742.739149346819;4853.781579828987;4899.118158731462;4938.530839570235;5000.67495612784;4930.753462326941;4930.926036109533;4934.703917764946;4970.577500912463;4977.477364876636;4808.759562021815;4810.876416616293;4810.903781924412;4813.590844778093;4866.124097662455;4878.878028049327;4887.266909963534;4928.926066109083;4945.497182944666;5005.024020316004;4838.903221935612;4852.927206091841;4863.659543831898;4903.41159060915;4916.360873086476 11:40:13 INFO - PROCESS | 13178 | |1;ext.html;565.9943400565993;568.5622071005326;569.6667449542018;582.9329627092883;585.6954383720465;27968;28469.28826779329;38129.61870381295;39242.41136382957;39376.80311598438;39117;39410.8029459853;39510.60489395105;39517.40723889144;39549.802250988774;7519.962400187991;7693.7307194248215;7716.035495563055;7721.613919304041;7727.343175830033;7616.923830761704;7695.884561731578;7700.845983080335;7707.730229441971;7708.229177082303;7717.263615686482;7780.183080776522;7780.455368124233;7783.532988020708;7788.766337009899;7413.851722965537;7435.219301973269;7447.2552744725635;7448.329650331496;7453.85092298151;7613.276738709869;7676.9616151919445;7684;7687.692492300302;7689.307962283421;31988.840055799574;32336.191595210308;32337.838310808296;32351.352972940644;32370.248528875072;2634.7628713415693;2805.719428057178;3107.6270847498445;3116.2832548513743;3191.569138166341;28397;28475.857620711762;29029.41941161165;29089.272768180752;30374.240643983856;3355.7949468840193;3548.8935331940083;3565.893023209282;3628.677646306366;3654.177809992757;178547.10726446286;178836;178990.1050494752;179056;179057;50626.24060639094;50947;50951.7452412743;50955.49044509581;51005;32614.83692581522;33205;33538.32923341519;34983.65016349804;35004.82497587496;13683.657908552166;13970.860291397159;13986.930065349608;13991;13994.440222390991;10318.17454603645;10502.789944201073;10504.737381565523;10513.894861051445;10514.526846291936;17977.370792022215;18054.638907221783;18090.90954545219;18094.27622895096;18136.63726725458;6506.934930650727;6569.835754106186;6665.166854143232;6712.328767123248;6853.17761868579;739.3641468337225;862.9093945135796;867.9566021698889;903.9457632542069;908.7591788176138;25495.745042549708;26708.46583068328;26763.86618066897;27156.456870862472;27729.306767330574;890.1098901098901;923.2429407885604;930.6184464369576;941;957.9346092504015;13685.521006764915;13696.452141914411;14395;14419.63950901215;14478.420863165355;387571;393874;394658;395017;398753;47278.29082563764;47805.76097119492;47851.5214847854;47860.28209576859;47897.281540776916;1034.2294990232326;1137.0960086730904;1140.2417392434104;1145.4215621111452;1160.5473865192582;26970.595441068792;28807.135785926457;29043.714211607537;29575.85212073926;29663.555046673886;40891.18217635571;41630.79184604058;41635.1672966545;41654.79172604118;41681;298092;298140;298672;298706;299313;19865.50336241548;20066.29767958173;20392.082356293704;22497.212597559006;22539.88730056339;34519.4822077674;34626.48060279148;34721.13197170091;34919.65080349266;34950.30099398048;33822.463315251945;34293.314133717686;34485;35326.64673353233;35364.646353537166;34074.488882667276;34167.4874876882;34417.48373774345;34610;36124.81937590295;33493.330133397685;34347.484787727706;34896.30207395888;35142.82428587841;35325.64674353327;29872;31700.365992679555;31711.841440792647;32134.19664508406;32486.18784530311;24019.519609608058;24497.4679684259;24588.385290367885;24657.506849862544;24948.625770613093 11:40:13 INFO - PROCESS | 13178 | |2;jquery.html;345.99481007784874;364.63536463536445;368.51356209803055;372.4450568652708;392.52896524171;12368.938155309223;15654;15978.360865565379;16165.43420980266;17024;14236.857631423683;14599.854001459982;14653.6336591585;14968.625784355396;15151.696966060672;4056.8782936511802;4338.479382474107;4482.753448560328;4483.260262056757;5137.306463627418;4985.6759310644875;5060.190369540875;5065.088284108859;5067.594592432615;5069.797208111671;4864.927026094611;4995.550400463958;5042.243663450475;5046.470120637336;5047.646664733452;4955.207166853286;5004.224345226477;5005.899882002376;5018.071656743514;5040.269160971675;4297.957020429787;4526.841560545398;4527.230370836933;4531.682782205247;4534.59188673021;11713.590024349107;11966.521339146424;11982.760344793143;11984.340861252627;12052.276863388224;1743.3288184049106;1824.9817501824944;1834.660587791263;1941.9417417477498;2271.127024314244;8536.615852286663;9262.515540717923;13186.142900711424;13899.79150312746;14032.087914285641;1685.772420723211;1740.782402199725;1750.912454377276;1754.456118603237;1757.5869670627392;65038.674806626135;68884.3111568888;69561.3043869565;69710;69730.99999999949;9993.501624593851;10106.545205465625;10107.898921010696;10393.16854651626;10506.161421751163;14141.363638636287;14158.07972481806;14232.359543820552;14240;14253.714925701428;6852.760153394607;6995.831292299302;7030.472714546429;7137.286271372821;7154.570725756367;6470.22357317125;6492.805215843532;6680.3987641112535;6696.665166741644;6739.427148692416;4318.978405107954;4357.803898824497;4387.868363949086;4491.505934347219;4523.2988886722615;1720.320473412995;1765.1968354398718;1778.519799654112;1801.9549511262323;1840.2914877772155;776.8290975985274;819.3690858039276;843.2579330189517;856.1780690537154;887.9911200887908;15995.920020400057;17218.397356092475;17231.814887928384;17267;17589.648207036043;793.4564823096198;794.2454668065361;819.8401311744271;848.1560846957317;862.7670528957146;9045.321600879828;9088.500132492643;9141.725748227564;9273.907260927439;9547.856782148274;374346;374784;376553;377172;387425;74820.25179748241;77258;77727.61136194282;80383.59808201039;81378;865.35098675993;888.1251966812684;893.84357737397;896.5606852642159;901.855703087516;14528.491502797351;14820.555383338517;15040.924795375953;15191;15657.21713914277;35971;36221.818890906434;36705.265894681426;40331.79834100928;40869.59130408777;50080.74959625324;54331.72834135804;54984;56429.43570564406;56717.43282567122;6738.124043874265;7401.296876796696;7444.99492568518;7515.661795219337;7556.811079723051;11482.081433485468;11923.642290731292;11931.403429828648;12007.879921200676;12936;9954.850677239703;9988.450635215133;10210.13213876799;10273;10429.217808664229;10174.694759157237;10279.383237005804;10362.067413932782;10438.164946804085;10484.52819623134;10005.349652272578;10075.949620252146;10361.896381036093;10744.946275268887;10795.352278863293;6854.862902742017;7066.364027237573;7195.748148814766;7226.096737907762;7315.341619254293;9083.18251357381;9651.806963860543;9696.321257511907;10137.695869123938;10278.691639250834 11:40:13 INFO - PROCESS | 13178 | |3;mootools.html;1210.800217964036;1331.5872079655305;1388.0145096981144;1433.1401159304412;1653.6114013206895;6522.804315870526;7446.888296675555;7649.426293028017;7668.808279793001;7876.724314648988;7653.425993050516;7742.574158421285;7750.341220996222;7751.0698716154;7757.456978011542;2109.1774208058832;2134.8505604607685;2138.6043581937392;2139.935801925937;2156.644153714635;2097.2974053691955;2139.058814121789;2143.496278374581;2144.7962443567835;2146.452654573082;2080.739907511561;2093.905774240163;2102.3692892132376;2103.92636257731;2160.503084290614;2098.5593025464673;2104.6842973553935;2105.6420408530435;2106.662933930579;2107.4520624637553;2039.3474088291753;2089.320970684518;2091.1948899673584;2093.413844123648;2097.339338108506;7396.55620662762;7523.210062943422;7556.4332675049045;7680.19357967411;7700.499467534592;4182.477190351206;4350.238708226079;4358.302671572565;4361.258586040349;4362.672799540047;2640.68311802583;2746.0388863897674;2792.0925699147656;2800.075974928269;2808.36811717364;924.9722508324761;936.7517607833929;940.3088729783603;947.2989987409336;954.5656726189567;10283.714535683039;10369.79260414795;10408.21938354619;10419.114375278035;10430.21773366993;3626.9818650906577;3830.7318487705593;3836.2135762168687;3933.1740334529495;3960.683145348365;8208.973878265217;8224.876626850602;8242.093369729326;8250.54621995796;8253.752387428387;4186.748795072305;4195.098053918361;4196.748195108304;4197.097624010791;4197.24449599069;3405.591329040531;3871.632194941476;3944.3097457944746;3944.585818489017;3976.58245884178;3331.233816222234;3348.2299071213756;3446.9310613787584;3464.255185135208;3484.6689564491335;1007.6422869881234;1011.9696409107738;1020.2654089055868;1028.321307936758;1031.3193292426963;696.1298377028714;702.6240961085795;716.813628456605;725.1841678112124;745.0277388008701;4788.329633851264;4791.880202994953;4836.347093142451;4913.263010548446;4998.100341938486;381.7137147139645;406.85759984005364;407.35841050345823;414.55435406937664;423.64202249099463;3282.14664187313;3299.7855139416342;3300.9009729708146;3302.9009129725664;3461.9480707789403;9240.122188392092;9521.476318802532;9556.522173891417;9558.808823823623;9578.377405468622;9521.714348569554;9523.095305945924;9543.284253681002;9562.808743825084;9590.712278631652;7196.748113815991;7272.672729727175;7274.018007569016;7283;7283.308085731847;4756.096341695067;4871.561559459666;4916.803327866845;4954.256861470808;5037.471065538212;8437.789055273668;8661.437006594802;8691.304695624209;8705.085965973482;8766;8648.740537783877;8868.379213455255;8880.200781929658;8963.507007114411;8977.730668079968;5365.570754339566;5789.102689083199;5944.613600115978;6002.579819412599;6008.459238668541;6945.687444064928;7172.928270717226;7178.676959536729;7179.569225846466;7187.209406965334;6353.650549219838;6360.840978975562;6381.617102973836;6503;6512.641804700787;6379.904301435575;6380.776672816429;6395.328490508616;6431.260405053292;6441.613503189824;5838.12428135766;5938.584299099021;5939.07944268639;5945.19739835134;5955.106733989936;4141;4150.149219410074;4185.225733239238;4257.063446041866;4365.781710914378;4286;4372.191144638252;4378.540253273488;4482.394876691736;4574.7941342639 11:40:13 INFO - PROCESS | 13178 | |4;prototype.html;282.837368513105;291.17742377782764;296.05115604487617;299.04902410335126;300.43967999680603;4633.9073218535605;4737.412966656174;4795.664303498756;4832.371791667083;4849.612031037513;4551.567601077901;4694.450831225696;4696.85909422717;4726.9290960635535;4750.358701575286;3786.659200671939;3788.109794198361;3799.6960243180615;3804.5624753153324;3804.858542437272;3547.7516573839844;3823.961760382402;3840.615938406151;3855.1904100139004;3856.826442810066;3341.8663253469954;3609.2601016791627;3726.888193354204;3735;3745.8127093645344;3726.7515382346946;3737.962620373802;3744.8314825832904;3750.4374343848367;3763.9623603763885;3298.1424829544253;3319.1038419626807;3320.468725004012;3326.6507016763376;3334.3831391192466;4452.532484089156;4590.219662657356;4594.931076033862;4662.277347011185;4667.439907211123;4234.840231481936;4249.957500425018;4253.723507971972;4254.3831144483875;4255.89346769839;4859.659823812334;4872.634552408584;4913.31213630092;4914.4839791821705;4963.982383611387;3488.4592888102384;3577.6422357764013;3589.766665166756;3600.135967367839;3605.296967091418;5162.819301324474;5168.793248270064;5178.792848286064;5191.247269145991;5198.740062996872;3661.1213308806227;3663.175785448253;3666.871659491905;3666.944995825065;3669.9266014679556;3737.439384092408;3749.2876353492748;3770.698344132463;3776.792276424823;3776.962230377661;3986.1828325193264;4182.410683940083;4190.476190476191;4270.722403043792;4276.273033584298;4938.456769755324;4949.455559888409;4952.4057113146655;4956.4547899731;4959.231319145538;1196.9940150299192;1218.9268643881219;1228.6252692928742;1253.9435725392198;1274.885260326575;838.5178522349673;844.4933040175845;851.199872120205;863.7797361672859;869.8173383589391;4341.630961368319;4351.97824010878;4390.143921935256;4406.427164468662;4430.933535996963;5025.442112944998;5026.396832380138;5030.270610761492;5039.874003149951;5045.646804723634;4340.739555626673;4354.956450435455;4370.475542934868;4376.533861156485;4400.073950822731;2237.6307909195125;2328.6157783965455;2332.682034650417;2357.5049239659866;2364.6285154610287;4191.958080419156;4225.070484493406;4252.405347994502;4257.957420425756;4277.3797799319545;4531.342955271467;4546.772661366918;4548.295014272793;4550.249208880564;4588.839390621312;3940.5468371137113;4193;4242.554531774181;4242.618164365222;4246.7239629423375;4398.516163222107;4434.33484977256;4444.777761111996;4458.24209884327;4460.710053846489;4373.475182978063;4414.27164517851;4431.645468362588;4449.532799056182;4469.240229160985;4235.470566179228;4235.661147108162;4235.767032813224;4255.212785634668;4479.574440428154;3527.506149139174;3572.1069732566857;3573.8034408106764;3578.2127931854952;3581.8030008349792;5172.922406163835;5175.171972484384;5175.792968281226;5178.291163915824;5216.843494695166;4806.255030470283;4868.586170175575;4987.177115775857;4994.875128121826;5025.145725226647;4959.975200123977;4966.602671786176;4968.2795994579865;4970.552650261349;4983.302337672656;4878.707277563358;4892.510748925079;4894.241392584155;4897.289892965571;4899.216125419915;4787.210110331756;4989.301497790239;5034.395872495324;5035.521625445577;5040.596752259884;4911.50884911506;4915.754212289443;4932.21084626458;4935.235038569028;4960.429550601727 11:40:13 INFO - PROCESS | 13178 | |5;yui.html;555.405715884004;591.4883625663797;612.2652816620056;613.8281281241254;625.0967352176104;11365.488553015113;12135.15053946222;12656.746865062705;12675.049371297155;13176;12629.052821038413;12885.871141288584;12906.483740650363;12911.612651620442;12917;629.131798118598;749.5203070035168;769.9076110866704;772.5750837039634;773.2808488106059;743.9590822504761;761.0866959648416;770.0297624992494;775.3603277296224;775.8138046868739;587.826591155608;589.1369144203741;589.3929252869551;589.4429763873142;589.7876764364826;587.650348042918;588.2822955993702;588.8733922206703;589.1016200294564;651.2152855808739;563.3240111865778;578.0664227272924;589.7198830555494;590.9054551271776;591.4558606082414;12617.495300187982;12637.241765494007;12644.810327845089;12649.051321150859;12649.810252846215;12038;12354.38228088592;12364.44360003793;12545.184563003375;13144.539941102015;10746.731331716692;10883.727906802314;11046.613368532062;11153.107751379952;11319.943400282946;4022.9195416091516;4073.246449406869;4075.1442197138635;4109.671226301919;4117.094239267356;65683;65753.3424665752;65782.67108664474;65834.3416565833;65909.01136483005;9202.539873006323;9551.14039736427;9923.206143508502;10090.34412763168;10093;18476.983765892735;18534.721979170325;18596.25614975413;18621.7206741899;18671.533211669816;6664.166979127609;6770.1537307836525;6810.727570897108;6817.829554261084;6928.965355173293;3589.748717589796;3670.632936706308;3694.113412780967;3729.627037296303;3733.6826369758874;2615.9869200653875;2736.86315684215;2738.151173136334;2738.288045108286;2739.0413355325877;455.64687367290617;462.6969335085457;462.85188739603007;469.2140664387138;469.76511744127936;464.8958723032797;471.11430510640463;492.5271739130403;496.0500641271924;504.45014933722416;6689.431398331099;6925.134358205224;7076.575405475688;7386.113666360071;7493.38423279535;485.6940127719514;500.1747117256483;500.8973160502088;529.2061907139291;532.3664838841765;3403.7787543809573;3468.497067925137;3637.5453068366455;3662.340778659867;3799.696024318048;61055;61529;61567;108329;109562;54479;55060.44939550633;55569;68291;81876.59061704653;76589;78491.60754196307;78745.60627196827;79966.60016699995;81929.18070819335;6668.699908504032;6845.349691779273;6914.688839002157;6960.965195174194;7146.32109949554;46676.53323466722;46971.76514117407;47844.28233576569;47884;48666.75666621644;61448;67455.3254467449;68855;70467.64766176137;72005.27994720195;8549.658013679633;8662.177093176138;8850.911490885008;9064.773380665536;9129.726108216764;10035.09684128432;10036.29745917808;10082.193424525874;10242.590296388062;10397.532111055172;9299.209567186594;9635.470049147365;9691.660791872533;9863.210943124677;9932.503374831374;8881.511516866634;9477.099675530813;9669.323147379897;9885.604575816888;9911.801763964824;9477.763055923657;9640.469774162488;9842.360246583949;10111.59553617847;10135.087842094246;8234.258916697527;8291.792705182419;8308.5430301334;8476.406651534333;8689.6089675966;8321.375896807886;8452.239298463168;8550.657973680984;8713.797837907288;8819.559022049 11:40:13 INFO - PROCESS | 13178 | __end_tp_report 11:40:13 INFO - PROCESS | 13178 | __start_cc_report 11:40:13 INFO - PROCESS | 13178 | _x_x_mozilla_cycle_collect,1150 11:40:13 INFO - PROCESS | 13178 | __end_cc_report 11:40:13 INFO - PROCESS | 13178 | __startTimestamp1471977613094__endTimestamp 11:40:13 INFO - PROCESS | 13178 | 11:40:13 INFO - PROCESS | 13178 | ------- Summary: start ------- 11:40:13 INFO - PROCESS | 13178 | Number of tests: 6 11:40:13 INFO - PROCESS | 13178 | 11:40:13 INFO - PROCESS | 13178 | [#0] dojo.html Cycles:165 Average:4661.61 Median:4748.86 stddev:488.91 (10.3%) stddev-sans-first:462.54 11:40:13 INFO - PROCESS | 13178 | Values: 2587.5 2596.7 2597.0 2626.5 2642.6 4611.9 4619.1 4676.6 4730.3 4746.7 4650.6 4678.8 4702.8 4725.6 4757.4 4244.0 4276.4 4305.3 4372.6 4466.9 4337.2 4400.7 4427.7 4443.1 4454.9 4293.3 4315.8 4325.3 4340.9 4355.3 4296.2 4302.7 4392.4 4393.2 4415.6 4263.6 4269.4 4295.8 4369.9 4377.0 4656.6 4663.9 4664.6 4671.3 4693.4 4839.2 4993.0 5016.8 5020.2 5071.7 5032.3 5069.3 5077.9 5081.7 5134.0 4723.7 4727.1 4729.9 4731.4 4748.9 5078.0 5122.2 5131.0 5156.1 5181.4 4922.4 4929.8 4939.2 4980.1 4989.8 5000.5 5008.9 5010.5 5011.7 5084.0 4828.8 4928.5 4957.5 4973.7 5036.4 4964.7 4996.2 4997.6 5050.9 5060.7 4248.0 4256.7 4257.4 4306.9 4309.7 3686.5 3696.3 3729.2 3748.5 3796.2 4353.5 4372.5 4408.8 4429.5 4446.3 5146.7 5147.9 5148.5 5158.4 5217.1 4397.3 4406.5 4411.8 4459.4 4467.0 4404.2 4459.8 4484.8 4595.2 4598.1 4714.1 4714.6 4717.7 4746.1 4776.5 5017.1 5018.6 5020.4 5022.8 5052.1 4605.7 4722.1 4732.6 4734.7 4755.4 4999.5 5008.2 5014.9 5017.7 5062.5 5084.1 5085.8 5086.5 5091.1 5133.9 4742.7 4853.8 4899.1 4938.5 5000.7 4930.8 4930.9 4934.7 4970.6 4977.5 4808.8 4810.9 4810.9 4813.6 4866.1 4878.9 4887.3 4928.9 4945.5 5005.0 4838.9 4852.9 4863.7 4903.4 4916.4 11:40:13 INFO - PROCESS | 13178 | 11:40:13 INFO - PROCESS | 13178 | [#1] ext.html Cycles:180 Average:43441.19 Median:34618.24 stddev:80233.06 (231.8%) stddev-sans-first:80393.55 11:40:13 INFO - PROCESS | 13178 | Values: 566.0 568.6 569.7 582.9 585.7 27968.0 28469.3 38129.6 39242.4 39376.8 39117.0 39410.8 39510.6 39517.4 39549.8 7520.0 7693.7 7716.0 7721.6 7727.3 7616.9 7695.9 7700.8 7707.7 7708.2 7717.3 7780.2 7780.5 7783.5 7788.8 7413.9 7435.2 7447.3 7448.3 7453.9 7613.3 7677.0 7684.0 7687.7 7689.3 31988.8 32336.2 32337.8 32351.4 32370.2 2634.8 2805.7 3107.6 3116.3 3191.6 28397.0 28475.9 29029.4 29089.3 30374.2 3355.8 3548.9 3565.9 3628.7 3654.2 178547.1 178836.0 178990.1 179056.0 179057.0 50626.2 50947.0 50951.7 50955.5 51005.0 32614.8 33205.0 33538.3 34983.7 35004.8 13683.7 13970.9 13986.9 13991.0 13994.4 10318.2 10502.8 10504.7 10513.9 10514.5 17977.4 18054.6 18090.9 18094.3 18136.6 6506.9 6569.8 6665.2 6712.3 6853.2 739.4 862.9 868.0 903.9 908.8 25495.7 26708.5 26763.9 27156.5 27729.3 890.1 923.2 930.6 941.0 957.9 13685.5 13696.5 14395.0 14419.6 14478.4 387571.0 393874.0 394658.0 395017.0 398753.0 47278.3 47805.8 47851.5 47860.3 47897.3 1034.2 1137.1 1140.2 1145.4 1160.5 26970.6 28807.1 29043.7 29575.9 29663.6 40891.2 41630.8 41635.2 41654.8 41681.0 298092.0 298140.0 298672.0 298706.0 299313.0 19865.5 20066.3 20392.1 22497.2 22539.9 34519.5 34626.5 34721.1 34919.7 34950.3 33822.5 34293.3 34485.0 35326.6 35364.6 34074.5 34167.5 34417.5 34610.0 36124.8 33493.3 34347.5 34896.3 35142.8 35325.6 29872.0 31700.4 31711.8 32134.2 32486.2 24019.5 24497.5 24588.4 24657.5 24948.6 11:40:13 INFO - PROCESS | 13178 | 11:40:13 INFO - PROCESS | 13178 | [#2] jquery.html Cycles:180 Average:23744.15 Median:4348.14 stddev:62643.26 (1440.7%) stddev-sans-first:62794.35 11:40:13 INFO - PROCESS | 13178 | Values: 346.0 364.6 368.5 372.4 392.5 12368.9 15654.0 15978.4 16165.4 17024.0 14236.9 14599.9 14653.6 14968.6 15151.7 4056.9 4338.5 4482.8 4483.3 5137.3 4985.7 5060.2 5065.1 5067.6 5069.8 4864.9 4995.6 5042.2 5046.5 5047.6 4955.2 5004.2 5005.9 5018.1 5040.3 4298.0 4526.8 4527.2 4531.7 4534.6 11713.6 11966.5 11982.8 11984.3 12052.3 1743.3 1825.0 1834.7 1941.9 2271.1 8536.6 9262.5 13186.1 13899.8 14032.1 1685.8 1740.8 1750.9 1754.5 1757.6 65038.7 68884.3 69561.3 69710.0 69731.0 9993.5 10106.5 10107.9 10393.2 10506.2 14141.4 14158.1 14232.4 14240.0 14253.7 6852.8 6995.8 7030.5 7137.3 7154.6 6470.2 6492.8 6680.4 6696.7 6739.4 4319.0 4357.8 4387.9 4491.5 4523.3 1720.3 1765.2 1778.5 1802.0 1840.3 776.8 819.4 843.3 856.2 888.0 15995.9 17218.4 17231.8 17267.0 17589.6 793.5 794.2 819.8 848.2 862.8 9045.3 9088.5 9141.7 9273.9 9547.9 374346.0 374784.0 376553.0 377172.0 387425.0 74820.3 77258.0 77727.6 80383.6 81378.0 865.4 888.1 893.8 896.6 901.9 14528.5 14820.6 15040.9 15191.0 15657.2 35971.0 36221.8 36705.3 40331.8 40869.6 50080.7 54331.7 54984.0 56429.4 56717.4 6738.1 7401.3 7445.0 7515.7 7556.8 11482.1 11923.6 11931.4 12007.9 12936.0 9954.9 9988.5 10210.1 10273.0 10429.2 10174.7 10279.4 10362.1 10438.2 10484.5 10005.3 10075.9 10361.9 10744.9 10795.4 6854.9 7066.4 7195.7 7226.1 7315.3 9083.2 9651.8 9696.3 10137.7 10278.7 11:40:13 INFO - PROCESS | 13178 | 11:40:13 INFO - PROCESS | 13178 | [#3] mootools.html Cycles:180 Average:4889.76 Median:4772.21 stddev:2823.18 (59.2%) stddev-sans-first:2817.57 11:40:13 INFO - PROCESS | 13178 | Values: 1210.8 1331.6 1388.0 1433.1 1653.6 6522.8 7446.9 7649.4 7668.8 7876.7 7653.4 7742.6 7750.3 7751.1 7757.5 2109.2 2134.9 2138.6 2139.9 2156.6 2097.3 2139.1 2143.5 2144.8 2146.5 2080.7 2093.9 2102.4 2103.9 2160.5 2098.6 2104.7 2105.6 2106.7 2107.5 2039.3 2089.3 2091.2 2093.4 2097.3 7396.6 7523.2 7556.4 7680.2 7700.5 4182.5 4350.2 4358.3 4361.3 4362.7 2640.7 2746.0 2792.1 2800.1 2808.4 925.0 936.8 940.3 947.3 954.6 10283.7 10369.8 10408.2 10419.1 10430.2 3627.0 3830.7 3836.2 3933.2 3960.7 8209.0 8224.9 8242.1 8250.5 8253.8 4186.7 4195.1 4196.7 4197.1 4197.2 3405.6 3871.6 3944.3 3944.6 3976.6 3331.2 3348.2 3446.9 3464.3 3484.7 1007.6 1012.0 1020.3 1028.3 1031.3 696.1 702.6 716.8 725.2 745.0 4788.3 4791.9 4836.3 4913.3 4998.1 381.7 406.9 407.4 414.6 423.6 3282.1 3299.8 3300.9 3302.9 3461.9 9240.1 9521.5 9556.5 9558.8 9578.4 9521.7 9523.1 9543.3 9562.8 9590.7 7196.7 7272.7 7274.0 7283.0 7283.3 4756.1 4871.6 4916.8 4954.3 5037.5 8437.8 8661.4 8691.3 8705.1 8766.0 8648.7 8868.4 8880.2 8963.5 8977.7 5365.6 5789.1 5944.6 6002.6 6008.5 6945.7 7172.9 7178.7 7179.6 7187.2 6353.7 6360.8 6381.6 6503.0 6512.6 6379.9 6380.8 6395.3 6431.3 6441.6 5838.1 5938.6 5939.1 5945.2 5955.1 4141.0 4150.1 4185.2 4257.1 4365.8 4286.0 4372.2 4378.5 4482.4 4574.8 11:40:13 INFO - PROCESS | 13178 | 11:40:13 INFO - PROCESS | 13178 | [#4] prototype.html Cycles:180 Average:4024.03 Median:4383.34 stddev:1159.65 (26.5%) stddev-sans-first:1128.39 11:40:13 INFO - PROCESS | 13178 | Values: 282.8 291.2 296.1 299.0 300.4 4633.9 4737.4 4795.7 4832.4 4849.6 4551.6 4694.5 4696.9 4726.9 4750.4 3786.7 3788.1 3799.7 3804.6 3804.9 3547.8 3824.0 3840.6 3855.2 3856.8 3341.9 3609.3 3726.9 3735.0 3745.8 3726.8 3738.0 3744.8 3750.4 3764.0 3298.1 3319.1 3320.5 3326.7 3334.4 4452.5 4590.2 4594.9 4662.3 4667.4 4234.8 4250.0 4253.7 4254.4 4255.9 4859.7 4872.6 4913.3 4914.5 4964.0 3488.5 3577.6 3589.8 3600.1 3605.3 5162.8 5168.8 5178.8 5191.2 5198.7 3661.1 3663.2 3666.9 3666.9 3669.9 3737.4 3749.3 3770.7 3776.8 3777.0 3986.2 4182.4 4190.5 4270.7 4276.3 4938.5 4949.5 4952.4 4956.5 4959.2 1197.0 1218.9 1228.6 1253.9 1274.9 838.5 844.5 851.2 863.8 869.8 4341.6 4352.0 4390.1 4406.4 4430.9 5025.4 5026.4 5030.3 5039.9 5045.6 4340.7 4355.0 4370.5 4376.5 4400.1 2237.6 2328.6 2332.7 2357.5 2364.6 4192.0 4225.1 4252.4 4258.0 4277.4 4531.3 4546.8 4548.3 4550.2 4588.8 3940.5 4193.0 4242.6 4242.6 4246.7 4398.5 4434.3 4444.8 4458.2 4460.7 4373.5 4414.3 4431.6 4449.5 4469.2 4235.5 4235.7 4235.8 4255.2 4479.6 3527.5 3572.1 3573.8 3578.2 3581.8 5172.9 5175.2 5175.8 5178.3 5216.8 4806.3 4868.6 4987.2 4994.9 5025.1 4960.0 4966.6 4968.3 4970.6 4983.3 4878.7 4892.5 4894.2 4897.3 4899.2 4787.2 4989.3 5034.4 5035.5 5040.6 4911.5 4915.8 4932.2 4935.2 4960.4 11:40:13 INFO - PROCESS | 13178 | 11:40:13 INFO - PROCESS | 13178 | [#5] yui.html Cycles:180 Average:16642.17 Median:588.99 stddev:24010.85 (4076.6%) stddev-sans-first:24047.82 11:40:13 INFO - PROCESS | 13178 | Values: 555.4 591.5 612.3 613.8 625.1 11365.5 12135.2 12656.7 12675.0 13176.0 12629.1 12885.9 12906.5 12911.6 12917.0 629.1 749.5 769.9 772.6 773.3 744.0 761.1 770.0 775.4 775.8 587.8 589.1 589.4 589.4 589.8 587.7 588.3 588.9 589.1 651.2 563.3 578.1 589.7 590.9 591.5 12617.5 12637.2 12644.8 12649.1 12649.8 12038.0 12354.4 12364.4 12545.2 13144.5 10746.7 10883.7 11046.6 11153.1 11319.9 4022.9 4073.2 4075.1 4109.7 4117.1 65683.0 65753.3 65782.7 65834.3 65909.0 9202.5 9551.1 9923.2 10090.3 10093.0 18477.0 18534.7 18596.3 18621.7 18671.5 6664.2 6770.2 6810.7 6817.8 6929.0 3589.7 3670.6 3694.1 3729.6 3733.7 2616.0 2736.9 2738.2 2738.3 2739.0 455.6 462.7 462.9 469.2 469.8 464.9 471.1 492.5 496.1 504.5 6689.4 6925.1 7076.6 7386.1 7493.4 485.7 500.2 500.9 529.2 532.4 3403.8 3468.5 3637.5 3662.3 3799.7 61055.0 61529.0 61567.0 108329.0 109562.0 54479.0 55060.4 55569.0 68291.0 81876.6 76589.0 78491.6 78745.6 79966.6 81929.2 6668.7 6845.3 6914.7 6961.0 7146.3 46676.5 46971.8 47844.3 47884.0 48666.8 61448.0 67455.3 68855.0 70467.6 72005.3 8549.7 8662.2 8850.9 9064.8 9129.7 10035.1 10036.3 10082.2 10242.6 10397.5 9299.2 9635.5 9691.7 9863.2 9932.5 8881.5 9477.1 9669.3 9885.6 9911.8 9477.8 9640.5 9842.4 10111.6 10135.1 8234.3 8291.8 8308.5 8476.4 8689.6 8321.4 8452.2 8550.7 8713.8 8819.6 11:40:13 INFO - PROCESS | 13178 | -------- Summary: end -------- 11:40:13 INFO - PROCESS | 13178 | 11:40:14 INFO - TEST-INFO | 13178: exit 0 11:40:14 INFO - TEST-OK | dromaeo_css | took 1122554ms 11:40:14 INFO - TEST-START | kraken 11:40:14 INFO - operating with platform_type : linux_ 11:40:14 INFO - Initialising browser for kraken test... 11:40:14 INFO - TEST-INFO | started process 13481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAuMdfo/profile http://localhost:57358/getInfo.html) 11:40:19 INFO - PROCESS | 13481 | __metrics Screen width/height:1600/1200 11:40:19 INFO - PROCESS | 13481 | colorDepth:24 11:40:19 INFO - PROCESS | 13481 | Browser inner width/height: 1024/697 11:40:19 INFO - PROCESS | 13481 | __metrics 11:40:19 INFO - PROCESS | 13481 | 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" 11:40:19 INFO - PROCESS | 13481 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:40:20 INFO - PROCESS | 13481 | console.error: PushService: 11:40:20 INFO - PROCESS | 13481 | stateChangeProcessEnqueue: Error transitioning state 11:40:20 INFO - PROCESS | 13481 | UnknownError 11:40:21 INFO - TEST-INFO | 13481: exit 0 11:40:21 INFO - Browser initialized. 11:40:21 INFO - Running cycle 1/1 for kraken test... 11:40:21 INFO - TEST-INFO | started process 13561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAuMdfo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:33 INFO - PROCESS | 13561 | RSS: Main: 182857728 11:40:33 INFO - PROCESS | 13561 | 11:40:36 INFO - PROCESS | 13561 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57358/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:36 INFO - PROCESS | 13561 | RSS: Main: 236630016 11:40:36 INFO - PROCESS | 13561 | 11:40:39 INFO - PROCESS | 13561 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57358/tests/kraken/driver.html?testName=audio-dft) 11:40:40 INFO - PROCESS | 13561 | RSS: Main: 227201024 11:40:40 INFO - PROCESS | 13561 | 11:40:43 INFO - PROCESS | 13561 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57358/tests/kraken/driver.html?testName=audio-fft) 11:40:44 INFO - PROCESS | 13561 | RSS: Main: 305561600 11:40:44 INFO - PROCESS | 13561 | 11:40:46 INFO - PROCESS | 13561 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57358/tests/kraken/driver.html?testName=audio-oscillator) 11:40:47 INFO - PROCESS | 13561 | RSS: Main: 214269952 11:40:47 INFO - PROCESS | 13561 | 11:40:49 INFO - PROCESS | 13561 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57358/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:49 INFO - PROCESS | 13561 | RSS: Main: 215527424 11:40:49 INFO - PROCESS | 13561 | 11:40:53 INFO - PROCESS | 13561 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57358/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:53 INFO - PROCESS | 13561 | RSS: Main: 253894656 11:40:53 INFO - PROCESS | 13561 | 11:40:57 INFO - PROCESS | 13561 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57358/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:58 INFO - PROCESS | 13561 | RSS: Main: 247828480 11:40:58 INFO - PROCESS | 13561 | 11:41:00 INFO - PROCESS | 13561 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57358/tests/kraken/driver.html?testName=json-parse-financial) 11:41:01 INFO - PROCESS | 13561 | RSS: Main: 251121664 11:41:01 INFO - PROCESS | 13561 | 11:41:03 INFO - PROCESS | 13561 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57358/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:41:03 INFO - PROCESS | 13561 | RSS: Main: 214999040 11:41:03 INFO - PROCESS | 13561 | 11:41:05 INFO - PROCESS | 13561 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:41:06 INFO - PROCESS | 13561 | RSS: Main: 221839360 11:41:06 INFO - PROCESS | 13561 | 11:41:08 INFO - PROCESS | 13561 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:41:09 INFO - PROCESS | 13561 | RSS: Main: 223264768 11:41:09 INFO - PROCESS | 13561 | 11:41:12 INFO - PROCESS | 13561 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:41:12 INFO - PROCESS | 13561 | RSS: Main: 218767360 11:41:12 INFO - PROCESS | 13561 | 11:41:15 INFO - PROCESS | 13561 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:41:16 INFO - PROCESS | 13561 | RSS: Main: 221798400 11:41:16 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57358/tests/kraken/driver.html?testName=ai-astar) 11:41:18 INFO - PROCESS | 13561 | RSS: Main: 272764928 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | __start_tp_report 11:41:18 INFO - PROCESS | 13561 | _x_x_mozilla_page_load 11:41:18 INFO - PROCESS | 13561 | _x_x_mozilla_page_load_details 11:41:18 INFO - PROCESS | 13561 | |i|pagename|runs| 11:41:18 INFO - PROCESS | 13561 | |0;ai-astar;114;114;129;115;115;115;113;114;115;114 11:41:18 INFO - PROCESS | 13561 | |1;audio-beat-detection;153;122;151;185;121;147;149;129;196;124 11:41:18 INFO - PROCESS | 13561 | |2;audio-dft;163;164;164;163;163;162;162;163;163;163 11:41:18 INFO - PROCESS | 13561 | |3;audio-fft;76;77;75;175;79;77;76;79;166;76 11:41:18 INFO - PROCESS | 13561 | |4;audio-oscillator;86;86;140;87;87;86;146;86;86;144 11:41:18 INFO - PROCESS | 13561 | |5;imaging-gaussian-blur;117;117;116;117;118;118;118;117;117;118 11:41:18 INFO - PROCESS | 13561 | |6;imaging-darkroom;147;148;147;146;147;147;147;147;147;148 11:41:18 INFO - PROCESS | 13561 | |7;imaging-desaturate;95;96;96;94;96;95;96;95;95;95 11:41:18 INFO - PROCESS | 13561 | |8;json-parse-financial;66;66;67;68;69;67;68;69;65;65 11:41:18 INFO - PROCESS | 13561 | |9;json-stringify-tinderbox;66;67;66;66;65;66;66;67;65;66 11:41:18 INFO - PROCESS | 13561 | |10;stanford-crypto-aes;84;83;83;83;84;85;82;83;89;82 11:41:18 INFO - PROCESS | 13561 | |11;stanford-crypto-ccm;138;132;130;132;136;132;131;131;157;143 11:41:18 INFO - PROCESS | 13561 | |12;stanford-crypto-pbkdf2;173;177;177;171;172;174;171;170;174;171 11:41:18 INFO - PROCESS | 13561 | |13;stanford-crypto-sha256-iterative;69;72;70;72;69;70;69;69;68;69 11:41:18 INFO - PROCESS | 13561 | __end_tp_report 11:41:18 INFO - PROCESS | 13561 | __start_cc_report 11:41:18 INFO - PROCESS | 13561 | _x_x_mozilla_cycle_collect,1995 11:41:18 INFO - PROCESS | 13561 | __end_cc_report 11:41:18 INFO - PROCESS | 13561 | __startTimestamp1471977678493__endTimestamp 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | ------- Summary: start ------- 11:41:18 INFO - PROCESS | 13561 | Number of tests: 14 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | [#0] ai-astar Cycles:10 Average:115.80 Median:115.00 stddev:4.69 (4.1%) stddev-sans-first:4.92 11:41:18 INFO - PROCESS | 13561 | Values: 114.0 114.0 129.0 115.0 115.0 115.0 113.0 114.0 115.0 114.0 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:150.00 stddev:25.93 (17.3%) stddev-sans-first:27.43 11:41:18 INFO - PROCESS | 13561 | Values: 153.0 122.0 151.0 185.0 121.0 147.0 149.0 129.0 196.0 124.0 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 11:41:18 INFO - PROCESS | 13561 | Values: 163.0 164.0 164.0 163.0 163.0 162.0 162.0 163.0 163.0 163.0 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.50 stddev:39.55 (51.7%) stddev-sans-first:41.31 11:41:18 INFO - PROCESS | 13561 | Values: 76.0 77.0 75.0 175.0 79.0 77.0 76.0 79.0 166.0 76.0 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:86.00 stddev:27.60 (32.1%) stddev-sans-first:28.54 11:41:18 INFO - PROCESS | 13561 | Values: 86.0 86.0 140.0 87.0 87.0 86.0 146.0 86.0 86.0 144.0 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 11:41:18 INFO - PROCESS | 13561 | Values: 117.0 117.0 116.0 117.0 118.0 118.0 118.0 117.0 117.0 118.0 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 11:41:18 INFO - PROCESS | 13561 | Values: 147.0 148.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 148.0 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 11:41:18 INFO - PROCESS | 13561 | Values: 95.0 96.0 96.0 94.0 96.0 95.0 96.0 95.0 95.0 95.0 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:67.50 stddev:1.49 (2.2%) stddev-sans-first:1.54 11:41:18 INFO - PROCESS | 13561 | Values: 66.0 66.0 67.0 68.0 69.0 67.0 68.0 69.0 65.0 65.0 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 11:41:18 INFO - PROCESS | 13561 | Values: 66.0 67.0 66.0 66.0 65.0 66.0 66.0 67.0 65.0 66.0 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:2.04 (2.4%) stddev-sans-first:2.17 11:41:18 INFO - PROCESS | 13561 | Values: 84.0 83.0 83.0 83.0 84.0 85.0 82.0 83.0 89.0 82.0 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:134.00 stddev:8.35 (6.2%) stddev-sans-first:8.83 11:41:18 INFO - PROCESS | 13561 | Values: 138.0 132.0 130.0 132.0 136.0 132.0 131.0 131.0 157.0 143.0 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:173.50 stddev:2.49 (1.4%) stddev-sans-first:2.65 11:41:18 INFO - PROCESS | 13561 | Values: 173.0 177.0 177.0 171.0 172.0 174.0 171.0 170.0 174.0 171.0 11:41:18 INFO - PROCESS | 13561 | 11:41:18 INFO - PROCESS | 13561 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.50 stddev:1.34 (1.9%) stddev-sans-first:1.39 11:41:18 INFO - PROCESS | 13561 | Values: 69.0 72.0 70.0 72.0 69.0 70.0 69.0 69.0 68.0 69.0 11:41:18 INFO - PROCESS | 13561 | -------- Summary: end -------- 11:41:18 INFO - PROCESS | 13561 | 11:41:19 INFO - TEST-INFO | 13561: exit 0 11:41:19 INFO - TEST-OK | kraken | took 65710ms 11:41:19 INFO - SUITE-END | took 1188s 11:41:20 INFO - Completed test suite (00:19:48) 11:41:20 INFO - javascript benchmark 11:41:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2587.4695687384083, 2596.727343628918, 2597.0164048173665, 2626.4747050589885, 2642.630031795549, 4611.884702882429, 4619.076184763053, 4676.625869930406, 4730.266808644666, 4746.691465054773, 4650.627949764019, 4678.836240731566, 4702.811887524504, 4725.598324142452, 4757.357756702844, 4244.0, 4276.401303817468, 4305.268104422255, 4372.606465418112, 4466.865994020169, 4337.197618440583, 4400.669949753766, 4427.690061695683, 4443.089166720814, 4454.933176002346, 4293.3130699088, 4315.762633055181, 4325.307950727868, 4340.871373442896, 4355.281378572532, 4296.226679197744, 4302.698811083225, 4392.407025051641, 4393.165298593257, 4415.580519850609, 4263.616274535276, 4269.444972153631, 4295.828166873322, 4369.890752731176, 4376.978115109436, 4656.557627025461, 4663.930041049387, 4664.626829853603, 4671.346011558385, 4693.436787585478, 4839.249916262985, 4993.0263598598285, 5016.849494515171, 5020.171671674169, 5071.670341427833, 5032.295478632995, 5069.315642388304, 5077.873053173664, 5081.745912704387, 5134.024535338311, 4723.716577005322, 4727.125481785881, 4729.881752956135, 4731.432228132578, 4748.857534273978, 5077.974610126999, 5122.1804511278015, 5131.0, 5156.149235376196, 5181.3782346118705, 4922.360093187863, 4929.827456039022, 4939.209726443752, 4980.078685443204, 4989.750512474435, 5000.474950130257, 5008.874778130503, 5010.549050585465, 5011.674241174312, 5083.974580127076, 4828.806847726122, 4928.48250933654, 4957.454679985199, 4973.651844370932, 5036.420811606712, 4964.652474326763, 4996.200607902718, 4997.575206107522, 5050.898982020339, 5060.671056381323, 4247.97876010618, 4256.7445953242905, 4257.425247591597, 4306.870793876189, 4309.719868208556, 3686.465462507975, 3696.2977034363385, 3729.1609387887506, 3748.475213470116, 3796.1648437343742, 4353.455818022747, 4372.519022907478, 4408.801603927831, 4429.512753597101, 4446.2663660495655, 5146.665466744649, 5147.867469156779, 5148.459411761786, 5158.432572417031, 5217.0870097733505, 4397.252467080604, 4406.537313582092, 4411.8014689338415, 4459.420275364182, 4467.039586488921, 4404.185225733249, 4459.799309031101, 4484.775761211927, 4595.241785105487, 4598.0803839232285, 4714.104320179155, 4714.5992590630185, 4717.693349932243, 4746.121967436035, 4776.498467660846, 5017.147084995632, 5018.598512119095, 5020.422651395136, 5022.773975171053, 5052.065367906949, 4605.654575906753, 4722.1028004679, 4732.550407711262, 4734.715917044989, 4755.405574303212, 4999.500049994971, 5008.223725322581, 5014.87462813418, 5017.724025178651, 5062.493750624908, 5084.059449001947, 5085.821996230262, 5086.465921078234, 5091.13450713387, 5133.948660513496, 4742.739149346819, 4853.781579828987, 4899.118158731462, 4938.530839570235, 5000.67495612784, 4930.753462326941, 4930.926036109533, 4934.703917764946, 4970.577500912463, 4977.477364876636, 4808.759562021815, 4810.876416616293, 4810.903781924412, 4813.590844778093, 4866.124097662455, 4878.878028049327, 4887.266909963534, 4928.926066109083, 4945.497182944666, 5005.024020316004, 4838.903221935612, 4852.927206091841, 4863.659543831898, 4903.41159060915, 4916.360873086476], "value": 4630.117304198537, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.9943400565993, 568.5622071005326, 569.6667449542018, 582.9329627092883, 585.6954383720465, 27968.0, 28469.28826779329, 38129.61870381295, 39242.41136382957, 39376.80311598438, 39117.0, 39410.8029459853, 39510.60489395105, 39517.40723889144, 39549.802250988774, 7519.962400187991, 7693.7307194248215, 7716.035495563055, 7721.613919304041, 7727.343175830033, 7616.923830761704, 7695.884561731578, 7700.845983080335, 7707.730229441971, 7708.229177082303, 7717.263615686482, 7780.183080776522, 7780.455368124233, 7783.532988020708, 7788.766337009899, 7413.851722965537, 7435.219301973269, 7447.2552744725635, 7448.329650331496, 7453.85092298151, 7613.276738709869, 7676.9616151919445, 7684.0, 7687.692492300302, 7689.307962283421, 31988.840055799574, 32336.191595210308, 32337.838310808296, 32351.352972940644, 32370.248528875072, 2634.7628713415693, 2805.719428057178, 3107.6270847498445, 3116.2832548513743, 3191.569138166341, 28397.0, 28475.857620711762, 29029.41941161165, 29089.272768180752, 30374.240643983856, 3355.7949468840193, 3548.8935331940083, 3565.893023209282, 3628.677646306366, 3654.177809992757, 178547.10726446286, 178836.0, 178990.1050494752, 179056.0, 179057.0, 50626.24060639094, 50947.0, 50951.7452412743, 50955.49044509581, 51005.0, 32614.83692581522, 33205.0, 33538.32923341519, 34983.65016349804, 35004.82497587496, 13683.657908552166, 13970.860291397159, 13986.930065349608, 13991.0, 13994.440222390991, 10318.17454603645, 10502.789944201073, 10504.737381565523, 10513.894861051445, 10514.526846291936, 17977.370792022215, 18054.638907221783, 18090.90954545219, 18094.27622895096, 18136.63726725458, 6506.934930650727, 6569.835754106186, 6665.166854143232, 6712.328767123248, 6853.17761868579, 739.3641468337225, 862.9093945135796, 867.9566021698889, 903.9457632542069, 908.7591788176138, 25495.745042549708, 26708.46583068328, 26763.86618066897, 27156.456870862472, 27729.306767330574, 890.1098901098901, 923.2429407885604, 930.6184464369576, 941.0, 957.9346092504015, 13685.521006764915, 13696.452141914411, 14395.0, 14419.63950901215, 14478.420863165355, 387571.0, 393874.0, 394658.0, 395017.0, 398753.0, 47278.29082563764, 47805.76097119492, 47851.5214847854, 47860.28209576859, 47897.281540776916, 1034.2294990232326, 1137.0960086730904, 1140.2417392434104, 1145.4215621111452, 1160.5473865192582, 26970.595441068792, 28807.135785926457, 29043.714211607537, 29575.85212073926, 29663.555046673886, 40891.18217635571, 41630.79184604058, 41635.1672966545, 41654.79172604118, 41681.0, 298092.0, 298140.0, 298672.0, 298706.0, 299313.0, 19865.50336241548, 20066.29767958173, 20392.082356293704, 22497.212597559006, 22539.88730056339, 34519.4822077674, 34626.48060279148, 34721.13197170091, 34919.65080349266, 34950.30099398048, 33822.463315251945, 34293.314133717686, 34485.0, 35326.64673353233, 35364.646353537166, 34074.488882667276, 34167.4874876882, 34417.48373774345, 34610.0, 36124.81937590295, 33493.330133397685, 34347.484787727706, 34896.30207395888, 35142.82428587841, 35325.64674353327, 29872.0, 31700.365992679555, 31711.841440792647, 32134.19664508406, 32486.18784530311, 24019.519609608058, 24497.4679684259, 24588.385290367885, 24657.506849862544, 24948.625770613093], "value": 16440.56577007897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.99481007784874, 364.63536463536445, 368.51356209803055, 372.4450568652708, 392.52896524171, 12368.938155309223, 15654.0, 15978.360865565379, 16165.43420980266, 17024.0, 14236.857631423683, 14599.854001459982, 14653.6336591585, 14968.625784355396, 15151.696966060672, 4056.8782936511802, 4338.479382474107, 4482.753448560328, 4483.260262056757, 5137.306463627418, 4985.6759310644875, 5060.190369540875, 5065.088284108859, 5067.594592432615, 5069.797208111671, 4864.927026094611, 4995.550400463958, 5042.243663450475, 5046.470120637336, 5047.646664733452, 4955.207166853286, 5004.224345226477, 5005.899882002376, 5018.071656743514, 5040.269160971675, 4297.957020429787, 4526.841560545398, 4527.230370836933, 4531.682782205247, 4534.59188673021, 11713.590024349107, 11966.521339146424, 11982.760344793143, 11984.340861252627, 12052.276863388224, 1743.3288184049106, 1824.9817501824944, 1834.660587791263, 1941.9417417477498, 2271.127024314244, 8536.615852286663, 9262.515540717923, 13186.142900711424, 13899.79150312746, 14032.087914285641, 1685.772420723211, 1740.782402199725, 1750.912454377276, 1754.456118603237, 1757.5869670627392, 65038.674806626135, 68884.3111568888, 69561.3043869565, 69710.0, 69730.99999999949, 9993.501624593851, 10106.545205465625, 10107.898921010696, 10393.16854651626, 10506.161421751163, 14141.363638636287, 14158.07972481806, 14232.359543820552, 14240.0, 14253.714925701428, 6852.760153394607, 6995.831292299302, 7030.472714546429, 7137.286271372821, 7154.570725756367, 6470.22357317125, 6492.805215843532, 6680.3987641112535, 6696.665166741644, 6739.427148692416, 4318.978405107954, 4357.803898824497, 4387.868363949086, 4491.505934347219, 4523.2988886722615, 1720.320473412995, 1765.1968354398718, 1778.519799654112, 1801.9549511262323, 1840.2914877772155, 776.8290975985274, 819.3690858039276, 843.2579330189517, 856.1780690537154, 887.9911200887908, 15995.920020400057, 17218.397356092475, 17231.814887928384, 17267.0, 17589.648207036043, 793.4564823096198, 794.2454668065361, 819.8401311744271, 848.1560846957317, 862.7670528957146, 9045.321600879828, 9088.500132492643, 9141.725748227564, 9273.907260927439, 9547.856782148274, 374346.0, 374784.0, 376553.0, 377172.0, 387425.0, 74820.25179748241, 77258.0, 77727.61136194282, 80383.59808201039, 81378.0, 865.35098675993, 888.1251966812684, 893.84357737397, 896.5606852642159, 901.855703087516, 14528.491502797351, 14820.555383338517, 15040.924795375953, 15191.0, 15657.21713914277, 35971.0, 36221.818890906434, 36705.265894681426, 40331.79834100928, 40869.59130408777, 50080.74959625324, 54331.72834135804, 54984.0, 56429.43570564406, 56717.43282567122, 6738.124043874265, 7401.296876796696, 7444.99492568518, 7515.661795219337, 7556.811079723051, 11482.081433485468, 11923.642290731292, 11931.403429828648, 12007.879921200676, 12936.0, 9954.850677239703, 9988.450635215133, 10210.13213876799, 10273.0, 10429.217808664229, 10174.694759157237, 10279.383237005804, 10362.067413932782, 10438.164946804085, 10484.52819623134, 10005.349652272578, 10075.949620252146, 10361.896381036093, 10744.946275268887, 10795.352278863293, 6854.862902742017, 7066.364027237573, 7195.748148814766, 7226.096737907762, 7315.341619254293, 9083.18251357381, 9651.806963860543, 9696.321257511907, 10137.695869123938, 10278.691639250834], "value": 7915.160860877368, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1210.800217964036, 1331.5872079655305, 1388.0145096981144, 1433.1401159304412, 1653.6114013206895, 6522.804315870526, 7446.888296675555, 7649.426293028017, 7668.808279793001, 7876.724314648988, 7653.425993050516, 7742.574158421285, 7750.341220996222, 7751.0698716154, 7757.456978011542, 2109.1774208058832, 2134.8505604607685, 2138.6043581937392, 2139.935801925937, 2156.644153714635, 2097.2974053691955, 2139.058814121789, 2143.496278374581, 2144.7962443567835, 2146.452654573082, 2080.739907511561, 2093.905774240163, 2102.3692892132376, 2103.92636257731, 2160.503084290614, 2098.5593025464673, 2104.6842973553935, 2105.6420408530435, 2106.662933930579, 2107.4520624637553, 2039.3474088291753, 2089.320970684518, 2091.1948899673584, 2093.413844123648, 2097.339338108506, 7396.55620662762, 7523.210062943422, 7556.4332675049045, 7680.19357967411, 7700.499467534592, 4182.477190351206, 4350.238708226079, 4358.302671572565, 4361.258586040349, 4362.672799540047, 2640.68311802583, 2746.0388863897674, 2792.0925699147656, 2800.075974928269, 2808.36811717364, 924.9722508324761, 936.7517607833929, 940.3088729783603, 947.2989987409336, 954.5656726189567, 10283.714535683039, 10369.79260414795, 10408.21938354619, 10419.114375278035, 10430.21773366993, 3626.9818650906577, 3830.7318487705593, 3836.2135762168687, 3933.1740334529495, 3960.683145348365, 8208.973878265217, 8224.876626850602, 8242.093369729326, 8250.54621995796, 8253.752387428387, 4186.748795072305, 4195.098053918361, 4196.748195108304, 4197.097624010791, 4197.24449599069, 3405.591329040531, 3871.632194941476, 3944.3097457944746, 3944.585818489017, 3976.58245884178, 3331.233816222234, 3348.2299071213756, 3446.9310613787584, 3464.255185135208, 3484.6689564491335, 1007.6422869881234, 1011.9696409107738, 1020.2654089055868, 1028.321307936758, 1031.3193292426963, 696.1298377028714, 702.6240961085795, 716.813628456605, 725.1841678112124, 745.0277388008701, 4788.329633851264, 4791.880202994953, 4836.347093142451, 4913.263010548446, 4998.100341938486, 381.7137147139645, 406.85759984005364, 407.35841050345823, 414.55435406937664, 423.64202249099463, 3282.14664187313, 3299.7855139416342, 3300.9009729708146, 3302.9009129725664, 3461.9480707789403, 9240.122188392092, 9521.476318802532, 9556.522173891417, 9558.808823823623, 9578.377405468622, 9521.714348569554, 9523.095305945924, 9543.284253681002, 9562.808743825084, 9590.712278631652, 7196.748113815991, 7272.672729727175, 7274.018007569016, 7283.0, 7283.308085731847, 4756.096341695067, 4871.561559459666, 4916.803327866845, 4954.256861470808, 5037.471065538212, 8437.789055273668, 8661.437006594802, 8691.304695624209, 8705.085965973482, 8766.0, 8648.740537783877, 8868.379213455255, 8880.200781929658, 8963.507007114411, 8977.730668079968, 5365.570754339566, 5789.102689083199, 5944.613600115978, 6002.579819412599, 6008.459238668541, 6945.687444064928, 7172.928270717226, 7178.676959536729, 7179.569225846466, 7187.209406965334, 6353.650549219838, 6360.840978975562, 6381.617102973836, 6503.0, 6512.641804700787, 6379.904301435575, 6380.776672816429, 6395.328490508616, 6431.260405053292, 6441.613503189824, 5838.12428135766, 5938.584299099021, 5939.07944268639, 5945.19739835134, 5955.106733989936, 4141.0, 4150.149219410074, 4185.225733239238, 4257.063446041866, 4365.781710914378, 4286.0, 4372.191144638252, 4378.540253273488, 4482.394876691736, 4574.7941342639], "value": 3848.3771807124567, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.837368513105, 291.17742377782764, 296.05115604487617, 299.04902410335126, 300.43967999680603, 4633.9073218535605, 4737.412966656174, 4795.664303498756, 4832.371791667083, 4849.612031037513, 4551.567601077901, 4694.450831225696, 4696.85909422717, 4726.9290960635535, 4750.358701575286, 3786.659200671939, 3788.109794198361, 3799.6960243180615, 3804.5624753153324, 3804.858542437272, 3547.7516573839844, 3823.961760382402, 3840.615938406151, 3855.1904100139004, 3856.826442810066, 3341.8663253469954, 3609.2601016791627, 3726.888193354204, 3735.0, 3745.8127093645344, 3726.7515382346946, 3737.962620373802, 3744.8314825832904, 3750.4374343848367, 3763.9623603763885, 3298.1424829544253, 3319.1038419626807, 3320.468725004012, 3326.6507016763376, 3334.3831391192466, 4452.532484089156, 4590.219662657356, 4594.931076033862, 4662.277347011185, 4667.439907211123, 4234.840231481936, 4249.957500425018, 4253.723507971972, 4254.3831144483875, 4255.89346769839, 4859.659823812334, 4872.634552408584, 4913.31213630092, 4914.4839791821705, 4963.982383611387, 3488.4592888102384, 3577.6422357764013, 3589.766665166756, 3600.135967367839, 3605.296967091418, 5162.819301324474, 5168.793248270064, 5178.792848286064, 5191.247269145991, 5198.740062996872, 3661.1213308806227, 3663.175785448253, 3666.871659491905, 3666.944995825065, 3669.9266014679556, 3737.439384092408, 3749.2876353492748, 3770.698344132463, 3776.792276424823, 3776.962230377661, 3986.1828325193264, 4182.410683940083, 4190.476190476191, 4270.722403043792, 4276.273033584298, 4938.456769755324, 4949.455559888409, 4952.4057113146655, 4956.4547899731, 4959.231319145538, 1196.9940150299192, 1218.9268643881219, 1228.6252692928742, 1253.9435725392198, 1274.885260326575, 838.5178522349673, 844.4933040175845, 851.199872120205, 863.7797361672859, 869.8173383589391, 4341.630961368319, 4351.97824010878, 4390.143921935256, 4406.427164468662, 4430.933535996963, 5025.442112944998, 5026.396832380138, 5030.270610761492, 5039.874003149951, 5045.646804723634, 4340.739555626673, 4354.956450435455, 4370.475542934868, 4376.533861156485, 4400.073950822731, 2237.6307909195125, 2328.6157783965455, 2332.682034650417, 2357.5049239659866, 2364.6285154610287, 4191.958080419156, 4225.070484493406, 4252.405347994502, 4257.957420425756, 4277.3797799319545, 4531.342955271467, 4546.772661366918, 4548.295014272793, 4550.249208880564, 4588.839390621312, 3940.5468371137113, 4193.0, 4242.554531774181, 4242.618164365222, 4246.7239629423375, 4398.516163222107, 4434.33484977256, 4444.777761111996, 4458.24209884327, 4460.710053846489, 4373.475182978063, 4414.27164517851, 4431.645468362588, 4449.532799056182, 4469.240229160985, 4235.470566179228, 4235.661147108162, 4235.767032813224, 4255.212785634668, 4479.574440428154, 3527.506149139174, 3572.1069732566857, 3573.8034408106764, 3578.2127931854952, 3581.8030008349792, 5172.922406163835, 5175.171972484384, 5175.792968281226, 5178.291163915824, 5216.843494695166, 4806.255030470283, 4868.586170175575, 4987.177115775857, 4994.875128121826, 5025.145725226647, 4959.975200123977, 4966.602671786176, 4968.2795994579865, 4970.552650261349, 4983.302337672656, 4878.707277563358, 4892.510748925079, 4894.241392584155, 4897.289892965571, 4899.216125419915, 4787.210110331756, 4989.301497790239, 5034.395872495324, 5035.521625445577, 5040.596752259884, 4911.50884911506, 4915.754212289443, 4932.21084626458, 4935.235038569028, 4960.429550601727], "value": 3657.8725814260697, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.405715884004, 591.4883625663797, 612.2652816620056, 613.8281281241254, 625.0967352176104, 11365.488553015113, 12135.15053946222, 12656.746865062705, 12675.049371297155, 13176.0, 12629.052821038413, 12885.871141288584, 12906.483740650363, 12911.612651620442, 12917.0, 629.131798118598, 749.5203070035168, 769.9076110866704, 772.5750837039634, 773.2808488106059, 743.9590822504761, 761.0866959648416, 770.0297624992494, 775.3603277296224, 775.8138046868739, 587.826591155608, 589.1369144203741, 589.3929252869551, 589.4429763873142, 589.7876764364826, 587.650348042918, 588.2822955993702, 588.8733922206703, 589.1016200294564, 651.2152855808739, 563.3240111865778, 578.0664227272924, 589.7198830555494, 590.9054551271776, 591.4558606082414, 12617.495300187982, 12637.241765494007, 12644.810327845089, 12649.051321150859, 12649.810252846215, 12038.0, 12354.38228088592, 12364.44360003793, 12545.184563003375, 13144.539941102015, 10746.731331716692, 10883.727906802314, 11046.613368532062, 11153.107751379952, 11319.943400282946, 4022.9195416091516, 4073.246449406869, 4075.1442197138635, 4109.671226301919, 4117.094239267356, 65683.0, 65753.3424665752, 65782.67108664474, 65834.3416565833, 65909.01136483005, 9202.539873006323, 9551.14039736427, 9923.206143508502, 10090.34412763168, 10093.0, 18476.983765892735, 18534.721979170325, 18596.25614975413, 18621.7206741899, 18671.533211669816, 6664.166979127609, 6770.1537307836525, 6810.727570897108, 6817.829554261084, 6928.965355173293, 3589.748717589796, 3670.632936706308, 3694.113412780967, 3729.627037296303, 3733.6826369758874, 2615.9869200653875, 2736.86315684215, 2738.151173136334, 2738.288045108286, 2739.0413355325877, 455.64687367290617, 462.6969335085457, 462.85188739603007, 469.2140664387138, 469.76511744127936, 464.8958723032797, 471.11430510640463, 492.5271739130403, 496.0500641271924, 504.45014933722416, 6689.431398331099, 6925.134358205224, 7076.575405475688, 7386.113666360071, 7493.38423279535, 485.6940127719514, 500.1747117256483, 500.8973160502088, 529.2061907139291, 532.3664838841765, 3403.7787543809573, 3468.497067925137, 3637.5453068366455, 3662.340778659867, 3799.696024318048, 61055.0, 61529.0, 61567.0, 108329.0, 109562.0, 54479.0, 55060.44939550633, 55569.0, 68291.0, 81876.59061704653, 76589.0, 78491.60754196307, 78745.60627196827, 79966.60016699995, 81929.18070819335, 6668.699908504032, 6845.349691779273, 6914.688839002157, 6960.965195174194, 7146.32109949554, 46676.53323466722, 46971.76514117407, 47844.28233576569, 47884.0, 48666.75666621644, 61448.0, 67455.3254467449, 68855.0, 70467.64766176137, 72005.27994720195, 8549.658013679633, 8662.177093176138, 8850.911490885008, 9064.773380665536, 9129.726108216764, 10035.09684128432, 10036.29745917808, 10082.193424525874, 10242.590296388062, 10397.532111055172, 9299.209567186594, 9635.470049147365, 9691.660791872533, 9863.210943124677, 9932.503374831374, 8881.511516866634, 9477.099675530813, 9669.323147379897, 9885.604575816888, 9911.801763964824, 9477.763055923657, 9640.469774162488, 9842.360246583949, 10111.59553617847, 10135.087842094246, 8234.258916697527, 8291.792705182419, 8308.5430301334, 8476.406651534333, 8689.6089675966, 8321.375896807886, 8452.239298463168, 8550.657973680984, 8713.797837907288, 8819.559022049], "value": 5997.0841118464805, "unit": "score"}], "name": "dromaeo_css", "value": 6087.107493455378, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 129.0, 115.0, 115.0, 115.0, 113.0, 114.0, 115.0, 114.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 151.0, 185.0, 121.0, 147.0, 149.0, 129.0, 196.0, 124.0], "value": 147.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 163.0, 163.0, 162.0, 162.0, 163.0, 163.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 175.0, 79.0, 77.0, 76.0, 79.0, 166.0, 76.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 140.0, 87.0, 87.0, 86.0, 146.0, 86.0, 86.0, 144.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 94.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 68.0, 69.0, 67.0, 68.0, 69.0, 65.0, 65.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0, 67.0, 65.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 83.0, 84.0, 85.0, 82.0, 83.0, 89.0, 82.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 132.0, 130.0, 132.0, 136.0, 132.0, 131.0, 131.0, 157.0, 143.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 177.0, 177.0, 171.0, 172.0, 174.0, 171.0, 170.0, 174.0, 171.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 70.0, 72.0, 69.0, 70.0, 69.0, 69.0, 68.0, 69.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1580.8999999999999, "alertThreshold": 2.0}]} 11:41:20 INFO - Return code: 0 11:41:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:41:20 INFO - # TBPL SUCCESS # 11:41:20 INFO - Running post-action listener: _resource_record_post_action 11:41:20 INFO - [mozharness: 2016-08-23 18:41:20.310147Z] Finished run-tests step (success) 11:41:20 INFO - Running post-run listener: _resource_record_post_run 11:41:20 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403222528; Read time: 16; Write time: 411956 11:41:20 INFO - TinderboxPrint: CPU usage
13.3% 11:41:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:41:20 INFO - TinderboxPrint: I/O write bytes / time
403,222,528 / 411,956 11:41:20 INFO - TinderboxPrint: CPU idle
8,335.9 (86.7%) 11:41:20 INFO - TinderboxPrint: CPU user
1,209.0 (12.6%) 11:41:20 INFO - TinderboxPrint: Swap in / out
0 / 0 11:41:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115933184; Read time: 0; Write time: 170228 11:41:20 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 287289344; Read time: 0; Write time: 241728 11:41:20 INFO - Running post-run listener: _upload_blobber_files 11:41:20 INFO - Blob upload gear active. 11:41:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:41:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:41:21 INFO - (blobuploader) - INFO - Open directory for files ... 11:41:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:41:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:41:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:25 INFO - (blobuploader) - INFO - Done attempting. 11:41:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:41:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:41:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:26 INFO - (blobuploader) - INFO - Done attempting. 11:41:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:41:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:41:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:26 INFO - (blobuploader) - INFO - Done attempting. 11:41:26 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:26 INFO - Return code: 0 11:41:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f44bd059fd4023dfdeb6974a1daef76a4a9049f1dcb1144dab9b098c8f586a45df606c8b52640fd5c7342adc9bf48490e5ddf38052045ecd4d840afc5a08a81c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/500f50c75fb581e87a591c0342c98f4843661ce8d309dca4e9247849cc7209e76050cf4ff4c0d0912c2582b559d37cd954166b88ea278883200c153eb7c9e224", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/289addfe3a9c586a8603ad63a2706a677959100490706fedc12b4d1827c06e7fb843656352384ea83bad8b8802f4d4b52be1f5354e5b418bc0231a2763ca0f72"} 11:41:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:26 INFO - Contents: 11:41:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f44bd059fd4023dfdeb6974a1daef76a4a9049f1dcb1144dab9b098c8f586a45df606c8b52640fd5c7342adc9bf48490e5ddf38052045ecd4d840afc5a08a81c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/500f50c75fb581e87a591c0342c98f4843661ce8d309dca4e9247849cc7209e76050cf4ff4c0d0912c2582b559d37cd954166b88ea278883200c153eb7c9e224", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/289addfe3a9c586a8603ad63a2706a677959100490706fedc12b4d1827c06e7fb843656352384ea83bad8b8802f4d4b52be1f5354e5b418bc0231a2763ca0f72"} 11:41:26 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:26 INFO - Copying logs to upload dir... 11:41:26 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.573749 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-23 11:41:26.736304) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 11:41:26.740081) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036 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/f44bd059fd4023dfdeb6974a1daef76a4a9049f1dcb1144dab9b098c8f586a45df606c8b52640fd5c7342adc9bf48490e5ddf38052045ecd4d840afc5a08a81c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/500f50c75fb581e87a591c0342c98f4843661ce8d309dca4e9247849cc7209e76050cf4ff4c0d0912c2582b559d37cd954166b88ea278883200c153eb7c9e224", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/289addfe3a9c586a8603ad63a2706a677959100490706fedc12b4d1827c06e7fb843656352384ea83bad8b8802f4d4b52be1f5354e5b418bc0231a2763ca0f72"} build_url:https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/Rm4iiPZFRI-hrtiVFXa_BA/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/f44bd059fd4023dfdeb6974a1daef76a4a9049f1dcb1144dab9b098c8f586a45df606c8b52640fd5c7342adc9bf48490e5ddf38052045ecd4d840afc5a08a81c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/500f50c75fb581e87a591c0342c98f4843661ce8d309dca4e9247849cc7209e76050cf4ff4c0d0912c2582b559d37cd954166b88ea278883200c153eb7c9e224", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/289addfe3a9c586a8603ad63a2706a677959100490706fedc12b4d1827c06e7fb843656352384ea83bad8b8802f4d4b52be1f5354e5b418bc0231a2763ca0f72"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 11:41:26.765819) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:41:26.766135) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1471976436.454284-886934036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:41:26.851467) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 11:41:26.851788) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 11:41:26.852068) ========= ========= Total master_lag: 0.18 =========