builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1471500291.65 results: success (0) buildid: 20160817203010 builduid: fa16ac8fbb3d4582932379b83e032517 revision: 3ebc785598eee4e31ff83b7cb859cb5b9c9147ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 23:04:51.650898) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 23:04:51.651341) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 23:04:51.651630) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 23:04:51.781277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 23:04:51.781590) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-17 23:04:52-- 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% 219M=0s 2016-08-17 23:04:52 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082188 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 23:04:51.880286) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 23:04:51.880644) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013785 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 23:04:51.929539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 23:04:51.929862) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3ebc785598eee4e31ff83b7cb859cb5b9c9147ce --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 3ebc785598eee4e31ff83b7cb859cb5b9c9147ce --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=d6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-17 23:04:52,942 truncating revision to first 12 chars 2016-08-17 23:04:52,942 Setting DEBUG logging. 2016-08-17 23:04:52,942 attempt 1/10 2016-08-17 23:04:52,942 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3ebc785598ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 23:04:53,258 unpacking tar archive at: fx-team-3ebc785598ee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660314 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 23:04:52.603326) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 23:04:52.603642) ========= script_repo_revision: 3ebc785598eee4e31ff83b7cb859cb5b9c9147ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 23:04:52.604079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 23:04:52.604359) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 23:04:52.615503) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-17 23:04:52.615783) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:04:53 INFO - MultiFileLogger online at 20160817 23:04:53 in /builds/slave/test 23:04:53 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:04:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:04:53 INFO - {'append_to_log': False, 23:04:53 INFO - 'base_work_dir': '/builds/slave/test', 23:04:53 INFO - 'blob_upload_branch': 'Fx-Team', 23:04:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:04:53 INFO - 'branch': 'Fx-Team', 23:04:53 INFO - 'buildbot_json_path': 'buildprops.json', 23:04:53 INFO - 'config_files': ('talos/linux_config.py',), 23:04:53 INFO - 'default_actions': ('clobber', 23:04:53 INFO - 'read-buildbot-config', 23:04:53 INFO - 'download-and-extract', 23:04:53 INFO - 'populate-webroot', 23:04:53 INFO - 'create-virtualenv', 23:04:53 INFO - 'install', 23:04:53 INFO - 'run-tests'), 23:04:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:04:53 INFO - 'download_minidump_stackwalk': True, 23:04:53 INFO - 'download_symbols': 'ondemand', 23:04:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:04:53 INFO - 'tooltool.py': '/tools/tooltool.py', 23:04:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:04:53 INFO - '/tools/misc-python/virtualenv.py')}, 23:04:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:04:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:04:53 INFO - 'installer_path': 'installer.exe', 23:04:53 INFO - 'log_level': 'info', 23:04:53 INFO - 'log_name': 'talos', 23:04:53 INFO - 'log_to_console': True, 23:04:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:04:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:04:53 INFO - 'opt_config_files': (), 23:04:53 INFO - 'pip_index': False, 23:04:53 INFO - 'sps_profile': False, 23:04:53 INFO - 'sps_profile_interval': 0, 23:04:53 INFO - 'suite': 'dromaeojs', 23:04:53 INFO - 'system_bits': '32', 23:04:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:04:53 INFO - 'title': 'talos-linux64-ix-034', 23:04:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:04:53 INFO - 'use_talos_json': True, 23:04:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:04:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:04:53 INFO - 'work_dir': 'build'} 23:04:53 INFO - [mozharness: 2016-08-18 06:04:53.716282Z] Running clobber step. 23:04:53 INFO - Running pre-action listener: _resource_record_pre_action 23:04:53 INFO - Running main action method: clobber 23:04:53 INFO - rmtree: /builds/slave/test/build 23:04:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:04:54 INFO - Running post-action listener: _resource_record_post_action 23:04:54 INFO - [mozharness: 2016-08-18 06:04:54.182538Z] Finished clobber step (success) 23:04:54 INFO - [mozharness: 2016-08-18 06:04:54.182640Z] Running read-buildbot-config step. 23:04:54 INFO - Running pre-action listener: _resource_record_pre_action 23:04:54 INFO - Running main action method: read_buildbot_config 23:04:54 INFO - Using buildbot properties: 23:04:54 INFO - { 23:04:54 INFO - "project": "", 23:04:54 INFO - "product": "firefox", 23:04:54 INFO - "script_repo_revision": "production", 23:04:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:04:54 INFO - "repository": "", 23:04:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:04:54 INFO - "buildid": "20160817203010", 23:04:54 INFO - "pgo_build": "True", 23:04:54 INFO - "basedir": "/builds/slave/test", 23:04:54 INFO - "buildnumber": 990, 23:04:54 INFO - "slavename": "talos-linux64-ix-034", 23:04:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:04:54 INFO - "platform": "ubuntu64_hw", 23:04:54 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:04:54 INFO - "branch": "fx-team", 23:04:54 INFO - "repo_path": "integration/fx-team", 23:04:54 INFO - "revision": "3ebc785598eee4e31ff83b7cb859cb5b9c9147ce", 23:04:54 INFO - "stage_platform": "linux64-pgo", 23:04:54 INFO - "builduid": "fa16ac8fbb3d4582932379b83e032517", 23:04:54 INFO - "slavebuilddir": "test" 23:04:54 INFO - } 23:04:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:04:54 INFO - Running post-action listener: _resource_record_post_action 23:04:54 INFO - [mozharness: 2016-08-18 06:04:54.185078Z] Finished read-buildbot-config step (success) 23:04:54 INFO - [mozharness: 2016-08-18 06:04:54.185167Z] Running download-and-extract step. 23:04:54 INFO - Running pre-action listener: _resource_record_pre_action 23:04:54 INFO - Running main action method: download_and_extract 23:04:54 INFO - mkdir: /builds/slave/test/build/tests 23:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:04:54 INFO - trying https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:04:54 INFO - Downloading https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/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:04:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/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:04:54 INFO - Downloaded 1361 bytes. 23:04:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:04:54 INFO - Using the following test package requirements: 23:04:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:04:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:04:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:04:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:54 INFO - u'jsshell-linux-x86_64.zip'], 23:04:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:04:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:04:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:04:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:04:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:04:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:04:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:04:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:04:54 INFO - trying https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:04:54 INFO - Downloading https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/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:04:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/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:04:55 INFO - Downloaded 21907534 bytes. 23:04:55 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:04:59 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:04:59 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:04:59 INFO - trying https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:04:59 INFO - Downloading https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/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:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/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:05:00 INFO - Downloaded 21907534 bytes. 23:05:00 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:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:05:05 INFO - trying https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:05:05 INFO - Downloading https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/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:05:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/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:05:06 INFO - Downloaded 14413981 bytes. 23:05:06 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:05:06 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:05:06 INFO - trying https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:05:06 INFO - Downloading https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/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:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/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:05:09 INFO - Downloaded 59603603 bytes. 23:05:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:05:09 INFO - mkdir: /builds/slave/test/properties 23:05:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:05:09 INFO - Writing to file /builds/slave/test/properties/build_url 23:05:09 INFO - Contents: 23:05:09 INFO - build_url:https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:05:10 INFO - Running post-action listener: _resource_record_post_action 23:05:10 INFO - Running post-action listener: set_extra_try_arguments 23:05:10 INFO - [mozharness: 2016-08-18 06:05:10.339747Z] Finished download-and-extract step (success) 23:05:10 INFO - [mozharness: 2016-08-18 06:05:10.339973Z] Running populate-webroot step. 23:05:10 INFO - Running pre-action listener: _resource_record_pre_action 23:05:10 INFO - Running main action method: populate_webroot 23:05:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:05:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:05:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:05:10 INFO - '--tppagecycles', 23:05:10 INFO - '7'], 23:05:10 INFO - 'tests': ['tsvgm']}}, 23:05:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:05:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:05:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:05:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:05:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:05:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:05:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:10 INFO - 'talos_options': ['--disable-e10s'], 23:05:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:10 INFO - 'talos_options': ['--disable-e10s'], 23:05:10 INFO - 'tests': ['damp', 'tps']}, 23:05:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:10 INFO - 'tests': ['damp', 'tps']}, 23:05:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:05:10 INFO - 'tests': ['dromaeo_dom']}, 23:05:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:05:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:05:10 INFO - 'tests': ['basic_compositor_video']}, 23:05:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:05:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:05:10 INFO - 'tests': ['a11yr', 23:05:10 INFO - 'ts_paint', 23:05:10 INFO - 'tpaint', 23:05:10 INFO - 'sessionrestore', 23:05:10 INFO - 'sessionrestore_no_auto_restore', 23:05:10 INFO - 'tabpaint']}, 23:05:10 INFO - 'other-e10s': {'tests': ['a11yr', 23:05:10 INFO - 'ts_paint', 23:05:10 INFO - 'tpaint', 23:05:10 INFO - 'sessionrestore', 23:05:10 INFO - 'sessionrestore_no_auto_restore', 23:05:10 INFO - 'tabpaint']}, 23:05:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:05:10 INFO - 'ts_paint', 23:05:10 INFO - 'tpaint', 23:05:10 INFO - 'sessionrestore', 23:05:10 INFO - 'sessionrestore_no_auto_restore', 23:05:10 INFO - 'tabpaint']}, 23:05:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:05:10 INFO - 'ts_paint', 23:05:10 INFO - 'tpaint', 23:05:10 INFO - 'sessionrestore', 23:05:10 INFO - 'sessionrestore_no_auto_restore', 23:05:10 INFO - 'tabpaint']}, 23:05:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:05:10 INFO - 'tests': ['a11yr', 23:05:10 INFO - 'ts_paint', 23:05:10 INFO - 'tpaint', 23:05:10 INFO - 'sessionrestore', 23:05:10 INFO - 'sessionrestore_no_auto_restore', 23:05:10 INFO - 'tabpaint']}, 23:05:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:05:10 INFO - 'tests': ['a11yr', 23:05:10 INFO - 'ts_paint', 23:05:10 INFO - 'tpaint', 23:05:10 INFO - 'sessionrestore', 23:05:10 INFO - 'sessionrestore_no_auto_restore', 23:05:10 INFO - 'tabpaint']}, 23:05:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:05:10 INFO - 'tests': ['tsvgx', 23:05:10 INFO - 'tsvgr_opacity', 23:05:10 INFO - 'tart', 23:05:10 INFO - 'tscrollx', 23:05:10 INFO - 'cart']}, 23:05:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:05:10 INFO - 'tsvgr_opacity', 23:05:10 INFO - 'tart', 23:05:10 INFO - 'tscrollx', 23:05:10 INFO - 'cart']}, 23:05:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:10 INFO - 'talos_options': ['--disable-e10s'], 23:05:10 INFO - 'tests': ['tp5o']}, 23:05:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:10 INFO - 'tests': ['tp5o']}, 23:05:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:10 INFO - 'talos_options': ['--disable-e10s', 23:05:10 INFO - '--xperf_path', 23:05:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:10 INFO - 'tests': ['tp5n']}, 23:05:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:10 INFO - 'talos_options': ['--xperf_path', 23:05:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:10 INFO - 'tests': ['tp5n']}}, 23:05:10 INFO - 'talos.zip': {'path': '', 23:05:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:05:10 INFO - Running post-action listener: _resource_record_post_action 23:05:10 INFO - [mozharness: 2016-08-18 06:05:10.356941Z] Finished populate-webroot step (success) 23:05:10 INFO - [mozharness: 2016-08-18 06:05:10.357030Z] Running create-virtualenv step. 23:05:10 INFO - Running pre-action listener: _resource_record_pre_action 23:05:10 INFO - Running main action method: create_virtualenv 23:05:10 INFO - Creating virtualenv /builds/slave/test/build/venv 23:05:10 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:05:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:05:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:05:10 INFO - Using real prefix '/usr' 23:05:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:05:10 INFO - Installing distribute.............................................................................................................................................................................................done. 23:05:12 INFO - Installing pip.................done. 23:05:12 INFO - Return code: 0 23:05:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8eeee60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768370>, '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 0x176b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176bd80>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', '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:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:05:12 INFO - Using env: {'DISPLAY': ':0', 23:05:12 INFO - 'HOME': '/home/cltbld', 23:05:12 INFO - 'LANG': 'en_US.UTF-8', 23:05:12 INFO - 'LANGUAGE': 'en_US:en', 23:05:12 INFO - 'LOGNAME': 'cltbld', 23:05:12 INFO - 'MAIL': '/var/mail/cltbld', 23:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:12 INFO - 'MOZ_NO_REMOTE': '1', 23:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:12 INFO - 'NO_EM_RESTART': '1', 23:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:12 INFO - 'PWD': '/builds/slave/test', 23:05:12 INFO - 'SHELL': '/bin/bash', 23:05:12 INFO - 'SHLVL': '1', 23:05:12 INFO - 'TERM': 'linux', 23:05:12 INFO - 'TMOUT': '86400', 23:05:12 INFO - 'USER': 'cltbld', 23:05:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', 23:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:12 INFO - '_': '/tools/buildbot/bin/python'} 23:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:13 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:05:13 INFO - Cleaning up... 23:05:13 INFO - Return code: 0 23:05:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:05: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:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05: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:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05: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', '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 0x7f8eeee60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768370>, '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 0x176b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176bd80>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', '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:05: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', 'psutil>=3.1.1'] in /builds/slave/test/build 23:05: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 psutil>=3.1.1 23:05:13 INFO - Using env: {'DISPLAY': ':0', 23:05:13 INFO - 'HOME': '/home/cltbld', 23:05:13 INFO - 'LANG': 'en_US.UTF-8', 23:05:13 INFO - 'LANGUAGE': 'en_US:en', 23:05:13 INFO - 'LOGNAME': 'cltbld', 23:05:13 INFO - 'MAIL': '/var/mail/cltbld', 23:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:13 INFO - 'MOZ_NO_REMOTE': '1', 23:05:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:13 INFO - 'NO_EM_RESTART': '1', 23:05:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:13 INFO - 'PWD': '/builds/slave/test', 23:05:13 INFO - 'SHELL': '/bin/bash', 23:05:13 INFO - 'SHLVL': '1', 23:05:13 INFO - 'TERM': 'linux', 23:05:13 INFO - 'TMOUT': '86400', 23:05:13 INFO - 'USER': 'cltbld', 23:05:13 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', 23:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:13 INFO - '_': '/tools/buildbot/bin/python'} 23:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:13 INFO - Downloading/unpacking psutil>=3.1.1 23:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:05:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:05:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:05:15 INFO - Installing collected packages: psutil 23:05:15 INFO - Running setup.py install for psutil 23:05:15 INFO - building 'psutil._psutil_linux' extension 23:05:15 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:05:15 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:05:15 INFO - building 'psutil._psutil_posix' extension 23:05:15 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:05:15 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:05:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:05:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:05:15 INFO - Successfully installed psutil 23:05:15 INFO - Cleaning up... 23:05:15 INFO - Return code: 0 23:05:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8eeee60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768370>, '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 0x176b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176bd80>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', '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:05:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:05:15 INFO - Using env: {'DISPLAY': ':0', 23:05:15 INFO - 'HOME': '/home/cltbld', 23:05:15 INFO - 'LANG': 'en_US.UTF-8', 23:05:15 INFO - 'LANGUAGE': 'en_US:en', 23:05:15 INFO - 'LOGNAME': 'cltbld', 23:05:15 INFO - 'MAIL': '/var/mail/cltbld', 23:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:15 INFO - 'MOZ_NO_REMOTE': '1', 23:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:15 INFO - 'NO_EM_RESTART': '1', 23:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:15 INFO - 'PWD': '/builds/slave/test', 23:05:15 INFO - 'SHELL': '/bin/bash', 23:05:15 INFO - 'SHLVL': '1', 23:05:15 INFO - 'TERM': 'linux', 23:05:15 INFO - 'TMOUT': '86400', 23:05:15 INFO - 'USER': 'cltbld', 23:05:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', 23:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:15 INFO - '_': '/tools/buildbot/bin/python'} 23:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:05:18 INFO - Installing collected packages: mozsystemmonitor 23:05:18 INFO - Running setup.py install for mozsystemmonitor 23:05:18 INFO - Successfully installed mozsystemmonitor 23:05:18 INFO - Cleaning up... 23:05:18 INFO - Return code: 0 23:05:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:05:18 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:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:18 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:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:18 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 0x7f8eeee60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768370>, '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 0x176b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176bd80>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', '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:05:18 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:05:18 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:05:18 INFO - Using env: {'DISPLAY': ':0', 23:05:18 INFO - 'HOME': '/home/cltbld', 23:05:18 INFO - 'LANG': 'en_US.UTF-8', 23:05:18 INFO - 'LANGUAGE': 'en_US:en', 23:05:18 INFO - 'LOGNAME': 'cltbld', 23:05:18 INFO - 'MAIL': '/var/mail/cltbld', 23:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:18 INFO - 'MOZ_NO_REMOTE': '1', 23:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:18 INFO - 'NO_EM_RESTART': '1', 23:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:18 INFO - 'PWD': '/builds/slave/test', 23:05:18 INFO - 'SHELL': '/bin/bash', 23:05:18 INFO - 'SHLVL': '1', 23:05:18 INFO - 'TERM': 'linux', 23:05:18 INFO - 'TMOUT': '86400', 23:05:18 INFO - 'USER': 'cltbld', 23:05:18 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', 23:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:18 INFO - '_': '/tools/buildbot/bin/python'} 23:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:18 INFO - Downloading/unpacking jsonschema==2.5.1 23:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:05:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:05:20 INFO - Downloading functools32-3.2.3-2.tar.gz 23:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:05:20 INFO - warning: no files found matching '*.txt' 23:05:20 INFO - no previously-included directories found matching 'build' 23:05:20 INFO - no previously-included directories found matching 'dist' 23:05:20 INFO - no previously-included directories found matching '.git*' 23:05:20 INFO - Installing collected packages: jsonschema, functools32 23:05:20 INFO - Running setup.py install for functools32 23:05:20 INFO - warning: no files found matching '*.txt' 23:05:20 INFO - no previously-included directories found matching 'build' 23:05:20 INFO - no previously-included directories found matching 'dist' 23:05:20 INFO - no previously-included directories found matching '.git*' 23:05:20 INFO - Successfully installed jsonschema functools32 23:05:20 INFO - Cleaning up... 23:05:21 INFO - Return code: 0 23:05:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:05: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:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05: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:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05: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 0x7f8eeee60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768370>, '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 0x176b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176bd80>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', '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:05: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:05: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:05:21 INFO - Using env: {'DISPLAY': ':0', 23:05:21 INFO - 'HOME': '/home/cltbld', 23:05:21 INFO - 'LANG': 'en_US.UTF-8', 23:05:21 INFO - 'LANGUAGE': 'en_US:en', 23:05:21 INFO - 'LOGNAME': 'cltbld', 23:05:21 INFO - 'MAIL': '/var/mail/cltbld', 23:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:21 INFO - 'MOZ_NO_REMOTE': '1', 23:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:21 INFO - 'NO_EM_RESTART': '1', 23:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:21 INFO - 'PWD': '/builds/slave/test', 23:05:21 INFO - 'SHELL': '/bin/bash', 23:05:21 INFO - 'SHLVL': '1', 23:05:21 INFO - 'TERM': 'linux', 23:05:21 INFO - 'TMOUT': '86400', 23:05:21 INFO - 'USER': 'cltbld', 23:05:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', 23:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:21 INFO - '_': '/tools/buildbot/bin/python'} 23:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:05:21 INFO - Cleaning up... 23:05:21 INFO - Return code: 0 23:05:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:05: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:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05: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:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05: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', '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 0x7f8eeee60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768370>, '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 0x176b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176bd80>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', '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:05: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:05: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 blobuploader==1.2.4 23:05:21 INFO - Using env: {'DISPLAY': ':0', 23:05:21 INFO - 'HOME': '/home/cltbld', 23:05:21 INFO - 'LANG': 'en_US.UTF-8', 23:05:21 INFO - 'LANGUAGE': 'en_US:en', 23:05:21 INFO - 'LOGNAME': 'cltbld', 23:05:21 INFO - 'MAIL': '/var/mail/cltbld', 23:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:21 INFO - 'MOZ_NO_REMOTE': '1', 23:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:21 INFO - 'NO_EM_RESTART': '1', 23:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:21 INFO - 'PWD': '/builds/slave/test', 23:05:21 INFO - 'SHELL': '/bin/bash', 23:05:21 INFO - 'SHLVL': '1', 23:05:21 INFO - 'TERM': 'linux', 23:05:21 INFO - 'TMOUT': '86400', 23:05:21 INFO - 'USER': 'cltbld', 23:05:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', 23:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:21 INFO - '_': '/tools/buildbot/bin/python'} 23:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:21 INFO - Downloading/unpacking blobuploader==1.2.4 23:05: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:05: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:05: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:05: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:05: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:05: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:05:23 INFO - Downloading blobuploader-1.2.4.tar.gz 23:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:05:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:05:23 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:05:23 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:05:23 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:05:23 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:05:23 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:05:23 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:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:05:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:05: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:05: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:05: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:05: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:05: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:05: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:05:24 INFO - Downloading docopt-0.6.1.tar.gz 23:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:05:24 INFO - Installing collected packages: blobuploader, requests, docopt 23:05:24 INFO - Running setup.py install for blobuploader 23:05:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:05:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:05:24 INFO - Running setup.py install for requests 23:05:24 INFO - Running setup.py install for docopt 23:05:24 INFO - Successfully installed blobuploader requests docopt 23:05:24 INFO - Cleaning up... 23:05:24 INFO - Return code: 0 23:05:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:24 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 0x7f8eeee60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768370>, '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 0x176b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176bd80>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', '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:05:24 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:05:24 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:05:24 INFO - Using env: {'DISPLAY': ':0', 23:05:24 INFO - 'HOME': '/home/cltbld', 23:05:24 INFO - 'LANG': 'en_US.UTF-8', 23:05:24 INFO - 'LANGUAGE': 'en_US:en', 23:05:24 INFO - 'LOGNAME': 'cltbld', 23:05:24 INFO - 'MAIL': '/var/mail/cltbld', 23:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:24 INFO - 'MOZ_NO_REMOTE': '1', 23:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:24 INFO - 'NO_EM_RESTART': '1', 23:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:24 INFO - 'PWD': '/builds/slave/test', 23:05:24 INFO - 'SHELL': '/bin/bash', 23:05:24 INFO - 'SHLVL': '1', 23:05:24 INFO - 'TERM': 'linux', 23:05:24 INFO - 'TMOUT': '86400', 23:05:24 INFO - 'USER': 'cltbld', 23:05:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', 23:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:24 INFO - '_': '/tools/buildbot/bin/python'} 23:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:05:25 INFO - Running setup.py (path:/tmp/pip-epLjdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:05:25 INFO - Running setup.py (path:/tmp/pip-bssJ2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:05:25 INFO - Running setup.py (path:/tmp/pip-YrO7oY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:05:25 INFO - Running setup.py (path:/tmp/pip-EwmAp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:05:25 INFO - Running setup.py (path:/tmp/pip-d6BjJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:05:25 INFO - Running setup.py (path:/tmp/pip-vWavTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:05:25 INFO - Running setup.py (path:/tmp/pip-jW2WoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:05:25 INFO - Running setup.py (path:/tmp/pip-6cIK2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:05:25 INFO - Running setup.py (path:/tmp/pip-_fHVE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:05:25 INFO - Running setup.py (path:/tmp/pip-EbNjtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:05:25 INFO - Running setup.py (path:/tmp/pip-GIWVNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:05:25 INFO - Running setup.py (path:/tmp/pip-z2l879-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:05:26 INFO - Running setup.py (path:/tmp/pip-ccPJFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:05:26 INFO - Running setup.py (path:/tmp/pip-M7r44m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:05:26 INFO - Running setup.py (path:/tmp/pip-lSmhVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:05:26 INFO - Running setup.py (path:/tmp/pip-FclEmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:05:26 INFO - Running setup.py (path:/tmp/pip-le_1oB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:05:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:05:26 INFO - Running setup.py install for manifestparser 23:05:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:05:26 INFO - Running setup.py install for mozcrash 23:05:26 INFO - Running setup.py install for mozdebug 23:05:26 INFO - Running setup.py install for mozdevice 23:05:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:05:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:05:26 INFO - Running setup.py install for mozfile 23:05:26 INFO - Running setup.py install for mozhttpd 23:05:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:05:26 INFO - Running setup.py install for mozinfo 23:05:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:05:27 INFO - Running setup.py install for mozInstall 23:05:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:05:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:05:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:05:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:05:27 INFO - Running setup.py install for mozleak 23:05:27 INFO - Running setup.py install for mozlog 23:05:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:05:27 INFO - Running setup.py install for moznetwork 23:05:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:05:27 INFO - Running setup.py install for mozprocess 23:05:27 INFO - Running setup.py install for mozprofile 23:05:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:05:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:05:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:05:27 INFO - Running setup.py install for mozrunner 23:05:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:05:27 INFO - Running setup.py install for mozscreenshot 23:05:27 INFO - Running setup.py install for moztest 23:05:28 INFO - Running setup.py install for mozversion 23:05:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:05:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:05:28 INFO - Cleaning up... 23:05:28 INFO - Return code: 0 23:05:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:05: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:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05: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:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05: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 0x7f8eeee60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768370>, '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 0x176b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176bd80>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', '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:05: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:05: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:05:28 INFO - Using env: {'DISPLAY': ':0', 23:05:28 INFO - 'HOME': '/home/cltbld', 23:05:28 INFO - 'LANG': 'en_US.UTF-8', 23:05:28 INFO - 'LANGUAGE': 'en_US:en', 23:05:28 INFO - 'LOGNAME': 'cltbld', 23:05:28 INFO - 'MAIL': '/var/mail/cltbld', 23:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:28 INFO - 'MOZ_NO_REMOTE': '1', 23:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:28 INFO - 'NO_EM_RESTART': '1', 23:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:28 INFO - 'PWD': '/builds/slave/test', 23:05:28 INFO - 'SHELL': '/bin/bash', 23:05:28 INFO - 'SHLVL': '1', 23:05:28 INFO - 'TERM': 'linux', 23:05:28 INFO - 'TMOUT': '86400', 23:05:28 INFO - 'USER': 'cltbld', 23:05:28 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', 23:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:28 INFO - '_': '/tools/buildbot/bin/python'} 23:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:05:28 INFO - Running setup.py (path:/tmp/pip-1_H3CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:05:28 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:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:05:28 INFO - Running setup.py (path:/tmp/pip-EoatGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:05:28 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:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:05:28 INFO - Running setup.py (path:/tmp/pip-OaS7Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:05:28 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:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:05:28 INFO - Running setup.py (path:/tmp/pip-XAmRO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:05:28 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:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:05:28 INFO - Running setup.py (path:/tmp/pip-h5rADs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:05:28 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:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:05:28 INFO - Running setup.py (path:/tmp/pip-1ecK6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:05:28 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:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:05:28 INFO - Running setup.py (path:/tmp/pip-NAZb1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:05:28 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:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:05:28 INFO - Running setup.py (path:/tmp/pip-Za5EOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:05:28 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:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:05:28 INFO - Running setup.py (path:/tmp/pip-BoX1mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:05: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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:05:29 INFO - Running setup.py (path:/tmp/pip-VV_jAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:05: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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:05:29 INFO - Running setup.py (path:/tmp/pip-BmNrg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:05: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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:05:29 INFO - Running setup.py (path:/tmp/pip-Y_o7Lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:05:29 INFO - Running setup.py (path:/tmp/pip-SsD0sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:05:29 INFO - Running setup.py (path:/tmp/pip-V7A1Az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:05:29 INFO - Running setup.py (path:/tmp/pip-Fof4Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:05:29 INFO - Running setup.py (path:/tmp/pip-LhL7D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:05:29 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:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:05:29 INFO - Running setup.py (path:/tmp/pip-12H7nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:05:29 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:05:29 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:05:29 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:05:29 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:05:29 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:05:29 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:05:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:05:29 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:05:29 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:05:29 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:05:29 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:05:29 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:05:29 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:05:32 INFO - Downloading blessings-1.6.tar.gz 23:05:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:05:32 INFO - Installing collected packages: blessings 23:05:32 INFO - Running setup.py install for blessings 23:05:32 INFO - Successfully installed blessings 23:05:32 INFO - Cleaning up... 23:05:32 INFO - Return code: 0 23:05:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:05:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:05:32 INFO - Reading from file tmpfile_stdout 23:05:32 INFO - Current package versions: 23:05:32 INFO - argparse == 1.2.1 23:05:32 INFO - blessings == 1.6 23:05:32 INFO - blobuploader == 1.2.4 23:05:32 INFO - docopt == 0.6.1 23:05:32 INFO - functools32 == 3.2.3-2 23:05:32 INFO - jsonschema == 2.5.1 23:05:32 INFO - manifestparser == 1.1 23:05:32 INFO - mozInstall == 1.12 23:05:32 INFO - mozcrash == 0.17 23:05:32 INFO - mozdebug == 0.1 23:05:32 INFO - mozdevice == 0.48 23:05:32 INFO - mozfile == 1.2 23:05:32 INFO - mozhttpd == 0.7 23:05:32 INFO - mozinfo == 0.9 23:05:32 INFO - mozleak == 0.1 23:05:32 INFO - mozlog == 3.3 23:05:32 INFO - moznetwork == 0.27 23:05:32 INFO - mozprocess == 0.23 23:05:32 INFO - mozprofile == 0.28 23:05:32 INFO - mozrunner == 6.12 23:05:32 INFO - mozscreenshot == 0.1 23:05:32 INFO - mozsystemmonitor == 0.3 23:05:32 INFO - moztest == 0.7 23:05:32 INFO - mozversion == 1.4 23:05:32 INFO - psutil == 3.1.1 23:05:32 INFO - requests == 1.2.3 23:05:32 INFO - wsgiref == 0.1.2 23:05:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:05: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:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05: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:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05: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 0x7f8eeee60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768370>, '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 0x176b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176bd80>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', '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:05: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:05: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:05:32 INFO - Using env: {'DISPLAY': ':0', 23:05:32 INFO - 'HOME': '/home/cltbld', 23:05:32 INFO - 'LANG': 'en_US.UTF-8', 23:05:32 INFO - 'LANGUAGE': 'en_US:en', 23:05:32 INFO - 'LOGNAME': 'cltbld', 23:05:32 INFO - 'MAIL': '/var/mail/cltbld', 23:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:32 INFO - 'MOZ_NO_REMOTE': '1', 23:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:32 INFO - 'NO_EM_RESTART': '1', 23:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:32 INFO - 'PWD': '/builds/slave/test', 23:05:32 INFO - 'SHELL': '/bin/bash', 23:05:32 INFO - 'SHLVL': '1', 23:05:32 INFO - 'TERM': 'linux', 23:05:32 INFO - 'TMOUT': '86400', 23:05:32 INFO - 'USER': 'cltbld', 23:05:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', 23:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:32 INFO - '_': '/tools/buildbot/bin/python'} 23:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:33 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:05:33 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:05:33 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:05:33 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:05:33 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:05:33 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:05:33 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:05:33 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:05:33 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:05:33 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:05:33 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:05:33 INFO - Cleaning up... 23:05:33 INFO - Return code: 0 23:05:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:05:33 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:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05:33 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:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:05: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 0x7f8eeee60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1768370>, '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 0x176b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176bd80>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', '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:05: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:05: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:05:33 INFO - Using env: {'DISPLAY': ':0', 23:05:33 INFO - 'HOME': '/home/cltbld', 23:05:33 INFO - 'LANG': 'en_US.UTF-8', 23:05:33 INFO - 'LANGUAGE': 'en_US:en', 23:05:33 INFO - 'LOGNAME': 'cltbld', 23:05:33 INFO - 'MAIL': '/var/mail/cltbld', 23:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:33 INFO - 'MOZ_NO_REMOTE': '1', 23:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:33 INFO - 'NO_EM_RESTART': '1', 23:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:33 INFO - 'PWD': '/builds/slave/test', 23:05:33 INFO - 'SHELL': '/bin/bash', 23:05:33 INFO - 'SHLVL': '1', 23:05:33 INFO - 'TERM': 'linux', 23:05:33 INFO - 'TMOUT': '86400', 23:05:33 INFO - 'USER': 'cltbld', 23:05:33 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', 23:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:33 INFO - '_': '/tools/buildbot/bin/python'} 23:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:05:33 INFO - Cleaning up... 23:05:33 INFO - Return code: 0 23:05:33 INFO - Running post-action listener: _resource_record_post_action 23:05:33 INFO - Running post-action listener: _start_resource_monitoring 23:05:33 INFO - Starting resource monitoring. 23:05:33 INFO - [mozharness: 2016-08-18 06:05:33.377133Z] Finished create-virtualenv step (success) 23:05:33 INFO - [mozharness: 2016-08-18 06:05:33.378198Z] Running install step. 23:05:33 INFO - Running pre-action listener: _resource_record_pre_action 23:05:33 INFO - Running main action method: install 23:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:05:33 INFO - Reading from file tmpfile_stdout 23:05:33 INFO - Detecting whether we're running mozinstall >=1.0... 23:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:05:33 INFO - Reading from file tmpfile_stdout 23:05:33 INFO - Output received: 23:05:33 INFO - Usage: mozinstall [options] installer 23:05:33 INFO - Options: 23:05:33 INFO - -h, --help show this help message and exit 23:05:33 INFO - -d DEST, --destination=DEST 23:05:33 INFO - Directory to install application into. [default: 23:05:33 INFO - "/builds/slave/test"] 23:05:33 INFO - --app=APP Application being installed. [default: firefox] 23:05:33 INFO - mkdir: /builds/slave/test/build/application 23:05: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:05: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:05:50 INFO - Reading from file tmpfile_stdout 23:05:50 INFO - Output received: 23:05:50 INFO - /builds/slave/test/build/application/firefox/firefox 23:05:50 INFO - Running post-action listener: _resource_record_post_action 23:05:50 INFO - [mozharness: 2016-08-18 06:05:50.658842Z] Finished install step (success) 23:05:50 INFO - [mozharness: 2016-08-18 06:05:50.659089Z] Running run-tests step. 23:05:50 INFO - Running pre-action listener: _resource_record_pre_action 23:05:50 INFO - Running main action method: run_tests 23:05:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:05:50 INFO - Python 2.7.3 23:05:50 INFO - Return code: 0 23:05:50 INFO - grabbing minidump binary from tooltool 23:05: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:05: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 0x1768370>, '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 0x176b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x176bd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:05: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:05: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:05: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:05:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:05:50 INFO - Return code: 0 23:05:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:05:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:05:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:05:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:05:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:05: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/GMTr4iMxS7KZkjBCyAHqoA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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:05: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/GMTr4iMxS7KZkjBCyAHqoA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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:05:50 INFO - Using env: {'DISPLAY': ':0', 23:05:50 INFO - 'HOME': '/home/cltbld', 23:05:50 INFO - 'LANG': 'en_US.UTF-8', 23:05:50 INFO - 'LANGUAGE': 'en_US:en', 23:05:50 INFO - 'LOGNAME': 'cltbld', 23:05:50 INFO - 'MAIL': '/var/mail/cltbld', 23:05:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:05:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:05:50 INFO - 'MOZ_NO_REMOTE': '1', 23:05:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:05:50 INFO - 'NO_EM_RESTART': '1', 23:05:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:05:50 INFO - 'PWD': '/builds/slave/test', 23:05:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:05:50 INFO - 'SHELL': '/bin/bash', 23:05:50 INFO - 'SHLVL': '1', 23:05:50 INFO - 'TERM': 'linux', 23:05:50 INFO - 'TMOUT': '86400', 23:05:50 INFO - 'USER': 'cltbld', 23:05:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259', 23:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:05:50 INFO - '_': '/tools/buildbot/bin/python'} 23:05: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/GMTr4iMxS7KZkjBCyAHqoA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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:05:50 INFO - mozversion application_buildid: 20160817203010 23:05:50 INFO - mozversion application_changeset: 3ebc785598eee4e31ff83b7cb859cb5b9c9147ce 23:05:50 INFO - mozversion application_display_name: Nightly 23:05:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:05:50 INFO - mozversion application_name: Firefox 23:05:50 INFO - mozversion application_remotingname: firefox 23:05:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:05:50 INFO - mozversion application_vendor: Mozilla 23:05:50 INFO - mozversion application_version: 51.0a1 23:05:50 INFO - mozversion platform_buildid: 20160817203010 23:05:50 INFO - mozversion platform_changeset: 3ebc785598eee4e31ff83b7cb859cb5b9c9147ce 23:05:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:05:50 INFO - mozversion platform_version: 51.0a1 23:05:50 INFO - using testdate: 1471500350 23:05:50 INFO - actual date: 1471500350 23:05:50 INFO - starting webserver on 'localhost:33016' 23:05:50 INFO - SUITE-START | Running 2 tests 23:05:50 INFO - TEST-START | dromaeo_css 23:05:50 INFO - operating with platform_type : linux_ 23:05:50 INFO - Initialising browser for dromaeo_css test... 23:05:50 INFO - TEST-INFO | started process 15365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Qy1Ze/profile http://localhost:33016/getInfo.html) 23:05:54 INFO - PROCESS | 15365 | __metrics Screen width/height:1600/1200 23:05:54 INFO - PROCESS | 15365 | colorDepth:24 23:05:54 INFO - PROCESS | 15365 | Browser inner width/height: 1024/697 23:05:54 INFO - PROCESS | 15365 | __metrics 23:05:55 INFO - PROCESS | 15365 | 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:05:55 INFO - PROCESS | 15365 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:05:56 INFO - PROCESS | 15365 | console.error: PushService: 23:05:56 INFO - PROCESS | 15365 | stateChangeProcessEnqueue: Error transitioning state 23:05:56 INFO - PROCESS | 15365 | UnknownError 23:05:56 INFO - TEST-INFO | 15365: exit 0 23:05:56 INFO - Browser initialized. 23:05:56 INFO - Running cycle 1/1 for dromaeo_css test... 23:05:56 INFO - TEST-INFO | started process 15446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Qy1Ze/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:06:08 INFO - PROCESS | 15446 | RSS: Main: 155639808 23:06:08 INFO - PROCESS | 15446 | 23:07:00 INFO - PROCESS | 15446 | 1471500419999 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:09:09 INFO - PROCESS | 15446 | Cycle 1(1): loaded http://localhost:33016/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33016/tests/dromaeo/cssquery-ext.html) 23:09:10 INFO - PROCESS | 15446 | RSS: Main: 249888768 23:09:10 INFO - PROCESS | 15446 | 23:12:13 INFO - PROCESS | 15446 | Cycle 1(1): loaded http://localhost:33016/tests/dromaeo/cssquery-ext.html (next: http://localhost:33016/tests/dromaeo/cssquery-jquery.html) 23:12:13 INFO - PROCESS | 15446 | RSS: Main: 243474432 23:12:13 INFO - PROCESS | 15446 | 23:15:15 INFO - PROCESS | 15446 | Cycle 1(1): loaded http://localhost:33016/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33016/tests/dromaeo/cssquery-mootools.html) 23:15:16 INFO - PROCESS | 15446 | RSS: Main: 188125184 23:15:16 INFO - PROCESS | 15446 | 23:18:18 INFO - PROCESS | 15446 | Cycle 1(1): loaded http://localhost:33016/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33016/tests/dromaeo/cssquery-prototype.html) 23:18:19 INFO - PROCESS | 15446 | RSS: Main: 186449920 23:18:19 INFO - PROCESS | 15446 | 23:21:21 INFO - PROCESS | 15446 | Cycle 1(1): loaded http://localhost:33016/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33016/tests/dromaeo/cssquery-yui.html) 23:21:22 INFO - PROCESS | 15446 | RSS: Main: 188862464 23:21:22 INFO - PROCESS | 15446 | 23:24:25 INFO - PROCESS | 15446 | Cycle 1(1): loaded http://localhost:33016/tests/dromaeo/cssquery-yui.html (next: http://localhost:33016/tests/dromaeo/cssquery-dojo.html) 23:24:25 INFO - PROCESS | 15446 | RSS: Main: 258027520 23:24:25 INFO - PROCESS | 15446 | 23:24:25 INFO - PROCESS | 15446 | __start_tp_report 23:24:25 INFO - PROCESS | 15446 | _x_x_mozilla_page_load 23:24:25 INFO - PROCESS | 15446 | _x_x_mozilla_page_load_details 23:24:25 INFO - PROCESS | 15446 | |i|pagename|runs| 23:24:25 INFO - PROCESS | 15446 | |0;dojo.html;2957.6598691150516;2977.211039074647;2986.372861699043;3002.7747918906075;3003.1140813460015;5067.366579177603;5091.15995860683;5123.282740416335;5225.764840582174;5226.137687281594;5168.7415629218485;5181.533661970422;5224.660397074187;5245.527902488775;5271.051210782058;4699.436067671884;4707.7175369477945;4823.927641085386;4837.540433658797;4868.805247790102;4828.203346447849;4872.366592342991;4878.804847806084;4890.046440944017;4907.950920490803;4669.4630117536235;4723.291506274052;4777.832775852863;4791.3531673224015;4840.298156767267;4680.742559159245;4698.4361876574685;4704.45898721648;4771.6898401603785;4850.684705494132;4706.95293047072;4739.715617062952;4742;4787.497312782142;4789.066132104241;5077.441481437039;5119.38567371914;5195.714235717034;5196.29849970253;5236.031334203185;5546.389897111315;5583;5609.3268807742925;5623.775048998076;5630.380658127603;5623.353314368859;5643.238162848004;5661.1508273758855;5671.234383358235;5672.432756724335;5085.516875896784;5174.223866419992;5221.13851214553;5284.260203571503;5287;5702.2301989231755;5706.172604972256;5749.511291540182;5749.741261643152;5755.050416681284;5512.448755124456;5540.418256083134;5552.056150454432;5556.194351818964;5558.44415558441;5362;5466.726663666801;5505.256790333334;5558.749856256478;5608.018596745554;5497.065498865202;5510.090835012258;5513.476219759196;5564.972175139179;5565.526930210977;5474.479924407175;5518.558515318765;5529.391766905637;5535.363433205152;5538.556915446755;4232.238197124486;4238.0888109056705;4279.614834664895;4305.74165550068;4341.6526677865695;3828.406596977473;3828.48315477407;3855.306044911943;3864.091938394475;3877.7673339599714;5230.947690523122;5242.16125419931;5246.97376513115;5288.180332048539;5296.09966305729;5442.074847275972;5487.067198576252;5537.418571050062;5546.334439867161;5558;5285.048691235615;5314.946850531523;5324.5740340772645;5334.813281535127;5342.599305052059;4762.476127625959;4773.76131193439;4774.880627984328;4776.068666610047;4823.1800593899125;5670.631408958405;5837.532997360286;5843;5846.444587764241;5864.2083318752275;5481.479259470344;5530.529904957963;5552.861178470571;5588.832335029955;5626.099824028136;5723.542116630576;5787.56593255516;5796.1305804129715;5798.94201057984;5810.854728631649;5432.348118225838;5465.043617366865;5466.753996070107;5470.042742519963;5482.259894914295;5382.3541175059245;5537.5569954404355;5553.972230138985;5579.832605021856;5639.689817059937;5504.422035686355;5513.558915286687;5517.475839795213;5520.1443776214755;5523.696196709059;5480.917786233289;5490.286262785812;5492.5331346835965;5494.697791621499;5533.806316779054;5311.814086506954;5403.9459605403445;5459.535939445192;5466.835994920159;5552.69460179694;5525.530329922001;5542.944570554404;5571.526420254162;5585.609007369445;5594.664320140804;5228.71242081674;5387.75755091014;5401.189821526802;5413.945860541344;5424.430434804289 23:24:25 INFO - PROCESS | 15446 | |1;ext.html;568.9971550142249;592.3691268798727;599.0534954771459;608.6895683201568;612.7469325229904;32748.83625581872;41706.79146604267;43140.78429607856;43153.56846431535;46158.30762538556;45365.773171134184;45727.085458290814;45751;45776.542234577646;45802.083958320814;8099.919000810005;8827.382083254159;8979.371443998923;8994.325425593073;9001.50491722955;8093.919060809405;8400.873986890201;8401.453905496153;10534.947325263363;10818.513166907469;10918;10922.890771092307;10932.234743567953;10975.451227438596;10976.560937562488;10766.24636275461;10833.349999000086;10845.240833141645;10854;10861.40262285574;10776.353418794819;10790.946045269802;10821.783564328747;10827.296225745302;10838.349699018085;42059.36910946338;42301.1539769206;42318.78840605777;42459.36310955338;42477.362839557434;3237.8866739664236;3449.5170676105367;3462.79223246606;3757.718171137148;3841.615838416164;31611;32117.35765284681;33152.50271245933;33215.501767473506;33255;4341.80461879213;4378.6934914555995;4406.25093734066;4409.7873084901585;4618.699784513996;342236;343281;344595;344777;345021.27489362645;52317.7384113077;52407.21389179165;52500.474995249555;52515.474845251825;52535;35572.731272247496;36691.26617467689;36782.816085919934;38433;59652;16238;16337.67324653524;16382;16382.262798174112;16383.754243686355;9793.559289831976;11614.477348519336;11614.825777613343;11645.883541164649;11651.475683594259;18453.446396608124;18849.680522363302;18905.7164142538;19119.617607647768;19404.320848770225;7071.297587104518;7078.338068536411;7195.8560828784175;7353.852922941511;7465.402767778564;1030.3817709374316;1030.6907927621683;1113.2374323588367;1124.2973141786383;1142.5772464188303;33279.849645858245;33587.83206083954;33645.32709345848;33746.83126584352;34097.65902340994;1127.8421021057059;1128.4357821089454;1129.8079326514512;1132.796096702585;1149.0864762513822;16371.508854734377;17488.387906423213;17604.504010761746;17605.64788704219;17859.196336164903;536344;573543;586925;587119;882946;59880.40119598836;60277.69861150754;60310;60398;60518.697406513566;1241.9565315213924;1369.9315034248448;1375.9243241621807;1385.0789225165151;1393.909395889264;29103.563446547894;34201.80293689709;34224.486632700035;34267.4859877107;34663.653363466045;50168.24747628716;50767.49232507627;50798.49201507938;50846;50890.23664644959;416362;419214;419599;419731;420902;25543.6168457477;28237.858810705817;28833.56749648715;29670.703292966795;29927.401451970403;42176;46723.76638116924;46879;47013.76493117512;47246;40161.799191003855;40321.39517907175;40500.332322207476;41422.58577414187;41848.58151418569;40302.798486007385;40453.595464044985;40886.18227635371;41925.371119432624;42000.369994449495;40959.59040409558;42098.368524471545;42883;42899;42911.78544107259;33931;36559.63440365669;36694.633053669124;36837.81581092077;37642.811785940896;28093.719062809112;28157;35216.64783352134;35609.28781424409;36180.55277788859 23:24:25 INFO - PROCESS | 15446 | |2;jquery.html;386.4705353665479;386.9148787266804;398.91423343981046;401.95176578810543;420.4045646770506;12929.418176182071;19492.317768878092;20250.29123980661;20257;20434;15639.92180039101;16035.599110022255;16953.32186712533;19831.5042123947;20151;5700.629459085157;5729.484346408823;5857.970710146444;5862.4430679085635;5879.735411906475;5902.468777809996;6018.3981601839905;6066.848328791793;6068.969655151718;6071.1803906472505;5862.267216597926;5944.64332140073;5953.43442372976;6063.848403789919;6071.78748743794;5946.97026514869;6008.969955150218;6041.969790151021;6046.365131661156;6046.848828779316;5691.686957217351;5866.501347385477;5905.4094590541035;5928.614640048383;5929.555283353766;14363.210023448706;14454.205018724071;14582.343794529272;14582.927085364612;14690.485832995793;2303.389601755536;2318.501522172741;2320.385097949045;2845.2460098074025;2877.323828900207;9850.408975461423;10211.540480678388;10591.470426478721;10760.3543787373;10869.565217391295;1941.4272789527124;1974.6544354738007;1980.6830907054946;2010.1758279105643;2046.171300623235;81844.59077704573;84135;84555.5772221135;85149.57425212896;86588.99999999937;11211;11306.886931130748;11347.829782553268;11565.016973557342;11630.6510804676;15724.584787369191;15742.606434838992;15744.370225191093;15759.921200394154;15784;7596.924030759732;7777.338926191337;7785.455018148788;7915.406344524184;8062.475939063942;7072.222055573883;7234.312740289664;7374.1151061872915;7397.260273972667;7545.50954187987;4702.952970470252;4777.8327758528285;4832.903341933142;4864.391951006124;4980.526849949249;1972.9901350493155;1992.8306093981885;2053.414776788638;2055.198472595689;2090.9581808363746;906.8549032154824;998.9550470228858;1035.8290882004385;1072.4155335342257;1085.1264731890903;20040.198392064154;20859.791402086088;20922.16311347529;20925.686114708293;21072;968.6851773173747;983.8130755156641;994.5226291380034;998.2912132385942;1010.1867996262932;9097.590608422637;10788.78422431547;11360.48877800501;11540.596079137189;11545.769084618261;443259;443478;451022;451500;453592;51687.74156129195;62248;86425;88265.55867220751;88278.11721882828;961.2886464016577;983.4197823284154;999.4902599674218;1001.8497225416246;1002.8144793213279;17294.567635808704;17974.730379044064;18166.182521786817;18207.271709131488;18354.90822545879;42258.154836903705;43048.78475607602;43219.78390108029;43285;43575.12849743051;59325.703371482865;60068;60448;61149.38850611615;61240.26357100626;8909;8914.821703565764;9012.54937253148;9064.773380665536;9263.490508022123;11967.401629918295;13039.543615973396;13127.671808204872;13304.13523120994;13762.931185344009;10925.07136893373;11779.88220117788;11780.469878855643;11838.822417663914;12259.938700306799;10960.780784384107;11644.708882277671;11768.882311176778;11820.70448238801;11882.346470944181;11322.207445478738;11719.589814356457;11907.226030308002;11920.821187682019;11986.940065299617;7671.309582137411;7985.121636620083;8763.912360876564;8951.73144805657;8954.104589540993;11111.333320000826;11521;11587.246828956091;11605.825912611148;11716.824247636121 23:24:25 INFO - PROCESS | 15446 | |3;mootools.html;1334.37951352621;1421.4527406948325;1473.3885437543418;1581.4306849534166;1781.4210381625967;7523.322900938914;7767.961160194205;7868.999999999993;7870.606469676522;8099.271065604109;7656.272654097866;7838.176991415905;8012.759617211478;8023;8035.357171426286;2032.6544487437097;2265.286434773041;2310.353101131682;2348.5772560939026;2351.388638953867;2336.5677349690277;2364.716234051916;2365.467769751809;2368.1948137633203;2369.893354799038;2306.261996161229;2307.2040146149634;2311.7688231176917;2323.512062466884;2339.7075365579303;1991.531989982353;2061.5670709150945;2239.2722365231284;2250.561140577588;2253.4704344479114;2077.7610574783944;2186.835987300943;2219.5006123622215;2252.0653928619604;2261.0390584001734;7957.442978991473;7997.600119994036;8013.95993020037;8017;8026.478278911852;4776.23580227162;4895.363602731658;4900.460949295574;4900.485449027872;4904.288878112689;3066.3254084101463;3223.178089587164;3273.2798784267425;3279.918002049944;3302.9009129726146;1066.3282132256707;1113.3987646670787;1115.6931843742955;1140.389891408101;1146.0945852776297;10793.83809242862;10940.23418360715;10985.560577576967;10985.61550345734;10990.780184396348;4247.638950689165;4344.82620695175;4525.547445255448;4543.25036369002;4552.795124219418;9430;9506.191973682176;9506.241345351133;9506.90493095074;9514.809703805886;5026.371703537058;5046.091703493333;5048.268001139814;5055.115354812893;5055.241713742895;4119.814608342632;4470.418845550058;4560.68075234737;4640.373549570765;4649.5350464953235;3763.9247215055548;3766.9246615067545;3863.9613603864163;3913.5695073541888;3920.9803950980063;1258.704204511939;1263.860975292717;1284.5054653958293;1290.6063650586661;1294.3851670456645;884.2572239319003;1009.6365308488938;1018.2261481274137;1019.90820826126;1026.779242462874;5767.971160144256;5771.451712087345;5784.132380143013;5784.59507834456;5920.881582368328;483.40541134404174;485.2163755534786;486.1371066357244;494.66610038224053;495.7347818916862;4014.3376342903093;4045.069633984141;4050.7772072535704;4101.753894766323;4109.219248342865;9455.385399948982;9676.27427942893;9765.9023409765;9768.023197680175;9771.364861284135;9635.277354198462;9636.903630963601;9680.612775489042;9681.515924203903;9682.177014953808;7234.131904171533;7413.406927445792;7519.668902640308;7540.3213710766295;7565.848683026419;5778.566607504538;5807.535397168132;5975.611585247119;5979.431953964367;6092.208012958287;8846.646134154818;8874.556272186494;9101.544922753703;9109.498977556297;9305.813883722423;9282.814343713222;9350.485723285285;9351.812963740824;9444.716658500256;9509.809803804024;6569.244536878129;7090.4682148840075;7296.562206267428;7305.269473052865;7409.66656500448;7959.044914610284;8048.476849004796;8065.274125328514;8066.395020373613;8087.353011758927;7278.563286202845;7295.671694773854;7377.483576149618;7433.591152486665;7550.924490755022;7059.5058345915295;7060.117485314336;7063;7087.929120708934;7220.277972202738;6701.195856497252;6723.058771772054;6756.324367563205;6766.4248538874745;6771.62756048422;4904.6321525886415;5024.095662780588;5086.491350864884;5108.642395032461;5157.303763991813;4894.437139728977;5080.771365288645;5087.567556757717;5129.230615407719;5265.89468210626 23:24:25 INFO - PROCESS | 15446 | |4;prototype.html;328.88160262305564;330.7370640340929;340.8687655252727;342.87827821123483;342.9211281405275;5169.844904652862;5218.582513398928;5227.5295223429885;5231.529162375386;5265.367736001842;5130.923036154451;5154.582489815302;5182.471171004553;5187.818426355069;5203.4536373680785;3869.767813931166;3958.168784555247;4077.9592204077876;4094.2220978014084;4116.6706663467;4091.856785012525;4097.508299004109;4113.650339721127;4123.731957422758;4125.257453658341;4072.511298644167;4077.55146933837;4081.7346872453195;4081.9387709184384;4107.815148318333;3903.2583809076186;3913.2956067907767;4039.818208180639;4052.63526282636;4054.5945405459515;3622.2936527377174;3625.546806649169;3630.1287690954246;3631.418972964313;3661.9816900915325;4964.379452568429;5025.7235852028125;5042.1428357179;5051.166557518042;5062.291279220912;4427.070315233805;4629.699069560502;4636.142313671948;4647.3029045643425;4659.231226847566;5315.760790764425;5323.414424413311;5325.721826761588;5334;5345.492178243061;3782.8486860525545;3964.960350396488;3980.223856348013;3981.5222173339093;4007.438958545806;5534.529564986981;5540.2243685884005;5550.750216240279;5556.72216389183;5578.553715702694;3983.6215559521797;3985.1830374773103;3987.501562304712;3995.220931918248;3996.501312007997;4024.3561030235023;4040.313146765057;4082.5713300103657;4110.34234522481;4111.97944010278;4492.798528720903;4595.241785105421;4607.424071991001;4624.468186158635;4631;5371.301730774974;5378.085725426608;5395;5398.703071331114;5419.810306639249;1390.4229744656056;1392.979105313421;1393.6097892590092;1393.6376542099126;1403.614006148297;915.6062892956093;942.962281508732;964.7636329099415;976.1166144639113;987.09680642213;5002.949970500248;5118.974405128025;5198.246254293106;5212.843614691566;5230.796916709102;5476.534494568006;5483.287172667528;5525.198846167364;5565.1930470082425;5616.9157462638095;5095.235714642759;5224.268602395668;5246.895062098813;5250.894982100336;5279.577633789288;2887.4080813433197;2926.6195394598567;2930.1502564256552;2933.193371822766;2934.1637633274413;5718.885622287531;5766.221560089418;5766.308043034863;5782.797602083991;5788.668606220593;5457.290552228185;5613.270274864241;5639.238702775073;5643.5203007743985;5648.209250704905;5696.344920334214;5712.115381732198;5722.685252311079;5726.508968598673;5754.597178197486;5280.313559237275;5474.178873169057;5501.339839219319;5513.228148059195;5542.2795036644975;5404.891902162013;5433.446280248277;5444.945550544444;5447.98424582891;5465.890682186414;5697.316322041216;5709.771609135754;5728.140778883201;5735.8852822944145;5759.0785474325585;3798.6581207691443;3962.8612998544913;3964.5044369453817;3974.2647610192207;3991.401289806552;5502.422245664147;5512.2558454608115;5512.6968016759465;5513.69178492901;5515;5377;5378.247045413724;5424.1321388577635;5424.24060631504;5425.403205647297;5205.895882082413;5309.4539979396695;5343.732813359395;5357.705326207096;5388;5343.679379237258;5368.469986053956;5375.81184658535;5391.649542779707;5397.730113494231;5235.895282094413;5290.095565596305;5438.782448702008;5476.288082549243;5486.341639003345;5345.33183352081;5348.304720386325;5349.598780091431;5355.410904800547;5379.327584051994 23:24:25 INFO - PROCESS | 15446 | |5;yui.html;701.8140192848895;735.7277807211331;739.8039519527326;764.5518710615124;799.8920145780318;15220.315085821137;16138.112403817786;16245.35018599256;16272.593185170377;16570.171491425426;15276.236188190602;15525;15557.06657600542;15571.68856622867;15573.766393504107;631.5989346764815;753.5102183580661;771.4291424345971;792.5403266105645;796.5181065455403;782.2920257167244;793.4247670438914;793.5595744361876;793.9920600794005;794.1621589223367;825.4222044568796;831.1480732249462;833.2500749325625;833.5457175839152;833.9958300208491;666.9133012708365;789.8222899847545;814.3281792521194;832.7127141136298;832.8958880139983;599.4934280532942;600.1447936690242;600.7356763024255;601.0683440666949;601.1283638723868;15656.138912359816;15681.529554113395;15686;15706.607334816606;15727.449539266185;14872.776908346383;15156.621084472867;15316.23418829054;15478.922605387013;15546.61133471661;11788.410579471078;11977.82033269493;13645.38595763193;13675.521356752566;14024.43902243909;4449.755263460508;4512.571305725951;4601.3558101865765;4631.1895418302;4792.496787837262;77610.61194694047;77745.22254777436;79525;80710;81867.18132818655;11058.723531911766;11143.944280278547;11161.218714690056;11204.215704900742;11222.326660400402;20862.791372086387;20894.895525522275;20987.475313117295;20992.005759452826;21030.369088927357;8377;8418.663253469915;8440.451370660887;8612.42588809723;8734.03925568187;4676.228422310349;4792.9281060784115;4860.73265970375;4898.583620392306;5062.291279220912;3562.839672214757;3712.201876596545;3714.758540694846;3719;3722;608.8721368512662;622.975330176925;623.2614351992903;629.9685015749286;641.323403808986;731.491613328742;737.5169264132002;769.127040808675;774.2528460036092;798.5767543202112;9296.30277729173;9960.203183745283;10307.330023548446;10404.895951040393;10453.320534165407;595.7884950842475;702.7540360873653;754.8641244576029;757.0801476206435;769.0502229746259;4695.248760198352;4830.975845120752;5081;5112.6421150519855;5170.250313704491;110814;122759.77240227662;127240;130005.34997324953;130995;97766.31271621979;108354.68530353042;109068.36645419322;110910;111214;88101.55949220213;94424.52787736154;95022.52488737513;96141;96240.51879740556;9517;9523.571439285388;9589.472579008221;9619.086186812241;9819.410835349901;53847.192292114865;54223.45776542184;54719.45280547144;55853.44146558482;57091.71454142703;77737;81722.59138704269;82530.58734706289;83706.58146709471;84193.57903210445;12972.740545189232;13275.493700205729;13285.800712989507;13503.932480337535;13972.650683732989;14442.638934026734;14459.710805784036;14575.562733118024;14668.339924703201;14935.925320373763;13121.606351809462;13395.799063014258;13677.384517696926;14090.22503762303;14131.293435327987;12146.75706485883;13540.526081587097;13587.932060339635;13640.86359136396;13874.23691696926;13639.590812275648;13799.51701690436;13858.4456621734;13926.164430134224;14012.789808152682;10308.12380947628;10548.367097974146;10586.788264234827;11004.339739615649;11830.467628956545;10604.734881628021;10683.679489615324;10747.46262686847;10871.402072886067;10885.891141088805 23:24:25 INFO - PROCESS | 15446 | __end_tp_report 23:24:25 INFO - PROCESS | 15446 | __start_cc_report 23:24:25 INFO - PROCESS | 15446 | _x_x_mozilla_cycle_collect,995 23:24:25 INFO - PROCESS | 15446 | __end_cc_report 23:24:25 INFO - PROCESS | 15446 | __startTimestamp1471501465786__endTimestamp 23:24:25 INFO - PROCESS | 15446 | 23:24:25 INFO - PROCESS | 15446 | ------- Summary: start ------- 23:24:25 INFO - PROCESS | 15446 | Number of tests: 6 23:24:25 INFO - PROCESS | 15446 | 23:24:25 INFO - PROCESS | 15446 | [#0] dojo.html Cycles:165 Average:5190.08 Median:5413.95 stddev:587.47 (10.9%) stddev-sans-first:562.56 23:24:25 INFO - PROCESS | 15446 | Values: 2957.7 2977.2 2986.4 3002.8 3003.1 5067.4 5091.2 5123.3 5225.8 5226.1 5168.7 5181.5 5224.7 5245.5 5271.1 4699.4 4707.7 4823.9 4837.5 4868.8 4828.2 4872.4 4878.8 4890.0 4908.0 4669.5 4723.3 4777.8 4791.4 4840.3 4680.7 4698.4 4704.5 4771.7 4850.7 4707.0 4739.7 4742.0 4787.5 4789.1 5077.4 5119.4 5195.7 5196.3 5236.0 5546.4 5583.0 5609.3 5623.8 5630.4 5623.4 5643.2 5661.2 5671.2 5672.4 5085.5 5174.2 5221.1 5284.3 5287.0 5702.2 5706.2 5749.5 5749.7 5755.1 5512.4 5540.4 5552.1 5556.2 5558.4 5362.0 5466.7 5505.3 5558.7 5608.0 5497.1 5510.1 5513.5 5565.0 5565.5 5474.5 5518.6 5529.4 5535.4 5538.6 4232.2 4238.1 4279.6 4305.7 4341.7 3828.4 3828.5 3855.3 3864.1 3877.8 5230.9 5242.2 5247.0 5288.2 5296.1 5442.1 5487.1 5537.4 5546.3 5558.0 5285.0 5314.9 5324.6 5334.8 5342.6 4762.5 4773.8 4774.9 4776.1 4823.2 5670.6 5837.5 5843.0 5846.4 5864.2 5481.5 5530.5 5552.9 5588.8 5626.1 5723.5 5787.6 5796.1 5798.9 5810.9 5432.3 5465.0 5466.8 5470.0 5482.3 5382.4 5537.6 5554.0 5579.8 5639.7 5504.4 5513.6 5517.5 5520.1 5523.7 5480.9 5490.3 5492.5 5494.7 5533.8 5311.8 5403.9 5459.5 5466.8 5552.7 5525.5 5542.9 5571.5 5585.6 5594.7 5228.7 5387.8 5401.2 5413.9 5424.4 23:24:25 INFO - PROCESS | 15446 | 23:24:25 INFO - PROCESS | 15446 | [#1] ext.html Cycles:180 Average:62002.50 Median:36810.32 stddev:129948.47 (353.0%) stddev-sans-first:130231.15 23:24:25 INFO - PROCESS | 15446 | Values: 569.0 592.4 599.1 608.7 612.7 32748.8 41706.8 43140.8 43153.6 46158.3 45365.8 45727.1 45751.0 45776.5 45802.1 8099.9 8827.4 8979.4 8994.3 9001.5 8093.9 8400.9 8401.5 10534.9 10818.5 10918.0 10922.9 10932.2 10975.5 10976.6 10766.2 10833.3 10845.2 10854.0 10861.4 10776.4 10790.9 10821.8 10827.3 10838.3 42059.4 42301.2 42318.8 42459.4 42477.4 3237.9 3449.5 3462.8 3757.7 3841.6 31611.0 32117.4 33152.5 33215.5 33255.0 4341.8 4378.7 4406.3 4409.8 4618.7 342236.0 343281.0 344595.0 344777.0 345021.3 52317.7 52407.2 52500.5 52515.5 52535.0 35572.7 36691.3 36782.8 38433.0 59652.0 16238.0 16337.7 16382.0 16382.3 16383.8 9793.6 11614.5 11614.8 11645.9 11651.5 18453.4 18849.7 18905.7 19119.6 19404.3 7071.3 7078.3 7195.9 7353.9 7465.4 1030.4 1030.7 1113.2 1124.3 1142.6 33279.8 33587.8 33645.3 33746.8 34097.7 1127.8 1128.4 1129.8 1132.8 1149.1 16371.5 17488.4 17604.5 17605.6 17859.2 536344.0 573543.0 586925.0 587119.0 882946.0 59880.4 60277.7 60310.0 60398.0 60518.7 1242.0 1369.9 1375.9 1385.1 1393.9 29103.6 34201.8 34224.5 34267.5 34663.7 50168.2 50767.5 50798.5 50846.0 50890.2 416362.0 419214.0 419599.0 419731.0 420902.0 25543.6 28237.9 28833.6 29670.7 29927.4 42176.0 46723.8 46879.0 47013.8 47246.0 40161.8 40321.4 40500.3 41422.6 41848.6 40302.8 40453.6 40886.2 41925.4 42000.4 40959.6 42098.4 42883.0 42899.0 42911.8 33931.0 36559.6 36694.6 36837.8 37642.8 28093.7 28157.0 35216.6 35609.3 36180.6 23:24:25 INFO - PROCESS | 15446 | 23:24:25 INFO - PROCESS | 15446 | [#2] jquery.html Cycles:180 Average:27413.71 Median:392.91 stddev:74028.69 (18840.9%) stddev-sans-first:74208.55 23:24:25 INFO - PROCESS | 15446 | Values: 386.5 386.9 398.9 402.0 420.4 12929.4 19492.3 20250.3 20257.0 20434.0 15639.9 16035.6 16953.3 19831.5 20151.0 5700.6 5729.5 5858.0 5862.4 5879.7 5902.5 6018.4 6066.8 6069.0 6071.2 5862.3 5944.6 5953.4 6063.8 6071.8 5947.0 6009.0 6042.0 6046.4 6046.8 5691.7 5866.5 5905.4 5928.6 5929.6 14363.2 14454.2 14582.3 14582.9 14690.5 2303.4 2318.5 2320.4 2845.2 2877.3 9850.4 10211.5 10591.5 10760.4 10869.6 1941.4 1974.7 1980.7 2010.2 2046.2 81844.6 84135.0 84555.6 85149.6 86589.0 11211.0 11306.9 11347.8 11565.0 11630.7 15724.6 15742.6 15744.4 15759.9 15784.0 7596.9 7777.3 7785.5 7915.4 8062.5 7072.2 7234.3 7374.1 7397.3 7545.5 4703.0 4777.8 4832.9 4864.4 4980.5 1973.0 1992.8 2053.4 2055.2 2091.0 906.9 999.0 1035.8 1072.4 1085.1 20040.2 20859.8 20922.2 20925.7 21072.0 968.7 983.8 994.5 998.3 1010.2 9097.6 10788.8 11360.5 11540.6 11545.8 443259.0 443478.0 451022.0 451500.0 453592.0 51687.7 62248.0 86425.0 88265.6 88278.1 961.3 983.4 999.5 1001.8 1002.8 17294.6 17974.7 18166.2 18207.3 18354.9 42258.2 43048.8 43219.8 43285.0 43575.1 59325.7 60068.0 60448.0 61149.4 61240.3 8909.0 8914.8 9012.5 9064.8 9263.5 11967.4 13039.5 13127.7 13304.1 13762.9 10925.1 11779.9 11780.5 11838.8 12259.9 10960.8 11644.7 11768.9 11820.7 11882.3 11322.2 11719.6 11907.2 11920.8 11986.9 7671.3 7985.1 8763.9 8951.7 8954.1 11111.3 11521.0 11587.2 11605.8 11716.8 23:24:25 INFO - PROCESS | 15446 | 23:24:25 INFO - PROCESS | 15446 | [#3] mootools.html Cycles:180 Average:5399.68 Median:5055.18 stddev:2944.76 (58.3%) stddev-sans-first:2937.17 23:24:25 INFO - PROCESS | 15446 | Values: 1334.4 1421.5 1473.4 1581.4 1781.4 7523.3 7768.0 7869.0 7870.6 8099.3 7656.3 7838.2 8012.8 8023.0 8035.4 2032.7 2265.3 2310.4 2348.6 2351.4 2336.6 2364.7 2365.5 2368.2 2369.9 2306.3 2307.2 2311.8 2323.5 2339.7 1991.5 2061.6 2239.3 2250.6 2253.5 2077.8 2186.8 2219.5 2252.1 2261.0 7957.4 7997.6 8014.0 8017.0 8026.5 4776.2 4895.4 4900.5 4900.5 4904.3 3066.3 3223.2 3273.3 3279.9 3302.9 1066.3 1113.4 1115.7 1140.4 1146.1 10793.8 10940.2 10985.6 10985.6 10990.8 4247.6 4344.8 4525.5 4543.3 4552.8 9430.0 9506.2 9506.2 9506.9 9514.8 5026.4 5046.1 5048.3 5055.1 5055.2 4119.8 4470.4 4560.7 4640.4 4649.5 3763.9 3766.9 3864.0 3913.6 3921.0 1258.7 1263.9 1284.5 1290.6 1294.4 884.3 1009.6 1018.2 1019.9 1026.8 5768.0 5771.5 5784.1 5784.6 5920.9 483.4 485.2 486.1 494.7 495.7 4014.3 4045.1 4050.8 4101.8 4109.2 9455.4 9676.3 9765.9 9768.0 9771.4 9635.3 9636.9 9680.6 9681.5 9682.2 7234.1 7413.4 7519.7 7540.3 7565.8 5778.6 5807.5 5975.6 5979.4 6092.2 8846.6 8874.6 9101.5 9109.5 9305.8 9282.8 9350.5 9351.8 9444.7 9509.8 6569.2 7090.5 7296.6 7305.3 7409.7 7959.0 8048.5 8065.3 8066.4 8087.4 7278.6 7295.7 7377.5 7433.6 7550.9 7059.5 7060.1 7063.0 7087.9 7220.3 6701.2 6723.1 6756.3 6766.4 6771.6 4904.6 5024.1 5086.5 5108.6 5157.3 4894.4 5080.8 5087.6 5129.2 5265.9 23:24:25 INFO - PROCESS | 15446 | 23:24:25 INFO - PROCESS | 15446 | [#4] prototype.html Cycles:180 Average:4562.90 Median:5231.16 stddev:1325.20 (25.3%) stddev-sans-first:1290.25 23:24:25 INFO - PROCESS | 15446 | Values: 328.9 330.7 340.9 342.9 342.9 5169.8 5218.6 5227.5 5231.5 5265.4 5130.9 5154.6 5182.5 5187.8 5203.5 3869.8 3958.2 4078.0 4094.2 4116.7 4091.9 4097.5 4113.7 4123.7 4125.3 4072.5 4077.6 4081.7 4081.9 4107.8 3903.3 3913.3 4039.8 4052.6 4054.6 3622.3 3625.5 3630.1 3631.4 3662.0 4964.4 5025.7 5042.1 5051.2 5062.3 4427.1 4629.7 4636.1 4647.3 4659.2 5315.8 5323.4 5325.7 5334.0 5345.5 3782.8 3965.0 3980.2 3981.5 4007.4 5534.5 5540.2 5550.8 5556.7 5578.6 3983.6 3985.2 3987.5 3995.2 3996.5 4024.4 4040.3 4082.6 4110.3 4112.0 4492.8 4595.2 4607.4 4624.5 4631.0 5371.3 5378.1 5395.0 5398.7 5419.8 1390.4 1393.0 1393.6 1393.6 1403.6 915.6 943.0 964.8 976.1 987.1 5002.9 5119.0 5198.2 5212.8 5230.8 5476.5 5483.3 5525.2 5565.2 5616.9 5095.2 5224.3 5246.9 5250.9 5279.6 2887.4 2926.6 2930.2 2933.2 2934.2 5718.9 5766.2 5766.3 5782.8 5788.7 5457.3 5613.3 5639.2 5643.5 5648.2 5696.3 5712.1 5722.7 5726.5 5754.6 5280.3 5474.2 5501.3 5513.2 5542.3 5404.9 5433.4 5444.9 5448.0 5465.9 5697.3 5709.8 5728.1 5735.9 5759.1 3798.7 3962.9 3964.5 3974.3 3991.4 5502.4 5512.3 5512.7 5513.7 5515.0 5377.0 5378.2 5424.1 5424.2 5425.4 5205.9 5309.5 5343.7 5357.7 5388.0 5343.7 5368.5 5375.8 5391.6 5397.7 5235.9 5290.1 5438.8 5476.3 5486.3 5345.3 5348.3 5349.6 5355.4 5379.3 23:24:25 INFO - PROCESS | 15446 | 23:24:25 INFO - PROCESS | 15446 | [#5] yui.html Cycles:180 Average:22044.04 Median:4653.71 stddev:32487.57 (698.1%) stddev-sans-first:32539.18 23:24:25 INFO - PROCESS | 15446 | Values: 701.8 735.7 739.8 764.6 799.9 15220.3 16138.1 16245.4 16272.6 16570.2 15276.2 15525.0 15557.1 15571.7 15573.8 631.6 753.5 771.4 792.5 796.5 782.3 793.4 793.6 794.0 794.2 825.4 831.1 833.3 833.5 834.0 666.9 789.8 814.3 832.7 832.9 599.5 600.1 600.7 601.1 601.1 15656.1 15681.5 15686.0 15706.6 15727.4 14872.8 15156.6 15316.2 15478.9 15546.6 11788.4 11977.8 13645.4 13675.5 14024.4 4449.8 4512.6 4601.4 4631.2 4792.5 77610.6 77745.2 79525.0 80710.0 81867.2 11058.7 11143.9 11161.2 11204.2 11222.3 20862.8 20894.9 20987.5 20992.0 21030.4 8377.0 8418.7 8440.5 8612.4 8734.0 4676.2 4792.9 4860.7 4898.6 5062.3 3562.8 3712.2 3714.8 3719.0 3722.0 608.9 623.0 623.3 630.0 641.3 731.5 737.5 769.1 774.3 798.6 9296.3 9960.2 10307.3 10404.9 10453.3 595.8 702.8 754.9 757.1 769.1 4695.2 4831.0 5081.0 5112.6 5170.3 110814.0 122759.8 127240.0 130005.3 130995.0 97766.3 108354.7 109068.4 110910.0 111214.0 88101.6 94424.5 95022.5 96141.0 96240.5 9517.0 9523.6 9589.5 9619.1 9819.4 53847.2 54223.5 54719.5 55853.4 57091.7 77737.0 81722.6 82530.6 83706.6 84193.6 12972.7 13275.5 13285.8 13503.9 13972.7 14442.6 14459.7 14575.6 14668.3 14935.9 13121.6 13395.8 13677.4 14090.2 14131.3 12146.8 13540.5 13587.9 13640.9 13874.2 13639.6 13799.5 13858.4 13926.2 14012.8 10308.1 10548.4 10586.8 11004.3 11830.5 10604.7 10683.7 10747.5 10871.4 10885.9 23:24:25 INFO - PROCESS | 15446 | -------- Summary: end -------- 23:24:25 INFO - PROCESS | 15446 | 23:24:26 INFO - TEST-INFO | 15446: exit 0 23:24:26 INFO - TEST-OK | dromaeo_css | took 1115620ms 23:24:26 INFO - TEST-START | kraken 23:24:26 INFO - operating with platform_type : linux_ 23:24:26 INFO - Initialising browser for kraken test... 23:24:26 INFO - TEST-INFO | started process 15757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCNnqB3/profile http://localhost:33016/getInfo.html) 23:24:30 INFO - PROCESS | 15757 | __metrics Screen width/height:1600/1200 23:24:30 INFO - PROCESS | 15757 | colorDepth:24 23:24:30 INFO - PROCESS | 15757 | Browser inner width/height: 1024/697 23:24:30 INFO - PROCESS | 15757 | __metrics 23:24:31 INFO - PROCESS | 15757 | 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:24:31 INFO - PROCESS | 15757 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:24:31 INFO - PROCESS | 15757 | console.error: PushService: 23:24:31 INFO - PROCESS | 15757 | stateChangeProcessEnqueue: Error transitioning state 23:24:31 INFO - PROCESS | 15757 | UnknownError 23:24:32 INFO - TEST-INFO | 15757: exit 0 23:24:32 INFO - Browser initialized. 23:24:32 INFO - Running cycle 1/1 for kraken test... 23:24:32 INFO - TEST-INFO | started process 15837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCNnqB3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:24:43 INFO - PROCESS | 15837 | RSS: Main: 156278784 23:24:43 INFO - PROCESS | 15837 | 23:24:46 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:33016/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33016/tests/kraken/driver.html?testName=audio-beat-detection) 23:24:47 INFO - PROCESS | 15837 | RSS: Main: 203870208 23:24:47 INFO - PROCESS | 15837 | 23:24:49 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:33016/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33016/tests/kraken/driver.html?testName=audio-dft) 23:24:50 INFO - PROCESS | 15837 | RSS: Main: 191979520 23:24:50 INFO - PROCESS | 15837 | 23:24:53 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:33016/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33016/tests/kraken/driver.html?testName=audio-fft) 23:24:54 INFO - PROCESS | 15837 | RSS: Main: 276549632 23:24:54 INFO - PROCESS | 15837 | 23:24:56 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:33016/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33016/tests/kraken/driver.html?testName=audio-oscillator) 23:24:57 INFO - PROCESS | 15837 | RSS: Main: 187224064 23:24:57 INFO - PROCESS | 15837 | 23:24:59 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:33016/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33016/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:24:59 INFO - PROCESS | 15837 | RSS: Main: 191258624 23:24:59 INFO - PROCESS | 15837 | 23:25:02 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:33016/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33016/tests/kraken/driver.html?testName=imaging-darkroom) 23:25:03 INFO - PROCESS | 15837 | RSS: Main: 226324480 23:25:03 INFO - PROCESS | 15837 | 23:25:06 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:33016/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33016/tests/kraken/driver.html?testName=imaging-desaturate) 23:25:07 INFO - PROCESS | 15837 | RSS: Main: 226807808 23:25:07 INFO - PROCESS | 15837 | 23:25:10 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:33016/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33016/tests/kraken/driver.html?testName=json-parse-financial) 23:25:10 INFO - PROCESS | 15837 | RSS: Main: 226512896 23:25:10 INFO - PROCESS | 15837 | 23:25:12 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:33016/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33016/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:25:12 INFO - PROCESS | 15837 | RSS: Main: 188788736 23:25:12 INFO - PROCESS | 15837 | 23:25:14 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:33016/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33016/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:25:15 INFO - PROCESS | 15837 | RSS: Main: 196120576 23:25:15 INFO - PROCESS | 15837 | 23:25:17 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:33016/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33016/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:25:18 INFO - PROCESS | 15837 | RSS: Main: 193138688 23:25:18 INFO - PROCESS | 15837 | 23:25:20 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:33016/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:25:21 INFO - PROCESS | 15837 | RSS: Main: 187195392 23:25:21 INFO - PROCESS | 15837 | 23:25:23 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:33016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:25:24 INFO - PROCESS | 15837 | RSS: Main: 191897600 23:25:24 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | Cycle 1(1): loaded http://localhost:33016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33016/tests/kraken/driver.html?testName=ai-astar) 23:25:26 INFO - PROCESS | 15837 | RSS: Main: 242671616 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | __start_tp_report 23:25:26 INFO - PROCESS | 15837 | _x_x_mozilla_page_load 23:25:26 INFO - PROCESS | 15837 | _x_x_mozilla_page_load_details 23:25:26 INFO - PROCESS | 15837 | |i|pagename|runs| 23:25:26 INFO - PROCESS | 15837 | |0;ai-astar;103;112;110;111;110;113;112;111;111;114 23:25:26 INFO - PROCESS | 15837 | |1;audio-beat-detection;149;118;119;180;119;119;146;121;177;121 23:25:26 INFO - PROCESS | 15837 | |2;audio-dft;161;160;160;161;160;160;161;161;162;160 23:25:26 INFO - PROCESS | 15837 | |3;audio-fft;75;76;76;118;75;76;75;84;120;75 23:25:26 INFO - PROCESS | 15837 | |4;audio-oscillator;84;85;142;85;85;85;118;85;85;128 23:25:26 INFO - PROCESS | 15837 | |5;imaging-gaussian-blur;117;119;118;117;117;117;117;117;116;117 23:25:26 INFO - PROCESS | 15837 | |6;imaging-darkroom;146;147;146;145;145;146;146;145;146;146 23:25:26 INFO - PROCESS | 15837 | |7;imaging-desaturate;95;95;95;94;95;95;94;94;95;95 23:25:26 INFO - PROCESS | 15837 | |8;json-parse-financial;52;49;52;51;52;53;54;52;53;50 23:25:26 INFO - PROCESS | 15837 | |9;json-stringify-tinderbox;61;61;62;62;62;61;61;63;63;65 23:25:26 INFO - PROCESS | 15837 | |10;stanford-crypto-aes;79;81;84;79;79;78;78;85;78;78 23:25:26 INFO - PROCESS | 15837 | |11;stanford-crypto-ccm;128;128;129;125;132;131;124;121;142;124 23:25:26 INFO - PROCESS | 15837 | |12;stanford-crypto-pbkdf2;161;164;164;166;168;166;164;167;162;163 23:25:26 INFO - PROCESS | 15837 | |13;stanford-crypto-sha256-iterative;65;63;66;64;64;64;63;66;67;62 23:25:26 INFO - PROCESS | 15837 | __end_tp_report 23:25:26 INFO - PROCESS | 15837 | __start_cc_report 23:25:26 INFO - PROCESS | 15837 | _x_x_mozilla_cycle_collect,1690 23:25:26 INFO - PROCESS | 15837 | __end_cc_report 23:25:26 INFO - PROCESS | 15837 | __startTimestamp1471501526512__endTimestamp 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | ------- Summary: start ------- 23:25:26 INFO - PROCESS | 15837 | Number of tests: 14 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.98 (2.7%) stddev-sans-first:1.33 23:25:26 INFO - PROCESS | 15837 | Values: 103.0 112.0 110.0 111.0 110.0 113.0 112.0 111.0 111.0 114.0 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:133.50 stddev:24.76 (18.5%) stddev-sans-first:25.88 23:25:26 INFO - PROCESS | 15837 | Values: 149.0 118.0 119.0 180.0 119.0 119.0 146.0 121.0 177.0 121.0 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 23:25:26 INFO - PROCESS | 15837 | Values: 161.0 160.0 160.0 161.0 160.0 160.0 161.0 161.0 162.0 160.0 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | [#3] audio-fft Cycles:10 Average:85.00 Median:75.50 stddev:18.13 (24.0%) stddev-sans-first:18.86 23:25:26 INFO - PROCESS | 15837 | Values: 75.0 76.0 76.0 118.0 75.0 76.0 75.0 84.0 120.0 75.0 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:85.00 stddev:22.23 (26.1%) stddev-sans-first:22.97 23:25:26 INFO - PROCESS | 15837 | Values: 84.0 85.0 142.0 85.0 85.0 85.0 118.0 85.0 85.0 128.0 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 23:25:26 INFO - PROCESS | 15837 | Values: 117.0 119.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 23:25:26 INFO - PROCESS | 15837 | Values: 146.0 147.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 23:25:26 INFO - PROCESS | 15837 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:1.48 (2.8%) stddev-sans-first:1.56 23:25:26 INFO - PROCESS | 15837 | Values: 52.0 49.0 52.0 51.0 52.0 53.0 54.0 52.0 53.0 50.0 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:1.29 (2.1%) stddev-sans-first:1.30 23:25:26 INFO - PROCESS | 15837 | Values: 61.0 61.0 62.0 62.0 62.0 61.0 61.0 63.0 63.0 65.0 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.00 stddev:2.60 (3.3%) stddev-sans-first:2.74 23:25:26 INFO - PROCESS | 15837 | Values: 79.0 81.0 84.0 79.0 79.0 78.0 78.0 85.0 78.0 78.0 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:128.50 stddev:5.87 (4.6%) stddev-sans-first:6.23 23:25:26 INFO - PROCESS | 15837 | Values: 128.0 128.0 129.0 125.0 132.0 131.0 124.0 121.0 142.0 124.0 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:165.00 stddev:2.22 (1.3%) stddev-sans-first:1.96 23:25:26 INFO - PROCESS | 15837 | Values: 161.0 164.0 164.0 166.0 168.0 166.0 164.0 167.0 162.0 163.0 23:25:26 INFO - PROCESS | 15837 | 23:25:26 INFO - PROCESS | 15837 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:1.58 (2.4%) stddev-sans-first:1.66 23:25:26 INFO - PROCESS | 15837 | Values: 65.0 63.0 66.0 64.0 64.0 64.0 63.0 66.0 67.0 62.0 23:25:26 INFO - PROCESS | 15837 | -------- Summary: end -------- 23:25:26 INFO - PROCESS | 15837 | 23:25:27 INFO - TEST-INFO | 15837: exit 0 23:25:27 INFO - TEST-OK | kraken | took 60993ms 23:25:27 INFO - SUITE-END | took 1176s 23:25:27 INFO - Completed test suite (00:19:36) 23:25:27 INFO - javascript benchmark 23:25:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2957.6598691150516, 2977.211039074647, 2986.372861699043, 3002.7747918906075, 3003.1140813460015, 5067.366579177603, 5091.15995860683, 5123.282740416335, 5225.764840582174, 5226.137687281594, 5168.7415629218485, 5181.533661970422, 5224.660397074187, 5245.527902488775, 5271.051210782058, 4699.436067671884, 4707.7175369477945, 4823.927641085386, 4837.540433658797, 4868.805247790102, 4828.203346447849, 4872.366592342991, 4878.804847806084, 4890.046440944017, 4907.950920490803, 4669.4630117536235, 4723.291506274052, 4777.832775852863, 4791.3531673224015, 4840.298156767267, 4680.742559159245, 4698.4361876574685, 4704.45898721648, 4771.6898401603785, 4850.684705494132, 4706.95293047072, 4739.715617062952, 4742.0, 4787.497312782142, 4789.066132104241, 5077.441481437039, 5119.38567371914, 5195.714235717034, 5196.29849970253, 5236.031334203185, 5546.389897111315, 5583.0, 5609.3268807742925, 5623.775048998076, 5630.380658127603, 5623.353314368859, 5643.238162848004, 5661.1508273758855, 5671.234383358235, 5672.432756724335, 5085.516875896784, 5174.223866419992, 5221.13851214553, 5284.260203571503, 5287.0, 5702.2301989231755, 5706.172604972256, 5749.511291540182, 5749.741261643152, 5755.050416681284, 5512.448755124456, 5540.418256083134, 5552.056150454432, 5556.194351818964, 5558.44415558441, 5362.0, 5466.726663666801, 5505.256790333334, 5558.749856256478, 5608.018596745554, 5497.065498865202, 5510.090835012258, 5513.476219759196, 5564.972175139179, 5565.526930210977, 5474.479924407175, 5518.558515318765, 5529.391766905637, 5535.363433205152, 5538.556915446755, 4232.238197124486, 4238.0888109056705, 4279.614834664895, 4305.74165550068, 4341.6526677865695, 3828.406596977473, 3828.48315477407, 3855.306044911943, 3864.091938394475, 3877.7673339599714, 5230.947690523122, 5242.16125419931, 5246.97376513115, 5288.180332048539, 5296.09966305729, 5442.074847275972, 5487.067198576252, 5537.418571050062, 5546.334439867161, 5558.0, 5285.048691235615, 5314.946850531523, 5324.5740340772645, 5334.813281535127, 5342.599305052059, 4762.476127625959, 4773.76131193439, 4774.880627984328, 4776.068666610047, 4823.1800593899125, 5670.631408958405, 5837.532997360286, 5843.0, 5846.444587764241, 5864.2083318752275, 5481.479259470344, 5530.529904957963, 5552.861178470571, 5588.832335029955, 5626.099824028136, 5723.542116630576, 5787.56593255516, 5796.1305804129715, 5798.94201057984, 5810.854728631649, 5432.348118225838, 5465.043617366865, 5466.753996070107, 5470.042742519963, 5482.259894914295, 5382.3541175059245, 5537.5569954404355, 5553.972230138985, 5579.832605021856, 5639.689817059937, 5504.422035686355, 5513.558915286687, 5517.475839795213, 5520.1443776214755, 5523.696196709059, 5480.917786233289, 5490.286262785812, 5492.5331346835965, 5494.697791621499, 5533.806316779054, 5311.814086506954, 5403.9459605403445, 5459.535939445192, 5466.835994920159, 5552.69460179694, 5525.530329922001, 5542.944570554404, 5571.526420254162, 5585.609007369445, 5594.664320140804, 5228.71242081674, 5387.75755091014, 5401.189821526802, 5413.945860541344, 5424.430434804289], "value": 5150.243699413094, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.9971550142249, 592.3691268798727, 599.0534954771459, 608.6895683201568, 612.7469325229904, 32748.83625581872, 41706.79146604267, 43140.78429607856, 43153.56846431535, 46158.30762538556, 45365.773171134184, 45727.085458290814, 45751.0, 45776.542234577646, 45802.083958320814, 8099.919000810005, 8827.382083254159, 8979.371443998923, 8994.325425593073, 9001.50491722955, 8093.919060809405, 8400.873986890201, 8401.453905496153, 10534.947325263363, 10818.513166907469, 10918.0, 10922.890771092307, 10932.234743567953, 10975.451227438596, 10976.560937562488, 10766.24636275461, 10833.349999000086, 10845.240833141645, 10854.0, 10861.40262285574, 10776.353418794819, 10790.946045269802, 10821.783564328747, 10827.296225745302, 10838.349699018085, 42059.36910946338, 42301.1539769206, 42318.78840605777, 42459.36310955338, 42477.362839557434, 3237.8866739664236, 3449.5170676105367, 3462.79223246606, 3757.718171137148, 3841.615838416164, 31611.0, 32117.35765284681, 33152.50271245933, 33215.501767473506, 33255.0, 4341.80461879213, 4378.6934914555995, 4406.25093734066, 4409.7873084901585, 4618.699784513996, 342236.0, 343281.0, 344595.0, 344777.0, 345021.27489362645, 52317.7384113077, 52407.21389179165, 52500.474995249555, 52515.474845251825, 52535.0, 35572.731272247496, 36691.26617467689, 36782.816085919934, 38433.0, 59652.0, 16238.0, 16337.67324653524, 16382.0, 16382.262798174112, 16383.754243686355, 9793.559289831976, 11614.477348519336, 11614.825777613343, 11645.883541164649, 11651.475683594259, 18453.446396608124, 18849.680522363302, 18905.7164142538, 19119.617607647768, 19404.320848770225, 7071.297587104518, 7078.338068536411, 7195.8560828784175, 7353.852922941511, 7465.402767778564, 1030.3817709374316, 1030.6907927621683, 1113.2374323588367, 1124.2973141786383, 1142.5772464188303, 33279.849645858245, 33587.83206083954, 33645.32709345848, 33746.83126584352, 34097.65902340994, 1127.8421021057059, 1128.4357821089454, 1129.8079326514512, 1132.796096702585, 1149.0864762513822, 16371.508854734377, 17488.387906423213, 17604.504010761746, 17605.64788704219, 17859.196336164903, 536344.0, 573543.0, 586925.0, 587119.0, 882946.0, 59880.40119598836, 60277.69861150754, 60310.0, 60398.0, 60518.697406513566, 1241.9565315213924, 1369.9315034248448, 1375.9243241621807, 1385.0789225165151, 1393.909395889264, 29103.563446547894, 34201.80293689709, 34224.486632700035, 34267.4859877107, 34663.653363466045, 50168.24747628716, 50767.49232507627, 50798.49201507938, 50846.0, 50890.23664644959, 416362.0, 419214.0, 419599.0, 419731.0, 420902.0, 25543.6168457477, 28237.858810705817, 28833.56749648715, 29670.703292966795, 29927.401451970403, 42176.0, 46723.76638116924, 46879.0, 47013.76493117512, 47246.0, 40161.799191003855, 40321.39517907175, 40500.332322207476, 41422.58577414187, 41848.58151418569, 40302.798486007385, 40453.595464044985, 40886.18227635371, 41925.371119432624, 42000.369994449495, 40959.59040409558, 42098.368524471545, 42883.0, 42899.0, 42911.78544107259, 33931.0, 36559.63440365669, 36694.633053669124, 36837.81581092077, 37642.811785940896, 28093.719062809112, 28157.0, 35216.64783352134, 35609.28781424409, 36180.55277788859], "value": 20402.988542333747, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.4705353665479, 386.9148787266804, 398.91423343981046, 401.95176578810543, 420.4045646770506, 12929.418176182071, 19492.317768878092, 20250.29123980661, 20257.0, 20434.0, 15639.92180039101, 16035.599110022255, 16953.32186712533, 19831.5042123947, 20151.0, 5700.629459085157, 5729.484346408823, 5857.970710146444, 5862.4430679085635, 5879.735411906475, 5902.468777809996, 6018.3981601839905, 6066.848328791793, 6068.969655151718, 6071.1803906472505, 5862.267216597926, 5944.64332140073, 5953.43442372976, 6063.848403789919, 6071.78748743794, 5946.97026514869, 6008.969955150218, 6041.969790151021, 6046.365131661156, 6046.848828779316, 5691.686957217351, 5866.501347385477, 5905.4094590541035, 5928.614640048383, 5929.555283353766, 14363.210023448706, 14454.205018724071, 14582.343794529272, 14582.927085364612, 14690.485832995793, 2303.389601755536, 2318.501522172741, 2320.385097949045, 2845.2460098074025, 2877.323828900207, 9850.408975461423, 10211.540480678388, 10591.470426478721, 10760.3543787373, 10869.565217391295, 1941.4272789527124, 1974.6544354738007, 1980.6830907054946, 2010.1758279105643, 2046.171300623235, 81844.59077704573, 84135.0, 84555.5772221135, 85149.57425212896, 86588.99999999937, 11211.0, 11306.886931130748, 11347.829782553268, 11565.016973557342, 11630.6510804676, 15724.584787369191, 15742.606434838992, 15744.370225191093, 15759.921200394154, 15784.0, 7596.924030759732, 7777.338926191337, 7785.455018148788, 7915.406344524184, 8062.475939063942, 7072.222055573883, 7234.312740289664, 7374.1151061872915, 7397.260273972667, 7545.50954187987, 4702.952970470252, 4777.8327758528285, 4832.903341933142, 4864.391951006124, 4980.526849949249, 1972.9901350493155, 1992.8306093981885, 2053.414776788638, 2055.198472595689, 2090.9581808363746, 906.8549032154824, 998.9550470228858, 1035.8290882004385, 1072.4155335342257, 1085.1264731890903, 20040.198392064154, 20859.791402086088, 20922.16311347529, 20925.686114708293, 21072.0, 968.6851773173747, 983.8130755156641, 994.5226291380034, 998.2912132385942, 1010.1867996262932, 9097.590608422637, 10788.78422431547, 11360.48877800501, 11540.596079137189, 11545.769084618261, 443259.0, 443478.0, 451022.0, 451500.0, 453592.0, 51687.74156129195, 62248.0, 86425.0, 88265.55867220751, 88278.11721882828, 961.2886464016577, 983.4197823284154, 999.4902599674218, 1001.8497225416246, 1002.8144793213279, 17294.567635808704, 17974.730379044064, 18166.182521786817, 18207.271709131488, 18354.90822545879, 42258.154836903705, 43048.78475607602, 43219.78390108029, 43285.0, 43575.12849743051, 59325.703371482865, 60068.0, 60448.0, 61149.38850611615, 61240.26357100626, 8909.0, 8914.821703565764, 9012.54937253148, 9064.773380665536, 9263.490508022123, 11967.401629918295, 13039.543615973396, 13127.671808204872, 13304.13523120994, 13762.931185344009, 10925.07136893373, 11779.88220117788, 11780.469878855643, 11838.822417663914, 12259.938700306799, 10960.780784384107, 11644.708882277671, 11768.882311176778, 11820.70448238801, 11882.346470944181, 11322.207445478738, 11719.589814356457, 11907.226030308002, 11920.821187682019, 11986.940065299617, 7671.309582137411, 7985.121636620083, 8763.912360876564, 8951.73144805657, 8954.104589540993, 11111.333320000826, 11521.0, 11587.246828956091, 11605.825912611148, 11716.824247636121], "value": 9158.496107898327, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.37951352621, 1421.4527406948325, 1473.3885437543418, 1581.4306849534166, 1781.4210381625967, 7523.322900938914, 7767.961160194205, 7868.999999999993, 7870.606469676522, 8099.271065604109, 7656.272654097866, 7838.176991415905, 8012.759617211478, 8023.0, 8035.357171426286, 2032.6544487437097, 2265.286434773041, 2310.353101131682, 2348.5772560939026, 2351.388638953867, 2336.5677349690277, 2364.716234051916, 2365.467769751809, 2368.1948137633203, 2369.893354799038, 2306.261996161229, 2307.2040146149634, 2311.7688231176917, 2323.512062466884, 2339.7075365579303, 1991.531989982353, 2061.5670709150945, 2239.2722365231284, 2250.561140577588, 2253.4704344479114, 2077.7610574783944, 2186.835987300943, 2219.5006123622215, 2252.0653928619604, 2261.0390584001734, 7957.442978991473, 7997.600119994036, 8013.95993020037, 8017.0, 8026.478278911852, 4776.23580227162, 4895.363602731658, 4900.460949295574, 4900.485449027872, 4904.288878112689, 3066.3254084101463, 3223.178089587164, 3273.2798784267425, 3279.918002049944, 3302.9009129726146, 1066.3282132256707, 1113.3987646670787, 1115.6931843742955, 1140.389891408101, 1146.0945852776297, 10793.83809242862, 10940.23418360715, 10985.560577576967, 10985.61550345734, 10990.780184396348, 4247.638950689165, 4344.82620695175, 4525.547445255448, 4543.25036369002, 4552.795124219418, 9430.0, 9506.191973682176, 9506.241345351133, 9506.90493095074, 9514.809703805886, 5026.371703537058, 5046.091703493333, 5048.268001139814, 5055.115354812893, 5055.241713742895, 4119.814608342632, 4470.418845550058, 4560.68075234737, 4640.373549570765, 4649.5350464953235, 3763.9247215055548, 3766.9246615067545, 3863.9613603864163, 3913.5695073541888, 3920.9803950980063, 1258.704204511939, 1263.860975292717, 1284.5054653958293, 1290.6063650586661, 1294.3851670456645, 884.2572239319003, 1009.6365308488938, 1018.2261481274137, 1019.90820826126, 1026.779242462874, 5767.971160144256, 5771.451712087345, 5784.132380143013, 5784.59507834456, 5920.881582368328, 483.40541134404174, 485.2163755534786, 486.1371066357244, 494.66610038224053, 495.7347818916862, 4014.3376342903093, 4045.069633984141, 4050.7772072535704, 4101.753894766323, 4109.219248342865, 9455.385399948982, 9676.27427942893, 9765.9023409765, 9768.023197680175, 9771.364861284135, 9635.277354198462, 9636.903630963601, 9680.612775489042, 9681.515924203903, 9682.177014953808, 7234.131904171533, 7413.406927445792, 7519.668902640308, 7540.3213710766295, 7565.848683026419, 5778.566607504538, 5807.535397168132, 5975.611585247119, 5979.431953964367, 6092.208012958287, 8846.646134154818, 8874.556272186494, 9101.544922753703, 9109.498977556297, 9305.813883722423, 9282.814343713222, 9350.485723285285, 9351.812963740824, 9444.716658500256, 9509.809803804024, 6569.244536878129, 7090.4682148840075, 7296.562206267428, 7305.269473052865, 7409.66656500448, 7959.044914610284, 8048.476849004796, 8065.274125328514, 8066.395020373613, 8087.353011758927, 7278.563286202845, 7295.671694773854, 7377.483576149618, 7433.591152486665, 7550.924490755022, 7059.5058345915295, 7060.117485314336, 7063.0, 7087.929120708934, 7220.277972202738, 6701.195856497252, 6723.058771772054, 6756.324367563205, 6766.4248538874745, 6771.62756048422, 4904.6321525886415, 5024.095662780588, 5086.491350864884, 5108.642395032461, 5157.303763991813, 4894.437139728977, 5080.771365288645, 5087.567556757717, 5129.230615407719, 5265.89468210626], "value": 4333.231792797889, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.88160262305564, 330.7370640340929, 340.8687655252727, 342.87827821123483, 342.9211281405275, 5169.844904652862, 5218.582513398928, 5227.5295223429885, 5231.529162375386, 5265.367736001842, 5130.923036154451, 5154.582489815302, 5182.471171004553, 5187.818426355069, 5203.4536373680785, 3869.767813931166, 3958.168784555247, 4077.9592204077876, 4094.2220978014084, 4116.6706663467, 4091.856785012525, 4097.508299004109, 4113.650339721127, 4123.731957422758, 4125.257453658341, 4072.511298644167, 4077.55146933837, 4081.7346872453195, 4081.9387709184384, 4107.815148318333, 3903.2583809076186, 3913.2956067907767, 4039.818208180639, 4052.63526282636, 4054.5945405459515, 3622.2936527377174, 3625.546806649169, 3630.1287690954246, 3631.418972964313, 3661.9816900915325, 4964.379452568429, 5025.7235852028125, 5042.1428357179, 5051.166557518042, 5062.291279220912, 4427.070315233805, 4629.699069560502, 4636.142313671948, 4647.3029045643425, 4659.231226847566, 5315.760790764425, 5323.414424413311, 5325.721826761588, 5334.0, 5345.492178243061, 3782.8486860525545, 3964.960350396488, 3980.223856348013, 3981.5222173339093, 4007.438958545806, 5534.529564986981, 5540.2243685884005, 5550.750216240279, 5556.72216389183, 5578.553715702694, 3983.6215559521797, 3985.1830374773103, 3987.501562304712, 3995.220931918248, 3996.501312007997, 4024.3561030235023, 4040.313146765057, 4082.5713300103657, 4110.34234522481, 4111.97944010278, 4492.798528720903, 4595.241785105421, 4607.424071991001, 4624.468186158635, 4631.0, 5371.301730774974, 5378.085725426608, 5395.0, 5398.703071331114, 5419.810306639249, 1390.4229744656056, 1392.979105313421, 1393.6097892590092, 1393.6376542099126, 1403.614006148297, 915.6062892956093, 942.962281508732, 964.7636329099415, 976.1166144639113, 987.09680642213, 5002.949970500248, 5118.974405128025, 5198.246254293106, 5212.843614691566, 5230.796916709102, 5476.534494568006, 5483.287172667528, 5525.198846167364, 5565.1930470082425, 5616.9157462638095, 5095.235714642759, 5224.268602395668, 5246.895062098813, 5250.894982100336, 5279.577633789288, 2887.4080813433197, 2926.6195394598567, 2930.1502564256552, 2933.193371822766, 2934.1637633274413, 5718.885622287531, 5766.221560089418, 5766.308043034863, 5782.797602083991, 5788.668606220593, 5457.290552228185, 5613.270274864241, 5639.238702775073, 5643.5203007743985, 5648.209250704905, 5696.344920334214, 5712.115381732198, 5722.685252311079, 5726.508968598673, 5754.597178197486, 5280.313559237275, 5474.178873169057, 5501.339839219319, 5513.228148059195, 5542.2795036644975, 5404.891902162013, 5433.446280248277, 5444.945550544444, 5447.98424582891, 5465.890682186414, 5697.316322041216, 5709.771609135754, 5728.140778883201, 5735.8852822944145, 5759.0785474325585, 3798.6581207691443, 3962.8612998544913, 3964.5044369453817, 3974.2647610192207, 3991.401289806552, 5502.422245664147, 5512.2558454608115, 5512.6968016759465, 5513.69178492901, 5515.0, 5377.0, 5378.247045413724, 5424.1321388577635, 5424.24060631504, 5425.403205647297, 5205.895882082413, 5309.4539979396695, 5343.732813359395, 5357.705326207096, 5388.0, 5343.679379237258, 5368.469986053956, 5375.81184658535, 5391.649542779707, 5397.730113494231, 5235.895282094413, 5290.095565596305, 5438.782448702008, 5476.288082549243, 5486.341639003345, 5345.33183352081, 5348.304720386325, 5349.598780091431, 5355.410904800547, 5379.327584051994], "value": 4146.0904753474515, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.8140192848895, 735.7277807211331, 739.8039519527326, 764.5518710615124, 799.8920145780318, 15220.315085821137, 16138.112403817786, 16245.35018599256, 16272.593185170377, 16570.171491425426, 15276.236188190602, 15525.0, 15557.06657600542, 15571.68856622867, 15573.766393504107, 631.5989346764815, 753.5102183580661, 771.4291424345971, 792.5403266105645, 796.5181065455403, 782.2920257167244, 793.4247670438914, 793.5595744361876, 793.9920600794005, 794.1621589223367, 825.4222044568796, 831.1480732249462, 833.2500749325625, 833.5457175839152, 833.9958300208491, 666.9133012708365, 789.8222899847545, 814.3281792521194, 832.7127141136298, 832.8958880139983, 599.4934280532942, 600.1447936690242, 600.7356763024255, 601.0683440666949, 601.1283638723868, 15656.138912359816, 15681.529554113395, 15686.0, 15706.607334816606, 15727.449539266185, 14872.776908346383, 15156.621084472867, 15316.23418829054, 15478.922605387013, 15546.61133471661, 11788.410579471078, 11977.82033269493, 13645.38595763193, 13675.521356752566, 14024.43902243909, 4449.755263460508, 4512.571305725951, 4601.3558101865765, 4631.1895418302, 4792.496787837262, 77610.61194694047, 77745.22254777436, 79525.0, 80710.0, 81867.18132818655, 11058.723531911766, 11143.944280278547, 11161.218714690056, 11204.215704900742, 11222.326660400402, 20862.791372086387, 20894.895525522275, 20987.475313117295, 20992.005759452826, 21030.369088927357, 8377.0, 8418.663253469915, 8440.451370660887, 8612.42588809723, 8734.03925568187, 4676.228422310349, 4792.9281060784115, 4860.73265970375, 4898.583620392306, 5062.291279220912, 3562.839672214757, 3712.201876596545, 3714.758540694846, 3719.0, 3722.0, 608.8721368512662, 622.975330176925, 623.2614351992903, 629.9685015749286, 641.323403808986, 731.491613328742, 737.5169264132002, 769.127040808675, 774.2528460036092, 798.5767543202112, 9296.30277729173, 9960.203183745283, 10307.330023548446, 10404.895951040393, 10453.320534165407, 595.7884950842475, 702.7540360873653, 754.8641244576029, 757.0801476206435, 769.0502229746259, 4695.248760198352, 4830.975845120752, 5081.0, 5112.6421150519855, 5170.250313704491, 110814.0, 122759.77240227662, 127240.0, 130005.34997324953, 130995.0, 97766.31271621979, 108354.68530353042, 109068.36645419322, 110910.0, 111214.0, 88101.55949220213, 94424.52787736154, 95022.52488737513, 96141.0, 96240.51879740556, 9517.0, 9523.571439285388, 9589.472579008221, 9619.086186812241, 9819.410835349901, 53847.192292114865, 54223.45776542184, 54719.45280547144, 55853.44146558482, 57091.71454142703, 77737.0, 81722.59138704269, 82530.58734706289, 83706.58146709471, 84193.57903210445, 12972.740545189232, 13275.493700205729, 13285.800712989507, 13503.932480337535, 13972.650683732989, 14442.638934026734, 14459.710805784036, 14575.562733118024, 14668.339924703201, 14935.925320373763, 13121.606351809462, 13395.799063014258, 13677.384517696926, 14090.22503762303, 14131.293435327987, 12146.75706485883, 13540.526081587097, 13587.932060339635, 13640.86359136396, 13874.23691696926, 13639.590812275648, 13799.51701690436, 13858.4456621734, 13926.164430134224, 14012.789808152682, 10308.12380947628, 10548.367097974146, 10586.788264234827, 11004.339739615649, 11830.467628956545, 10604.734881628021, 10683.679489615324, 10747.46262686847, 10871.402072886067, 10885.891141088805], "value": 7735.576346455231, "unit": "score"}], "name": "dromaeo_css", "value": 7151.379254862639, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 110.0, 111.0, 110.0, 113.0, 112.0, 111.0, 111.0, 114.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 119.0, 180.0, 119.0, 119.0, 146.0, 121.0, 177.0, 121.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 160.0, 160.0, 161.0, 161.0, 162.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 118.0, 75.0, 76.0, 75.0, 84.0, 120.0, 75.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 142.0, 85.0, 85.0, 85.0, 118.0, 85.0, 85.0, 128.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 52.0, 51.0, 52.0, 53.0, 54.0, 52.0, 53.0, 50.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 61.0, 63.0, 63.0, 65.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 84.0, 79.0, 79.0, 78.0, 78.0, 85.0, 78.0, 78.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 129.0, 125.0, 132.0, 131.0, 124.0, 121.0, 142.0, 124.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 164.0, 166.0, 168.0, 166.0, 164.0, 167.0, 162.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 66.0, 64.0, 64.0, 64.0, 63.0, 66.0, 67.0, 62.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1500.2000000000003, "alertThreshold": 2.0}]} 23:25:27 INFO - Return code: 0 23:25:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:25:27 INFO - # TBPL SUCCESS # 23:25:27 INFO - Running post-action listener: _resource_record_post_action 23:25:27 INFO - [mozharness: 2016-08-18 06:25:27.800155Z] Finished run-tests step (success) 23:25:27 INFO - Running post-run listener: _resource_record_post_run 23:25:27 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408621056; Read time: 8; Write time: 280480 23:25:27 INFO - TinderboxPrint: CPU usage
13.0% 23:25:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 23:25:27 INFO - TinderboxPrint: I/O write bytes / time
408,621,056 / 280,480 23:25:27 INFO - TinderboxPrint: CPU idle
8,290.7 (87.0%) 23:25:27 INFO - TinderboxPrint: CPU user
1,195.3 (12.5%) 23:25:27 INFO - TinderboxPrint: Swap in / out
0 / 0 23:25:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117882880; Read time: 0; Write time: 89320 23:25:27 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 290004992; Read time: 0; Write time: 191140 23:25:28 INFO - Running post-run listener: _upload_blobber_files 23:25:28 INFO - Blob upload gear active. 23:25:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:25:28 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 23:25:28 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'] 23:25:28 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 23:25:28 INFO - (blobuploader) - INFO - Open directory for files ... 23:25:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:25:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:25:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:25:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:25:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:25:29 INFO - (blobuploader) - INFO - Done attempting. 23:25:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:25:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:25:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:25:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:25:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:25:30 INFO - (blobuploader) - INFO - Done attempting. 23:25:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:25:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:25:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:25:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:25:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:25:34 INFO - (blobuploader) - INFO - Done attempting. 23:25:34 INFO - (blobuploader) - INFO - Iteration through files over. 23:25:34 INFO - Return code: 0 23:25:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:25:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:25:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2505057b5e2ae60814eb7699be077cd2ccdfc0e56a03ef3b0285d01cee47045468518c3b420d567afbdcdc53c7aaa48c2dcd3ad8e9507ce039f96f12e338df28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63d25f367037ee19f9bc9a8131a418c9658a0c46a56683f31f0ebe6be8ea8fc60e905c009bb03439d97111c2c9e28f822ada1d7cf964a9dc911aa5a2941c98a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/231c0b1a4df459e9f81683f1b0fc6a350f1532beed8c84063e1caf457e5f983ab63ba2b785650b1d85a9fe0c3c995d5c2b0ddc227d9730bc22da5b0065380b6f"} 23:25:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:25:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:25:34 INFO - Contents: 23:25:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2505057b5e2ae60814eb7699be077cd2ccdfc0e56a03ef3b0285d01cee47045468518c3b420d567afbdcdc53c7aaa48c2dcd3ad8e9507ce039f96f12e338df28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63d25f367037ee19f9bc9a8131a418c9658a0c46a56683f31f0ebe6be8ea8fc60e905c009bb03439d97111c2c9e28f822ada1d7cf964a9dc911aa5a2941c98a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/231c0b1a4df459e9f81683f1b0fc6a350f1532beed8c84063e1caf457e5f983ab63ba2b785650b1d85a9fe0c3c995d5c2b0ddc227d9730bc22da5b0065380b6f"} 23:25:34 INFO - Running post-run listener: copy_logs_to_upload_dir 23:25:34 INFO - Copying logs to upload dir... 23:25:34 INFO - mkdir: /builds/slave/test/build/upload/logs 23:25:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.785602 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-17 23:25:33.410672) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 23:25:33.414496) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259 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/2505057b5e2ae60814eb7699be077cd2ccdfc0e56a03ef3b0285d01cee47045468518c3b420d567afbdcdc53c7aaa48c2dcd3ad8e9507ce039f96f12e338df28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63d25f367037ee19f9bc9a8131a418c9658a0c46a56683f31f0ebe6be8ea8fc60e905c009bb03439d97111c2c9e28f822ada1d7cf964a9dc911aa5a2941c98a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/231c0b1a4df459e9f81683f1b0fc6a350f1532beed8c84063e1caf457e5f983ab63ba2b785650b1d85a9fe0c3c995d5c2b0ddc227d9730bc22da5b0065380b6f"} build_url:https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011490 build_url: 'https://queue.taskcluster.net/v1/task/GMTr4iMxS7KZkjBCyAHqoA/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/2505057b5e2ae60814eb7699be077cd2ccdfc0e56a03ef3b0285d01cee47045468518c3b420d567afbdcdc53c7aaa48c2dcd3ad8e9507ce039f96f12e338df28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63d25f367037ee19f9bc9a8131a418c9658a0c46a56683f31f0ebe6be8ea8fc60e905c009bb03439d97111c2c9e28f822ada1d7cf964a9dc911aa5a2941c98a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/231c0b1a4df459e9f81683f1b0fc6a350f1532beed8c84063e1caf457e5f983ab63ba2b785650b1d85a9fe0c3c995d5c2b0ddc227d9730bc22da5b0065380b6f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 23:25:33.440609) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 23:25:33.440944) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1471498629.661522-1415035259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004704 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 23:25:33.525493) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 23:25:33.525867) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 23:25:33.526217) ========= ========= Total master_lag: 0.17 =========