builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1472712894.0 results: success (0) buildid: 20160831203012 builduid: ac0101aac8484daca6913ddc6a387a51 revision: 9f33ab9fd502d2a4c38aef7744ab68c0aaa78234 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 23:54:54.001054) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 23:54:54.001569) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 23:54:54.001900) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 23:54:54.017010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 23:54:54.017435) ========= 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=cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-31 23:54:54-- 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% 42.9M=0s 2016-08-31 23:54:54 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093210 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 23:54:54.125069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 23:54:54.125418) ========= 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=cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019538 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 23:54:54.175873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 23:54:54.176288) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9f33ab9fd502d2a4c38aef7744ab68c0aaa78234 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9f33ab9fd502d2a4c38aef7744ab68c0aaa78234 --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=cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-31 23:54:55,105 truncating revision to first 12 chars 2016-08-31 23:54:55,105 Setting DEBUG logging. 2016-08-31 23:54:55,105 attempt 1/10 2016-08-31 23:54:55,105 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9f33ab9fd502?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 23:54:55,412 unpacking tar archive at: fx-team-9f33ab9fd502/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617843 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 23:54:54.808392) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 23:54:54.808777) ========= script_repo_revision: 9f33ab9fd502d2a4c38aef7744ab68c0aaa78234 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 23:54:54.809213) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 23:54:54.809518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 23:54:54.819424) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-31 23:54:54.819761) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:54:55 INFO - MultiFileLogger online at 20160831 23:54:55 in /builds/slave/test 23:54:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:54:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:54:55 INFO - {'append_to_log': False, 23:54:55 INFO - 'base_work_dir': '/builds/slave/test', 23:54:55 INFO - 'blob_upload_branch': 'Fx-Team', 23:54:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:54:55 INFO - 'branch': 'Fx-Team', 23:54:55 INFO - 'buildbot_json_path': 'buildprops.json', 23:54:55 INFO - 'config_files': ('talos/linux_config.py',), 23:54:55 INFO - 'default_actions': ('clobber', 23:54:55 INFO - 'read-buildbot-config', 23:54:55 INFO - 'download-and-extract', 23:54:55 INFO - 'populate-webroot', 23:54:55 INFO - 'create-virtualenv', 23:54:55 INFO - 'install', 23:54:55 INFO - 'run-tests'), 23:54:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:54:55 INFO - 'download_minidump_stackwalk': True, 23:54:55 INFO - 'download_symbols': 'ondemand', 23:54:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:54:55 INFO - 'tooltool.py': '/tools/tooltool.py', 23:54:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:54:55 INFO - '/tools/misc-python/virtualenv.py')}, 23:54:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:54:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:54:55 INFO - 'installer_path': 'installer.exe', 23:54:55 INFO - 'log_level': 'info', 23:54:55 INFO - 'log_name': 'talos', 23:54:55 INFO - 'log_to_console': True, 23:54:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:54:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:54:55 INFO - 'opt_config_files': (), 23:54:55 INFO - 'pip_index': False, 23:54:55 INFO - 'sps_profile': False, 23:54:55 INFO - 'sps_profile_interval': 0, 23:54:55 INFO - 'suite': 'dromaeojs', 23:54:55 INFO - 'system_bits': '32', 23:54:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:54:55 INFO - 'title': 'talos-linux64-ix-054', 23:54:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:54:55 INFO - 'use_talos_json': True, 23:54:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:54:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:54:55 INFO - 'work_dir': 'build'} 23:54:55 INFO - [mozharness: 2016-09-01 06:54:55.841933Z] Running clobber step. 23:54:55 INFO - Running pre-action listener: _resource_record_pre_action 23:54:55 INFO - Running main action method: clobber 23:54:55 INFO - rmtree: /builds/slave/test/build 23:54:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:54:56 INFO - Running post-action listener: _resource_record_post_action 23:54:56 INFO - [mozharness: 2016-09-01 06:54:56.304947Z] Finished clobber step (success) 23:54:56 INFO - [mozharness: 2016-09-01 06:54:56.305048Z] Running read-buildbot-config step. 23:54:56 INFO - Running pre-action listener: _resource_record_pre_action 23:54:56 INFO - Running main action method: read_buildbot_config 23:54:56 INFO - Using buildbot properties: 23:54:56 INFO - { 23:54:56 INFO - "project": "", 23:54:56 INFO - "product": "firefox", 23:54:56 INFO - "script_repo_revision": "production", 23:54:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:54:56 INFO - "repository": "", 23:54:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:54:56 INFO - "buildid": "20160831203012", 23:54:56 INFO - "pgo_build": "True", 23:54:56 INFO - "basedir": "/builds/slave/test", 23:54:56 INFO - "buildnumber": 1516, 23:54:56 INFO - "slavename": "talos-linux64-ix-054", 23:54:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:54:56 INFO - "platform": "ubuntu64_hw", 23:54:56 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:54:56 INFO - "branch": "fx-team", 23:54:56 INFO - "repo_path": "integration/fx-team", 23:54:56 INFO - "revision": "9f33ab9fd502d2a4c38aef7744ab68c0aaa78234", 23:54:56 INFO - "stage_platform": "linux64-pgo", 23:54:56 INFO - "builduid": "ac0101aac8484daca6913ddc6a387a51", 23:54:56 INFO - "slavebuilddir": "test" 23:54:56 INFO - } 23:54:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:54:56 INFO - Running post-action listener: _resource_record_post_action 23:54:56 INFO - [mozharness: 2016-09-01 06:54:56.307501Z] Finished read-buildbot-config step (success) 23:54:56 INFO - [mozharness: 2016-09-01 06:54:56.307592Z] Running download-and-extract step. 23:54:56 INFO - Running pre-action listener: _resource_record_pre_action 23:54:56 INFO - Running main action method: download_and_extract 23:54:56 INFO - mkdir: /builds/slave/test/build/tests 23:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:54:56 INFO - trying https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:54:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:54:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:54:56 INFO - Downloaded 1361 bytes. 23:54:56 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:54:56 INFO - Using the following test package requirements: 23:54:56 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:54:56 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:54:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:54:56 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:54:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:54:56 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:54:56 INFO - u'jsshell-linux-x86_64.zip'], 23:54:56 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:54:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:54:56 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:54:56 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:54:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:54:56 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:54:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:54:56 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:54:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:54:56 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:54:56 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:54:56 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:54:56 INFO - trying https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:54:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:54:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:54:58 INFO - Downloaded 21906704 bytes. 23:54:58 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 23:55:02 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 23:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:02 INFO - trying https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:55:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:55:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:55:03 INFO - Downloaded 21906704 bytes. 23:55:03 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 23:55:08 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')]} 23:55:08 INFO - trying https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:55:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:55:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:55:09 INFO - Downloaded 14413998 bytes. 23:55:09 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 23:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:09 INFO - trying https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:55:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:55:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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 23:55:10 INFO - Downloaded 59735366 bytes. 23:55:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:55:10 INFO - mkdir: /builds/slave/test/properties 23:55:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:55:10 INFO - Writing to file /builds/slave/test/properties/build_url 23:55:10 INFO - Contents: 23:55:10 INFO - build_url:https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:55:11 INFO - Running post-action listener: _resource_record_post_action 23:55:11 INFO - Running post-action listener: set_extra_try_arguments 23:55:11 INFO - [mozharness: 2016-09-01 06:55:11.242661Z] Finished download-and-extract step (success) 23:55:11 INFO - [mozharness: 2016-09-01 06:55:11.242890Z] Running populate-webroot step. 23:55:11 INFO - Running pre-action listener: _resource_record_pre_action 23:55:11 INFO - Running main action method: populate_webroot 23:55:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:55:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:55:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:55:11 INFO - '--tppagecycles', 23:55:11 INFO - '7'], 23:55:11 INFO - 'tests': ['tsvgm']}}, 23:55:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:55:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:55:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:55:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:55:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:55:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:55:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:11 INFO - 'talos_options': ['--disable-e10s'], 23:55:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:55:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:55:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:11 INFO - 'talos_options': ['--disable-e10s'], 23:55:11 INFO - 'tests': ['damp', 'tps']}, 23:55:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:11 INFO - 'tests': ['damp', 'tps']}, 23:55:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:55:11 INFO - 'tests': ['dromaeo_dom']}, 23:55:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:55:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:55:11 INFO - 'tests': ['basic_compositor_video']}, 23:55:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:55:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:55:11 INFO - 'tests': ['a11yr', 23:55:11 INFO - 'ts_paint', 23:55:11 INFO - 'tpaint', 23:55:11 INFO - 'sessionrestore', 23:55:11 INFO - 'sessionrestore_no_auto_restore', 23:55:11 INFO - 'tabpaint']}, 23:55:11 INFO - 'other-e10s': {'tests': ['a11yr', 23:55:11 INFO - 'ts_paint', 23:55:11 INFO - 'tpaint', 23:55:11 INFO - 'sessionrestore', 23:55:11 INFO - 'sessionrestore_no_auto_restore', 23:55:11 INFO - 'tabpaint']}, 23:55:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:55:11 INFO - 'ts_paint', 23:55:11 INFO - 'tpaint', 23:55:11 INFO - 'sessionrestore', 23:55:11 INFO - 'sessionrestore_no_auto_restore', 23:55:11 INFO - 'tabpaint']}, 23:55:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:55:11 INFO - 'ts_paint', 23:55:11 INFO - 'tpaint', 23:55:11 INFO - 'sessionrestore', 23:55:11 INFO - 'sessionrestore_no_auto_restore', 23:55:11 INFO - 'tabpaint']}, 23:55:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:55:11 INFO - 'tests': ['a11yr', 23:55:11 INFO - 'ts_paint', 23:55:11 INFO - 'tpaint', 23:55:11 INFO - 'sessionrestore', 23:55:11 INFO - 'sessionrestore_no_auto_restore', 23:55:11 INFO - 'tabpaint']}, 23:55:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:55:11 INFO - 'tests': ['a11yr', 23:55:11 INFO - 'ts_paint', 23:55:11 INFO - 'tpaint', 23:55:11 INFO - 'sessionrestore', 23:55:11 INFO - 'sessionrestore_no_auto_restore', 23:55:11 INFO - 'tabpaint']}, 23:55:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:55:11 INFO - 'tests': ['tsvgx', 23:55:11 INFO - 'tsvgr_opacity', 23:55:11 INFO - 'tart', 23:55:11 INFO - 'tscrollx', 23:55:11 INFO - 'cart']}, 23:55:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:55:11 INFO - 'tsvgr_opacity', 23:55:11 INFO - 'tart', 23:55:11 INFO - 'tscrollx', 23:55:11 INFO - 'cart']}, 23:55:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:11 INFO - 'talos_options': ['--disable-e10s'], 23:55:11 INFO - 'tests': ['tp5o']}, 23:55:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:11 INFO - 'tests': ['tp5o']}, 23:55:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:11 INFO - 'talos_options': ['--disable-e10s', 23:55:11 INFO - '--xperf_path', 23:55:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:55:11 INFO - 'tests': ['tp5n']}, 23:55:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:55:11 INFO - 'talos_options': ['--xperf_path', 23:55:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:55:11 INFO - 'tests': ['tp5n']}}, 23:55:11 INFO - 'talos.zip': {'path': '', 23:55:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:55:11 INFO - Running post-action listener: _resource_record_post_action 23:55:11 INFO - [mozharness: 2016-09-01 06:55:11.260324Z] Finished populate-webroot step (success) 23:55:11 INFO - [mozharness: 2016-09-01 06:55:11.260414Z] Running create-virtualenv step. 23:55:11 INFO - Running pre-action listener: _resource_record_pre_action 23:55:11 INFO - Running main action method: create_virtualenv 23:55:11 INFO - Creating virtualenv /builds/slave/test/build/venv 23:55:11 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 23:55:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:55:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:55:11 INFO - Using real prefix '/usr' 23:55:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:55:11 INFO - Installing distribute.............................................................................................................................................................................................done. 23:55:13 INFO - Installing pip.................done. 23:55:13 INFO - Return code: 0 23:55:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb30d373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e370>, '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 0x10418f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041d80>, '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': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', '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 23:55:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:55:13 INFO - Using env: {'DISPLAY': ':0', 23:55:13 INFO - 'HOME': '/home/cltbld', 23:55:13 INFO - 'LANG': 'en_US.UTF-8', 23:55:13 INFO - 'LANGUAGE': 'en_US:en', 23:55:13 INFO - 'LOGNAME': 'cltbld', 23:55:13 INFO - 'MAIL': '/var/mail/cltbld', 23:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:13 INFO - 'MOZ_NO_REMOTE': '1', 23:55:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:13 INFO - 'NO_EM_RESTART': '1', 23:55:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:13 INFO - 'PWD': '/builds/slave/test', 23:55:13 INFO - 'SHELL': '/bin/bash', 23:55:13 INFO - 'SHLVL': '1', 23:55:13 INFO - 'TERM': 'linux', 23:55:13 INFO - 'TMOUT': '86400', 23:55:13 INFO - 'USER': 'cltbld', 23:55:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', 23:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:13 INFO - '_': '/tools/buildbot/bin/python'} 23:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:14 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 23:55:14 INFO - Cleaning up... 23:55:14 INFO - Return code: 0 23:55:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:55: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')]} 23:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55: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')]} 23:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55: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', '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 0x7fb30d373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e370>, '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 0x10418f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041d80>, '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': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', '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 23:55: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', 'psutil>=3.1.1'] in /builds/slave/test/build 23:55: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 psutil>=3.1.1 23:55:14 INFO - Using env: {'DISPLAY': ':0', 23:55:14 INFO - 'HOME': '/home/cltbld', 23:55:14 INFO - 'LANG': 'en_US.UTF-8', 23:55:14 INFO - 'LANGUAGE': 'en_US:en', 23:55:14 INFO - 'LOGNAME': 'cltbld', 23:55:14 INFO - 'MAIL': '/var/mail/cltbld', 23:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:14 INFO - 'MOZ_NO_REMOTE': '1', 23:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:14 INFO - 'NO_EM_RESTART': '1', 23:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:14 INFO - 'PWD': '/builds/slave/test', 23:55:14 INFO - 'SHELL': '/bin/bash', 23:55:14 INFO - 'SHLVL': '1', 23:55:14 INFO - 'TERM': 'linux', 23:55:14 INFO - 'TMOUT': '86400', 23:55:14 INFO - 'USER': 'cltbld', 23:55:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', 23:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:14 INFO - '_': '/tools/buildbot/bin/python'} 23:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:14 INFO - Downloading/unpacking psutil>=3.1.1 23:55:14 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 23:55:14 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 23:55:14 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 23:55:14 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 23:55:14 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 23:55:14 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 23:55:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:55:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:55:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:55:16 INFO - Installing collected packages: psutil 23:55:16 INFO - Running setup.py install for psutil 23:55:16 INFO - building 'psutil._psutil_linux' extension 23:55:16 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 23:55:16 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 23:55:16 INFO - building 'psutil._psutil_posix' extension 23:55:16 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 23:55:16 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 23:55:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:55:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:55:16 INFO - Successfully installed psutil 23:55:16 INFO - Cleaning up... 23:55:16 INFO - Return code: 0 23:55:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:55:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:16 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 0x7fb30d373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e370>, '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 0x10418f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041d80>, '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': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', '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 23:55:16 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 23:55:16 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 23:55:16 INFO - Using env: {'DISPLAY': ':0', 23:55:16 INFO - 'HOME': '/home/cltbld', 23:55:16 INFO - 'LANG': 'en_US.UTF-8', 23:55:16 INFO - 'LANGUAGE': 'en_US:en', 23:55:16 INFO - 'LOGNAME': 'cltbld', 23:55:16 INFO - 'MAIL': '/var/mail/cltbld', 23:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:16 INFO - 'MOZ_NO_REMOTE': '1', 23:55:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:16 INFO - 'NO_EM_RESTART': '1', 23:55:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:16 INFO - 'PWD': '/builds/slave/test', 23:55:16 INFO - 'SHELL': '/bin/bash', 23:55:16 INFO - 'SHLVL': '1', 23:55:16 INFO - 'TERM': 'linux', 23:55:16 INFO - 'TMOUT': '86400', 23:55:16 INFO - 'USER': 'cltbld', 23:55:16 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', 23:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:16 INFO - '_': '/tools/buildbot/bin/python'} 23:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:55:19 INFO - Installing collected packages: mozsystemmonitor 23:55:19 INFO - Running setup.py install for mozsystemmonitor 23:55:19 INFO - Successfully installed mozsystemmonitor 23:55:19 INFO - Cleaning up... 23:55:19 INFO - Return code: 0 23:55:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:19 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 0x7fb30d373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e370>, '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 0x10418f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041d80>, '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': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', '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 23:55:19 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 23:55:19 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 23:55:19 INFO - Using env: {'DISPLAY': ':0', 23:55:19 INFO - 'HOME': '/home/cltbld', 23:55:19 INFO - 'LANG': 'en_US.UTF-8', 23:55:19 INFO - 'LANGUAGE': 'en_US:en', 23:55:19 INFO - 'LOGNAME': 'cltbld', 23:55:19 INFO - 'MAIL': '/var/mail/cltbld', 23:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:19 INFO - 'MOZ_NO_REMOTE': '1', 23:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:19 INFO - 'NO_EM_RESTART': '1', 23:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:19 INFO - 'PWD': '/builds/slave/test', 23:55:19 INFO - 'SHELL': '/bin/bash', 23:55:19 INFO - 'SHLVL': '1', 23:55:19 INFO - 'TERM': 'linux', 23:55:19 INFO - 'TMOUT': '86400', 23:55:19 INFO - 'USER': 'cltbld', 23:55:19 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', 23:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:19 INFO - '_': '/tools/buildbot/bin/python'} 23:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:19 INFO - Downloading/unpacking jsonschema==2.5.1 23:55:19 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 23:55:19 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 23:55:19 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 23:55:19 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 23:55:19 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 23:55:19 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 23:55:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:55:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:55:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:55:21 INFO - Downloading functools32-3.2.3-2.tar.gz 23:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:55:21 INFO - warning: no files found matching '*.txt' 23:55:21 INFO - no previously-included directories found matching 'build' 23:55:21 INFO - no previously-included directories found matching 'dist' 23:55:21 INFO - no previously-included directories found matching '.git*' 23:55:21 INFO - Installing collected packages: jsonschema, functools32 23:55:21 INFO - Running setup.py install for functools32 23:55:21 INFO - warning: no files found matching '*.txt' 23:55:21 INFO - no previously-included directories found matching 'build' 23:55:21 INFO - no previously-included directories found matching 'dist' 23:55:21 INFO - no previously-included directories found matching '.git*' 23:55:21 INFO - Successfully installed jsonschema functools32 23:55:21 INFO - Cleaning up... 23:55:21 INFO - Return code: 0 23:55:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb30d373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e370>, '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 0x10418f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041d80>, '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': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', '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 23:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:55:21 INFO - Using env: {'DISPLAY': ':0', 23:55:21 INFO - 'HOME': '/home/cltbld', 23:55:21 INFO - 'LANG': 'en_US.UTF-8', 23:55:21 INFO - 'LANGUAGE': 'en_US:en', 23:55:21 INFO - 'LOGNAME': 'cltbld', 23:55:21 INFO - 'MAIL': '/var/mail/cltbld', 23:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:21 INFO - 'MOZ_NO_REMOTE': '1', 23:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:21 INFO - 'NO_EM_RESTART': '1', 23:55:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:21 INFO - 'PWD': '/builds/slave/test', 23:55:21 INFO - 'SHELL': '/bin/bash', 23:55:21 INFO - 'SHLVL': '1', 23:55:21 INFO - 'TERM': 'linux', 23:55:21 INFO - 'TMOUT': '86400', 23:55:21 INFO - 'USER': 'cltbld', 23:55:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', 23:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:21 INFO - '_': '/tools/buildbot/bin/python'} 23:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:55:22 INFO - Cleaning up... 23:55:22 INFO - Return code: 0 23:55:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:22 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 0x7fb30d373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e370>, '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 0x10418f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041d80>, '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': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', '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 23:55:22 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 23:55:22 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 23:55:22 INFO - Using env: {'DISPLAY': ':0', 23:55:22 INFO - 'HOME': '/home/cltbld', 23:55:22 INFO - 'LANG': 'en_US.UTF-8', 23:55:22 INFO - 'LANGUAGE': 'en_US:en', 23:55:22 INFO - 'LOGNAME': 'cltbld', 23:55:22 INFO - 'MAIL': '/var/mail/cltbld', 23:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:22 INFO - 'MOZ_NO_REMOTE': '1', 23:55:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:22 INFO - 'NO_EM_RESTART': '1', 23:55:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:22 INFO - 'PWD': '/builds/slave/test', 23:55:22 INFO - 'SHELL': '/bin/bash', 23:55:22 INFO - 'SHLVL': '1', 23:55:22 INFO - 'TERM': 'linux', 23:55:22 INFO - 'TMOUT': '86400', 23:55:22 INFO - 'USER': 'cltbld', 23:55:22 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', 23:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:22 INFO - '_': '/tools/buildbot/bin/python'} 23:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:22 INFO - Downloading/unpacking blobuploader==1.2.4 23:55:22 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 23:55:22 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 23:55:22 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 23:55:22 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 23:55:22 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 23:55:22 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 23:55:24 INFO - Downloading blobuploader-1.2.4.tar.gz 23:55:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:55:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:55:24 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 23:55:24 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 23:55:24 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 23:55:24 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 23:55:24 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 23:55:24 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 23:55:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:55:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:55:24 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 23:55:24 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 23:55:24 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 23:55:24 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 23:55:24 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 23:55:24 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 23:55:24 INFO - Downloading docopt-0.6.1.tar.gz 23:55:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:55:25 INFO - Installing collected packages: blobuploader, requests, docopt 23:55:25 INFO - Running setup.py install for blobuploader 23:55:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:55:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:55:25 INFO - Running setup.py install for requests 23:55:25 INFO - Running setup.py install for docopt 23:55:25 INFO - Successfully installed blobuploader requests docopt 23:55:25 INFO - Cleaning up... 23:55:25 INFO - Return code: 0 23:55:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:25 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 0x7fb30d373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e370>, '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 0x10418f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041d80>, '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': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', '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 23:55:25 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 23:55:25 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 23:55:25 INFO - Using env: {'DISPLAY': ':0', 23:55:25 INFO - 'HOME': '/home/cltbld', 23:55:25 INFO - 'LANG': 'en_US.UTF-8', 23:55:25 INFO - 'LANGUAGE': 'en_US:en', 23:55:25 INFO - 'LOGNAME': 'cltbld', 23:55:25 INFO - 'MAIL': '/var/mail/cltbld', 23:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:25 INFO - 'MOZ_NO_REMOTE': '1', 23:55:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:25 INFO - 'NO_EM_RESTART': '1', 23:55:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:25 INFO - 'PWD': '/builds/slave/test', 23:55:25 INFO - 'SHELL': '/bin/bash', 23:55:25 INFO - 'SHLVL': '1', 23:55:25 INFO - 'TERM': 'linux', 23:55:25 INFO - 'TMOUT': '86400', 23:55:25 INFO - 'USER': 'cltbld', 23:55:25 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', 23:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:25 INFO - '_': '/tools/buildbot/bin/python'} 23:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:55:25 INFO - Running setup.py (path:/tmp/pip-W2s7vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:55:26 INFO - Running setup.py (path:/tmp/pip-14pQiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:55:26 INFO - Running setup.py (path:/tmp/pip-GhVE5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:55:26 INFO - Running setup.py (path:/tmp/pip-ekRbUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:55:26 INFO - Running setup.py (path:/tmp/pip-nsiYtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:55:26 INFO - Running setup.py (path:/tmp/pip-no3JeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:55:26 INFO - Running setup.py (path:/tmp/pip-h_1CcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:55:26 INFO - Running setup.py (path:/tmp/pip-RLq5mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:55:26 INFO - Running setup.py (path:/tmp/pip-9dNse1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:55:26 INFO - Running setup.py (path:/tmp/pip-zphIeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:55:26 INFO - Running setup.py (path:/tmp/pip-XtjPBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:55:26 INFO - Running setup.py (path:/tmp/pip-ioLYfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:55:26 INFO - Running setup.py (path:/tmp/pip-DJMZ_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:55:26 INFO - Running setup.py (path:/tmp/pip-Q8WcHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:55:26 INFO - Running setup.py (path:/tmp/pip-pQ3FDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:55:27 INFO - Running setup.py (path:/tmp/pip-OCjMlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:55:27 INFO - Running setup.py (path:/tmp/pip-DvsAzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:55:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:55:27 INFO - Running setup.py install for manifestparser 23:55:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:55:27 INFO - Running setup.py install for mozcrash 23:55:27 INFO - Running setup.py install for mozdebug 23:55:27 INFO - Running setup.py install for mozdevice 23:55:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:55:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:55:27 INFO - Running setup.py install for mozfile 23:55:27 INFO - Running setup.py install for mozhttpd 23:55:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:55:27 INFO - Running setup.py install for mozinfo 23:55:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:55:27 INFO - Running setup.py install for mozInstall 23:55:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:55:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:55:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:55:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:55:27 INFO - Running setup.py install for mozleak 23:55:28 INFO - Running setup.py install for mozlog 23:55:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:55:28 INFO - Running setup.py install for moznetwork 23:55:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:55:28 INFO - Running setup.py install for mozprocess 23:55:28 INFO - Running setup.py install for mozprofile 23:55:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:55:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:55:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:55:28 INFO - Running setup.py install for mozrunner 23:55:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:55:28 INFO - Running setup.py install for mozscreenshot 23:55:28 INFO - Running setup.py install for moztest 23:55:28 INFO - Running setup.py install for mozversion 23:55:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:55:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:55:28 INFO - Cleaning up... 23:55:28 INFO - Return code: 0 23:55:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:28 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 0x7fb30d373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e370>, '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 0x10418f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041d80>, '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': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', '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 23:55:28 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 23:55:28 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 23:55:28 INFO - Using env: {'DISPLAY': ':0', 23:55:28 INFO - 'HOME': '/home/cltbld', 23:55:28 INFO - 'LANG': 'en_US.UTF-8', 23:55:28 INFO - 'LANGUAGE': 'en_US:en', 23:55:28 INFO - 'LOGNAME': 'cltbld', 23:55:28 INFO - 'MAIL': '/var/mail/cltbld', 23:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:28 INFO - 'MOZ_NO_REMOTE': '1', 23:55:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:28 INFO - 'NO_EM_RESTART': '1', 23:55:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:28 INFO - 'PWD': '/builds/slave/test', 23:55:28 INFO - 'SHELL': '/bin/bash', 23:55:28 INFO - 'SHLVL': '1', 23:55:28 INFO - 'TERM': 'linux', 23:55:28 INFO - 'TMOUT': '86400', 23:55:28 INFO - 'USER': 'cltbld', 23:55:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', 23:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:28 INFO - '_': '/tools/buildbot/bin/python'} 23:55:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:55:29 INFO - Running setup.py (path:/tmp/pip-s_7FHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:55:29 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)) 23:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:55:29 INFO - Running setup.py (path:/tmp/pip-8jQGhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:55:29 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)) 23:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:55:29 INFO - Running setup.py (path:/tmp/pip-pUswXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:55:29 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)) 23:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:55:29 INFO - Running setup.py (path:/tmp/pip-HHjm8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:55:29 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)) 23:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:55:29 INFO - Running setup.py (path:/tmp/pip-IDeEh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:55:29 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)) 23:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:55:29 INFO - Running setup.py (path:/tmp/pip-WHuE2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:55:29 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)) 23:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:55:29 INFO - Running setup.py (path:/tmp/pip-VwTbDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:55:29 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)) 23:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:55:29 INFO - Running setup.py (path:/tmp/pip-ELn2pF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:55:29 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)) 23:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:55:29 INFO - Running setup.py (path:/tmp/pip-c1y5Uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:55:29 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)) 23:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:55:29 INFO - Running setup.py (path:/tmp/pip-k_WZ5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:55:29 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)) 23:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:55:29 INFO - Running setup.py (path:/tmp/pip-PxNM84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:55:29 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)) 23:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:55:29 INFO - Running setup.py (path:/tmp/pip-86wcSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:55:30 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)) 23:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:55:30 INFO - Running setup.py (path:/tmp/pip-DdF07b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:55:30 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)) 23:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:55:30 INFO - Running setup.py (path:/tmp/pip-hhcId_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:55:30 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)) 23:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:55:30 INFO - Running setup.py (path:/tmp/pip-IzpLZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:55:30 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)) 23:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:55:30 INFO - Running setup.py (path:/tmp/pip-3lz4YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:55:30 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)) 23:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:55:30 INFO - Running setup.py (path:/tmp/pip-SjXWTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:55:30 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)) 23:55:30 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)) 23:55:30 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)) 23:55:30 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)) 23:55:30 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)) 23:55:30 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)) 23:55:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:55:30 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 23:55:30 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 23:55:30 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 23:55:30 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 23:55:30 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 23:55:30 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 23:55:32 INFO - Downloading blessings-1.6.tar.gz 23:55:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:55:32 INFO - Installing collected packages: blessings 23:55:32 INFO - Running setup.py install for blessings 23:55:32 INFO - Successfully installed blessings 23:55:32 INFO - Cleaning up... 23:55:32 INFO - Return code: 0 23:55:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:55:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:55:32 INFO - Reading from file tmpfile_stdout 23:55:32 INFO - Current package versions: 23:55:32 INFO - argparse == 1.2.1 23:55:32 INFO - blessings == 1.6 23:55:32 INFO - blobuploader == 1.2.4 23:55:32 INFO - docopt == 0.6.1 23:55:32 INFO - functools32 == 3.2.3-2 23:55:32 INFO - jsonschema == 2.5.1 23:55:32 INFO - manifestparser == 1.1 23:55:32 INFO - mozInstall == 1.12 23:55:32 INFO - mozcrash == 0.17 23:55:32 INFO - mozdebug == 0.1 23:55:32 INFO - mozdevice == 0.48 23:55:32 INFO - mozfile == 1.2 23:55:32 INFO - mozhttpd == 0.7 23:55:32 INFO - mozinfo == 0.9 23:55:32 INFO - mozleak == 0.1 23:55:32 INFO - mozlog == 3.3 23:55:32 INFO - moznetwork == 0.27 23:55:32 INFO - mozprocess == 0.23 23:55:32 INFO - mozprofile == 0.28 23:55:32 INFO - mozrunner == 6.12 23:55:32 INFO - mozscreenshot == 0.1 23:55:32 INFO - mozsystemmonitor == 0.3 23:55:32 INFO - moztest == 0.7 23:55:32 INFO - mozversion == 1.4 23:55:32 INFO - psutil == 3.1.1 23:55:32 INFO - requests == 1.2.3 23:55:32 INFO - wsgiref == 0.1.2 23:55:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:55:32 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')]} 23:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:32 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')]} 23:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:32 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 0x7fb30d373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e370>, '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 0x10418f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041d80>, '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': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', '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 23:55:32 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 23:55:32 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 23:55:32 INFO - Using env: {'DISPLAY': ':0', 23:55:32 INFO - 'HOME': '/home/cltbld', 23:55:32 INFO - 'LANG': 'en_US.UTF-8', 23:55:32 INFO - 'LANGUAGE': 'en_US:en', 23:55:32 INFO - 'LOGNAME': 'cltbld', 23:55:32 INFO - 'MAIL': '/var/mail/cltbld', 23:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:32 INFO - 'MOZ_NO_REMOTE': '1', 23:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:32 INFO - 'NO_EM_RESTART': '1', 23:55:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:32 INFO - 'PWD': '/builds/slave/test', 23:55:32 INFO - 'SHELL': '/bin/bash', 23:55:32 INFO - 'SHLVL': '1', 23:55:32 INFO - 'TERM': 'linux', 23:55:32 INFO - 'TMOUT': '86400', 23:55:32 INFO - 'USER': 'cltbld', 23:55:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', 23:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:32 INFO - '_': '/tools/buildbot/bin/python'} 23:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:32 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)) 23:55:32 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)) 23:55:32 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)) 23:55:32 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)) 23:55:32 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)) 23:55:32 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)) 23:55:32 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)) 23:55:32 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)) 23:55:32 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)) 23:55:32 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)) 23:55:32 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)) 23:55:32 INFO - Cleaning up... 23:55:32 INFO - Return code: 0 23:55:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:55:32 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')]} 23:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:32 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')]} 23:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:55:33 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 0x7fb30d373f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e370>, '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 0x10418f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041d80>, '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': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', '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 23:55:33 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 23:55:33 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 23:55:33 INFO - Using env: {'DISPLAY': ':0', 23:55:33 INFO - 'HOME': '/home/cltbld', 23:55:33 INFO - 'LANG': 'en_US.UTF-8', 23:55:33 INFO - 'LANGUAGE': 'en_US:en', 23:55:33 INFO - 'LOGNAME': 'cltbld', 23:55:33 INFO - 'MAIL': '/var/mail/cltbld', 23:55:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:33 INFO - 'MOZ_NO_REMOTE': '1', 23:55:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:33 INFO - 'NO_EM_RESTART': '1', 23:55:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:33 INFO - 'PWD': '/builds/slave/test', 23:55:33 INFO - 'SHELL': '/bin/bash', 23:55:33 INFO - 'SHLVL': '1', 23:55:33 INFO - 'TERM': 'linux', 23:55:33 INFO - 'TMOUT': '86400', 23:55:33 INFO - 'USER': 'cltbld', 23:55:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', 23:55:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:33 INFO - '_': '/tools/buildbot/bin/python'} 23:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:55:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:55:33 INFO - Cleaning up... 23:55:33 INFO - Return code: 0 23:55:33 INFO - Running post-action listener: _resource_record_post_action 23:55:33 INFO - Running post-action listener: _start_resource_monitoring 23:55:33 INFO - Starting resource monitoring. 23:55:33 INFO - [mozharness: 2016-09-01 06:55:33.249983Z] Finished create-virtualenv step (success) 23:55:33 INFO - [mozharness: 2016-09-01 06:55:33.250489Z] Running install step. 23:55:33 INFO - Running pre-action listener: _resource_record_pre_action 23:55:33 INFO - Running main action method: install 23:55:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:55:33 INFO - Reading from file tmpfile_stdout 23:55:33 INFO - Detecting whether we're running mozinstall >=1.0... 23:55:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:55:33 INFO - Reading from file tmpfile_stdout 23:55:33 INFO - Output received: 23:55:33 INFO - Usage: mozinstall [options] installer 23:55:33 INFO - Options: 23:55:33 INFO - -h, --help show this help message and exit 23:55:33 INFO - -d DEST, --destination=DEST 23:55:33 INFO - Directory to install application into. [default: 23:55:33 INFO - "/builds/slave/test"] 23:55:33 INFO - --app=APP Application being installed. [default: firefox] 23:55:33 INFO - mkdir: /builds/slave/test/build/application 23:55:33 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'] 23:55:33 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 23:55:50 INFO - Reading from file tmpfile_stdout 23:55:50 INFO - Output received: 23:55:50 INFO - /builds/slave/test/build/application/firefox/firefox 23:55:50 INFO - Running post-action listener: _resource_record_post_action 23:55:50 INFO - [mozharness: 2016-09-01 06:55:50.562876Z] Finished install step (success) 23:55:50 INFO - [mozharness: 2016-09-01 06:55:50.563158Z] Running run-tests step. 23:55:50 INFO - Running pre-action listener: _resource_record_pre_action 23:55:50 INFO - Running main action method: run_tests 23:55:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:55:50 INFO - Python 2.7.3 23:55:50 INFO - Return code: 0 23:55:50 INFO - grabbing minidump binary from tooltool 23:55: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')]} 23:55:50 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 0x103e370>, '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 0x10418f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:55:50 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 23:55:50 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 23:55:50 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 23:55:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:55:50 INFO - Return code: 0 23:55:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:55:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:55:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:55:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:55:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:55:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 23:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 23:55:50 INFO - Using env: {'DISPLAY': ':0', 23:55:50 INFO - 'HOME': '/home/cltbld', 23:55:50 INFO - 'LANG': 'en_US.UTF-8', 23:55:50 INFO - 'LANGUAGE': 'en_US:en', 23:55:50 INFO - 'LOGNAME': 'cltbld', 23:55:50 INFO - 'MAIL': '/var/mail/cltbld', 23:55:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:55:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:55:50 INFO - 'MOZ_NO_REMOTE': '1', 23:55:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:55:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:55:50 INFO - 'NO_EM_RESTART': '1', 23:55:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:55:50 INFO - 'PWD': '/builds/slave/test', 23:55:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:55:50 INFO - 'SHELL': '/bin/bash', 23:55:50 INFO - 'SHLVL': '1', 23:55:50 INFO - 'TERM': 'linux', 23:55:50 INFO - 'TMOUT': '86400', 23:55:50 INFO - 'USER': 'cltbld', 23:55:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073', 23:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:55:50 INFO - '_': '/tools/buildbot/bin/python'} 23:55:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 23:55:50 INFO - mozversion application_buildid: 20160831203012 23:55:50 INFO - mozversion application_changeset: 9f33ab9fd502d2a4c38aef7744ab68c0aaa78234 23:55:50 INFO - mozversion application_display_name: Nightly 23:55:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:55:50 INFO - mozversion application_name: Firefox 23:55:50 INFO - mozversion application_remotingname: firefox 23:55:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:55:50 INFO - mozversion application_vendor: Mozilla 23:55:50 INFO - mozversion application_version: 51.0a1 23:55:50 INFO - mozversion platform_buildid: 20160831203012 23:55:50 INFO - mozversion platform_changeset: 9f33ab9fd502d2a4c38aef7744ab68c0aaa78234 23:55:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:55:50 INFO - mozversion platform_version: 51.0a1 23:55:50 INFO - using testdate: 1472712950 23:55:50 INFO - actual date: 1472712950 23:55:50 INFO - starting webserver on 'localhost:45769' 23:55:50 INFO - SUITE-START | Running 2 tests 23:55:50 INFO - TEST-START | dromaeo_css 23:55:50 INFO - operating with platform_type : linux_ 23:55:50 INFO - Initialising browser for dromaeo_css test... 23:55:50 INFO - TEST-INFO | started process 19490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyvMcpB/profile http://localhost:45769/getInfo.html) 23:55:55 INFO - PROCESS | 19490 | __metrics Screen width/height:1600/1200 23:55:55 INFO - PROCESS | 19490 | colorDepth:24 23:55:55 INFO - PROCESS | 19490 | Browser inner width/height: 1024/697 23:55:55 INFO - PROCESS | 19490 | __metrics 23:55:55 INFO - PROCESS | 19490 | 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" 23:55:55 INFO - PROCESS | 19490 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:55:56 INFO - PROCESS | 19490 | console.error: PushService: 23:55:56 INFO - PROCESS | 19490 | stateChangeProcessEnqueue: Error transitioning state 23:55:56 INFO - PROCESS | 19490 | UnknownError 23:55:56 INFO - TEST-INFO | 19490: exit 0 23:55:56 INFO - Browser initialized. 23:55:56 INFO - Running cycle 1/1 for dromaeo_css test... 23:55:56 INFO - TEST-INFO | started process 19572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyvMcpB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:56:09 INFO - PROCESS | 19572 | RSS: Main: 180240384 23:56:09 INFO - PROCESS | 19572 | 23:57:00 INFO - PROCESS | 19572 | 1472713020867 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] 23:59:10 INFO - PROCESS | 19572 | Cycle 1(1): loaded http://localhost:45769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45769/tests/dromaeo/cssquery-ext.html) 23:59:11 INFO - PROCESS | 19572 | RSS: Main: 289300480 23:59:11 INFO - PROCESS | 19572 | 00:02:13 INFO - PROCESS | 19572 | Cycle 1(1): loaded http://localhost:45769/tests/dromaeo/cssquery-ext.html (next: http://localhost:45769/tests/dromaeo/cssquery-jquery.html) 00:02:14 INFO - PROCESS | 19572 | RSS: Main: 275357696 00:02:14 INFO - PROCESS | 19572 | 00:05:16 INFO - PROCESS | 19572 | Cycle 1(1): loaded http://localhost:45769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45769/tests/dromaeo/cssquery-mootools.html) 00:05:16 INFO - PROCESS | 19572 | RSS: Main: 216125440 00:05:16 INFO - PROCESS | 19572 | 00:08:19 INFO - PROCESS | 19572 | Cycle 1(1): loaded http://localhost:45769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45769/tests/dromaeo/cssquery-prototype.html) 00:08:19 INFO - PROCESS | 19572 | RSS: Main: 215101440 00:08:19 INFO - PROCESS | 19572 | 00:11:22 INFO - PROCESS | 19572 | Cycle 1(1): loaded http://localhost:45769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45769/tests/dromaeo/cssquery-yui.html) 00:11:22 INFO - PROCESS | 19572 | RSS: Main: 216776704 00:11:22 INFO - PROCESS | 19572 | 00:14:25 INFO - PROCESS | 19572 | Cycle 1(1): loaded http://localhost:45769/tests/dromaeo/cssquery-yui.html (next: http://localhost:45769/tests/dromaeo/cssquery-dojo.html) 00:14:26 INFO - PROCESS | 19572 | RSS: Main: 301056000 00:14:26 INFO - PROCESS | 19572 | 00:14:26 INFO - PROCESS | 19572 | __start_tp_report 00:14:26 INFO - PROCESS | 19572 | _x_x_mozilla_page_load 00:14:26 INFO - PROCESS | 19572 | _x_x_mozilla_page_load_details 00:14:26 INFO - PROCESS | 19572 | |i|pagename|runs| 00:14:26 INFO - PROCESS | 19572 | |0;dojo.html;3046.741027012705;3052.9084127476176;3068.585740924975;3098.5816914716534;3111.7977331473453;5208.687478751278;5292.788288468457;5327.973360133199;5417.864553386167;5452.236686863837;5333.919991200135;5343.278657381253;5384.273123128377;5411.107167317388;5430.131179011359;4758.928616070744;4822.469528351879;4841.370621819158;4847.369841920546;5003.549680528752;4922.138625740499;4971.602271818264;4980.302757613937;5003.374578177728;5003.424606170301;4765.404324459442;4807.735574543399;4876.122297986361;4887.584555312803;4931.038447502739;4799.712017278975;4816.951830481686;4824.276358546211;4876.341693871353;4914.385701787277;4807.591354734852;4820.39745031871;4827.686200396963;4844.903101937976;4871.780769865364;5298.337707786527;5305.0450918834595;5351;5432.511074003319;5455.099908515091;5673.46102120302;5725.656460612377;5727.885442291131;5736.971315143439;5748.540116790688;5727.513161381287;5738.254026976467;5738.598298119134;5743.10981797822;5758.3665796762325;5226.891922707052;5310.601704872072;5347.759350829183;5366.034113859465;5370.489803468742;5897.616654917417;5899.764009439575;5901.498372638288;5905.291365036223;5963.284405871236;5640.802571910045;5643.266375371258;5648.74580643872;5659.122835960433;5664.575156863251;5616.971915140398;5699.088145896637;5756.222909907109;5810.738516766755;5811.912821307684;5738.282714660668;5738.426157384311;5740.311162660508;5744.396838331999;5802.33273173582;5700.144978253295;5734.254546908875;5748.798792042258;5751.712414379264;5757.769689212469;4362.149380870763;4440.511543730187;4440.533743956838;4460.219461594208;4493.775311234425;3938.5864484229314;3947.703922205789;3959.0300376407963;4018.1963607278662;4066.1867626474823;5485.341758988867;5494.917576236359;5496.477834605706;5496.560275177976;5499.257600223918;5767.336756273083;5768.711564421846;5818.592698511148;5823.621464604787;5836.766529338779;5325.121354976385;5394.973025134927;5432.429594892558;5481.643693159932;5519.613627046148;4972.279019542146;5007.7245751484015;5017.724025178651;5018.071656743514;5135.845924622267;5947.583669143291;6000.309964354068;6002.459778619946;6007.549433792483;6008.969955150284;5667.801626943037;5749;5788.507976822018;5805.912911306249;5891.911621325769;5982.760689572368;5983.102534619842;5983.401659834156;5989.700514974146;5990.7004649768205;5646.378898321099;5650.547956163415;5702.315722113373;5713.314402271754;5720.227769251098;5604.271444712162;5652.717364131695;5695.857603559944;5708.086706127;5801.3038435388025;5552.222688823487;5579.553635709052;5587.357453892691;5590.664560126243;5594.4125866785025;5607.859803504782;5610.438956104357;5612.130119831432;5621.044422448112;5623.2127502148915;5417.160340147126;5500.312460942382;5552.361478430033;5567.749451274622;5641.633293835887;5622.409646987171;5634.6337488063145;5637.548996080386;5647.519960803378;5652.349979752216;5479.835604931858;5495.670259784426;5496.285482887199;5499.092649712753;5511.641743286674 00:14:26 INFO - PROCESS | 19572 | |1;ext.html;551.1460680607981;586.6509426891;598.5660396212744;603.4990957505271;606.7803714533786;32017.359652806957;44996.55003449965;46059.769701151534;46140.538594614125;46285.76857115718;45259.77370113153;45547.544524554825;45769.771151144196;45781.31328030082;45836;8950.552472376372;9086.454812711225;9098.863517047217;9106.590203440861;9107.180353768159;8899.866502002475;8987.46075235488;8991.41555798871;8992.730218093468;8999.865002024975;9028.954855225715;9072.954635226848;9078.909210907872;9082.273418126568;9102.59038343273;9004.234640055603;9034;9045.77385565366;9056.275497960214;9057.18485336323;8862.955685221597;8937.240334571568;8944.508052057134;8945.105489451067;8947.32895032875;43244;43531.12937741259;43622.56377436248;43691;43711;3247.3342964692183;3485.9651403486146;3595.1910820065277;3840.2127563849344;3847.5382954045413;32853.83573082143;33037.6696233037;33109.83445082783;33119.172020699436;33201;4398.186335527906;4462.843800466968;4488.41650585425;4626.953730462686;4689.859304220879;345423;347775.09486029705;351416;351692;352213.99999999744;58725.706371468725;58847;58917.11624325639;59032.11451828226;59065.11402328969;61915.38084619186;61919.690401547705;61951.38048619456;61963;62033.68983155055;17234.310627575007;17484.737728934077;17494.387696430564;17497;17521.7371739424;13679.726405472034;13761.31193440344;13763.31183440824;13764.862351376558;13767.793483097761;15913.363465461483;17335.56661083483;17359.305627775;17469.737953930446;17493.212805423787;5957.821265362046;6071.635701857903;6089.634621922699;6223.993845938691;6244.968775156186;927.6289484206236;994.5325696922434;1042.6142327338932;1070.5182667799522;1083.669480808361;31689;31967.84016079951;32253;32763.836180818944;32891;1068.615298492542;1078.4338222433284;1090.575592639114;1096.1942971915635;1140.703417111557;16437.58906027359;16983.49049528516;17060.914695426443;17071.829281707272;17286.481405557854;507002;514296;515205;520279.7902073409;521653;57962.420375796544;58135.70932145312;58180.4181958175;58230;58269.70865145647;1199.1965383193108;1317.6705823544114;1331.5872079655337;1348.858369871169;1358.9524366646922;31121.37757244797;32744;33006.17484562905;33164.50253246252;34074.488882667276;50375.24437133373;50584;50609.49390506048;50700.49299506958;50732.23901641552;402134;404555;405498;406300;406352.3647635331;34950.82524587463;35295;40078.59921400749;41415;43629.12741745211;46549.30176047294;47179.52820471889;47316.2902556455;47374.763126184145;47529.287060694805;39494.21011579695;39655.80172099121;39835.80082099687;41196.94015299163;42211.3668294982;39192.41211381774;39794;40374.39438408367;41300;41701.79149104235;39436.40845387379;39494;40033.599664002984;40054.1989160221;40534.39198411967;33094.83452582722;36258;37052;37095.629043710294;37285.62714372821;27423.588646169923;27592.448151037268;27833;27877.721222787513;27883.44233115367 00:14:26 INFO - PROCESS | 19572 | |2;jquery.html;389.4080996884733;390.39099005551327;392.4603669953814;403.29222215012646;423.8516519218274;13721.45114195431;18318.900865948035;20081.196752129916;20097.698534521995;21344;16230.269637866295;18853.434396968078;19527.121279542418;19721.40835774929;20301.898490507563;5674.460926212003;5869.413058694139;5873.765049398019;5877.85305367365;5899.174115623795;5644.181593668915;5756.913646295309;5827.096799995987;5829.300483941933;5842.094475356326;5888.5877988540815;5890.852728681796;5894.204282421882;5894.263217097863;5895.469407753301;5606.775728970836;5807;5852;5853.707314634273;5855.502282306009;5208.088584497736;5214.7914083437;5223.138182199932;5229.921551176697;5230.21546767984;22800.201992930168;23508.294751157493;24067.879660601586;24154.637680434807;24250.272491825275;2134.001727572763;2316.224064938248;2348.5068135691527;2408.915687950931;2501.3246423465744;9141.268698504104;10061.79876402468;10375.584976600927;10831.104556702545;10897.509612067397;1960.4314748722854;1980.9405717828488;1996.7919408757637;2014.1037238428905;2058.4030631116957;74125.62937185279;76087.61956190184;76245;81576.59211703904;87175;10803.405812680221;10946.835797463045;10974.725631859108;11114.443977843108;11342.319460832376;15467.5359739208;15481.458148964732;15488.303026363841;15494.450554944415;15520.844791552166;8101.351891848638;8259.793505162419;8319.168083191633;8421.70524031656;8562;7841.4118941078505;8028.157043510348;8230.382721295926;8239.876401853977;8281.875771863426;4277.2087163874785;4350.891227719269;4511.187986162457;4601.4248218972625;4643.976780116078;1914.3295103330775;1964.204497178645;2029.1274751856547;2049.40567235503;2049.8872562009233;928.5125309212582;969.2536746704998;975.6390135649855;999.7050869993369;1010.242318261304;18848.434546963337;19515.121819518157;19557.217711291672;19662;19986.90006549958;915.4141349536302;944.7401964459691;970.3256236915277;971.8007808399261;1032.5198782565992;10450.007249311304;10764.677059688222;11038.503267352988;11046.779064418828;11084.113270938306;450615;486849;492925;493224;495125;89578;94238;94364;94574.52712736392;94927.52536237413;948.6158105967095;992.1417973452911;1021.6883850425692;1022.3610243597751;1022.4274406332478;16598.336066557204;17002.48992530226;17455;17467.47597572075;17478.12609369552;40995.590044099175;41620.79189604154;41637.37543936904;41765.58234417617;42381.788091059345;51544.74227628838;52939;53893.73053134709;58363.4163658358;58987.705061474415;9154.633814647339;9977.900220997988;11652.475638596114;12544.498220071095;12596.496140154657;13496.987725920399;13828.446862125402;14507.709845802814;14705.705885882437;15557.222138892783;11928;12386.5664701735;12604;12684.492620295085;12738.490460381481;12312.445939932546;12471.750564988832;12611.30637814929;12658.746825063632;13086.869131308566;12455.688607784878;13026.739465210832;13056.477740890257;13339.799903001656;13409.865901341253;12938.611841644766;12979.935100324437;13066.869331306565;13161.47354105825;13453.865461345653;12524.248545087325;12953.870461295643;12964.935175324063;13021.804672929724;13295.401706923018 00:14:26 INFO - PROCESS | 19572 | |3;mootools.html;1320.5378117658818;1387.3202130955835;1405.7399381114492;1451.3614009835671;1785.4554360919922;8544.316454683625;8995.235404990575;9004.72985810426;9214.861777073333;9219.723408297745;8950.239229665487;9129.178373946343;9157.130072643105;9158.358914875962;9165.633374665005;2174.5759576882515;2299.540091981602;2324.790768830805;2327.173853282086;2371.27676058802;2450.0444826517582;2471.9258422247362;2488.639147323637;2501.837380570257;2508.059477695864;2392.3181893160454;2393.700787401575;2406.2660888429023;2409.7108346998384;2452.7179374372;2295.2884605772265;2352.9647055294186;2438.0247900839627;2440.4021014851296;2447.657327974076;2441.340837973755;2455.1038870812204;2463.8275320727557;2468.1731619907355;2482.2677310193535;9186.908130918671;9239.769005774842;9263.583138758771;9268.073192680746;9270.30472714549;5378;5522.420145884705;5523.6409633374105;5524.640898341635;5527.170924361338;3297.4394352960053;3408.1820363112674;3563.7861728296384;3570.107473131717;3591.084273510264;1185.2296007595046;1213.1992884696058;2169.2082389927564;2235.9888200559058;2243.304575581575;12256.44845981933;12365.938170309091;12400.56598019065;12408.255504669658;12410.255384676948;4383.211022016068;4598.126355992351;4608.769561521911;4776.331313616097;4809.158397280462;9666.323357364918;9682.080202380763;9687.2734544908;9688.564014619358;9690.321677482649;5323.866903327448;5325.9733701332025;5326.041312563776;5326.6537675050995;5327.893442131136;4574.382458368078;4951.876203094951;4986.750662466862;5009.12340340439;5036.194208926554;3879.689624830007;3892.9805350973065;4017.2367250222364;4040.939385909214;4070.3894415837267;1169.8245263210586;1202.8015377462796;1204.7530256297614;1211.8182272659171;1224.9020078393708;937.8452555328431;975.302658599105;975.882894052704;977.3012296208245;996.242855429864;5973.402659733992;6018.578699490994;6127.3566275540425;6161.383861613803;6235.469985051322;487.4540514623573;490.8699194713404;499.6951859365784;507.7258280528473;508.9262057001714;4165.45849039629;4227.513835908849;4366.825326986885;4451.9554804451545;4562.110388474282;11225.158113141548;11287.266327688674;11392.088632909348;11393.772124557463;11488.425578721031;11269.323840569592;11287.322760634388;11298;11309.773804524028;11325.773484530264;7664.80837979055;7956.7215147470715;7961.323287520626;8188.26305632484;8285.54429506383;6230.470410015199;6243.282022567463;6346.90479642815;6364.268109167505;6438.420542151229;10263.84604230952;10403.791924161324;10423.322484038514;10560.524776384927;10586.523606437882;10388.220883433622;10511.159107271247;10687.89312106869;10734.677959661223;10797.784044318912;7864.134945155914;7900.565468899265;8064.3548516119745;8068.757937261891;8146.266835984789;8545.786355341166;8615.483071015758;8619.482831030158;8622.223999840044;8625.654973800978;7677.654505547375;7769.805754856174;7856.84286314282;7950.16523265072;8034.718784842503;7120.216776154515;7205.099362579677;7357.8160545986775;7423.480356375002;7427.145878224073;7082.610456424946;7213.062301900719;7213.495055346076;7222.855542889218;7227.819304517218;5024.246363045426;5059.696418214919;5150.0987327216835;5185.274061631299;5213.947860521346;5342.225377320345;5386.919196211981;5393.83818485446;5470.945290547043;5567.331920169606 00:14:26 INFO - PROCESS | 19572 | |4;prototype.html;315.35542147699755;319.1240046073528;323.70542806046495;327.6166884744848;330.1827975759994;5268.341457317835;5323.760430780614;5334.706591137486;5355.6251062425645;5367.865803354918;5210.4729206335;5218.582513398919;5315.521603055734;5333.493318134781;5333.826558157209;3885.1064255221318;3960;3996.3206254936586;3998.8000599969887;4033.616806403387;3687.575928768186;4098.8360465581345;4100.405441211023;4117.155983023488;4119.464469618945;4073.959260407388;4090.1389867610164;4094.7133700640966;4098.549159592442;4114.177164567083;3901.43429202764;3959.46547216125;4092.240336655252;4115.691323150746;4116.300228961069;3590.5152804371337;3598.3702852000797;3612.963870361289;3623.1123374773088;3635.981820090909;5089.236614507853;5118.718470484122;5135.124330375002;5139.974300128475;5154.587632989352;4638.281066434674;4641.559051890065;4649.511801260886;4691.366665500148;4692.788824502905;5508.394076651565;5509.815389691235;5510.421405752379;5524.14375771756;5531.419200983879;3991.201759648082;3992.680585553149;3995.0411901143807;4002.0995276062945;4005.759654420715;5163.483651634844;5358.981793459269;5644.391348465668;5686.402927692574;5730.570207234432;4035;4037.8586749464216;4041.3937909313836;4041.5958404159937;4061.8375264989068;4072.226277007359;4082.9996650820144;4094.7747873867224;4101.2207680540605;4101.815418306183;4467.481056440761;4671.813127474863;4683.501279590567;4684.578387945033;4703.223968045234;5477.67133971963;5480.780768769205;5483.8080667176455;5488.451154884479;5490.670559766427;1398.6573289543924;1412.6750847305177;1415.4338264694204;1415.7380884536394;1422.615893708693;823.2549542663899;877.7279043496536;882.9911700883038;884.3853521802286;888.7422647432302;4680.2916935319045;4689.366935463737;4696.5577899492755;4698.2952557116705;4703.471371804178;4915.861600203852;4919.901601968012;4923.48303428142;4936.950630493649;4983.92845538211;4355.564443555619;4723.31511930775;4734.455537613149;4751;4785.449673287617;2658.24240091573;2662.640543526638;2667.7999150063824;2670.198940317936;2676.2470581768584;5146.614003949719;5148.330717006766;5150;5173.482651734872;5217.2695822584865;4752.833650822205;4985.750712464363;5078.415982162099;5078.669886457368;5088.414832294334;4998.375203099613;5021.422536408287;5032.496750325012;5033.773480193473;5034.546890779774;4886.633502487257;4896.828610998598;4899.902001960012;4913.729744864067;4966.528179822911;4804.42346918372;4896.828610998598;4904.6321525886415;4941.591646380764;4972.776225069808;5155.587552995827;5555.7499912504845;5708;5779.682117483579;5796.768129274782;4090.734102283342;4119.237940980808;4153.836925660819;4178.080822219107;4186.68599855006;5566.165075238747;5637.998510528703;5651.954388438152;5687.800926967702;5721.170430287501;5420.376656684532;5434.619576629598;5464.28964234647;5469.562435005269;5472.671639701631;5431.185322201702;5436.673799572039;5486.324162811006;5506.91739623898;5552.278203833475;5279.313689220377;5484.314460692413;5501.394846566955;5521;5530.668159910419;5459.372172200247;5471.398146203994;5574.609777315549;5587.944120558743;5590.776368945197;5399.487048730364;5415.539679127318;5456.809011684572;5470.070088085115;5475.835724928259 00:14:26 INFO - PROCESS | 19572 | |5;yui.html;695.342900958594;723.5152447859934;750.1036261667306;771.7221800151945;795.7493389582285;15716.764248536267;17100.572485687862;17125;17293.740593891085;17335.82664173358;15344.156071416068;15472.303746331414;15489.380424782996;15496.922515387436;15533.766993495106;653.3923451190391;767.8656235158853;778.8792737125755;786.1431040166218;792.3067316098413;796.928276455119;798.9081255655586;805.0862271322034;809.7125520440247;810.0360570920615;849.1254008371387;853.9829203415928;854.2269246332079;855;859.8968123825118;676.4757313082351;838.9244967952914;841.7180244618061;842.9957850210772;843.4939036578065;606.2088973889117;615.6275453350748;615.9076138579204;617.3641149615903;618.9659568723719;13043;13205.471781128743;13248.20510769357;13266.800997985038;13267.336633168303;13876.722465550733;14279.286035698173;14700.632484187874;14982.780983049348;15088.321025553876;13359.046109037403;13425.39585718645;13454.52909148175;13473.124246923919;13998.790018149735;4440.156370289635;4528.456585209763;4544.636429085698;4569.794359253841;4651.465081515636;55369;80363.19636803615;87339.56330218309;89145.10854891498;89261.55369223113;11187.4965626547;11190.38452885083;11368.658940231806;11402.94298528502;11845.526178952918;21567.35297941033;21577.56844863094;21598.78401215999;21617.89191054066;21628.4592885176;8642.956785216034;8687.34844886636;8702.216800487986;8825.867611985825;8837.867431988525;4462.419885414875;4506.459224892968;4548.249538826123;4611.538846115362;4627.745473998963;3447.7414193935556;3572.0534058474527;3575.6781889630056;3575.964240357563;3578.856845726194;613.408061220924;616.4113271825396;639.0988705924717;652.1847690387016;659.4032400677395;664.4119953840885;679.58205703492;691.4502970138752;692.1590267824516;707.7204504220907;9503.477308747946;9504;9522.714318570454;9607.471589062528;9769.364991275545;660.92729799722;664.7241394821192;674.8932744251285;714.7641278378122;719.5790462579345;4443.511213766483;4559.361689363492;4861.781219845116;4919.508049195052;4923.8276660316715;82891;98483;129761;130755;132632;93502.25990960286;95108;99030;99379.50310248547;99458;85172.57413712892;87538.56230718805;88051.11948880558;88221;89038;9538;9763.707088787347;9789.46157961319;9883.85174222373;9929.404235745878;46390.304145438524;51105;51220.74389628028;52494.73752631212;52936.735316323175;70230;70836;77653.61173194098;77887.221127788;77979;12685.873141268468;12757.617271481871;12768.6807829805;13406.530771423344;13474.854637355542;15344.30950607203;15481;15705.528834134995;16079.75880361819;16572.419965301156;13212.273324967218;13238.27189504548;13505.392257348247;13715.794263086262;13721.176729396268;13100.410481528164;13151.671208219872;13345.532906348231;13784.310784460937;13925.234112123526;13069.934650326688;13310.534131305745;13349.599512014654;13449.798253026016;13915.443382264595;11430.542778289107;11550.48022838991;11670.591529296435;11766.58816941403;11812.645620631394;10039;10236.283460157718;11104.944475277573;11798.941005294919;11950.880491195325 00:14:26 INFO - PROCESS | 19572 | __end_tp_report 00:14:26 INFO - PROCESS | 19572 | __start_cc_report 00:14:26 INFO - PROCESS | 19572 | _x_x_mozilla_cycle_collect,1044 00:14:26 INFO - PROCESS | 19572 | __end_cc_report 00:14:26 INFO - PROCESS | 19572 | __startTimestamp1472714066082__endTimestamp 00:14:26 INFO - PROCESS | 19572 | 00:14:26 INFO - PROCESS | 19572 | ------- Summary: start ------- 00:14:26 INFO - PROCESS | 19572 | Number of tests: 6 00:14:26 INFO - PROCESS | 19572 | 00:14:26 INFO - PROCESS | 19572 | [#0] dojo.html Cycles:165 Average:5342.51 Median:5552.22 stddev:606.81 (10.9%) stddev-sans-first:581.34 00:14:26 INFO - PROCESS | 19572 | Values: 3046.7 3052.9 3068.6 3098.6 3111.8 5208.7 5292.8 5328.0 5417.9 5452.2 5333.9 5343.3 5384.3 5411.1 5430.1 4758.9 4822.5 4841.4 4847.4 5003.5 4922.1 4971.6 4980.3 5003.4 5003.4 4765.4 4807.7 4876.1 4887.6 4931.0 4799.7 4817.0 4824.3 4876.3 4914.4 4807.6 4820.4 4827.7 4844.9 4871.8 5298.3 5305.0 5351.0 5432.5 5455.1 5673.5 5725.7 5727.9 5737.0 5748.5 5727.5 5738.3 5738.6 5743.1 5758.4 5226.9 5310.6 5347.8 5366.0 5370.5 5897.6 5899.8 5901.5 5905.3 5963.3 5640.8 5643.3 5648.7 5659.1 5664.6 5617.0 5699.1 5756.2 5810.7 5811.9 5738.3 5738.4 5740.3 5744.4 5802.3 5700.1 5734.3 5748.8 5751.7 5757.8 4362.1 4440.5 4440.5 4460.2 4493.8 3938.6 3947.7 3959.0 4018.2 4066.2 5485.3 5494.9 5496.5 5496.6 5499.3 5767.3 5768.7 5818.6 5823.6 5836.8 5325.1 5395.0 5432.4 5481.6 5519.6 4972.3 5007.7 5017.7 5018.1 5135.8 5947.6 6000.3 6002.5 6007.5 6009.0 5667.8 5749.0 5788.5 5805.9 5891.9 5982.8 5983.1 5983.4 5989.7 5990.7 5646.4 5650.5 5702.3 5713.3 5720.2 5604.3 5652.7 5695.9 5708.1 5801.3 5552.2 5579.6 5587.4 5590.7 5594.4 5607.9 5610.4 5612.1 5621.0 5623.2 5417.2 5500.3 5552.4 5567.7 5641.6 5622.4 5634.6 5637.5 5647.5 5652.3 5479.8 5495.7 5496.3 5499.1 5511.6 00:14:26 INFO - PROCESS | 19572 | 00:14:26 INFO - PROCESS | 19572 | [#1] ext.html Cycles:180 Average:59170.16 Median:41558.40 stddev:113456.45 (273.0%) stddev-sans-first:113689.36 00:14:26 INFO - PROCESS | 19572 | Values: 551.1 586.7 598.6 603.5 606.8 32017.4 44996.6 46059.8 46140.5 46285.8 45259.8 45547.5 45769.8 45781.3 45836.0 8950.6 9086.5 9098.9 9106.6 9107.2 8899.9 8987.5 8991.4 8992.7 8999.9 9029.0 9073.0 9078.9 9082.3 9102.6 9004.2 9034.0 9045.8 9056.3 9057.2 8863.0 8937.2 8944.5 8945.1 8947.3 43244.0 43531.1 43622.6 43691.0 43711.0 3247.3 3486.0 3595.2 3840.2 3847.5 32853.8 33037.7 33109.8 33119.2 33201.0 4398.2 4462.8 4488.4 4627.0 4689.9 345423.0 347775.1 351416.0 351692.0 352214.0 58725.7 58847.0 58917.1 59032.1 59065.1 61915.4 61919.7 61951.4 61963.0 62033.7 17234.3 17484.7 17494.4 17497.0 17521.7 13679.7 13761.3 13763.3 13764.9 13767.8 15913.4 17335.6 17359.3 17469.7 17493.2 5957.8 6071.6 6089.6 6224.0 6245.0 927.6 994.5 1042.6 1070.5 1083.7 31689.0 31967.8 32253.0 32763.8 32891.0 1068.6 1078.4 1090.6 1096.2 1140.7 16437.6 16983.5 17060.9 17071.8 17286.5 507002.0 514296.0 515205.0 520279.8 521653.0 57962.4 58135.7 58180.4 58230.0 58269.7 1199.2 1317.7 1331.6 1348.9 1359.0 31121.4 32744.0 33006.2 33164.5 34074.5 50375.2 50584.0 50609.5 50700.5 50732.2 402134.0 404555.0 405498.0 406300.0 406352.4 34950.8 35295.0 40078.6 41415.0 43629.1 46549.3 47179.5 47316.3 47374.8 47529.3 39494.2 39655.8 39835.8 41196.9 42211.4 39192.4 39794.0 40374.4 41300.0 41701.8 39436.4 39494.0 40033.6 40054.2 40534.4 33094.8 36258.0 37052.0 37095.6 37285.6 27423.6 27592.4 27833.0 27877.7 27883.4 00:14:26 INFO - PROCESS | 19572 | 00:14:26 INFO - PROCESS | 19572 | [#2] jquery.html Cycles:180 Average:29108.61 Median:12928.40 stddev:79741.69 (616.8%) stddev-sans-first:79936.23 00:14:26 INFO - PROCESS | 19572 | Values: 389.4 390.4 392.5 403.3 423.9 13721.5 18318.9 20081.2 20097.7 21344.0 16230.3 18853.4 19527.1 19721.4 20301.9 5674.5 5869.4 5873.8 5877.9 5899.2 5644.2 5756.9 5827.1 5829.3 5842.1 5888.6 5890.9 5894.2 5894.3 5895.5 5606.8 5807.0 5852.0 5853.7 5855.5 5208.1 5214.8 5223.1 5229.9 5230.2 22800.2 23508.3 24067.9 24154.6 24250.3 2134.0 2316.2 2348.5 2408.9 2501.3 9141.3 10061.8 10375.6 10831.1 10897.5 1960.4 1980.9 1996.8 2014.1 2058.4 74125.6 76087.6 76245.0 81576.6 87175.0 10803.4 10946.8 10974.7 11114.4 11342.3 15467.5 15481.5 15488.3 15494.5 15520.8 8101.4 8259.8 8319.2 8421.7 8562.0 7841.4 8028.2 8230.4 8239.9 8281.9 4277.2 4350.9 4511.2 4601.4 4644.0 1914.3 1964.2 2029.1 2049.4 2049.9 928.5 969.3 975.6 999.7 1010.2 18848.4 19515.1 19557.2 19662.0 19986.9 915.4 944.7 970.3 971.8 1032.5 10450.0 10764.7 11038.5 11046.8 11084.1 450615.0 486849.0 492925.0 493224.0 495125.0 89578.0 94238.0 94364.0 94574.5 94927.5 948.6 992.1 1021.7 1022.4 1022.4 16598.3 17002.5 17455.0 17467.5 17478.1 40995.6 41620.8 41637.4 41765.6 42381.8 51544.7 52939.0 53893.7 58363.4 58987.7 9154.6 9977.9 11652.5 12544.5 12596.5 13497.0 13828.4 14507.7 14705.7 15557.2 11928.0 12386.6 12604.0 12684.5 12738.5 12312.4 12471.8 12611.3 12658.7 13086.9 12455.7 13026.7 13056.5 13339.8 13409.9 12938.6 12979.9 13066.9 13161.5 13453.9 12524.2 12953.9 12964.9 13021.8 13295.4 00:14:26 INFO - PROCESS | 19572 | 00:14:26 INFO - PROCESS | 19572 | [#3] mootools.html Cycles:180 Average:5924.87 Median:2754.41 stddev:3352.05 (121.7%) stddev-sans-first:3343.59 00:14:26 INFO - PROCESS | 19572 | Values: 1320.5 1387.3 1405.7 1451.4 1785.5 8544.3 8995.2 9004.7 9214.9 9219.7 8950.2 9129.2 9157.1 9158.4 9165.6 2174.6 2299.5 2324.8 2327.2 2371.3 2450.0 2471.9 2488.6 2501.8 2508.1 2392.3 2393.7 2406.3 2409.7 2452.7 2295.3 2353.0 2438.0 2440.4 2447.7 2441.3 2455.1 2463.8 2468.2 2482.3 9186.9 9239.8 9263.6 9268.1 9270.3 5378.0 5522.4 5523.6 5524.6 5527.2 3297.4 3408.2 3563.8 3570.1 3591.1 1185.2 1213.2 2169.2 2236.0 2243.3 12256.4 12365.9 12400.6 12408.3 12410.3 4383.2 4598.1 4608.8 4776.3 4809.2 9666.3 9682.1 9687.3 9688.6 9690.3 5323.9 5326.0 5326.0 5326.7 5327.9 4574.4 4951.9 4986.8 5009.1 5036.2 3879.7 3893.0 4017.2 4040.9 4070.4 1169.8 1202.8 1204.8 1211.8 1224.9 937.8 975.3 975.9 977.3 996.2 5973.4 6018.6 6127.4 6161.4 6235.5 487.5 490.9 499.7 507.7 508.9 4165.5 4227.5 4366.8 4452.0 4562.1 11225.2 11287.3 11392.1 11393.8 11488.4 11269.3 11287.3 11298.0 11309.8 11325.8 7664.8 7956.7 7961.3 8188.3 8285.5 6230.5 6243.3 6346.9 6364.3 6438.4 10263.8 10403.8 10423.3 10560.5 10586.5 10388.2 10511.2 10687.9 10734.7 10797.8 7864.1 7900.6 8064.4 8068.8 8146.3 8545.8 8615.5 8619.5 8622.2 8625.7 7677.7 7769.8 7856.8 7950.2 8034.7 7120.2 7205.1 7357.8 7423.5 7427.1 7082.6 7213.1 7213.5 7222.9 7227.8 5024.2 5059.7 5150.1 5185.3 5213.9 5342.2 5386.9 5393.8 5470.9 5567.3 00:14:26 INFO - PROCESS | 19572 | 00:14:26 INFO - PROCESS | 19572 | [#4] prototype.html Cycles:180 Average:4466.47 Median:4930.22 stddev:1291.87 (26.2%) stddev-sans-first:1257.36 00:14:26 INFO - PROCESS | 19572 | Values: 315.4 319.1 323.7 327.6 330.2 5268.3 5323.8 5334.7 5355.6 5367.9 5210.5 5218.6 5315.5 5333.5 5333.8 3885.1 3960.0 3996.3 3998.8 4033.6 3687.6 4098.8 4100.4 4117.2 4119.5 4074.0 4090.1 4094.7 4098.5 4114.2 3901.4 3959.5 4092.2 4115.7 4116.3 3590.5 3598.4 3613.0 3623.1 3636.0 5089.2 5118.7 5135.1 5140.0 5154.6 4638.3 4641.6 4649.5 4691.4 4692.8 5508.4 5509.8 5510.4 5524.1 5531.4 3991.2 3992.7 3995.0 4002.1 4005.8 5163.5 5359.0 5644.4 5686.4 5730.6 4035.0 4037.9 4041.4 4041.6 4061.8 4072.2 4083.0 4094.8 4101.2 4101.8 4467.5 4671.8 4683.5 4684.6 4703.2 5477.7 5480.8 5483.8 5488.5 5490.7 1398.7 1412.7 1415.4 1415.7 1422.6 823.3 877.7 883.0 884.4 888.7 4680.3 4689.4 4696.6 4698.3 4703.5 4915.9 4919.9 4923.5 4937.0 4983.9 4355.6 4723.3 4734.5 4751.0 4785.4 2658.2 2662.6 2667.8 2670.2 2676.2 5146.6 5148.3 5150.0 5173.5 5217.3 4752.8 4985.8 5078.4 5078.7 5088.4 4998.4 5021.4 5032.5 5033.8 5034.5 4886.6 4896.8 4899.9 4913.7 4966.5 4804.4 4896.8 4904.6 4941.6 4972.8 5155.6 5555.7 5708.0 5779.7 5796.8 4090.7 4119.2 4153.8 4178.1 4186.7 5566.2 5638.0 5652.0 5687.8 5721.2 5420.4 5434.6 5464.3 5469.6 5472.7 5431.2 5436.7 5486.3 5506.9 5552.3 5279.3 5484.3 5501.4 5521.0 5530.7 5459.4 5471.4 5574.6 5587.9 5590.8 5399.5 5415.5 5456.8 5470.1 5475.8 00:14:26 INFO - PROCESS | 19572 | 00:14:26 INFO - PROCESS | 19572 | [#5] yui.html Cycles:180 Average:21014.79 Median:4756.62 stddev:30341.37 (637.9%) stddev-sans-first:30388.12 00:14:26 INFO - PROCESS | 19572 | Values: 695.3 723.5 750.1 771.7 795.7 15716.8 17100.6 17125.0 17293.7 17335.8 15344.2 15472.3 15489.4 15496.9 15533.8 653.4 767.9 778.9 786.1 792.3 796.9 798.9 805.1 809.7 810.0 849.1 854.0 854.2 855.0 859.9 676.5 838.9 841.7 843.0 843.5 606.2 615.6 615.9 617.4 619.0 13043.0 13205.5 13248.2 13266.8 13267.3 13876.7 14279.3 14700.6 14982.8 15088.3 13359.0 13425.4 13454.5 13473.1 13998.8 4440.2 4528.5 4544.6 4569.8 4651.5 55369.0 80363.2 87339.6 89145.1 89261.6 11187.5 11190.4 11368.7 11402.9 11845.5 21567.4 21577.6 21598.8 21617.9 21628.5 8643.0 8687.3 8702.2 8825.9 8837.9 4462.4 4506.5 4548.2 4611.5 4627.7 3447.7 3572.1 3575.7 3576.0 3578.9 613.4 616.4 639.1 652.2 659.4 664.4 679.6 691.5 692.2 707.7 9503.5 9504.0 9522.7 9607.5 9769.4 660.9 664.7 674.9 714.8 719.6 4443.5 4559.4 4861.8 4919.5 4923.8 82891.0 98483.0 129761.0 130755.0 132632.0 93502.3 95108.0 99030.0 99379.5 99458.0 85172.6 87538.6 88051.1 88221.0 89038.0 9538.0 9763.7 9789.5 9883.9 9929.4 46390.3 51105.0 51220.7 52494.7 52936.7 70230.0 70836.0 77653.6 77887.2 77979.0 12685.9 12757.6 12768.7 13406.5 13474.9 15344.3 15481.0 15705.5 16079.8 16572.4 13212.3 13238.3 13505.4 13715.8 13721.2 13100.4 13151.7 13345.5 13784.3 13925.2 13069.9 13310.5 13349.6 13449.8 13915.4 11430.5 11550.5 11670.6 11766.6 11812.6 10039.0 10236.3 11104.9 11798.9 11950.9 00:14:26 INFO - PROCESS | 19572 | -------- Summary: end -------- 00:14:26 INFO - PROCESS | 19572 | 00:14:27 INFO - TEST-INFO | 19572: exit 0 00:14:27 INFO - TEST-OK | dromaeo_css | took 1116233ms 00:14:27 INFO - TEST-START | kraken 00:14:27 INFO - operating with platform_type : linux_ 00:14:27 INFO - Initialising browser for kraken test... 00:14:27 INFO - TEST-INFO | started process 19877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHpcyDh/profile http://localhost:45769/getInfo.html) 00:14:31 INFO - PROCESS | 19877 | __metrics Screen width/height:1600/1200 00:14:31 INFO - PROCESS | 19877 | colorDepth:24 00:14:31 INFO - PROCESS | 19877 | Browser inner width/height: 1024/697 00:14:31 INFO - PROCESS | 19877 | __metrics 00:14:31 INFO - PROCESS | 19877 | 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" 00:14:31 INFO - PROCESS | 19877 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:14:32 INFO - PROCESS | 19877 | console.error: PushService: 00:14:32 INFO - PROCESS | 19877 | stateChangeProcessEnqueue: Error transitioning state 00:14:32 INFO - PROCESS | 19877 | UnknownError 00:14:33 INFO - TEST-INFO | 19877: exit 0 00:14:33 INFO - Browser initialized. 00:14:33 INFO - Running cycle 1/1 for kraken test... 00:14:33 INFO - TEST-INFO | started process 19962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHpcyDh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:14:45 INFO - PROCESS | 19962 | RSS: Main: 180895744 00:14:45 INFO - PROCESS | 19962 | 00:14:47 INFO - PROCESS | 19962 | Cycle 1(1): loaded http://localhost:45769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45769/tests/kraken/driver.html?testName=audio-beat-detection) 00:14:48 INFO - PROCESS | 19962 | RSS: Main: 234201088 00:14:48 INFO - PROCESS | 19962 | 00:14:51 INFO - PROCESS | 19962 | Cycle 1(1): loaded http://localhost:45769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45769/tests/kraken/driver.html?testName=audio-dft) 00:14:51 INFO - PROCESS | 19962 | RSS: Main: 225058816 00:14:51 INFO - PROCESS | 19962 | 00:14:54 INFO - PROCESS | 19962 | Cycle 1(1): loaded http://localhost:45769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45769/tests/kraken/driver.html?testName=audio-fft) 00:14:55 INFO - PROCESS | 19962 | RSS: Main: 302989312 00:14:55 INFO - PROCESS | 19962 | 00:14:57 INFO - PROCESS | 19962 | Cycle 1(1): loaded http://localhost:45769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45769/tests/kraken/driver.html?testName=audio-oscillator) 00:14:58 INFO - PROCESS | 19962 | RSS: Main: 212439040 00:14:58 INFO - PROCESS | 19962 | 00:15:00 INFO - PROCESS | 19962 | Cycle 1(1): loaded http://localhost:45769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:15:00 INFO - PROCESS | 19962 | RSS: Main: 213536768 00:15:00 INFO - PROCESS | 19962 | 00:15:04 INFO - PROCESS | 19962 | Cycle 1(1): loaded http://localhost:45769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45769/tests/kraken/driver.html?testName=imaging-darkroom) 00:15:04 INFO - PROCESS | 19962 | RSS: Main: 252563456 00:15:04 INFO - PROCESS | 19962 | 00:15:07 INFO - PROCESS | 19962 | Cycle 1(1): loaded http://localhost:45769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45769/tests/kraken/driver.html?testName=imaging-desaturate) 00:15:08 INFO - PROCESS | 19962 | RSS: Main: 250695680 00:15:08 INFO - PROCESS | 19962 | 00:15:11 INFO - PROCESS | 19962 | Cycle 1(1): loaded http://localhost:45769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45769/tests/kraken/driver.html?testName=json-parse-financial) 00:15:11 INFO - PROCESS | 19962 | RSS: Main: 251375616 00:15:11 INFO - PROCESS | 19962 | 00:15:13 INFO - PROCESS | 19962 | Cycle 1(1): loaded http://localhost:45769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:15:14 INFO - PROCESS | 19962 | RSS: Main: 214097920 00:15:14 INFO - PROCESS | 19962 | 00:15:15 INFO - PROCESS | 19962 | Cycle 1(1): loaded http://localhost:45769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45769/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:15:16 INFO - PROCESS | 19962 | RSS: Main: 220721152 00:15:16 INFO - PROCESS | 19962 | 00:15:18 INFO - PROCESS | 19962 | Cycle 1(1): loaded http://localhost:45769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:15:19 INFO - PROCESS | 19962 | RSS: Main: 222183424 00:15:19 INFO - PROCESS | 19962 | 00:15:21 INFO - PROCESS | 19962 | Cycle 1(1): loaded http://localhost:45769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:15:22 INFO - PROCESS | 19962 | RSS: Main: 223997952 00:15:22 INFO - PROCESS | 19962 | 00:15:25 INFO - PROCESS | 19962 | Cycle 1(1): loaded http://localhost:45769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:15:25 INFO - PROCESS | 19962 | RSS: Main: 221425664 00:15:25 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | Cycle 1(1): loaded http://localhost:45769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45769/tests/kraken/driver.html?testName=ai-astar) 00:15:27 INFO - PROCESS | 19962 | RSS: Main: 272809984 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | __start_tp_report 00:15:27 INFO - PROCESS | 19962 | _x_x_mozilla_page_load 00:15:27 INFO - PROCESS | 19962 | _x_x_mozilla_page_load_details 00:15:27 INFO - PROCESS | 19962 | |i|pagename|runs| 00:15:27 INFO - PROCESS | 19962 | |0;ai-astar;114;111;128;111;111;109;113;111;111;111 00:15:27 INFO - PROCESS | 19962 | |1;audio-beat-detection;154;117;145;173;120;149;147;133;184;118 00:15:27 INFO - PROCESS | 19962 | |2;audio-dft;163;163;161;161;161;162;162;163;161;162 00:15:27 INFO - PROCESS | 19962 | |3;audio-fft;74;74;76;180;77;77;76;77;170;76 00:15:27 INFO - PROCESS | 19962 | |4;audio-oscillator;81;82;153;82;82;81;139;82;82;144 00:15:27 INFO - PROCESS | 19962 | |5;imaging-gaussian-blur;116;117;118;118;116;116;117;117;117;116 00:15:27 INFO - PROCESS | 19962 | |6;imaging-darkroom;146;146;147;145;146;146;146;147;146;146 00:15:27 INFO - PROCESS | 19962 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;95 00:15:27 INFO - PROCESS | 19962 | |8;json-parse-financial;52;51;53;52;53;60;53;52;53;52 00:15:27 INFO - PROCESS | 19962 | |9;json-stringify-tinderbox;63;62;62;62;63;62;61;63;63;63 00:15:27 INFO - PROCESS | 19962 | |10;stanford-crypto-aes;80;79;87;82;87;78;78;82;78;80 00:15:27 INFO - PROCESS | 19962 | |11;stanford-crypto-ccm;127;130;137;141;126;123;127;137;172;135 00:15:27 INFO - PROCESS | 19962 | |12;stanford-crypto-pbkdf2;163;164;166;161;162;161;159;157;160;160 00:15:27 INFO - PROCESS | 19962 | |13;stanford-crypto-sha256-iterative;65;67;66;64;64;69;64;65;63;63 00:15:27 INFO - PROCESS | 19962 | __end_tp_report 00:15:27 INFO - PROCESS | 19962 | __start_cc_report 00:15:27 INFO - PROCESS | 19962 | _x_x_mozilla_cycle_collect,1731 00:15:27 INFO - PROCESS | 19962 | __end_cc_report 00:15:27 INFO - PROCESS | 19962 | __startTimestamp1472714127674__endTimestamp 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | ------- Summary: start ------- 00:15:27 INFO - PROCESS | 19962 | Number of tests: 14 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | [#0] ai-astar Cycles:10 Average:113.00 Median:111.00 stddev:5.44 (4.9%) stddev-sans-first:5.75 00:15:27 INFO - PROCESS | 19962 | Values: 114.0 111.0 128.0 111.0 111.0 109.0 113.0 111.0 111.0 111.0 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:148.00 stddev:22.80 (15.4%) stddev-sans-first:23.89 00:15:27 INFO - PROCESS | 19962 | Values: 154.0 117.0 145.0 173.0 120.0 149.0 147.0 133.0 184.0 118.0 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.83 00:15:27 INFO - PROCESS | 19962 | Values: 163.0 163.0 161.0 161.0 161.0 162.0 162.0 163.0 161.0 162.0 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:41.88 (55.1%) stddev-sans-first:43.67 00:15:27 INFO - PROCESS | 19962 | Values: 74.0 74.0 76.0 180.0 77.0 77.0 76.0 77.0 170.0 76.0 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:82.00 stddev:30.91 (37.7%) stddev-sans-first:31.95 00:15:27 INFO - PROCESS | 19962 | Values: 81.0 82.0 153.0 82.0 82.0 81.0 139.0 82.0 82.0 144.0 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 00:15:27 INFO - PROCESS | 19962 | Values: 116.0 117.0 118.0 118.0 116.0 116.0 117.0 117.0 117.0 116.0 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 00:15:27 INFO - PROCESS | 19962 | Values: 146.0 146.0 147.0 145.0 146.0 146.0 146.0 147.0 146.0 146.0 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 00:15:27 INFO - PROCESS | 19962 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:2.51 (4.7%) stddev-sans-first:2.64 00:15:27 INFO - PROCESS | 19962 | Values: 52.0 51.0 53.0 52.0 53.0 60.0 53.0 52.0 53.0 52.0 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 00:15:27 INFO - PROCESS | 19962 | Values: 63.0 62.0 62.0 62.0 63.0 62.0 61.0 63.0 63.0 63.0 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:3.45 (4.3%) stddev-sans-first:3.63 00:15:27 INFO - PROCESS | 19962 | Values: 80.0 79.0 87.0 82.0 87.0 78.0 78.0 82.0 78.0 80.0 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:136.00 stddev:14.10 (10.4%) stddev-sans-first:14.61 00:15:27 INFO - PROCESS | 19962 | Values: 127.0 130.0 137.0 141.0 126.0 123.0 127.0 137.0 172.0 135.0 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.50 stddev:2.58 (1.6%) stddev-sans-first:2.67 00:15:27 INFO - PROCESS | 19962 | Values: 163.0 164.0 166.0 161.0 162.0 161.0 159.0 157.0 160.0 160.0 00:15:27 INFO - PROCESS | 19962 | 00:15:27 INFO - PROCESS | 19962 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.89 (2.9%) stddev-sans-first:2.00 00:15:27 INFO - PROCESS | 19962 | Values: 65.0 67.0 66.0 64.0 64.0 69.0 64.0 65.0 63.0 63.0 00:15:27 INFO - PROCESS | 19962 | -------- Summary: end -------- 00:15:27 INFO - PROCESS | 19962 | 00:15:28 INFO - TEST-INFO | 19962: exit 0 00:15:28 INFO - TEST-OK | kraken | took 61660ms 00:15:28 INFO - SUITE-END | took 1177s 00:15:28 INFO - Completed test suite (00:19:37) 00:15:28 INFO - javascript benchmark 00:15:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3046.741027012705, 3052.9084127476176, 3068.585740924975, 3098.5816914716534, 3111.7977331473453, 5208.687478751278, 5292.788288468457, 5327.973360133199, 5417.864553386167, 5452.236686863837, 5333.919991200135, 5343.278657381253, 5384.273123128377, 5411.107167317388, 5430.131179011359, 4758.928616070744, 4822.469528351879, 4841.370621819158, 4847.369841920546, 5003.549680528752, 4922.138625740499, 4971.602271818264, 4980.302757613937, 5003.374578177728, 5003.424606170301, 4765.404324459442, 4807.735574543399, 4876.122297986361, 4887.584555312803, 4931.038447502739, 4799.712017278975, 4816.951830481686, 4824.276358546211, 4876.341693871353, 4914.385701787277, 4807.591354734852, 4820.39745031871, 4827.686200396963, 4844.903101937976, 4871.780769865364, 5298.337707786527, 5305.0450918834595, 5351.0, 5432.511074003319, 5455.099908515091, 5673.46102120302, 5725.656460612377, 5727.885442291131, 5736.971315143439, 5748.540116790688, 5727.513161381287, 5738.254026976467, 5738.598298119134, 5743.10981797822, 5758.3665796762325, 5226.891922707052, 5310.601704872072, 5347.759350829183, 5366.034113859465, 5370.489803468742, 5897.616654917417, 5899.764009439575, 5901.498372638288, 5905.291365036223, 5963.284405871236, 5640.802571910045, 5643.266375371258, 5648.74580643872, 5659.122835960433, 5664.575156863251, 5616.971915140398, 5699.088145896637, 5756.222909907109, 5810.738516766755, 5811.912821307684, 5738.282714660668, 5738.426157384311, 5740.311162660508, 5744.396838331999, 5802.33273173582, 5700.144978253295, 5734.254546908875, 5748.798792042258, 5751.712414379264, 5757.769689212469, 4362.149380870763, 4440.511543730187, 4440.533743956838, 4460.219461594208, 4493.775311234425, 3938.5864484229314, 3947.703922205789, 3959.0300376407963, 4018.1963607278662, 4066.1867626474823, 5485.341758988867, 5494.917576236359, 5496.477834605706, 5496.560275177976, 5499.257600223918, 5767.336756273083, 5768.711564421846, 5818.592698511148, 5823.621464604787, 5836.766529338779, 5325.121354976385, 5394.973025134927, 5432.429594892558, 5481.643693159932, 5519.613627046148, 4972.279019542146, 5007.7245751484015, 5017.724025178651, 5018.071656743514, 5135.845924622267, 5947.583669143291, 6000.309964354068, 6002.459778619946, 6007.549433792483, 6008.969955150284, 5667.801626943037, 5749.0, 5788.507976822018, 5805.912911306249, 5891.911621325769, 5982.760689572368, 5983.102534619842, 5983.401659834156, 5989.700514974146, 5990.7004649768205, 5646.378898321099, 5650.547956163415, 5702.315722113373, 5713.314402271754, 5720.227769251098, 5604.271444712162, 5652.717364131695, 5695.857603559944, 5708.086706127, 5801.3038435388025, 5552.222688823487, 5579.553635709052, 5587.357453892691, 5590.664560126243, 5594.4125866785025, 5607.859803504782, 5610.438956104357, 5612.130119831432, 5621.044422448112, 5623.2127502148915, 5417.160340147126, 5500.312460942382, 5552.361478430033, 5567.749451274622, 5641.633293835887, 5622.409646987171, 5634.6337488063145, 5637.548996080386, 5647.519960803378, 5652.349979752216, 5479.835604931858, 5495.670259784426, 5496.285482887199, 5499.092649712753, 5511.641743286674], "value": 5301.35004561214, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.1460680607981, 586.6509426891, 598.5660396212744, 603.4990957505271, 606.7803714533786, 32017.359652806957, 44996.55003449965, 46059.769701151534, 46140.538594614125, 46285.76857115718, 45259.77370113153, 45547.544524554825, 45769.771151144196, 45781.31328030082, 45836.0, 8950.552472376372, 9086.454812711225, 9098.863517047217, 9106.590203440861, 9107.180353768159, 8899.866502002475, 8987.46075235488, 8991.41555798871, 8992.730218093468, 8999.865002024975, 9028.954855225715, 9072.954635226848, 9078.909210907872, 9082.273418126568, 9102.59038343273, 9004.234640055603, 9034.0, 9045.77385565366, 9056.275497960214, 9057.18485336323, 8862.955685221597, 8937.240334571568, 8944.508052057134, 8945.105489451067, 8947.32895032875, 43244.0, 43531.12937741259, 43622.56377436248, 43691.0, 43711.0, 3247.3342964692183, 3485.9651403486146, 3595.1910820065277, 3840.2127563849344, 3847.5382954045413, 32853.83573082143, 33037.6696233037, 33109.83445082783, 33119.172020699436, 33201.0, 4398.186335527906, 4462.843800466968, 4488.41650585425, 4626.953730462686, 4689.859304220879, 345423.0, 347775.09486029705, 351416.0, 351692.0, 352213.99999999744, 58725.706371468725, 58847.0, 58917.11624325639, 59032.11451828226, 59065.11402328969, 61915.38084619186, 61919.690401547705, 61951.38048619456, 61963.0, 62033.68983155055, 17234.310627575007, 17484.737728934077, 17494.387696430564, 17497.0, 17521.7371739424, 13679.726405472034, 13761.31193440344, 13763.31183440824, 13764.862351376558, 13767.793483097761, 15913.363465461483, 17335.56661083483, 17359.305627775, 17469.737953930446, 17493.212805423787, 5957.821265362046, 6071.635701857903, 6089.634621922699, 6223.993845938691, 6244.968775156186, 927.6289484206236, 994.5325696922434, 1042.6142327338932, 1070.5182667799522, 1083.669480808361, 31689.0, 31967.84016079951, 32253.0, 32763.836180818944, 32891.0, 1068.615298492542, 1078.4338222433284, 1090.575592639114, 1096.1942971915635, 1140.703417111557, 16437.58906027359, 16983.49049528516, 17060.914695426443, 17071.829281707272, 17286.481405557854, 507002.0, 514296.0, 515205.0, 520279.7902073409, 521653.0, 57962.420375796544, 58135.70932145312, 58180.4181958175, 58230.0, 58269.70865145647, 1199.1965383193108, 1317.6705823544114, 1331.5872079655337, 1348.858369871169, 1358.9524366646922, 31121.37757244797, 32744.0, 33006.17484562905, 33164.50253246252, 34074.488882667276, 50375.24437133373, 50584.0, 50609.49390506048, 50700.49299506958, 50732.23901641552, 402134.0, 404555.0, 405498.0, 406300.0, 406352.3647635331, 34950.82524587463, 35295.0, 40078.59921400749, 41415.0, 43629.12741745211, 46549.30176047294, 47179.52820471889, 47316.2902556455, 47374.763126184145, 47529.287060694805, 39494.21011579695, 39655.80172099121, 39835.80082099687, 41196.94015299163, 42211.3668294982, 39192.41211381774, 39794.0, 40374.39438408367, 41300.0, 41701.79149104235, 39436.40845387379, 39494.0, 40033.599664002984, 40054.1989160221, 40534.39198411967, 33094.83452582722, 36258.0, 37052.0, 37095.629043710294, 37285.62714372821, 27423.588646169923, 27592.448151037268, 27833.0, 27877.721222787513, 27883.44233115367], "value": 20225.03490700357, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.4080996884733, 390.39099005551327, 392.4603669953814, 403.29222215012646, 423.8516519218274, 13721.45114195431, 18318.900865948035, 20081.196752129916, 20097.698534521995, 21344.0, 16230.269637866295, 18853.434396968078, 19527.121279542418, 19721.40835774929, 20301.898490507563, 5674.460926212003, 5869.413058694139, 5873.765049398019, 5877.85305367365, 5899.174115623795, 5644.181593668915, 5756.913646295309, 5827.096799995987, 5829.300483941933, 5842.094475356326, 5888.5877988540815, 5890.852728681796, 5894.204282421882, 5894.263217097863, 5895.469407753301, 5606.775728970836, 5807.0, 5852.0, 5853.707314634273, 5855.502282306009, 5208.088584497736, 5214.7914083437, 5223.138182199932, 5229.921551176697, 5230.21546767984, 22800.201992930168, 23508.294751157493, 24067.879660601586, 24154.637680434807, 24250.272491825275, 2134.001727572763, 2316.224064938248, 2348.5068135691527, 2408.915687950931, 2501.3246423465744, 9141.268698504104, 10061.79876402468, 10375.584976600927, 10831.104556702545, 10897.509612067397, 1960.4314748722854, 1980.9405717828488, 1996.7919408757637, 2014.1037238428905, 2058.4030631116957, 74125.62937185279, 76087.61956190184, 76245.0, 81576.59211703904, 87175.0, 10803.405812680221, 10946.835797463045, 10974.725631859108, 11114.443977843108, 11342.319460832376, 15467.5359739208, 15481.458148964732, 15488.303026363841, 15494.450554944415, 15520.844791552166, 8101.351891848638, 8259.793505162419, 8319.168083191633, 8421.70524031656, 8562.0, 7841.4118941078505, 8028.157043510348, 8230.382721295926, 8239.876401853977, 8281.875771863426, 4277.2087163874785, 4350.891227719269, 4511.187986162457, 4601.4248218972625, 4643.976780116078, 1914.3295103330775, 1964.204497178645, 2029.1274751856547, 2049.40567235503, 2049.8872562009233, 928.5125309212582, 969.2536746704998, 975.6390135649855, 999.7050869993369, 1010.242318261304, 18848.434546963337, 19515.121819518157, 19557.217711291672, 19662.0, 19986.90006549958, 915.4141349536302, 944.7401964459691, 970.3256236915277, 971.8007808399261, 1032.5198782565992, 10450.007249311304, 10764.677059688222, 11038.503267352988, 11046.779064418828, 11084.113270938306, 450615.0, 486849.0, 492925.0, 493224.0, 495125.0, 89578.0, 94238.0, 94364.0, 94574.52712736392, 94927.52536237413, 948.6158105967095, 992.1417973452911, 1021.6883850425692, 1022.3610243597751, 1022.4274406332478, 16598.336066557204, 17002.48992530226, 17455.0, 17467.47597572075, 17478.12609369552, 40995.590044099175, 41620.79189604154, 41637.37543936904, 41765.58234417617, 42381.788091059345, 51544.74227628838, 52939.0, 53893.73053134709, 58363.4163658358, 58987.705061474415, 9154.633814647339, 9977.900220997988, 11652.475638596114, 12544.498220071095, 12596.496140154657, 13496.987725920399, 13828.446862125402, 14507.709845802814, 14705.705885882437, 15557.222138892783, 11928.0, 12386.5664701735, 12604.0, 12684.492620295085, 12738.490460381481, 12312.445939932546, 12471.750564988832, 12611.30637814929, 12658.746825063632, 13086.869131308566, 12455.688607784878, 13026.739465210832, 13056.477740890257, 13339.799903001656, 13409.865901341253, 12938.611841644766, 12979.935100324437, 13066.869331306565, 13161.47354105825, 13453.865461345653, 12524.248545087325, 12953.870461295643, 12964.935175324063, 13021.804672929724, 13295.401706923018], "value": 9507.747320706008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.5378117658818, 1387.3202130955835, 1405.7399381114492, 1451.3614009835671, 1785.4554360919922, 8544.316454683625, 8995.235404990575, 9004.72985810426, 9214.861777073333, 9219.723408297745, 8950.239229665487, 9129.178373946343, 9157.130072643105, 9158.358914875962, 9165.633374665005, 2174.5759576882515, 2299.540091981602, 2324.790768830805, 2327.173853282086, 2371.27676058802, 2450.0444826517582, 2471.9258422247362, 2488.639147323637, 2501.837380570257, 2508.059477695864, 2392.3181893160454, 2393.700787401575, 2406.2660888429023, 2409.7108346998384, 2452.7179374372, 2295.2884605772265, 2352.9647055294186, 2438.0247900839627, 2440.4021014851296, 2447.657327974076, 2441.340837973755, 2455.1038870812204, 2463.8275320727557, 2468.1731619907355, 2482.2677310193535, 9186.908130918671, 9239.769005774842, 9263.583138758771, 9268.073192680746, 9270.30472714549, 5378.0, 5522.420145884705, 5523.6409633374105, 5524.640898341635, 5527.170924361338, 3297.4394352960053, 3408.1820363112674, 3563.7861728296384, 3570.107473131717, 3591.084273510264, 1185.2296007595046, 1213.1992884696058, 2169.2082389927564, 2235.9888200559058, 2243.304575581575, 12256.44845981933, 12365.938170309091, 12400.56598019065, 12408.255504669658, 12410.255384676948, 4383.211022016068, 4598.126355992351, 4608.769561521911, 4776.331313616097, 4809.158397280462, 9666.323357364918, 9682.080202380763, 9687.2734544908, 9688.564014619358, 9690.321677482649, 5323.866903327448, 5325.9733701332025, 5326.041312563776, 5326.6537675050995, 5327.893442131136, 4574.382458368078, 4951.876203094951, 4986.750662466862, 5009.12340340439, 5036.194208926554, 3879.689624830007, 3892.9805350973065, 4017.2367250222364, 4040.939385909214, 4070.3894415837267, 1169.8245263210586, 1202.8015377462796, 1204.7530256297614, 1211.8182272659171, 1224.9020078393708, 937.8452555328431, 975.302658599105, 975.882894052704, 977.3012296208245, 996.242855429864, 5973.402659733992, 6018.578699490994, 6127.3566275540425, 6161.383861613803, 6235.469985051322, 487.4540514623573, 490.8699194713404, 499.6951859365784, 507.7258280528473, 508.9262057001714, 4165.45849039629, 4227.513835908849, 4366.825326986885, 4451.9554804451545, 4562.110388474282, 11225.158113141548, 11287.266327688674, 11392.088632909348, 11393.772124557463, 11488.425578721031, 11269.323840569592, 11287.322760634388, 11298.0, 11309.773804524028, 11325.773484530264, 7664.80837979055, 7956.7215147470715, 7961.323287520626, 8188.26305632484, 8285.54429506383, 6230.470410015199, 6243.282022567463, 6346.90479642815, 6364.268109167505, 6438.420542151229, 10263.84604230952, 10403.791924161324, 10423.322484038514, 10560.524776384927, 10586.523606437882, 10388.220883433622, 10511.159107271247, 10687.89312106869, 10734.677959661223, 10797.784044318912, 7864.134945155914, 7900.565468899265, 8064.3548516119745, 8068.757937261891, 8146.266835984789, 8545.786355341166, 8615.483071015758, 8619.482831030158, 8622.223999840044, 8625.654973800978, 7677.654505547375, 7769.805754856174, 7856.84286314282, 7950.16523265072, 8034.718784842503, 7120.216776154515, 7205.099362579677, 7357.8160545986775, 7423.480356375002, 7427.145878224073, 7082.610456424946, 7213.062301900719, 7213.495055346076, 7222.855542889218, 7227.819304517218, 5024.246363045426, 5059.696418214919, 5150.0987327216835, 5185.274061631299, 5213.947860521346, 5342.225377320345, 5386.919196211981, 5393.83818485446, 5470.945290547043, 5567.331920169606], "value": 4703.698150635322, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.35542147699755, 319.1240046073528, 323.70542806046495, 327.6166884744848, 330.1827975759994, 5268.341457317835, 5323.760430780614, 5334.706591137486, 5355.6251062425645, 5367.865803354918, 5210.4729206335, 5218.582513398919, 5315.521603055734, 5333.493318134781, 5333.826558157209, 3885.1064255221318, 3960.0, 3996.3206254936586, 3998.8000599969887, 4033.616806403387, 3687.575928768186, 4098.8360465581345, 4100.405441211023, 4117.155983023488, 4119.464469618945, 4073.959260407388, 4090.1389867610164, 4094.7133700640966, 4098.549159592442, 4114.177164567083, 3901.43429202764, 3959.46547216125, 4092.240336655252, 4115.691323150746, 4116.300228961069, 3590.5152804371337, 3598.3702852000797, 3612.963870361289, 3623.1123374773088, 3635.981820090909, 5089.236614507853, 5118.718470484122, 5135.124330375002, 5139.974300128475, 5154.587632989352, 4638.281066434674, 4641.559051890065, 4649.511801260886, 4691.366665500148, 4692.788824502905, 5508.394076651565, 5509.815389691235, 5510.421405752379, 5524.14375771756, 5531.419200983879, 3991.201759648082, 3992.680585553149, 3995.0411901143807, 4002.0995276062945, 4005.759654420715, 5163.483651634844, 5358.981793459269, 5644.391348465668, 5686.402927692574, 5730.570207234432, 4035.0, 4037.8586749464216, 4041.3937909313836, 4041.5958404159937, 4061.8375264989068, 4072.226277007359, 4082.9996650820144, 4094.7747873867224, 4101.2207680540605, 4101.815418306183, 4467.481056440761, 4671.813127474863, 4683.501279590567, 4684.578387945033, 4703.223968045234, 5477.67133971963, 5480.780768769205, 5483.8080667176455, 5488.451154884479, 5490.670559766427, 1398.6573289543924, 1412.6750847305177, 1415.4338264694204, 1415.7380884536394, 1422.615893708693, 823.2549542663899, 877.7279043496536, 882.9911700883038, 884.3853521802286, 888.7422647432302, 4680.2916935319045, 4689.366935463737, 4696.5577899492755, 4698.2952557116705, 4703.471371804178, 4915.861600203852, 4919.901601968012, 4923.48303428142, 4936.950630493649, 4983.92845538211, 4355.564443555619, 4723.31511930775, 4734.455537613149, 4751.0, 4785.449673287617, 2658.24240091573, 2662.640543526638, 2667.7999150063824, 2670.198940317936, 2676.2470581768584, 5146.614003949719, 5148.330717006766, 5150.0, 5173.482651734872, 5217.2695822584865, 4752.833650822205, 4985.750712464363, 5078.415982162099, 5078.669886457368, 5088.414832294334, 4998.375203099613, 5021.422536408287, 5032.496750325012, 5033.773480193473, 5034.546890779774, 4886.633502487257, 4896.828610998598, 4899.902001960012, 4913.729744864067, 4966.528179822911, 4804.42346918372, 4896.828610998598, 4904.6321525886415, 4941.591646380764, 4972.776225069808, 5155.587552995827, 5555.7499912504845, 5708.0, 5779.682117483579, 5796.768129274782, 4090.734102283342, 4119.237940980808, 4153.836925660819, 4178.080822219107, 4186.68599855006, 5566.165075238747, 5637.998510528703, 5651.954388438152, 5687.800926967702, 5721.170430287501, 5420.376656684532, 5434.619576629598, 5464.28964234647, 5469.562435005269, 5472.671639701631, 5431.185322201702, 5436.673799572039, 5486.324162811006, 5506.91739623898, 5552.278203833475, 5279.313689220377, 5484.314460692413, 5501.394846566955, 5521.0, 5530.668159910419, 5459.372172200247, 5471.398146203994, 5574.609777315549, 5587.944120558743, 5590.776368945197, 5399.487048730364, 5415.539679127318, 5456.809011684572, 5470.070088085115, 5475.835724928259], "value": 4054.0955021652003, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.342900958594, 723.5152447859934, 750.1036261667306, 771.7221800151945, 795.7493389582285, 15716.764248536267, 17100.572485687862, 17125.0, 17293.740593891085, 17335.82664173358, 15344.156071416068, 15472.303746331414, 15489.380424782996, 15496.922515387436, 15533.766993495106, 653.3923451190391, 767.8656235158853, 778.8792737125755, 786.1431040166218, 792.3067316098413, 796.928276455119, 798.9081255655586, 805.0862271322034, 809.7125520440247, 810.0360570920615, 849.1254008371387, 853.9829203415928, 854.2269246332079, 855.0, 859.8968123825118, 676.4757313082351, 838.9244967952914, 841.7180244618061, 842.9957850210772, 843.4939036578065, 606.2088973889117, 615.6275453350748, 615.9076138579204, 617.3641149615903, 618.9659568723719, 13043.0, 13205.471781128743, 13248.20510769357, 13266.800997985038, 13267.336633168303, 13876.722465550733, 14279.286035698173, 14700.632484187874, 14982.780983049348, 15088.321025553876, 13359.046109037403, 13425.39585718645, 13454.52909148175, 13473.124246923919, 13998.790018149735, 4440.156370289635, 4528.456585209763, 4544.636429085698, 4569.794359253841, 4651.465081515636, 55369.0, 80363.19636803615, 87339.56330218309, 89145.10854891498, 89261.55369223113, 11187.4965626547, 11190.38452885083, 11368.658940231806, 11402.94298528502, 11845.526178952918, 21567.35297941033, 21577.56844863094, 21598.78401215999, 21617.89191054066, 21628.4592885176, 8642.956785216034, 8687.34844886636, 8702.216800487986, 8825.867611985825, 8837.867431988525, 4462.419885414875, 4506.459224892968, 4548.249538826123, 4611.538846115362, 4627.745473998963, 3447.7414193935556, 3572.0534058474527, 3575.6781889630056, 3575.964240357563, 3578.856845726194, 613.408061220924, 616.4113271825396, 639.0988705924717, 652.1847690387016, 659.4032400677395, 664.4119953840885, 679.58205703492, 691.4502970138752, 692.1590267824516, 707.7204504220907, 9503.477308747946, 9504.0, 9522.714318570454, 9607.471589062528, 9769.364991275545, 660.92729799722, 664.7241394821192, 674.8932744251285, 714.7641278378122, 719.5790462579345, 4443.511213766483, 4559.361689363492, 4861.781219845116, 4919.508049195052, 4923.8276660316715, 82891.0, 98483.0, 129761.0, 130755.0, 132632.0, 93502.25990960286, 95108.0, 99030.0, 99379.50310248547, 99458.0, 85172.57413712892, 87538.56230718805, 88051.11948880558, 88221.0, 89038.0, 9538.0, 9763.707088787347, 9789.46157961319, 9883.85174222373, 9929.404235745878, 46390.304145438524, 51105.0, 51220.74389628028, 52494.73752631212, 52936.735316323175, 70230.0, 70836.0, 77653.61173194098, 77887.221127788, 77979.0, 12685.873141268468, 12757.617271481871, 12768.6807829805, 13406.530771423344, 13474.854637355542, 15344.30950607203, 15481.0, 15705.528834134995, 16079.75880361819, 16572.419965301156, 13212.273324967218, 13238.27189504548, 13505.392257348247, 13715.794263086262, 13721.176729396268, 13100.410481528164, 13151.671208219872, 13345.532906348231, 13784.310784460937, 13925.234112123526, 13069.934650326688, 13310.534131305745, 13349.599512014654, 13449.798253026016, 13915.443382264595, 11430.542778289107, 11550.48022838991, 11670.591529296435, 11766.58816941403, 11812.645620631394, 10039.0, 10236.283460157718, 11104.944475277573, 11798.941005294919, 11950.880491195325], "value": 7611.772598343156, "unit": "score"}], "name": "dromaeo_css", "value": 7272.827997717638, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 128.0, 111.0, 111.0, 109.0, 113.0, 111.0, 111.0, 111.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 117.0, 145.0, 173.0, 120.0, 149.0, 147.0, 133.0, 184.0, 118.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 161.0, 161.0, 162.0, 162.0, 163.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 180.0, 77.0, 77.0, 76.0, 77.0, 170.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 153.0, 82.0, 82.0, 81.0, 139.0, 82.0, 82.0, 144.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 118.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 53.0, 52.0, 53.0, 60.0, 53.0, 52.0, 53.0, 52.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 63.0, 62.0, 61.0, 63.0, 63.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 87.0, 82.0, 87.0, 78.0, 78.0, 82.0, 78.0, 80.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 130.0, 137.0, 141.0, 126.0, 123.0, 127.0, 137.0, 172.0, 135.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 166.0, 161.0, 162.0, 161.0, 159.0, 157.0, 160.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 64.0, 64.0, 69.0, 64.0, 65.0, 63.0, 63.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1531.6, "alertThreshold": 2.0}]} 00:15:28 INFO - Return code: 0 00:15:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:15:28 INFO - # TBPL SUCCESS # 00:15:28 INFO - Running post-action listener: _resource_record_post_action 00:15:28 INFO - [mozharness: 2016-09-01 07:15:28.956453Z] Finished run-tests step (success) 00:15:28 INFO - Running post-run listener: _resource_record_post_run 00:15:29 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 406646784; Read time: 208; Write time: 301024 00:15:29 INFO - TinderboxPrint: CPU usage
13.1% 00:15:29 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 208 00:15:29 INFO - TinderboxPrint: I/O write bytes / time
406,646,784 / 301,024 00:15:29 INFO - TinderboxPrint: CPU idle
8,281.1 (86.9%) 00:15:29 INFO - TinderboxPrint: CPU user
1,203.0 (12.6%) 00:15:29 INFO - TinderboxPrint: Swap in / out
0 / 0 00:15:29 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 118239232; Read time: 192; Write time: 132344 00:15:29 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 288407552; Read time: 0; Write time: 168680 00:15:29 INFO - Running post-run listener: _upload_blobber_files 00:15:29 INFO - Blob upload gear active. 00:15:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:15:29 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 00:15:29 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:15:29 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:15:29 INFO - (blobuploader) - INFO - Open directory for files ... 00:15:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:15:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:15:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:15:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:15:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:15:31 INFO - (blobuploader) - INFO - Done attempting. 00:15:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:15:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:15:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:15:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:15:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:15:35 INFO - (blobuploader) - INFO - Done attempting. 00:15:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:15:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:15:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:15:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:15:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:15:35 INFO - (blobuploader) - INFO - Done attempting. 00:15:35 INFO - (blobuploader) - INFO - Iteration through files over. 00:15:35 INFO - Return code: 0 00:15:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:15:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:15:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dee063087ed44edde4c92a00fa22a4cb1aba23a0b4d54697d77e1abe5e25977248333500cfe8daa7318caf6628fdca1082f0c5ccc127219783d4971f4442137d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b86e08aa21941e824e1c34c9ae14722d73b211ea6102a7e790756d047ebf020f7d2dcea479e5823cac9a051201e8f693590d755a3db4b1cf692397b8d39f9d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d3d439e402b7ff5f626a2bcfdcc5afd72e89a7486c85947cf25cea1295b6e7f4fca3c0a39316f0465da8cd84e9a56a5e9ef6fcba943b384a5f67d4d9cd0834f"} 00:15:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:15:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:15:35 INFO - Contents: 00:15:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dee063087ed44edde4c92a00fa22a4cb1aba23a0b4d54697d77e1abe5e25977248333500cfe8daa7318caf6628fdca1082f0c5ccc127219783d4971f4442137d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b86e08aa21941e824e1c34c9ae14722d73b211ea6102a7e790756d047ebf020f7d2dcea479e5823cac9a051201e8f693590d755a3db4b1cf692397b8d39f9d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d3d439e402b7ff5f626a2bcfdcc5afd72e89a7486c85947cf25cea1295b6e7f4fca3c0a39316f0465da8cd84e9a56a5e9ef6fcba943b384a5f67d4d9cd0834f"} 00:15:35 INFO - Running post-run listener: copy_logs_to_upload_dir 00:15:35 INFO - Copying logs to upload dir... 00:15:35 INFO - mkdir: /builds/slave/test/build/upload/logs 00:15:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.171814 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-01 00:15:35.007313) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 00:15:35.011169) ========= 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=cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dee063087ed44edde4c92a00fa22a4cb1aba23a0b4d54697d77e1abe5e25977248333500cfe8daa7318caf6628fdca1082f0c5ccc127219783d4971f4442137d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b86e08aa21941e824e1c34c9ae14722d73b211ea6102a7e790756d047ebf020f7d2dcea479e5823cac9a051201e8f693590d755a3db4b1cf692397b8d39f9d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d3d439e402b7ff5f626a2bcfdcc5afd72e89a7486c85947cf25cea1295b6e7f4fca3c0a39316f0465da8cd84e9a56a5e9ef6fcba943b384a5f67d4d9cd0834f"} build_url:https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/Am6SJUvWSXusVEMhyU9avA/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/Fx-Team/sha512/dee063087ed44edde4c92a00fa22a4cb1aba23a0b4d54697d77e1abe5e25977248333500cfe8daa7318caf6628fdca1082f0c5ccc127219783d4971f4442137d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b86e08aa21941e824e1c34c9ae14722d73b211ea6102a7e790756d047ebf020f7d2dcea479e5823cac9a051201e8f693590d755a3db4b1cf692397b8d39f9d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d3d439e402b7ff5f626a2bcfdcc5afd72e89a7486c85947cf25cea1295b6e7f4fca3c0a39316f0465da8cd84e9a56a5e9ef6fcba943b384a5f67d4d9cd0834f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 00:15:35.038710) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 00:15:35.039153) ========= 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=cbe409c6de289db6ac707de3000001d4-1472712894.192184-915559073 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-09-01 00:15:35.120769) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 00:15:35.121133) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 00:15:35.121451) ========= ========= Total master_lag: 0.17 =========