builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1467882824.89 results: success (0) buildid: 20160706233030 builduid: 844054b3b18e49da8e29e6e812be56bd revision: a2d888c74624106e976bec81a881cb97d737dd08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 02:13:44.891636) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 02:13:44.892212) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 02:13:44.892499) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 02:13:44.907806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:13:44.908178) ========= 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=db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 02:13:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-07-07 02:13:45 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083861 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:13:45.006399) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:13:45.006712) ========= 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=db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015448 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:13:45.055994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:13:45.056508) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a2d888c74624106e976bec81a881cb97d737dd08 --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 a2d888c74624106e976bec81a881cb97d737dd08 --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=db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 02:13:45,170 truncating revision to first 12 chars 2016-07-07 02:13:45,170 Setting DEBUG logging. 2016-07-07 02:13:45,170 attempt 1/10 2016-07-07 02:13:45,170 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a2d888c74624?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 02:13:45,488 unpacking tar archive at: fx-team-a2d888c74624/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649551 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:13:45.719550) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 02:13:45.719854) ========= script_repo_revision: a2d888c74624106e976bec81a881cb97d737dd08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 02:13:45.720248) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 02:13:45.720511) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 02:13:45.729591) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-07 02:13:45.729861) ========= /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=db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:13:45 INFO - MultiFileLogger online at 20160707 02:13:45 in /builds/slave/test 02:13:45 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 02:13:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:13:45 INFO - {'append_to_log': False, 02:13:45 INFO - 'base_work_dir': '/builds/slave/test', 02:13:45 INFO - 'blob_upload_branch': 'Fx-Team', 02:13:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:13:45 INFO - 'branch': 'Fx-Team', 02:13:45 INFO - 'buildbot_json_path': 'buildprops.json', 02:13:45 INFO - 'config_files': ('talos/linux_config.py',), 02:13:45 INFO - 'default_actions': ('clobber', 02:13:45 INFO - 'read-buildbot-config', 02:13:45 INFO - 'download-and-extract', 02:13:45 INFO - 'populate-webroot', 02:13:45 INFO - 'create-virtualenv', 02:13:45 INFO - 'install', 02:13:45 INFO - 'run-tests'), 02:13:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:13:45 INFO - 'download_minidump_stackwalk': True, 02:13:45 INFO - 'download_symbols': 'ondemand', 02:13:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:13:45 INFO - 'tooltool.py': '/tools/tooltool.py', 02:13:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:13:45 INFO - '/tools/misc-python/virtualenv.py')}, 02:13:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:13:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:13:45 INFO - 'installer_path': 'installer.exe', 02:13:45 INFO - 'log_level': 'info', 02:13:45 INFO - 'log_name': 'talos', 02:13:45 INFO - 'log_to_console': True, 02:13:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:13:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:13:45 INFO - 'opt_config_files': (), 02:13:45 INFO - 'pip_index': False, 02:13:45 INFO - 'sps_profile': False, 02:13:45 INFO - 'sps_profile_interval': 0, 02:13:45 INFO - 'suite': 'dromaeojs', 02:13:45 INFO - 'system_bits': '32', 02:13:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:13:45 INFO - 'title': 'talos-linux64-ix-031', 02:13:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:13:45 INFO - 'use_talos_json': True, 02:13:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:13:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:13:45 INFO - 'work_dir': 'build'} 02:13:45 INFO - ##### 02:13:45 INFO - ##### Running clobber step. 02:13:45 INFO - ##### 02:13:45 INFO - Running pre-action listener: _resource_record_pre_action 02:13:45 INFO - Running main action method: clobber 02:13:45 INFO - rmtree: /builds/slave/test/build 02:13:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:13:46 INFO - Running post-action listener: _resource_record_post_action 02:13:46 INFO - ##### 02:13:46 INFO - ##### Finished clobber step (success) 02:13:46 INFO - ##### 02:13:46 INFO - ##### 02:13:46 INFO - ##### Running read-buildbot-config step. 02:13:46 INFO - ##### 02:13:46 INFO - Running pre-action listener: _resource_record_pre_action 02:13:46 INFO - Running main action method: read_buildbot_config 02:13:46 INFO - Using buildbot properties: 02:13:46 INFO - { 02:13:46 INFO - "project": "", 02:13:46 INFO - "product": "firefox", 02:13:46 INFO - "script_repo_revision": "production", 02:13:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:13:46 INFO - "repository": "", 02:13:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:13:46 INFO - "buildid": "20160706233030", 02:13:46 INFO - "pgo_build": "True", 02:13:46 INFO - "basedir": "/builds/slave/test", 02:13:46 INFO - "buildnumber": 1312, 02:13:46 INFO - "slavename": "talos-linux64-ix-031", 02:13:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:13:46 INFO - "platform": "ubuntu64_hw", 02:13:46 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:13:46 INFO - "branch": "fx-team", 02:13:46 INFO - "repo_path": "integration/fx-team", 02:13:46 INFO - "revision": "a2d888c74624106e976bec81a881cb97d737dd08", 02:13:46 INFO - "stage_platform": "linux64-pgo", 02:13:46 INFO - "builduid": "844054b3b18e49da8e29e6e812be56bd", 02:13:46 INFO - "slavebuilddir": "test" 02:13:46 INFO - } 02:13:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:13:46 INFO - Running post-action listener: _resource_record_post_action 02:13:46 INFO - ##### 02:13:46 INFO - ##### Finished read-buildbot-config step (success) 02:13:46 INFO - ##### 02:13:46 INFO - ##### 02:13:46 INFO - ##### Running download-and-extract step. 02:13:46 INFO - ##### 02:13:46 INFO - Running pre-action listener: _resource_record_pre_action 02:13:46 INFO - Running main action method: download_and_extract 02:13:46 INFO - mkdir: /builds/slave/test/build/tests 02:13:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:46 INFO - https://queue.taskcluster.net/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:13:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:13:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:13:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:13:47 INFO - Downloaded 1361 bytes. 02:13:47 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:13:47 INFO - Using the following test package requirements: 02:13:47 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:13:47 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:13:47 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:13:47 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:47 INFO - u'jsshell-linux-x86_64.zip'], 02:13:47 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:13:47 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:13:47 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:13:47 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:13:47 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:13:47 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:13:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:47 INFO - https://queue.taskcluster.net/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:13:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:13:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:13:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:13:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:13:48 INFO - Downloaded 24302761 bytes. 02:13:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:13:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:13:49 INFO - Return code: 0 02:13:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:13:49 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:49 INFO - https://queue.taskcluster.net/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:13:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:13:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:13:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:13:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:13:50 INFO - Downloaded 24302761 bytes. 02:13:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:13:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:13:51 INFO - Return code: 0 02:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:51 INFO - https://queue.taskcluster.net/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:13:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:13:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:13:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:13:52 INFO - Downloaded 14403333 bytes. 02:13:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:13:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:13:53 INFO - Return code: 0 02:13:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:53 INFO - https://queue.taskcluster.net/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:13:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:13:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:13:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:13:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:13:54 INFO - Downloaded 60392917 bytes. 02:13:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:13:54 INFO - mkdir: /builds/slave/test/properties 02:13:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:13:54 INFO - Writing to file /builds/slave/test/properties/build_url 02:13:54 INFO - Contents: 02:13:54 INFO - build_url:https://queue.taskcluster.net/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:13:55 INFO - Running post-action listener: _resource_record_post_action 02:13:55 INFO - Running post-action listener: set_extra_try_arguments 02:13:55 INFO - ##### 02:13:55 INFO - ##### Finished download-and-extract step (success) 02:13:55 INFO - ##### 02:13:55 INFO - ##### 02:13:55 INFO - ##### Running populate-webroot step. 02:13:55 INFO - ##### 02:13:55 INFO - Running pre-action listener: _resource_record_pre_action 02:13:55 INFO - Running main action method: populate_webroot 02:13:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:13:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:13:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:13:55 INFO - '--tppagecycles', 02:13:55 INFO - '7'], 02:13:55 INFO - 'tests': ['tsvgm']}}, 02:13:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:13:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:13:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:13:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:13:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:13:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:13:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:55 INFO - 'talos_options': ['--disable-e10s'], 02:13:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:55 INFO - 'talos_options': ['--disable-e10s'], 02:13:55 INFO - 'tests': ['damp', 'tps']}, 02:13:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:55 INFO - 'tests': ['damp', 'tps']}, 02:13:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:13:55 INFO - 'tests': ['dromaeo_dom']}, 02:13:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:13:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:13:55 INFO - 'tests': ['basic_compositor_video']}, 02:13:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:13:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:13:55 INFO - 'tests': ['a11yr', 02:13:55 INFO - 'ts_paint', 02:13:55 INFO - 'tpaint', 02:13:55 INFO - 'sessionrestore', 02:13:55 INFO - 'sessionrestore_no_auto_restore', 02:13:55 INFO - 'tabpaint']}, 02:13:55 INFO - 'other-e10s': {'tests': ['a11yr', 02:13:55 INFO - 'ts_paint', 02:13:55 INFO - 'tpaint', 02:13:55 INFO - 'sessionrestore', 02:13:55 INFO - 'sessionrestore_no_auto_restore', 02:13:55 INFO - 'tabpaint']}, 02:13:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:13:55 INFO - 'ts_paint', 02:13:55 INFO - 'tpaint', 02:13:55 INFO - 'sessionrestore', 02:13:55 INFO - 'sessionrestore_no_auto_restore', 02:13:55 INFO - 'tabpaint']}, 02:13:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:13:55 INFO - 'ts_paint', 02:13:55 INFO - 'tpaint', 02:13:55 INFO - 'sessionrestore', 02:13:55 INFO - 'sessionrestore_no_auto_restore', 02:13:55 INFO - 'tabpaint']}, 02:13:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:13:55 INFO - 'tests': ['a11yr', 02:13:55 INFO - 'ts_paint', 02:13:55 INFO - 'tpaint', 02:13:55 INFO - 'sessionrestore', 02:13:55 INFO - 'sessionrestore_no_auto_restore', 02:13:55 INFO - 'tabpaint']}, 02:13:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:13:55 INFO - 'tests': ['a11yr', 02:13:55 INFO - 'ts_paint', 02:13:55 INFO - 'tpaint', 02:13:55 INFO - 'sessionrestore', 02:13:55 INFO - 'sessionrestore_no_auto_restore', 02:13:55 INFO - 'tabpaint']}, 02:13:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:13:55 INFO - 'tests': ['tsvgx', 02:13:55 INFO - 'tsvgr_opacity', 02:13:55 INFO - 'tart', 02:13:55 INFO - 'tscrollx', 02:13:55 INFO - 'cart']}, 02:13:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:13:55 INFO - 'tsvgr_opacity', 02:13:55 INFO - 'tart', 02:13:55 INFO - 'tscrollx', 02:13:55 INFO - 'cart']}, 02:13:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:55 INFO - 'talos_options': ['--disable-e10s'], 02:13:55 INFO - 'tests': ['tp5o']}, 02:13:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:55 INFO - 'tests': ['tp5o']}, 02:13:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:55 INFO - 'talos_options': ['--disable-e10s', 02:13:55 INFO - '--xperf_path', 02:13:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:55 INFO - 'tests': ['tp5n']}, 02:13:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:55 INFO - 'talos_options': ['--xperf_path', 02:13:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:55 INFO - 'tests': ['tp5n']}}, 02:13:55 INFO - 'talos.zip': {'path': '', 02:13:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:13:55 INFO - Running post-action listener: _resource_record_post_action 02:13:55 INFO - ##### 02:13:55 INFO - ##### Finished populate-webroot step (success) 02:13:55 INFO - ##### 02:13:55 INFO - ##### 02:13:55 INFO - ##### Running create-virtualenv step. 02:13:55 INFO - ##### 02:13:55 INFO - Running pre-action listener: _resource_record_pre_action 02:13:55 INFO - Running main action method: create_virtualenv 02:13:55 INFO - Creating virtualenv /builds/slave/test/build/venv 02:13:55 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 02:13:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:13:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:13:55 INFO - Using real prefix '/usr' 02:13:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:13:55 INFO - Installing distribute.............................................................................................................................................................................................done. 02:13:57 INFO - Installing pip.................done. 02:13:57 INFO - Return code: 0 02:13:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:57 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 0x187a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b393b0>, '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 0x1b3a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a740>, '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': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', '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 02:13:57 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 02:13:57 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 02:13:57 INFO - Using env: {'DISPLAY': ':0', 02:13:57 INFO - 'HOME': '/home/cltbld', 02:13:57 INFO - 'LANG': 'en_US.UTF-8', 02:13:57 INFO - 'LANGUAGE': 'en_US:en', 02:13:57 INFO - 'LOGNAME': 'cltbld', 02:13:57 INFO - 'MAIL': '/var/mail/cltbld', 02:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:57 INFO - 'MOZ_NO_REMOTE': '1', 02:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:57 INFO - 'NO_EM_RESTART': '1', 02:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:57 INFO - 'PWD': '/builds/slave/test', 02:13:57 INFO - 'SHELL': '/bin/bash', 02:13:57 INFO - 'SHLVL': '1', 02:13:57 INFO - 'TERM': 'linux', 02:13:57 INFO - 'TMOUT': '86400', 02:13:57 INFO - 'USER': 'cltbld', 02:13:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', 02:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:57 INFO - '_': '/tools/buildbot/bin/python'} 02:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:58 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 02:13:58 INFO - Cleaning up... 02:13:58 INFO - Return code: 0 02:13:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x187a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b393b0>, '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 0x1b3a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a740>, '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': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', '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 02:13:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:13:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:13:58 INFO - Using env: {'DISPLAY': ':0', 02:13:58 INFO - 'HOME': '/home/cltbld', 02:13:58 INFO - 'LANG': 'en_US.UTF-8', 02:13:58 INFO - 'LANGUAGE': 'en_US:en', 02:13:58 INFO - 'LOGNAME': 'cltbld', 02:13:58 INFO - 'MAIL': '/var/mail/cltbld', 02:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:58 INFO - 'MOZ_NO_REMOTE': '1', 02:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:58 INFO - 'NO_EM_RESTART': '1', 02:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:58 INFO - 'PWD': '/builds/slave/test', 02:13:58 INFO - 'SHELL': '/bin/bash', 02:13:58 INFO - 'SHLVL': '1', 02:13:58 INFO - 'TERM': 'linux', 02:13:58 INFO - 'TMOUT': '86400', 02:13:58 INFO - 'USER': 'cltbld', 02:13:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', 02:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:58 INFO - '_': '/tools/buildbot/bin/python'} 02:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:58 INFO - Downloading/unpacking psutil>=3.1.1 02:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:14:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:00 INFO - Installing collected packages: psutil 02:14:00 INFO - Running setup.py install for psutil 02:14:00 INFO - building 'psutil._psutil_linux' extension 02:14:00 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 02:14:00 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 02:14:00 INFO - building 'psutil._psutil_posix' extension 02:14:00 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 02:14:00 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 02:14:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:00 INFO - Successfully installed psutil 02:14:00 INFO - Cleaning up... 02:14:01 INFO - Return code: 0 02:14:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b393b0>, '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 0x1b3a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a740>, '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': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', '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 02:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:14:01 INFO - Using env: {'DISPLAY': ':0', 02:14:01 INFO - 'HOME': '/home/cltbld', 02:14:01 INFO - 'LANG': 'en_US.UTF-8', 02:14:01 INFO - 'LANGUAGE': 'en_US:en', 02:14:01 INFO - 'LOGNAME': 'cltbld', 02:14:01 INFO - 'MAIL': '/var/mail/cltbld', 02:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:01 INFO - 'MOZ_NO_REMOTE': '1', 02:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:01 INFO - 'NO_EM_RESTART': '1', 02:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:01 INFO - 'PWD': '/builds/slave/test', 02:14:01 INFO - 'SHELL': '/bin/bash', 02:14:01 INFO - 'SHLVL': '1', 02:14:01 INFO - 'TERM': 'linux', 02:14:01 INFO - 'TMOUT': '86400', 02:14:01 INFO - 'USER': 'cltbld', 02:14:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', 02:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:01 INFO - '_': '/tools/buildbot/bin/python'} 02:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:14:03 INFO - Installing collected packages: mozsystemmonitor 02:14:03 INFO - Running setup.py install for mozsystemmonitor 02:14:03 INFO - Successfully installed mozsystemmonitor 02:14:03 INFO - Cleaning up... 02:14:03 INFO - Return code: 0 02:14:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x187a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b393b0>, '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 0x1b3a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a740>, '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': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', '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 02:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:14:03 INFO - Using env: {'DISPLAY': ':0', 02:14:03 INFO - 'HOME': '/home/cltbld', 02:14:03 INFO - 'LANG': 'en_US.UTF-8', 02:14:03 INFO - 'LANGUAGE': 'en_US:en', 02:14:03 INFO - 'LOGNAME': 'cltbld', 02:14:03 INFO - 'MAIL': '/var/mail/cltbld', 02:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:03 INFO - 'MOZ_NO_REMOTE': '1', 02:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:03 INFO - 'NO_EM_RESTART': '1', 02:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:03 INFO - 'PWD': '/builds/slave/test', 02:14:03 INFO - 'SHELL': '/bin/bash', 02:14:03 INFO - 'SHLVL': '1', 02:14:03 INFO - 'TERM': 'linux', 02:14:03 INFO - 'TMOUT': '86400', 02:14:03 INFO - 'USER': 'cltbld', 02:14:03 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', 02:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:03 INFO - '_': '/tools/buildbot/bin/python'} 02:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:03 INFO - Downloading/unpacking jsonschema==2.5.1 02:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:14:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:05 INFO - Downloading functools32-3.2.3-2.tar.gz 02:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:14:05 INFO - warning: no files found matching '*.txt' 02:14:05 INFO - no previously-included directories found matching 'build' 02:14:05 INFO - no previously-included directories found matching 'dist' 02:14:05 INFO - no previously-included directories found matching '.git*' 02:14:05 INFO - Installing collected packages: jsonschema, functools32 02:14:05 INFO - Running setup.py install for functools32 02:14:05 INFO - warning: no files found matching '*.txt' 02:14:05 INFO - no previously-included directories found matching 'build' 02:14:05 INFO - no previously-included directories found matching 'dist' 02:14:05 INFO - no previously-included directories found matching '.git*' 02:14:05 INFO - Successfully installed jsonschema functools32 02:14:05 INFO - Cleaning up... 02:14:05 INFO - Return code: 0 02:14:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x187a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b393b0>, '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 0x1b3a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a740>, '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': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', '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 02:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:14:05 INFO - Using env: {'DISPLAY': ':0', 02:14:05 INFO - 'HOME': '/home/cltbld', 02:14:05 INFO - 'LANG': 'en_US.UTF-8', 02:14:05 INFO - 'LANGUAGE': 'en_US:en', 02:14:05 INFO - 'LOGNAME': 'cltbld', 02:14:05 INFO - 'MAIL': '/var/mail/cltbld', 02:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:05 INFO - 'MOZ_NO_REMOTE': '1', 02:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:05 INFO - 'NO_EM_RESTART': '1', 02:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:05 INFO - 'PWD': '/builds/slave/test', 02:14:05 INFO - 'SHELL': '/bin/bash', 02:14:05 INFO - 'SHLVL': '1', 02:14:05 INFO - 'TERM': 'linux', 02:14:05 INFO - 'TMOUT': '86400', 02:14:05 INFO - 'USER': 'cltbld', 02:14:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', 02:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:05 INFO - '_': '/tools/buildbot/bin/python'} 02:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:06 INFO - Downloading/unpacking blobuploader==1.2.4 02:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:08 INFO - Downloading blobuploader-1.2.4.tar.gz 02:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:14:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:14:08 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 02:14:08 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 02:14:08 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 02:14:08 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 02:14:08 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 02:14:08 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 02:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:14:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:14:08 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 02:14:08 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 02:14:08 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 02:14:08 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 02:14:08 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 02:14:08 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 02:14:08 INFO - Downloading docopt-0.6.1.tar.gz 02:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:14:08 INFO - Installing collected packages: blobuploader, requests, docopt 02:14:08 INFO - Running setup.py install for blobuploader 02:14:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:14:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:14:09 INFO - Running setup.py install for requests 02:14:09 INFO - Running setup.py install for docopt 02:14:09 INFO - Successfully installed blobuploader requests docopt 02:14:09 INFO - Cleaning up... 02:14:09 INFO - Return code: 0 02:14:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:09 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 0x187a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b393b0>, '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 0x1b3a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a740>, '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': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', '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 02:14:09 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 02:14:09 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 02:14:09 INFO - Using env: {'DISPLAY': ':0', 02:14:09 INFO - 'HOME': '/home/cltbld', 02:14:09 INFO - 'LANG': 'en_US.UTF-8', 02:14:09 INFO - 'LANGUAGE': 'en_US:en', 02:14:09 INFO - 'LOGNAME': 'cltbld', 02:14:09 INFO - 'MAIL': '/var/mail/cltbld', 02:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:09 INFO - 'MOZ_NO_REMOTE': '1', 02:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:09 INFO - 'NO_EM_RESTART': '1', 02:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:09 INFO - 'PWD': '/builds/slave/test', 02:14:09 INFO - 'SHELL': '/bin/bash', 02:14:09 INFO - 'SHLVL': '1', 02:14:09 INFO - 'TERM': 'linux', 02:14:09 INFO - 'TMOUT': '86400', 02:14:09 INFO - 'USER': 'cltbld', 02:14:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', 02:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:09 INFO - '_': '/tools/buildbot/bin/python'} 02:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:09 INFO - Running setup.py (path:/tmp/pip-c0h8mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:09 INFO - Running setup.py (path:/tmp/pip-hQ8Rtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:09 INFO - Running setup.py (path:/tmp/pip-Yj7mgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:09 INFO - Running setup.py (path:/tmp/pip-BOsWoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:10 INFO - Running setup.py (path:/tmp/pip-YYOTx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:10 INFO - Running setup.py (path:/tmp/pip-007dNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:10 INFO - Running setup.py (path:/tmp/pip-HTFNkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:10 INFO - Running setup.py (path:/tmp/pip-2aaXwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:10 INFO - Running setup.py (path:/tmp/pip-iYOcrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:10 INFO - Running setup.py (path:/tmp/pip-5vetsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:10 INFO - Running setup.py (path:/tmp/pip-vyegDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:10 INFO - Running setup.py (path:/tmp/pip-IcZYue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:10 INFO - Running setup.py (path:/tmp/pip-7woCGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:10 INFO - Running setup.py (path:/tmp/pip-ygzl_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:10 INFO - Running setup.py (path:/tmp/pip-sc7XEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:10 INFO - Running setup.py (path:/tmp/pip-ddbeK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:10 INFO - Running setup.py (path:/tmp/pip-0qLMSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:14:10 INFO - Running setup.py install for manifestparser 02:14:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:14:11 INFO - Running setup.py install for mozcrash 02:14:11 INFO - Running setup.py install for mozdebug 02:14:11 INFO - Running setup.py install for mozdevice 02:14:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:14:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:14:11 INFO - Running setup.py install for mozfile 02:14:11 INFO - Running setup.py install for mozhttpd 02:14:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:14:11 INFO - Running setup.py install for mozinfo 02:14:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:14:11 INFO - Running setup.py install for mozInstall 02:14:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:14:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:14:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:14:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:14:11 INFO - Running setup.py install for mozleak 02:14:11 INFO - Running setup.py install for mozlog 02:14:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:14:12 INFO - Running setup.py install for moznetwork 02:14:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:14:12 INFO - Running setup.py install for mozprocess 02:14:12 INFO - Running setup.py install for mozprofile 02:14:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:14:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:14:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:14:12 INFO - Running setup.py install for mozrunner 02:14:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:14:12 INFO - Running setup.py install for mozscreenshot 02:14:12 INFO - Running setup.py install for moztest 02:14:12 INFO - Running setup.py install for mozversion 02:14:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:14:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:14:12 INFO - Cleaning up... 02:14:12 INFO - Return code: 0 02:14:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:12 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 0x187a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b393b0>, '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 0x1b3a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a740>, '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': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', '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 02:14:12 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 02:14:12 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 02:14:12 INFO - Using env: {'DISPLAY': ':0', 02:14:12 INFO - 'HOME': '/home/cltbld', 02:14:12 INFO - 'LANG': 'en_US.UTF-8', 02:14:12 INFO - 'LANGUAGE': 'en_US:en', 02:14:12 INFO - 'LOGNAME': 'cltbld', 02:14:12 INFO - 'MAIL': '/var/mail/cltbld', 02:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:12 INFO - 'MOZ_NO_REMOTE': '1', 02:14:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:12 INFO - 'NO_EM_RESTART': '1', 02:14:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:12 INFO - 'PWD': '/builds/slave/test', 02:14:12 INFO - 'SHELL': '/bin/bash', 02:14:12 INFO - 'SHLVL': '1', 02:14:12 INFO - 'TERM': 'linux', 02:14:12 INFO - 'TMOUT': '86400', 02:14:12 INFO - 'USER': 'cltbld', 02:14:12 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', 02:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:12 INFO - '_': '/tools/buildbot/bin/python'} 02:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:12 INFO - Running setup.py (path:/tmp/pip-Vtv7d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:13 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)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:13 INFO - Running setup.py (path:/tmp/pip-qZJCRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:13 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)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:13 INFO - Running setup.py (path:/tmp/pip-prDSTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:13 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)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:13 INFO - Running setup.py (path:/tmp/pip-FtUMUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:13 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)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:13 INFO - Running setup.py (path:/tmp/pip-xC3tQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:13 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)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:13 INFO - Running setup.py (path:/tmp/pip-JSYJg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:13 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)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:13 INFO - Running setup.py (path:/tmp/pip-cGvYDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:13 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)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:13 INFO - Running setup.py (path:/tmp/pip-isSE4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:13 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)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:13 INFO - Running setup.py (path:/tmp/pip-vZmb3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:13 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)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:13 INFO - Running setup.py (path:/tmp/pip-nQ4RO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:13 INFO - Running setup.py (path:/tmp/pip-QUxWSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:13 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)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:13 INFO - Running setup.py (path:/tmp/pip-g3c7Cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:13 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)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:13 INFO - Running setup.py (path:/tmp/pip-Hz4LMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:13 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)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:13 INFO - Running setup.py (path:/tmp/pip-WordkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:14 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)) 02:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:14 INFO - Running setup.py (path:/tmp/pip-d9mWIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:14 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)) 02:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:14 INFO - Running setup.py (path:/tmp/pip-FxnAkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:14 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)) 02:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:14 INFO - Running setup.py (path:/tmp/pip-YnxK0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:14 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)) 02:14:14 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)) 02:14:14 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)) 02:14:14 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)) 02:14:14 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)) 02:14:14 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)) 02:14:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:19 INFO - Downloading blessings-1.6.tar.gz 02:14:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:14:19 INFO - Installing collected packages: blessings 02:14:19 INFO - Running setup.py install for blessings 02:14:19 INFO - Successfully installed blessings 02:14:19 INFO - Cleaning up... 02:14:19 INFO - Return code: 0 02:14:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:14:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:19 INFO - Reading from file tmpfile_stdout 02:14:19 INFO - Current package versions: 02:14:19 INFO - argparse == 1.2.1 02:14:19 INFO - blessings == 1.6 02:14:19 INFO - blobuploader == 1.2.4 02:14:19 INFO - docopt == 0.6.1 02:14:19 INFO - functools32 == 3.2.3-2 02:14:19 INFO - jsonschema == 2.5.1 02:14:19 INFO - manifestparser == 1.1 02:14:19 INFO - mozInstall == 1.12 02:14:19 INFO - mozcrash == 0.17 02:14:19 INFO - mozdebug == 0.1 02:14:19 INFO - mozdevice == 0.48 02:14:19 INFO - mozfile == 1.2 02:14:19 INFO - mozhttpd == 0.7 02:14:19 INFO - mozinfo == 0.9 02:14:19 INFO - mozleak == 0.1 02:14:19 INFO - mozlog == 3.2 02:14:19 INFO - moznetwork == 0.27 02:14:19 INFO - mozprocess == 0.23 02:14:19 INFO - mozprofile == 0.28 02:14:19 INFO - mozrunner == 6.12 02:14:19 INFO - mozscreenshot == 0.1 02:14:19 INFO - mozsystemmonitor == 0.3 02:14:19 INFO - moztest == 0.7 02:14:19 INFO - mozversion == 1.4 02:14:19 INFO - psutil == 3.1.1 02:14:19 INFO - requests == 1.2.3 02:14:19 INFO - wsgiref == 0.1.2 02:14:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:19 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 0x187a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b393b0>, '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 0x1b3a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a740>, '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': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', '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 02:14:19 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 02:14:19 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 02:14:19 INFO - Using env: {'DISPLAY': ':0', 02:14:19 INFO - 'HOME': '/home/cltbld', 02:14:19 INFO - 'LANG': 'en_US.UTF-8', 02:14:19 INFO - 'LANGUAGE': 'en_US:en', 02:14:19 INFO - 'LOGNAME': 'cltbld', 02:14:19 INFO - 'MAIL': '/var/mail/cltbld', 02:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:19 INFO - 'MOZ_NO_REMOTE': '1', 02:14:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:19 INFO - 'NO_EM_RESTART': '1', 02:14:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:19 INFO - 'PWD': '/builds/slave/test', 02:14:19 INFO - 'SHELL': '/bin/bash', 02:14:19 INFO - 'SHLVL': '1', 02:14:19 INFO - 'TERM': 'linux', 02:14:19 INFO - 'TMOUT': '86400', 02:14:19 INFO - 'USER': 'cltbld', 02:14:19 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', 02:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:19 INFO - '_': '/tools/buildbot/bin/python'} 02:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:19 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)) 02:14:19 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)) 02:14:19 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)) 02:14:19 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)) 02:14:19 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)) 02:14:19 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)) 02:14:19 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)) 02:14:19 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)) 02:14:19 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)) 02:14:19 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)) 02:14:19 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)) 02:14:19 INFO - Cleaning up... 02:14:19 INFO - Return code: 0 02:14:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b393b0>, '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 0x1b3a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a740>, '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': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', '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 02:14:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:14:19 INFO - Using env: {'DISPLAY': ':0', 02:14:19 INFO - 'HOME': '/home/cltbld', 02:14:19 INFO - 'LANG': 'en_US.UTF-8', 02:14:19 INFO - 'LANGUAGE': 'en_US:en', 02:14:19 INFO - 'LOGNAME': 'cltbld', 02:14:19 INFO - 'MAIL': '/var/mail/cltbld', 02:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:19 INFO - 'MOZ_NO_REMOTE': '1', 02:14:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:19 INFO - 'NO_EM_RESTART': '1', 02:14:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:19 INFO - 'PWD': '/builds/slave/test', 02:14:19 INFO - 'SHELL': '/bin/bash', 02:14:19 INFO - 'SHLVL': '1', 02:14:19 INFO - 'TERM': 'linux', 02:14:19 INFO - 'TMOUT': '86400', 02:14:19 INFO - 'USER': 'cltbld', 02:14:19 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', 02:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:19 INFO - '_': '/tools/buildbot/bin/python'} 02:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:14:20 INFO - Cleaning up... 02:14:20 INFO - Return code: 0 02:14:20 INFO - Running post-action listener: _resource_record_post_action 02:14:20 INFO - Running post-action listener: _start_resource_monitoring 02:14:20 INFO - Starting resource monitoring. 02:14:20 INFO - ##### 02:14:20 INFO - ##### Finished create-virtualenv step (success) 02:14:20 INFO - ##### 02:14:20 INFO - ##### 02:14:20 INFO - ##### Running install step. 02:14:20 INFO - ##### 02:14:20 INFO - Running pre-action listener: _resource_record_pre_action 02:14:20 INFO - Running main action method: install 02:14:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:20 INFO - Reading from file tmpfile_stdout 02:14:20 INFO - Detecting whether we're running mozinstall >=1.0... 02:14:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:14:20 INFO - Reading from file tmpfile_stdout 02:14:20 INFO - Output received: 02:14:20 INFO - Usage: mozinstall [options] installer 02:14:20 INFO - Options: 02:14:20 INFO - -h, --help show this help message and exit 02:14:20 INFO - -d DEST, --destination=DEST 02:14:20 INFO - Directory to install application into. [default: 02:14:20 INFO - "/builds/slave/test"] 02:14:20 INFO - --app=APP Application being installed. [default: firefox] 02:14:20 INFO - mkdir: /builds/slave/test/build/application 02:14:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:14:37 INFO - Reading from file tmpfile_stdout 02:14:37 INFO - Output received: 02:14:37 INFO - /builds/slave/test/build/application/firefox/firefox 02:14:37 INFO - Running post-action listener: _resource_record_post_action 02:14:37 INFO - ##### 02:14:37 INFO - ##### Finished install step (success) 02:14:37 INFO - ##### 02:14:37 INFO - ##### 02:14:37 INFO - ##### Running run-tests step. 02:14:37 INFO - ##### 02:14:37 INFO - Running pre-action listener: _resource_record_pre_action 02:14:37 INFO - Running main action method: run_tests 02:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:14:37 INFO - Python 2.7.3 02:14:37 INFO - Return code: 0 02:14:37 INFO - grabbing minidump binary from tooltool 02:14:37 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:37 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 0x1b393b0>, '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 0x1b3a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:14:37 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 02:14:37 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 02:14:37 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 02:14:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:14:37 INFO - Return code: 0 02:14:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:14:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:14:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:14:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:14:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:14:37 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/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 02:14:37 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/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 02:14:37 INFO - Using env: {'DISPLAY': ':0', 02:14:37 INFO - 'HOME': '/home/cltbld', 02:14:37 INFO - 'LANG': 'en_US.UTF-8', 02:14:37 INFO - 'LANGUAGE': 'en_US:en', 02:14:37 INFO - 'LOGNAME': 'cltbld', 02:14:37 INFO - 'MAIL': '/var/mail/cltbld', 02:14:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:14:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:37 INFO - 'MOZ_NO_REMOTE': '1', 02:14:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:37 INFO - 'NO_EM_RESTART': '1', 02:14:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:37 INFO - 'PWD': '/builds/slave/test', 02:14:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:14:37 INFO - 'SHELL': '/bin/bash', 02:14:37 INFO - 'SHLVL': '1', 02:14:37 INFO - 'TERM': 'linux', 02:14:37 INFO - 'TMOUT': '86400', 02:14:37 INFO - 'USER': 'cltbld', 02:14:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691', 02:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:37 INFO - '_': '/tools/buildbot/bin/python'} 02:14:37 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/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 02:14:37 INFO - mozversion application_buildid: 20160706233030 02:14:37 INFO - mozversion application_changeset: a2d888c74624106e976bec81a881cb97d737dd08 02:14:37 INFO - mozversion application_display_name: Nightly 02:14:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:14:37 INFO - mozversion application_name: Firefox 02:14:37 INFO - mozversion application_remotingname: firefox 02:14:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:14:37 INFO - mozversion application_vendor: Mozilla 02:14:37 INFO - mozversion application_version: 50.0a1 02:14:37 INFO - mozversion platform_buildid: 20160706233030 02:14:37 INFO - mozversion platform_changeset: a2d888c74624106e976bec81a881cb97d737dd08 02:14:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:14:37 INFO - mozversion platform_version: 50.0a1 02:14:37 INFO - using testdate: 1467882877 02:14:37 INFO - actual date: 1467882877 02:14:37 INFO - starting webserver on 'localhost:59153' 02:14:37 INFO - SUITE-START | Running 2 tests 02:14:37 INFO - TEST-START | dromaeo_css 02:14:37 INFO - operating with platform_type : linux_ 02:14:37 INFO - Initialising browser for dromaeo_css test... 02:14:37 INFO - TEST-INFO | started process 3180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEJr5tP/profile http://localhost:59153/getInfo.html) 02:14:41 INFO - PROCESS | 3180 | __metrics Screen width/height:1600/1200 02:14:41 INFO - PROCESS | 3180 | colorDepth:24 02:14:41 INFO - PROCESS | 3180 | Browser inner width/height: 1024/697 02:14:41 INFO - PROCESS | 3180 | __metrics 02:14:42 INFO - PROCESS | 3180 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:14:43 INFO - TEST-INFO | 3180: exit 0 02:14:43 INFO - Browser initialized. 02:14:43 INFO - Running cycle 1/1 for dromaeo_css test... 02:14:43 INFO - TEST-INFO | started process 3260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEJr5tP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:14:55 INFO - PROCESS | 3260 | RSS: Main: 157728768 02:14:55 INFO - PROCESS | 3260 | 02:15:46 INFO - PROCESS | 3260 | 1467882946024 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] 02:17:54 INFO - PROCESS | 3260 | Cycle 1(1): loaded http://localhost:59153/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59153/tests/dromaeo/cssquery-ext.html) 02:17:55 INFO - PROCESS | 3260 | RSS: Main: 246378496 02:17:55 INFO - PROCESS | 3260 | 02:20:57 INFO - PROCESS | 3260 | Cycle 1(1): loaded http://localhost:59153/tests/dromaeo/cssquery-ext.html (next: http://localhost:59153/tests/dromaeo/cssquery-jquery.html) 02:20:58 INFO - PROCESS | 3260 | RSS: Main: 242397184 02:20:58 INFO - PROCESS | 3260 | 02:24:00 INFO - PROCESS | 3260 | Cycle 1(1): loaded http://localhost:59153/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59153/tests/dromaeo/cssquery-mootools.html) 02:24:00 INFO - PROCESS | 3260 | RSS: Main: 243843072 02:24:00 INFO - PROCESS | 3260 | 02:27:02 INFO - PROCESS | 3260 | Cycle 1(1): loaded http://localhost:59153/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59153/tests/dromaeo/cssquery-prototype.html) 02:27:03 INFO - PROCESS | 3260 | RSS: Main: 243085312 02:27:03 INFO - PROCESS | 3260 | 02:30:06 INFO - PROCESS | 3260 | Cycle 1(1): loaded http://localhost:59153/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59153/tests/dromaeo/cssquery-yui.html) 02:30:06 INFO - PROCESS | 3260 | RSS: Main: 229167104 02:30:06 INFO - PROCESS | 3260 | 02:33:09 INFO - PROCESS | 3260 | Cycle 1(1): loaded http://localhost:59153/tests/dromaeo/cssquery-yui.html (next: http://localhost:59153/tests/dromaeo/cssquery-dojo.html) 02:33:09 INFO - PROCESS | 3260 | RSS: Main: 308428800 02:33:09 INFO - PROCESS | 3260 | 02:33:09 INFO - PROCESS | 3260 | __start_tp_report 02:33:09 INFO - PROCESS | 3260 | _x_x_mozilla_page_load 02:33:09 INFO - PROCESS | 3260 | _x_x_mozilla_page_load_details 02:33:09 INFO - PROCESS | 3260 | |i|pagename|runs| 02:33:09 INFO - PROCESS | 3260 | |0;dojo.html;3091.273550715581;3096.3652451247494;3122.703343182397;3137.513685378767;3161.8102913825173;5116.258142569325;5158.7936482540745;5243.213517972306;5267.815626453075;5324.281222035024;5168.48315168483;5263.078961181787;5290.994711004916;5330.253764472977;5364.409914909357;4718.57532822046;4747.477777444478;4781.737004464753;4789.640776941726;4980.402351717799;4917.0903382874285;4949.406071271453;4981.053599816023;4992.950070499285;4997.325361076245;4671.719696818185;4739.123262196505;4746.857594272177;4826.469088400273;4847.272909063651;4776.593989510861;4797.208460603996;4797.904041919142;4799.13615549201;4901.166801643693;4795.112904112751;4815.566599006072;4822.855314340575;4832.613390928753;4852.902941941176;5069.44236134025;5168.302279192299;5214.478552144793;5225.895482090337;5328.786848526054;5568.888622227573;5590.664560126364;5607.55139588836;5626.409227031185;5638.915416268759;5631.690257035862;5660.632058916157;5674.035413979634;5683.971580142114;5684.261046064026;5072.492750724935;5200.167973124282;5262.05283049051;5271.235670827708;5277.736113194325;5761.567882408836;5765.567582431335;5810.767569297181;5811.360750317462;5812.302523697099;5323.281357016831;5584.134459158837;5588.832335029955;5592.692401917933;5594.356648985337;5497.917531237034;5557.527610153183;5601.103823388238;5604.495595396434;5611.046122159161;5515.61390702647;5517.310336207974;5517.393086760453;5523.7238138092935;5561.082421400504;5374.704391258519;5513.889722205534;5516.282883225155;5522.171674248895;5540.722963851791;4317.568243175658;4322.22200003996;4323.156984388077;4333.804978775963;4359.738415695068;3845.250176215611;3861.8262178201485;3876.302265592164;3898.8440462381755;3903.277893589695;5179.559737422286;5222.033923724123;5229.607779416559;5287.4976877196605;5294.152935530296;5487.5884308677005;5541.168824676331;5566.053770858964;5567.66594004361;5609.691466969274;5204.661696989683;5217.956408718272;5221.503957124067;5224.03355379256;5332.573394128461;4542.318652202196;4632.3977882875015;4653.115907977473;4678.672492925531;4692.41344831896;5732.996725573008;5740.712964351849;5744.597878148573;5756.136579513023;5771.278590176228;5565;5583.609147359646;5583.860403489945;5592.5525957922455;5596.132599447093;5594.524465420485;5729.8567535811935;5730.369659337386;5731.369549349652;5778.8266352009505;5542.5565954722715;5544.251526044094;5549.056660367828;5549.472800083986;5551.389347171727;5676.290463692038;5684.403137670651;5688.971555142198;5689.715514224355;5693.146028095819;5351.357837059578;5402.648827826179;5408.13469844823;5449.918251226156;5470.8085217017215;5446.1558458439;5452.372977107683;5454.209139674805;5460.26286451324;5469.097598896137;5145.4340022598235;5385.4076051635075;5404.621676482609;5405.24326594285;5445.891082178255;5496.80761173357;5556.694381809039;5558.44415558441;5571.164325351229;5598.888022239614;5455.809046683347;5459.836204913859;5461.071617825059;5463.699496527729;5468.0430924587245 02:33:09 INFO - PROCESS | 3260 | |1;ext.html;565.3592529811186;591.5267785771383;592.8932792097426;598.8233471126017;604.2567641800586;31060.689393106062;34013.48979765303;38815.41776873346;41199;41284.793576032076;42381.78809105958;42717.14565708692;42720.14559708804;42769.78615106928;42777;8872.979607345158;9027;9029.277657787361;9030.638774449015;9033.503157326344;8501.107383724713;8572.742817715447;8591.398602097855;8592.613332400026;8593.183647553473;8623.396362254645;8629.309655227598;8653.524056176908;8689.174528419822;8696.47821130731;8564.700235491759;8611.655533778641;8635.39552231344;8657.523836189008;8676.132386761337;8791.472511649257;8858.247049000842;8867.73396798097;8867.822643547157;8884.333674974403;39843.60156398428;40176.19647607031;40219.19561608751;40262;40300.79849600733;3624.1845584743487;3693.261347730465;3792.9620703792884;4030.073083190853;4227.7463352198965;31185.532217016764;31668.683313166803;31996.360072798645;32005.679943200503;32641.67358326434;4189.099343641132;4195.790210489494;4197.517285512145;4240.681948853849;4386.576379207342;317823;318587;319230;319573;322606.9999999977;51984.740076300135;52337;52362.21456678153;52378.738106309225;52403.73798130985;53836.46163538393;54497.1825422619;54509.45490545123;54543.72728136334;54565.454345456834;15105.3202605883;15134.470293539673;15211.08733475995;15246.923765381101;15258.16080115582;12264.080193985486;12306.07704422172;12324.630261092181;12341;12441.93779031117;14151.29243537819;14865.851341486663;14952.775708364383;15009.174495402858;15161.924190378977;5660.943390566042;5684.63049901755;5712.542996560265;5716.942365662366;5755.510781583528;921.083521895718;923.732117685877;961.8893827209961;1001.8296889528798;1013.5894962540183;30053.549196762066;30744.231394215323;30809.383812323627;30915.381692366478;31567;1046.863907691995;1102.2614848051824;1121.147927575049;1121.4168632311153;1134.1040577943497;16233.837661623233;16272.18639068042;16356;16513.91743041301;16611.83388166127;545244;548924;552188;552458;552563;51864.22203666948;52689;52944.470555293956;52970.47029529655;53156.20265696017;1159.3565571108115;1247.2890452442202;1266.316189257809;1289.722709617418;1302.257713103541;30766.155030313937;31006.22484437907;31934.52098218575;31994.36011279808;32641.673583264812;44724.55275447204;45233.32150017818;45387.31919021283;45855.85360366017;46030;403431;404847;406777;408108;408241;25571.488570228863;26589.601155983062;26700.198994030212;27934.3016424591;37270.813645931594;44333.556664432945;44696.32955505605;44980.550194497635;45311.54688453073;46026;36551;38349;38536.6146338533;39196;39428.40857387084;38737;39424.21151576895;39556;39811.60188398079;39851;37861.24277514379;38581;39022.2195556093;39636.80181599074;39799;32401.51397729083;35319.29361412706;35543.64456355404;35800;35820.462693059104;26427.471450571265;26857.86571067132;27045.729542705107;27223.958203134447;27253.45493090167 02:33:09 INFO - PROCESS | 3260 | |2;jquery.html;363.7108498743499;379.63175719552044;382.319471341013;389.25069241709707;405.446565438177;17678.116094195288;19483.41549753508;19540.413787586396;19554.12006459711;19576.608467830636;18103.81896181038;18405.35581254653;18412;18650.440486785385;19102.617947641073;5486.670799752028;5633.830985070434;5783.6529808211435;5836.97081514594;5838.124281357809;5729.054705973509;5744.712764361786;5771.365149833536;5772.595918285721;5774.8267551973295;5755.165501002373;5759.424057594228;5763;6053.667048312341;6376.0754690570075;6507.772227972046;6519.8696026079215;6538.836529086763;6559.737610495598;6567.211934567858;5546.084895992157;5553.278073850414;5554.527865131468;5554.583406244547;5561.499465048125;12679.302638354888;12939.87060129396;12946.287954162517;21685.67471487929;23080.65379019299;2487.664165337674;2620.685517737884;2662.5739881618847;2754;3010.0969709087403;9470.289728270407;9615.471149086798;9708.514574271258;9750;9905.75235619108;1924.4707705380993;1973.2698901406573;1983.9404817855489;2004.6091012252616;2073.1292857000094;49850.252246216696;67213.9917901227;80975.38049239041;86988;91056.54471727599;10644.467776611138;10812.891871081345;10898.727531811768;10906.127509799197;11176.491173691447;15243.923780381027;15288.388464461297;15295.694086118216;15333.080015199124;15342.309596068204;7731.690732370755;8027.1972802719265;8044.637991290406;8163.224493673091;8180.46826956246;7726.806829829186;7812.882806757903;7829.099653539802;7893.052833659997;7938.404619653549;4277.850275240352;4302.440682711227;4382.824687012484;4425.933610995838;4647.790849411717;1766.4612293250682;1852.1665250637268;1919.9040047997544;1946.6009468059015;1959.9804001959799;872.5113936195751;939.727479031087;970.4953424219508;982.6266018912768;1004.8241557727515;18373.51957485749;19471.221151153793;19499.51251218731;19553.804461955482;19835.504112397306;947.0955237747934;953.9856902146473;961.3895176562933;975.1963106070049;975.3270243532082;10618.712898338405;10929.726756831144;10960.561577536968;10963.890361096286;11006.779864402828;397723;423132;450165;457382;457990;56587;90214;94536;96913;97337;921.2998121427763;935.2798345274101;967.032967032967;968.2205824311357;968.9467079310565;17315.7402638958;17959.551011224823;18002.459926202235;18093.457196284133;18093.81906180974;41500.37749433701;42187.15625687531;43215.13569728525;43360;45385.77307113575;61886;63214;64272;64847.67576162089;66209;7859.646315915683;8221.671133154607;8662.696805612026;8668.739937801876;8936.106389361012;13376.866231337563;13489.865101349253;14081.436742530184;14273.286335682966;14287.64280892986;12047.457864396298;12123.696907577381;12345.444454999368;12381.938090309492;12675.30285834288;12065.396730163633;12100.394980251129;12114.091443141975;12293.93853030729;12441.688957775767;12363.196392234477;12649.177803442746;12736.936315318364;12763.93618031941;12771.425285861973;7513.361364283878;7698.461107722405;7856.607169641381;7896.368290536629;8349.081601024003;10517.894821051997;11790.705232369259;12261.938690306491;12448.502059917502;12535.874641253471 02:33:09 INFO - PROCESS | 3260 | |3;mootools.html;1358.225811287566;1376.7108907129505;1437.8705916467516;1606.8232494425617;1648.653782705631;8456.661733530658;8905.732828015161;8920.509371984539;8940.061293564171;8976.237019853304;7241.927580724191;8311.833763324745;8562.871556926651;8606.526641034741;8775.78060548485;2206.249875042485;2213.380253529014;2231.163313757341;2232.7320721513443;2235.3852690510075;2232.1406258590478;2237.7314722233355;2277.23712556293;2278.2140161644206;2280.543891221754;1898.591802762406;2164.5346250556127;2242.8654280743126;2243;2266.626006708891;2204.655160352184;2210.812080973119;2228.5542891421783;2230.0410823345956;2248.651459023854;2230.2194232018824;2232.241038047072;2233.586786444513;2234.240358278177;2234.5195782906753;9016.053314402025;9043;9043.954780226122;9044.909550904473;9082.27436787015;4801.855944321676;4915.3855768029;4924;4935.432425271068;4950.925736113961;3277.8197199154038;3383.2387712764676;3421.323551459792;3432.7940323580415;3446.672566106216;1020.9183265338755;1045.29442626227;1047.5809676129534;1052.095198129608;1072.8015317166348;12582.622521324374;12594.74810503794;12621.873781262162;12628.431720572504;12643.43104560297;4255.085156691264;4255.085156691326;4430.091831174602;4431.202383570988;4451.643868490513;10226.795464090825;10228;10235.43705096212;10239.334443261165;10240.385576865412;5131.87170320745;5139.177731562932;5140.691558506502;5148.639595228373;5150.40770311419;4619.69971951822;4751.40607424072;4755.857324280277;4756.405449318835;4762.571368576845;3811.7903515306925;3837.0791010157363;3889.630485103911;3897.824597893102;3950.822213000422;1079.1959989807644;1147.6901236666054;1164.831099490586;1173.7945859474728;1204.9397530123458;859.8667206582865;865.7272959017889;900.6757567275776;907.228855472856;910.7768596693852;5547.389787123413;5664.575156863251;5733.913991290134;5853.209816674779;5862.472377485961;914.8170365926841;921.8893732752113;928.8142371525587;944.3295260365218;960.7502049467189;3983.5618082010956;4090.1615168890903;4106.466159399259;4149.336106223051;4171.666266698657;11045.502952367162;11363.943180284212;11484.19610627248;11518.36648984297;11540.711482212844;9957.30298879086;10020.849687254697;11349.943250283695;11362.375069371099;11376;7962.562059086806;8049.9597502013285;8060.073091594424;8105.432619716563;8115.513069215748;5842.357340692435;6001.5798894077;6007.48936340416;6040.879182416239;6157.138000679819;10358.274920755475;10422.791544169226;10451.94774026125;10464.843027354747;10490.475476226005;10671.626493072705;10693.304935179189;10713.89286107129;10797;10809.621663241749;7069.787906362817;7106.7157313706875;7191.820204494929;7207.279272072751;7262.782116536512;7995.240452157036;8091.595420228848;8091.907592475176;8112.310453611273;8127.3091787198755;7244.058272424551;7335.889961650473;7428.962855185906;7475.850482990419;7549.584772837547;7302.707891684273;7415.073115860518;7418.109826820601;7422.035135432359;7542.208068152984;6717.731290748316;6723.092382528492;6774.762883299061;6788.93211067883;6791.66041697923;4821.349117869043;4962.900741985212;5076.0863044652315;5097.337346144977;5134.589232861437;4995.350604421402;4997.100521906092;5097.1844504879045;5191.402988656202;5356.009138309425 02:33:09 INFO - PROCESS | 3260 | |4;prototype.html;284.2382415127459;291.2558413254135;300.33475850990055;305.38769766617935;307.9568860359549;5266.368035835705;5270.341207349082;5299.364076310839;5316.17599272113;5332.680039197651;4975.353204083464;5051.964347308802;5146.871328216796;5223.164293713006;5273.446288139748;4054.452648892406;4070.3080476319096;4071.653909417703;4089.488813898263;4099.713020088595;4090.550039495653;4104.712670113093;4108.5275193352845;4112.321466957948;4112.938305925399;3851.2490064437447;3958.7237338530317;4004.5394779600283;4020.6582440492593;4027.4764280643476;3993.1614360984227;4003.339448990913;4005.399190121505;4005.959940400588;4016.31722607156;3505.3865573524786;3509.3683137035323;3510.4909788080586;3513.94729079064;3525.3478106550115;4935.087008903329;5071.174377224196;5082.720450375228;5106.795728170869;5120;4583.1062942726185;4597.758605176617;4600.102979918917;4620.676552641316;4635.907281854378;5452.100403433429;5466.644668096561;5479.3424789025175;5501.157112367362;5510.91733623996;3769.719319811502;3906.5312162540677;3912.5937548407524;3926.960730392688;3930.290323709167;5678;5705.286839145107;5716.456936591017;5725.513331366838;5733.369329373765;3995.900102497461;3995.9400608990886;4000.4799376080923;4004.539477960072;4019.537753158366;3980.7810570418324;4028.637422631977;4048.109415928491;4055.168690418457;4073.2260870435116;4588.715159755274;4604.700694454849;4638.5593368629925;4673.499677672429;4696.084263568571;5502.147167189092;5534.501894829405;5555.694436805934;5558.44415558441;5587.525060369833;1254.6549698832712;1327.2633688302892;1410.4569740649924;1420.566727148209;1423.8718515333462;957;978.6183388478499;985.4530735441755;998.8951160128228;999.6801023672355;4778.04439112179;4799.9200179959225;4807.278908163804;4810.230363141881;4838.879028024327;4995.425526064549;5004.749762511933;5037.236967061499;5042.420121686053;5054.772535235849;4796.8081276749235;5058.317127187856;5343.893122137535;5409.486098820606;5418.187271909245;2958.926026849346;2976.318380115228;3027.5458681197997;3036;3040.695930406986;5699.971500142473;5859.568279164099;5880.441358070976;5887.264091988502;5903.704814759245;5771.769129234867;5792.913106303409;5805.941940580625;5826.533877289807;5840.912386314209;5810.273715785527;5820.8253752386645;5830.53355731549;5858.326292476249;5867.765289388462;5455.554278116381;5670.177824215548;5675.914861277167;5690.268671037842;5702.97346477638;5589;5594.0769772987005;5595.916061259166;5608.495235428831;5611.607187496836;5637.548996080386;5753.964286428316;5828.446297601721;5833;5835.3581106077445;3651.7808931464197;4031.09300407406;4033.1328764315813;4047.9797601011805;4054.55399906016;5537.335519737496;5665.263515742927;5690.971545142248;5698.344690360662;5713.8285851424525;5504.422035686195;5507.256520369699;5521.135205356187;5525.751341189576;5542.418046105101;5286.312779338661;5508.512701570634;5515.503604675599;5562.5549956002615;5565.666060036411;5453.700046497481;5472.972635136799;5481.945180548303;5491.807786727445;5502.972485137709;5515.365732940763;5517.724113794214;5534.557235421237;5560.36055853582;5595.35653399848;5298.231756395224;5471.124620060771;5479.808206712746;5489.34127904654;5505.862353441196 02:33:09 INFO - PROCESS | 3260 | |5;yui.html;752.4018405367732;764.8699721047421;767.3630886364317;776.4526009163541;788.9171636978116;14275.571732848019;15044.548663540085;15293.2353382331;15317.770233446507;16261.674766504662;13385.063045586812;13393.732125357486;13570.592882213525;13631.931840340785;13677.521286754965;585.0609771317039;701.9929800701979;705.3863139068992;714.2607401339602;724.9927500725005;725.8040329111137;726.3208899678791;735.5292612727858;735.7020406735281;735.8712225360567;756.0511557994708;770.0297624992522;770.4606775257314;774.9883751743729;775.7013549783318;625.1685258606043;741.0625558668289;760.277736150659;766.9041369828772;771.090113665874;537.8305833662383;540.9918851217235;545.3346916761544;547.3951283831389;553.698234462219;14717.116972981656;14781.408743650241;14805.925970370186;14831.925840370837;14869.628259293497;14292.499762508261;14635.560933172022;14649.267536623232;14705.338259778335;14726.33731482086;13013.349332533335;13073.803892941614;13081.542146024938;13181.275029873354;13646.317684115853;4372.606465418127;4478.932816007762;4517.9774101129615;4601.470830854461;4633.72197668141;76851;77667;77840.61079694622;77908.61045694735;77940.22059779442;11194.272372295774;11416.771664566828;11537.826932596017;11563.88436115628;11814.35021073832;20092.296769612993;20145.899270503553;20168.59662806765;20170.59658806845;20224.393268201977;8577.656893724306;8598.39811213209;8641.092685268082;8911.73264802057;8987.011428742833;4559.589636932692;4646.883827904262;4711.316859055486;4773.427188737304;4791.329213910055;3421.1105112670884;3508.649135086471;3514.5079688843584;3516.7889926604485;3530.5586801649793;550.3560982128329;630.6594439002887;643.954923155384;658.4723441615406;662.9105070815475;582.6533212738414;606.3633185155569;650.8210242183437;657.5857209957792;692.3007762160255;9923.404595724136;10324.48377581133;10340.276180667432;10349.482525873827;10658.467076646137;614.1786972267663;656.2846497317946;719.5646633786588;744.4491076603383;781.355381810009;4634.420697412824;4966.90066198674;4968.701877887338;5063.822766203239;5154.639175257696;97902;113633.4318328403;114012.42993784978;117408;118071;58269.41730582725;58624.4137558619;84206.26349891994;98865;99439.50280248553;85086.574567128;86789;88894.55552722195;91308.54345728362;92583.53708231416;9884.456354900549;9924.1068303853;10046.598136074475;10465.9476702616;10557.736056598647;46103.769481152376;46557;53815.730921345144;55301.170482441994;55321.72339138279;56833.14750278832;59371;75192;76849.61575192088;77372.61313693396;12642.39158428581;13021.153625014344;13133.146345487512;13218.60344189676;13460.865391345962;15218.771718424012;15338.233088345314;15358.462453814063;15460.690786183988;15618.843811562194;13482.325883705971;14731.33708983077;14917.403303867724;15032.323545440262;15283.388664453742;14186.219757913414;14392.85607143957;14555.92722036383;14783.630409239855;15057.623559411102;14128;14378.784318235445;14567.781483277548;14581;14897.106173629616;10870.510827012646;11075.390853502813;11177.105831533296;11300.434978251218;11428.94285528567;11194.216404851582;11377.20359574855;11401.942990284995;11682.649520514398;11773.529058837894 02:33:09 INFO - PROCESS | 3260 | __end_tp_report 02:33:09 INFO - PROCESS | 3260 | __start_cc_report 02:33:09 INFO - PROCESS | 3260 | _x_x_mozilla_cycle_collect,792 02:33:09 INFO - PROCESS | 3260 | __end_cc_report 02:33:09 INFO - PROCESS | 3260 | __startTimestamp1467883989772__endTimestamp 02:33:09 INFO - PROCESS | 3260 | 02:33:09 INFO - PROCESS | 3260 | ------- Summary: start ------- 02:33:09 INFO - PROCESS | 3260 | Number of tests: 6 02:33:09 INFO - PROCESS | 3260 | 02:33:09 INFO - PROCESS | 3260 | [#0] dojo.html Cycles:165 Average:5207.05 Median:5405.24 stddev:569.31 (10.5%) stddev-sans-first:546.33 02:33:09 INFO - PROCESS | 3260 | Values: 3091.3 3096.4 3122.7 3137.5 3161.8 5116.3 5158.8 5243.2 5267.8 5324.3 5168.5 5263.1 5291.0 5330.3 5364.4 4718.6 4747.5 4781.7 4789.6 4980.4 4917.1 4949.4 4981.1 4993.0 4997.3 4671.7 4739.1 4746.9 4826.5 4847.3 4776.6 4797.2 4797.9 4799.1 4901.2 4795.1 4815.6 4822.9 4832.6 4852.9 5069.4 5168.3 5214.5 5225.9 5328.8 5568.9 5590.7 5607.6 5626.4 5638.9 5631.7 5660.6 5674.0 5684.0 5684.3 5072.5 5200.2 5262.1 5271.2 5277.7 5761.6 5765.6 5810.8 5811.4 5812.3 5323.3 5584.1 5588.8 5592.7 5594.4 5497.9 5557.5 5601.1 5604.5 5611.0 5515.6 5517.3 5517.4 5523.7 5561.1 5374.7 5513.9 5516.3 5522.2 5540.7 4317.6 4322.2 4323.2 4333.8 4359.7 3845.3 3861.8 3876.3 3898.8 3903.3 5179.6 5222.0 5229.6 5287.5 5294.2 5487.6 5541.2 5566.1 5567.7 5609.7 5204.7 5218.0 5221.5 5224.0 5332.6 4542.3 4632.4 4653.1 4678.7 4692.4 5733.0 5740.7 5744.6 5756.1 5771.3 5565.0 5583.6 5583.9 5592.6 5596.1 5594.5 5729.9 5730.4 5731.4 5778.8 5542.6 5544.3 5549.1 5549.5 5551.4 5676.3 5684.4 5689.0 5689.7 5693.1 5351.4 5402.6 5408.1 5449.9 5470.8 5446.2 5452.4 5454.2 5460.3 5469.1 5145.4 5385.4 5404.6 5405.2 5445.9 5496.8 5556.7 5558.4 5571.2 5598.9 5455.8 5459.8 5461.1 5463.7 5468.0 02:33:09 INFO - PROCESS | 3260 | 02:33:09 INFO - PROCESS | 3260 | [#1] ext.html Cycles:180 Average:57454.35 Median:40240.60 stddev:115819.58 (287.8%) stddev-sans-first:116065.72 02:33:09 INFO - PROCESS | 3260 | Values: 565.4 591.5 592.9 598.8 604.3 31060.7 34013.5 38815.4 41199.0 41284.8 42381.8 42717.1 42720.1 42769.8 42777.0 8873.0 9027.0 9029.3 9030.6 9033.5 8501.1 8572.7 8591.4 8592.6 8593.2 8623.4 8629.3 8653.5 8689.2 8696.5 8564.7 8611.7 8635.4 8657.5 8676.1 8791.5 8858.2 8867.7 8867.8 8884.3 39843.6 40176.2 40219.2 40262.0 40300.8 3624.2 3693.3 3793.0 4030.1 4227.7 31185.5 31668.7 31996.4 32005.7 32641.7 4189.1 4195.8 4197.5 4240.7 4386.6 317823.0 318587.0 319230.0 319573.0 322607.0 51984.7 52337.0 52362.2 52378.7 52403.7 53836.5 54497.2 54509.5 54543.7 54565.5 15105.3 15134.5 15211.1 15246.9 15258.2 12264.1 12306.1 12324.6 12341.0 12441.9 14151.3 14865.9 14952.8 15009.2 15161.9 5660.9 5684.6 5712.5 5716.9 5755.5 921.1 923.7 961.9 1001.8 1013.6 30053.5 30744.2 30809.4 30915.4 31567.0 1046.9 1102.3 1121.1 1121.4 1134.1 16233.8 16272.2 16356.0 16513.9 16611.8 545244.0 548924.0 552188.0 552458.0 552563.0 51864.2 52689.0 52944.5 52970.5 53156.2 1159.4 1247.3 1266.3 1289.7 1302.3 30766.2 31006.2 31934.5 31994.4 32641.7 44724.6 45233.3 45387.3 45855.9 46030.0 403431.0 404847.0 406777.0 408108.0 408241.0 25571.5 26589.6 26700.2 27934.3 37270.8 44333.6 44696.3 44980.6 45311.5 46026.0 36551.0 38349.0 38536.6 39196.0 39428.4 38737.0 39424.2 39556.0 39811.6 39851.0 37861.2 38581.0 39022.2 39636.8 39799.0 32401.5 35319.3 35543.6 35800.0 35820.5 26427.5 26857.9 27045.7 27224.0 27253.5 02:33:09 INFO - PROCESS | 3260 | 02:33:09 INFO - PROCESS | 3260 | [#2] jquery.html Cycles:180 Average:27337.67 Median:4290.15 stddev:72482.73 (1689.5%) stddev-sans-first:72657.77 02:33:09 INFO - PROCESS | 3260 | Values: 363.7 379.6 382.3 389.3 405.4 17678.1 19483.4 19540.4 19554.1 19576.6 18103.8 18405.4 18412.0 18650.4 19102.6 5486.7 5633.8 5783.7 5837.0 5838.1 5729.1 5744.7 5771.4 5772.6 5774.8 5755.2 5759.4 5763.0 6053.7 6376.1 6507.8 6519.9 6538.8 6559.7 6567.2 5546.1 5553.3 5554.5 5554.6 5561.5 12679.3 12939.9 12946.3 21685.7 23080.7 2487.7 2620.7 2662.6 2754.0 3010.1 9470.3 9615.5 9708.5 9750.0 9905.8 1924.5 1973.3 1983.9 2004.6 2073.1 49850.3 67214.0 80975.4 86988.0 91056.5 10644.5 10812.9 10898.7 10906.1 11176.5 15243.9 15288.4 15295.7 15333.1 15342.3 7731.7 8027.2 8044.6 8163.2 8180.5 7726.8 7812.9 7829.1 7893.1 7938.4 4277.9 4302.4 4382.8 4425.9 4647.8 1766.5 1852.2 1919.9 1946.6 1960.0 872.5 939.7 970.5 982.6 1004.8 18373.5 19471.2 19499.5 19553.8 19835.5 947.1 954.0 961.4 975.2 975.3 10618.7 10929.7 10960.6 10963.9 11006.8 397723.0 423132.0 450165.0 457382.0 457990.0 56587.0 90214.0 94536.0 96913.0 97337.0 921.3 935.3 967.0 968.2 968.9 17315.7 17959.6 18002.5 18093.5 18093.8 41500.4 42187.2 43215.1 43360.0 45385.8 61886.0 63214.0 64272.0 64847.7 66209.0 7859.6 8221.7 8662.7 8668.7 8936.1 13376.9 13489.9 14081.4 14273.3 14287.6 12047.5 12123.7 12345.4 12381.9 12675.3 12065.4 12100.4 12114.1 12293.9 12441.7 12363.2 12649.2 12736.9 12763.9 12771.4 7513.4 7698.5 7856.6 7896.4 8349.1 10517.9 11790.7 12261.9 12448.5 12535.9 02:33:09 INFO - PROCESS | 3260 | 02:33:09 INFO - PROCESS | 3260 | [#3] mootools.html Cycles:180 Average:5731.23 Median:4753.63 stddev:3367.90 (70.8%) stddev-sans-first:3361.31 02:33:09 INFO - PROCESS | 3260 | Values: 1358.2 1376.7 1437.9 1606.8 1648.7 8456.7 8905.7 8920.5 8940.1 8976.2 7241.9 8311.8 8562.9 8606.5 8775.8 2206.2 2213.4 2231.2 2232.7 2235.4 2232.1 2237.7 2277.2 2278.2 2280.5 1898.6 2164.5 2242.9 2243.0 2266.6 2204.7 2210.8 2228.6 2230.0 2248.7 2230.2 2232.2 2233.6 2234.2 2234.5 9016.1 9043.0 9044.0 9044.9 9082.3 4801.9 4915.4 4924.0 4935.4 4950.9 3277.8 3383.2 3421.3 3432.8 3446.7 1020.9 1045.3 1047.6 1052.1 1072.8 12582.6 12594.7 12621.9 12628.4 12643.4 4255.1 4255.1 4430.1 4431.2 4451.6 10226.8 10228.0 10235.4 10239.3 10240.4 5131.9 5139.2 5140.7 5148.6 5150.4 4619.7 4751.4 4755.9 4756.4 4762.6 3811.8 3837.1 3889.6 3897.8 3950.8 1079.2 1147.7 1164.8 1173.8 1204.9 859.9 865.7 900.7 907.2 910.8 5547.4 5664.6 5733.9 5853.2 5862.5 914.8 921.9 928.8 944.3 960.8 3983.6 4090.2 4106.5 4149.3 4171.7 11045.5 11363.9 11484.2 11518.4 11540.7 9957.3 10020.8 11349.9 11362.4 11376.0 7962.6 8050.0 8060.1 8105.4 8115.5 5842.4 6001.6 6007.5 6040.9 6157.1 10358.3 10422.8 10451.9 10464.8 10490.5 10671.6 10693.3 10713.9 10797.0 10809.6 7069.8 7106.7 7191.8 7207.3 7262.8 7995.2 8091.6 8091.9 8112.3 8127.3 7244.1 7335.9 7429.0 7475.9 7549.6 7302.7 7415.1 7418.1 7422.0 7542.2 6717.7 6723.1 6774.8 6788.9 6791.7 4821.3 4962.9 5076.1 5097.3 5134.6 4995.4 4997.1 5097.2 5191.4 5356.0 02:33:09 INFO - PROCESS | 3260 | 02:33:09 INFO - PROCESS | 3260 | [#4] prototype.html Cycles:180 Average:4594.37 Median:5244.77 stddev:1362.00 (26.0%) stddev-sans-first:1326.84 02:33:09 INFO - PROCESS | 3260 | Values: 284.2 291.3 300.3 305.4 308.0 5266.4 5270.3 5299.4 5316.2 5332.7 4975.4 5052.0 5146.9 5223.2 5273.4 4054.5 4070.3 4071.7 4089.5 4099.7 4090.6 4104.7 4108.5 4112.3 4112.9 3851.2 3958.7 4004.5 4020.7 4027.5 3993.2 4003.3 4005.4 4006.0 4016.3 3505.4 3509.4 3510.5 3513.9 3525.3 4935.1 5071.2 5082.7 5106.8 5120.0 4583.1 4597.8 4600.1 4620.7 4635.9 5452.1 5466.6 5479.3 5501.2 5510.9 3769.7 3906.5 3912.6 3927.0 3930.3 5678.0 5705.3 5716.5 5725.5 5733.4 3995.9 3995.9 4000.5 4004.5 4019.5 3980.8 4028.6 4048.1 4055.2 4073.2 4588.7 4604.7 4638.6 4673.5 4696.1 5502.1 5534.5 5555.7 5558.4 5587.5 1254.7 1327.3 1410.5 1420.6 1423.9 957.0 978.6 985.5 998.9 999.7 4778.0 4799.9 4807.3 4810.2 4838.9 4995.4 5004.7 5037.2 5042.4 5054.8 4796.8 5058.3 5343.9 5409.5 5418.2 2958.9 2976.3 3027.5 3036.0 3040.7 5700.0 5859.6 5880.4 5887.3 5903.7 5771.8 5792.9 5805.9 5826.5 5840.9 5810.3 5820.8 5830.5 5858.3 5867.8 5455.6 5670.2 5675.9 5690.3 5703.0 5589.0 5594.1 5595.9 5608.5 5611.6 5637.5 5754.0 5828.4 5833.0 5835.4 3651.8 4031.1 4033.1 4048.0 4054.6 5537.3 5665.3 5691.0 5698.3 5713.8 5504.4 5507.3 5521.1 5525.8 5542.4 5286.3 5508.5 5515.5 5562.6 5565.7 5453.7 5473.0 5481.9 5491.8 5503.0 5515.4 5517.7 5534.6 5560.4 5595.4 5298.2 5471.1 5479.8 5489.3 5505.9 02:33:09 INFO - PROCESS | 3260 | 02:33:09 INFO - PROCESS | 3260 | [#5] yui.html Cycles:180 Average:20286.26 Median:25352.62 stddev:28583.88 (112.7%) stddev-sans-first:28626.44 02:33:09 INFO - PROCESS | 3260 | Values: 752.4 764.9 767.4 776.5 788.9 14275.6 15044.5 15293.2 15317.8 16261.7 13385.1 13393.7 13570.6 13631.9 13677.5 585.1 702.0 705.4 714.3 725.0 725.8 726.3 735.5 735.7 735.9 756.1 770.0 770.5 775.0 775.7 625.2 741.1 760.3 766.9 771.1 537.8 541.0 545.3 547.4 553.7 14717.1 14781.4 14805.9 14831.9 14869.6 14292.5 14635.6 14649.3 14705.3 14726.3 13013.3 13073.8 13081.5 13181.3 13646.3 4372.6 4478.9 4518.0 4601.5 4633.7 76851.0 77667.0 77840.6 77908.6 77940.2 11194.3 11416.8 11537.8 11563.9 11814.4 20092.3 20145.9 20168.6 20170.6 20224.4 8577.7 8598.4 8641.1 8911.7 8987.0 4559.6 4646.9 4711.3 4773.4 4791.3 3421.1 3508.6 3514.5 3516.8 3530.6 550.4 630.7 644.0 658.5 662.9 582.7 606.4 650.8 657.6 692.3 9923.4 10324.5 10340.3 10349.5 10658.5 614.2 656.3 719.6 744.4 781.4 4634.4 4966.9 4968.7 5063.8 5154.6 97902.0 113633.4 114012.4 117408.0 118071.0 58269.4 58624.4 84206.3 98865.0 99439.5 85086.6 86789.0 88894.6 91308.5 92583.5 9884.5 9924.1 10046.6 10465.9 10557.7 46103.8 46557.0 53815.7 55301.2 55321.7 56833.1 59371.0 75192.0 76849.6 77372.6 12642.4 13021.2 13133.1 13218.6 13460.9 15218.8 15338.2 15358.5 15460.7 15618.8 13482.3 14731.3 14917.4 15032.3 15283.4 14186.2 14392.9 14555.9 14783.6 15057.6 14128.0 14378.8 14567.8 14581.0 14897.1 10870.5 11075.4 11177.1 11300.4 11428.9 11194.2 11377.2 11401.9 11682.6 11773.5 02:33:09 INFO - PROCESS | 3260 | -------- Summary: end -------- 02:33:09 INFO - PROCESS | 3260 | 02:33:10 INFO - TEST-INFO | 3260: exit 0 02:33:10 INFO - TEST-OK | dromaeo_css | took 1112703ms 02:33:10 INFO - TEST-START | kraken 02:33:10 INFO - operating with platform_type : linux_ 02:33:10 INFO - Initialising browser for kraken test... 02:33:10 INFO - TEST-INFO | started process 3450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAyqxuE/profile http://localhost:59153/getInfo.html) 02:33:14 INFO - PROCESS | 3450 | __metrics Screen width/height:1600/1200 02:33:14 INFO - PROCESS | 3450 | colorDepth:24 02:33:14 INFO - PROCESS | 3450 | Browser inner width/height: 1024/697 02:33:14 INFO - PROCESS | 3450 | __metrics 02:33:15 INFO - PROCESS | 3450 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:33:16 INFO - TEST-INFO | 3450: exit 0 02:33:16 INFO - Browser initialized. 02:33:16 INFO - Running cycle 1/1 for kraken test... 02:33:16 INFO - TEST-INFO | started process 3534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAyqxuE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:28 INFO - PROCESS | 3534 | RSS: Main: 157310976 02:33:28 INFO - PROCESS | 3534 | 02:33:30 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:59153/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59153/tests/kraken/driver.html?testName=audio-beat-detection) 02:33:31 INFO - PROCESS | 3534 | RSS: Main: 215658496 02:33:31 INFO - PROCESS | 3534 | 02:33:33 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:59153/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59153/tests/kraken/driver.html?testName=audio-dft) 02:33:34 INFO - PROCESS | 3534 | RSS: Main: 202805248 02:33:34 INFO - PROCESS | 3534 | 02:33:37 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:59153/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59153/tests/kraken/driver.html?testName=audio-fft) 02:33:38 INFO - PROCESS | 3534 | RSS: Main: 268943360 02:33:38 INFO - PROCESS | 3534 | 02:33:40 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:59153/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59153/tests/kraken/driver.html?testName=audio-oscillator) 02:33:40 INFO - PROCESS | 3534 | RSS: Main: 180490240 02:33:40 INFO - PROCESS | 3534 | 02:33:42 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:59153/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59153/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:33:43 INFO - PROCESS | 3534 | RSS: Main: 184500224 02:33:43 INFO - PROCESS | 3534 | 02:33:46 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:59153/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59153/tests/kraken/driver.html?testName=imaging-darkroom) 02:33:47 INFO - PROCESS | 3534 | RSS: Main: 221192192 02:33:47 INFO - PROCESS | 3534 | 02:33:50 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:59153/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59153/tests/kraken/driver.html?testName=imaging-desaturate) 02:33:51 INFO - PROCESS | 3534 | RSS: Main: 221212672 02:33:51 INFO - PROCESS | 3534 | 02:33:53 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:59153/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59153/tests/kraken/driver.html?testName=json-parse-financial) 02:33:54 INFO - PROCESS | 3534 | RSS: Main: 221986816 02:33:54 INFO - PROCESS | 3534 | 02:33:56 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:59153/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59153/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:33:56 INFO - PROCESS | 3534 | RSS: Main: 205926400 02:33:56 INFO - PROCESS | 3534 | 02:33:58 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:59153/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59153/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:33:59 INFO - PROCESS | 3534 | RSS: Main: 211046400 02:33:59 INFO - PROCESS | 3534 | 02:34:00 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:59153/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59153/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:34:01 INFO - PROCESS | 3534 | RSS: Main: 214052864 02:34:01 INFO - PROCESS | 3534 | 02:34:04 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:59153/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:34:04 INFO - PROCESS | 3534 | RSS: Main: 224088064 02:34:04 INFO - PROCESS | 3534 | 02:34:07 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:59153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:34:08 INFO - PROCESS | 3534 | RSS: Main: 225140736 02:34:08 INFO - PROCESS | 3534 | 02:34:09 INFO - PROCESS | 3534 | Cycle 1(1): loaded http://localhost:59153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59153/tests/kraken/driver.html?testName=ai-astar) 02:34:10 INFO - PROCESS | 3534 | RSS: Main: 268132352 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | __start_tp_report 02:34:10 INFO - PROCESS | 3534 | _x_x_mozilla_page_load 02:34:10 INFO - PROCESS | 3534 | _x_x_mozilla_page_load_details 02:34:10 INFO - PROCESS | 3534 | |i|pagename|runs| 02:34:10 INFO - PROCESS | 3534 | |0;ai-astar;101;110;110;110;110;110;108;108;110;107 02:34:10 INFO - PROCESS | 3534 | |1;audio-beat-detection;151;115;119;163;121;122;143;116;173;120 02:34:10 INFO - PROCESS | 3534 | |2;audio-dft;161;163;161;160;162;160;159;163;162;160 02:34:10 INFO - PROCESS | 3534 | |3;audio-fft;74;74;75;126;75;76;73;73;96;75 02:34:10 INFO - PROCESS | 3534 | |4;audio-oscillator;83;83;119;85;84;85;121;84;84;121 02:34:10 INFO - PROCESS | 3534 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;116;117;117 02:34:10 INFO - PROCESS | 3534 | |6;imaging-darkroom;146;146;146;146;146;145;146;146;147;146 02:34:10 INFO - PROCESS | 3534 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 02:34:10 INFO - PROCESS | 3534 | |8;json-parse-financial;53;51;52;52;52;53;52;57;51;52 02:34:10 INFO - PROCESS | 3534 | |9;json-stringify-tinderbox;61;62;61;62;61;62;60;62;61;60 02:34:10 INFO - PROCESS | 3534 | |10;stanford-crypto-aes;76;81;85;78;76;74;75;81;75;83 02:34:10 INFO - PROCESS | 3534 | |11;stanford-crypto-ccm;134;120;127;120;121;128;119;120;208;121 02:34:10 INFO - PROCESS | 3534 | |12;stanford-crypto-pbkdf2;164;160;159;158;162;158;159;164;159;158 02:34:10 INFO - PROCESS | 3534 | |13;stanford-crypto-sha256-iterative;63;63;63;64;62;62;62;62;62;64 02:34:10 INFO - PROCESS | 3534 | __end_tp_report 02:34:10 INFO - PROCESS | 3534 | __start_cc_report 02:34:10 INFO - PROCESS | 3534 | _x_x_mozilla_cycle_collect,1656 02:34:10 INFO - PROCESS | 3534 | __end_cc_report 02:34:10 INFO - PROCESS | 3534 | __startTimestamp1467884050065__endTimestamp 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | ------- Summary: start ------- 02:34:10 INFO - PROCESS | 3534 | Number of tests: 14 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:2.84 (2.6%) stddev-sans-first:1.20 02:34:10 INFO - PROCESS | 3534 | Values: 101.0 110.0 110.0 110.0 110.0 110.0 108.0 108.0 110.0 107.0 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:132.50 stddev:21.47 (16.2%) stddev-sans-first:21.91 02:34:10 INFO - PROCESS | 3534 | Values: 151.0 115.0 119.0 163.0 121.0 122.0 143.0 116.0 173.0 120.0 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.37 (0.8%) stddev-sans-first:1.45 02:34:10 INFO - PROCESS | 3534 | Values: 161.0 163.0 161.0 160.0 162.0 160.0 159.0 163.0 162.0 160.0 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:17.01 (22.7%) stddev-sans-first:17.81 02:34:10 INFO - PROCESS | 3534 | Values: 74.0 74.0 75.0 126.0 75.0 76.0 73.0 73.0 96.0 75.0 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.00 stddev:17.57 (20.9%) stddev-sans-first:18.10 02:34:10 INFO - PROCESS | 3534 | Values: 83.0 83.0 119.0 85.0 84.0 85.0 121.0 84.0 84.0 121.0 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:34:10 INFO - PROCESS | 3534 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 02:34:10 INFO - PROCESS | 3534 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 147.0 146.0 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:34:10 INFO - PROCESS | 3534 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.00 stddev:1.72 (3.3%) stddev-sans-first:1.81 02:34:10 INFO - PROCESS | 3534 | Values: 53.0 51.0 52.0 52.0 52.0 53.0 52.0 57.0 51.0 52.0 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.50 stddev:0.79 (1.3%) stddev-sans-first:0.83 02:34:10 INFO - PROCESS | 3534 | Values: 61.0 62.0 61.0 62.0 61.0 62.0 60.0 62.0 61.0 60.0 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:79.50 stddev:3.84 (4.8%) stddev-sans-first:3.97 02:34:10 INFO - PROCESS | 3534 | Values: 76.0 81.0 85.0 78.0 76.0 74.0 75.0 81.0 75.0 83.0 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:124.00 stddev:27.21 (21.9%) stddev-sans-first:28.85 02:34:10 INFO - PROCESS | 3534 | Values: 134.0 120.0 127.0 120.0 121.0 128.0 119.0 120.0 208.0 121.0 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:159.50 stddev:2.38 (1.5%) stddev-sans-first:2.06 02:34:10 INFO - PROCESS | 3534 | Values: 164.0 160.0 159.0 158.0 162.0 158.0 159.0 164.0 159.0 158.0 02:34:10 INFO - PROCESS | 3534 | 02:34:10 INFO - PROCESS | 3534 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 02:34:10 INFO - PROCESS | 3534 | Values: 63.0 63.0 63.0 64.0 62.0 62.0 62.0 62.0 62.0 64.0 02:34:10 INFO - PROCESS | 3534 | -------- Summary: end -------- 02:34:10 INFO - PROCESS | 3534 | 02:34:11 INFO - TEST-INFO | 3534: exit 0 02:34:11 INFO - TEST-OK | kraken | took 60639ms 02:34:11 INFO - SUITE-END | took 1173s 02:34:11 INFO - Completed test suite (00:19:33) 02:34:11 INFO - javascript benchmark 02:34:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3091.273550715581, 3096.3652451247494, 3122.703343182397, 3137.513685378767, 3161.8102913825173, 5116.258142569325, 5158.7936482540745, 5243.213517972306, 5267.815626453075, 5324.281222035024, 5168.48315168483, 5263.078961181787, 5290.994711004916, 5330.253764472977, 5364.409914909357, 4718.57532822046, 4747.477777444478, 4781.737004464753, 4789.640776941726, 4980.402351717799, 4917.0903382874285, 4949.406071271453, 4981.053599816023, 4992.950070499285, 4997.325361076245, 4671.719696818185, 4739.123262196505, 4746.857594272177, 4826.469088400273, 4847.272909063651, 4776.593989510861, 4797.208460603996, 4797.904041919142, 4799.13615549201, 4901.166801643693, 4795.112904112751, 4815.566599006072, 4822.855314340575, 4832.613390928753, 4852.902941941176, 5069.44236134025, 5168.302279192299, 5214.478552144793, 5225.895482090337, 5328.786848526054, 5568.888622227573, 5590.664560126364, 5607.55139588836, 5626.409227031185, 5638.915416268759, 5631.690257035862, 5660.632058916157, 5674.035413979634, 5683.971580142114, 5684.261046064026, 5072.492750724935, 5200.167973124282, 5262.05283049051, 5271.235670827708, 5277.736113194325, 5761.567882408836, 5765.567582431335, 5810.767569297181, 5811.360750317462, 5812.302523697099, 5323.281357016831, 5584.134459158837, 5588.832335029955, 5592.692401917933, 5594.356648985337, 5497.917531237034, 5557.527610153183, 5601.103823388238, 5604.495595396434, 5611.046122159161, 5515.61390702647, 5517.310336207974, 5517.393086760453, 5523.7238138092935, 5561.082421400504, 5374.704391258519, 5513.889722205534, 5516.282883225155, 5522.171674248895, 5540.722963851791, 4317.568243175658, 4322.22200003996, 4323.156984388077, 4333.804978775963, 4359.738415695068, 3845.250176215611, 3861.8262178201485, 3876.302265592164, 3898.8440462381755, 3903.277893589695, 5179.559737422286, 5222.033923724123, 5229.607779416559, 5287.4976877196605, 5294.152935530296, 5487.5884308677005, 5541.168824676331, 5566.053770858964, 5567.66594004361, 5609.691466969274, 5204.661696989683, 5217.956408718272, 5221.503957124067, 5224.03355379256, 5332.573394128461, 4542.318652202196, 4632.3977882875015, 4653.115907977473, 4678.672492925531, 4692.41344831896, 5732.996725573008, 5740.712964351849, 5744.597878148573, 5756.136579513023, 5771.278590176228, 5565.0, 5583.609147359646, 5583.860403489945, 5592.5525957922455, 5596.132599447093, 5594.524465420485, 5729.8567535811935, 5730.369659337386, 5731.369549349652, 5778.8266352009505, 5542.5565954722715, 5544.251526044094, 5549.056660367828, 5549.472800083986, 5551.389347171727, 5676.290463692038, 5684.403137670651, 5688.971555142198, 5689.715514224355, 5693.146028095819, 5351.357837059578, 5402.648827826179, 5408.13469844823, 5449.918251226156, 5470.8085217017215, 5446.1558458439, 5452.372977107683, 5454.209139674805, 5460.26286451324, 5469.097598896137, 5145.4340022598235, 5385.4076051635075, 5404.621676482609, 5405.24326594285, 5445.891082178255, 5496.80761173357, 5556.694381809039, 5558.44415558441, 5571.164325351229, 5598.888022239614, 5455.809046683347, 5459.836204913859, 5461.071617825059, 5463.699496527729, 5468.0430924587245], "value": 5170.451290255977, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.3592529811186, 591.5267785771383, 592.8932792097426, 598.8233471126017, 604.2567641800586, 31060.689393106062, 34013.48979765303, 38815.41776873346, 41199.0, 41284.793576032076, 42381.78809105958, 42717.14565708692, 42720.14559708804, 42769.78615106928, 42777.0, 8872.979607345158, 9027.0, 9029.277657787361, 9030.638774449015, 9033.503157326344, 8501.107383724713, 8572.742817715447, 8591.398602097855, 8592.613332400026, 8593.183647553473, 8623.396362254645, 8629.309655227598, 8653.524056176908, 8689.174528419822, 8696.47821130731, 8564.700235491759, 8611.655533778641, 8635.39552231344, 8657.523836189008, 8676.132386761337, 8791.472511649257, 8858.247049000842, 8867.73396798097, 8867.822643547157, 8884.333674974403, 39843.60156398428, 40176.19647607031, 40219.19561608751, 40262.0, 40300.79849600733, 3624.1845584743487, 3693.261347730465, 3792.9620703792884, 4030.073083190853, 4227.7463352198965, 31185.532217016764, 31668.683313166803, 31996.360072798645, 32005.679943200503, 32641.67358326434, 4189.099343641132, 4195.790210489494, 4197.517285512145, 4240.681948853849, 4386.576379207342, 317823.0, 318587.0, 319230.0, 319573.0, 322606.9999999977, 51984.740076300135, 52337.0, 52362.21456678153, 52378.738106309225, 52403.73798130985, 53836.46163538393, 54497.1825422619, 54509.45490545123, 54543.72728136334, 54565.454345456834, 15105.3202605883, 15134.470293539673, 15211.08733475995, 15246.923765381101, 15258.16080115582, 12264.080193985486, 12306.07704422172, 12324.630261092181, 12341.0, 12441.93779031117, 14151.29243537819, 14865.851341486663, 14952.775708364383, 15009.174495402858, 15161.924190378977, 5660.943390566042, 5684.63049901755, 5712.542996560265, 5716.942365662366, 5755.510781583528, 921.083521895718, 923.732117685877, 961.8893827209961, 1001.8296889528798, 1013.5894962540183, 30053.549196762066, 30744.231394215323, 30809.383812323627, 30915.381692366478, 31567.0, 1046.863907691995, 1102.2614848051824, 1121.147927575049, 1121.4168632311153, 1134.1040577943497, 16233.837661623233, 16272.18639068042, 16356.0, 16513.91743041301, 16611.83388166127, 545244.0, 548924.0, 552188.0, 552458.0, 552563.0, 51864.22203666948, 52689.0, 52944.470555293956, 52970.47029529655, 53156.20265696017, 1159.3565571108115, 1247.2890452442202, 1266.316189257809, 1289.722709617418, 1302.257713103541, 30766.155030313937, 31006.22484437907, 31934.52098218575, 31994.36011279808, 32641.673583264812, 44724.55275447204, 45233.32150017818, 45387.31919021283, 45855.85360366017, 46030.0, 403431.0, 404847.0, 406777.0, 408108.0, 408241.0, 25571.488570228863, 26589.601155983062, 26700.198994030212, 27934.3016424591, 37270.813645931594, 44333.556664432945, 44696.32955505605, 44980.550194497635, 45311.54688453073, 46026.0, 36551.0, 38349.0, 38536.6146338533, 39196.0, 39428.40857387084, 38737.0, 39424.21151576895, 39556.0, 39811.60188398079, 39851.0, 37861.24277514379, 38581.0, 39022.2195556093, 39636.80181599074, 39799.0, 32401.51397729083, 35319.29361412706, 35543.64456355404, 35800.0, 35820.462693059104, 26427.471450571265, 26857.86571067132, 27045.729542705107, 27223.958203134447, 27253.45493090167], "value": 19058.144292298708, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.7108498743499, 379.63175719552044, 382.319471341013, 389.25069241709707, 405.446565438177, 17678.116094195288, 19483.41549753508, 19540.413787586396, 19554.12006459711, 19576.608467830636, 18103.81896181038, 18405.35581254653, 18412.0, 18650.440486785385, 19102.617947641073, 5486.670799752028, 5633.830985070434, 5783.6529808211435, 5836.97081514594, 5838.124281357809, 5729.054705973509, 5744.712764361786, 5771.365149833536, 5772.595918285721, 5774.8267551973295, 5755.165501002373, 5759.424057594228, 5763.0, 6053.667048312341, 6376.0754690570075, 6507.772227972046, 6519.8696026079215, 6538.836529086763, 6559.737610495598, 6567.211934567858, 5546.084895992157, 5553.278073850414, 5554.527865131468, 5554.583406244547, 5561.499465048125, 12679.302638354888, 12939.87060129396, 12946.287954162517, 21685.67471487929, 23080.65379019299, 2487.664165337674, 2620.685517737884, 2662.5739881618847, 2754.0, 3010.0969709087403, 9470.289728270407, 9615.471149086798, 9708.514574271258, 9750.0, 9905.75235619108, 1924.4707705380993, 1973.2698901406573, 1983.9404817855489, 2004.6091012252616, 2073.1292857000094, 49850.252246216696, 67213.9917901227, 80975.38049239041, 86988.0, 91056.54471727599, 10644.467776611138, 10812.891871081345, 10898.727531811768, 10906.127509799197, 11176.491173691447, 15243.923780381027, 15288.388464461297, 15295.694086118216, 15333.080015199124, 15342.309596068204, 7731.690732370755, 8027.1972802719265, 8044.637991290406, 8163.224493673091, 8180.46826956246, 7726.806829829186, 7812.882806757903, 7829.099653539802, 7893.052833659997, 7938.404619653549, 4277.850275240352, 4302.440682711227, 4382.824687012484, 4425.933610995838, 4647.790849411717, 1766.4612293250682, 1852.1665250637268, 1919.9040047997544, 1946.6009468059015, 1959.9804001959799, 872.5113936195751, 939.727479031087, 970.4953424219508, 982.6266018912768, 1004.8241557727515, 18373.51957485749, 19471.221151153793, 19499.51251218731, 19553.804461955482, 19835.504112397306, 947.0955237747934, 953.9856902146473, 961.3895176562933, 975.1963106070049, 975.3270243532082, 10618.712898338405, 10929.726756831144, 10960.561577536968, 10963.890361096286, 11006.779864402828, 397723.0, 423132.0, 450165.0, 457382.0, 457990.0, 56587.0, 90214.0, 94536.0, 96913.0, 97337.0, 921.2998121427763, 935.2798345274101, 967.032967032967, 968.2205824311357, 968.9467079310565, 17315.7402638958, 17959.551011224823, 18002.459926202235, 18093.457196284133, 18093.81906180974, 41500.37749433701, 42187.15625687531, 43215.13569728525, 43360.0, 45385.77307113575, 61886.0, 63214.0, 64272.0, 64847.67576162089, 66209.0, 7859.646315915683, 8221.671133154607, 8662.696805612026, 8668.739937801876, 8936.106389361012, 13376.866231337563, 13489.865101349253, 14081.436742530184, 14273.286335682966, 14287.64280892986, 12047.457864396298, 12123.696907577381, 12345.444454999368, 12381.938090309492, 12675.30285834288, 12065.396730163633, 12100.394980251129, 12114.091443141975, 12293.93853030729, 12441.688957775767, 12363.196392234477, 12649.177803442746, 12736.936315318364, 12763.93618031941, 12771.425285861973, 7513.361364283878, 7698.461107722405, 7856.607169641381, 7896.368290536629, 8349.081601024003, 10517.894821051997, 11790.705232369259, 12261.938690306491, 12448.502059917502, 12535.874641253471], "value": 9148.467741118679, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.225811287566, 1376.7108907129505, 1437.8705916467516, 1606.8232494425617, 1648.653782705631, 8456.661733530658, 8905.732828015161, 8920.509371984539, 8940.061293564171, 8976.237019853304, 7241.927580724191, 8311.833763324745, 8562.871556926651, 8606.526641034741, 8775.78060548485, 2206.249875042485, 2213.380253529014, 2231.163313757341, 2232.7320721513443, 2235.3852690510075, 2232.1406258590478, 2237.7314722233355, 2277.23712556293, 2278.2140161644206, 2280.543891221754, 1898.591802762406, 2164.5346250556127, 2242.8654280743126, 2243.0, 2266.626006708891, 2204.655160352184, 2210.812080973119, 2228.5542891421783, 2230.0410823345956, 2248.651459023854, 2230.2194232018824, 2232.241038047072, 2233.586786444513, 2234.240358278177, 2234.5195782906753, 9016.053314402025, 9043.0, 9043.954780226122, 9044.909550904473, 9082.27436787015, 4801.855944321676, 4915.3855768029, 4924.0, 4935.432425271068, 4950.925736113961, 3277.8197199154038, 3383.2387712764676, 3421.323551459792, 3432.7940323580415, 3446.672566106216, 1020.9183265338755, 1045.29442626227, 1047.5809676129534, 1052.095198129608, 1072.8015317166348, 12582.622521324374, 12594.74810503794, 12621.873781262162, 12628.431720572504, 12643.43104560297, 4255.085156691264, 4255.085156691326, 4430.091831174602, 4431.202383570988, 4451.643868490513, 10226.795464090825, 10228.0, 10235.43705096212, 10239.334443261165, 10240.385576865412, 5131.87170320745, 5139.177731562932, 5140.691558506502, 5148.639595228373, 5150.40770311419, 4619.69971951822, 4751.40607424072, 4755.857324280277, 4756.405449318835, 4762.571368576845, 3811.7903515306925, 3837.0791010157363, 3889.630485103911, 3897.824597893102, 3950.822213000422, 1079.1959989807644, 1147.6901236666054, 1164.831099490586, 1173.7945859474728, 1204.9397530123458, 859.8667206582865, 865.7272959017889, 900.6757567275776, 907.228855472856, 910.7768596693852, 5547.389787123413, 5664.575156863251, 5733.913991290134, 5853.209816674779, 5862.472377485961, 914.8170365926841, 921.8893732752113, 928.8142371525587, 944.3295260365218, 960.7502049467189, 3983.5618082010956, 4090.1615168890903, 4106.466159399259, 4149.336106223051, 4171.666266698657, 11045.502952367162, 11363.943180284212, 11484.19610627248, 11518.36648984297, 11540.711482212844, 9957.30298879086, 10020.849687254697, 11349.943250283695, 11362.375069371099, 11376.0, 7962.562059086806, 8049.9597502013285, 8060.073091594424, 8105.432619716563, 8115.513069215748, 5842.357340692435, 6001.5798894077, 6007.48936340416, 6040.879182416239, 6157.138000679819, 10358.274920755475, 10422.791544169226, 10451.94774026125, 10464.843027354747, 10490.475476226005, 10671.626493072705, 10693.304935179189, 10713.89286107129, 10797.0, 10809.621663241749, 7069.787906362817, 7106.7157313706875, 7191.820204494929, 7207.279272072751, 7262.782116536512, 7995.240452157036, 8091.595420228848, 8091.907592475176, 8112.310453611273, 8127.3091787198755, 7244.058272424551, 7335.889961650473, 7428.962855185906, 7475.850482990419, 7549.584772837547, 7302.707891684273, 7415.073115860518, 7418.109826820601, 7422.035135432359, 7542.208068152984, 6717.731290748316, 6723.092382528492, 6774.762883299061, 6788.93211067883, 6791.66041697923, 4821.349117869043, 4962.900741985212, 5076.0863044652315, 5097.337346144977, 5134.589232861437, 4995.350604421402, 4997.100521906092, 5097.1844504879045, 5191.402988656202, 5356.009138309425], "value": 4528.901452387887, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.2382415127459, 291.2558413254135, 300.33475850990055, 305.38769766617935, 307.9568860359549, 5266.368035835705, 5270.341207349082, 5299.364076310839, 5316.17599272113, 5332.680039197651, 4975.353204083464, 5051.964347308802, 5146.871328216796, 5223.164293713006, 5273.446288139748, 4054.452648892406, 4070.3080476319096, 4071.653909417703, 4089.488813898263, 4099.713020088595, 4090.550039495653, 4104.712670113093, 4108.5275193352845, 4112.321466957948, 4112.938305925399, 3851.2490064437447, 3958.7237338530317, 4004.5394779600283, 4020.6582440492593, 4027.4764280643476, 3993.1614360984227, 4003.339448990913, 4005.399190121505, 4005.959940400588, 4016.31722607156, 3505.3865573524786, 3509.3683137035323, 3510.4909788080586, 3513.94729079064, 3525.3478106550115, 4935.087008903329, 5071.174377224196, 5082.720450375228, 5106.795728170869, 5120.0, 4583.1062942726185, 4597.758605176617, 4600.102979918917, 4620.676552641316, 4635.907281854378, 5452.100403433429, 5466.644668096561, 5479.3424789025175, 5501.157112367362, 5510.91733623996, 3769.719319811502, 3906.5312162540677, 3912.5937548407524, 3926.960730392688, 3930.290323709167, 5678.0, 5705.286839145107, 5716.456936591017, 5725.513331366838, 5733.369329373765, 3995.900102497461, 3995.9400608990886, 4000.4799376080923, 4004.539477960072, 4019.537753158366, 3980.7810570418324, 4028.637422631977, 4048.109415928491, 4055.168690418457, 4073.2260870435116, 4588.715159755274, 4604.700694454849, 4638.5593368629925, 4673.499677672429, 4696.084263568571, 5502.147167189092, 5534.501894829405, 5555.694436805934, 5558.44415558441, 5587.525060369833, 1254.6549698832712, 1327.2633688302892, 1410.4569740649924, 1420.566727148209, 1423.8718515333462, 957.0, 978.6183388478499, 985.4530735441755, 998.8951160128228, 999.6801023672355, 4778.04439112179, 4799.9200179959225, 4807.278908163804, 4810.230363141881, 4838.879028024327, 4995.425526064549, 5004.749762511933, 5037.236967061499, 5042.420121686053, 5054.772535235849, 4796.8081276749235, 5058.317127187856, 5343.893122137535, 5409.486098820606, 5418.187271909245, 2958.926026849346, 2976.318380115228, 3027.5458681197997, 3036.0, 3040.695930406986, 5699.971500142473, 5859.568279164099, 5880.441358070976, 5887.264091988502, 5903.704814759245, 5771.769129234867, 5792.913106303409, 5805.941940580625, 5826.533877289807, 5840.912386314209, 5810.273715785527, 5820.8253752386645, 5830.53355731549, 5858.326292476249, 5867.765289388462, 5455.554278116381, 5670.177824215548, 5675.914861277167, 5690.268671037842, 5702.97346477638, 5589.0, 5594.0769772987005, 5595.916061259166, 5608.495235428831, 5611.607187496836, 5637.548996080386, 5753.964286428316, 5828.446297601721, 5833.0, 5835.3581106077445, 3651.7808931464197, 4031.09300407406, 4033.1328764315813, 4047.9797601011805, 4054.55399906016, 5537.335519737496, 5665.263515742927, 5690.971545142248, 5698.344690360662, 5713.8285851424525, 5504.422035686195, 5507.256520369699, 5521.135205356187, 5525.751341189576, 5542.418046105101, 5286.312779338661, 5508.512701570634, 5515.503604675599, 5562.5549956002615, 5565.666060036411, 5453.700046497481, 5472.972635136799, 5481.945180548303, 5491.807786727445, 5502.972485137709, 5515.365732940763, 5517.724113794214, 5534.557235421237, 5560.36055853582, 5595.35653399848, 5298.231756395224, 5471.124620060771, 5479.808206712746, 5489.34127904654, 5505.862353441196], "value": 4155.362857925443, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.4018405367732, 764.8699721047421, 767.3630886364317, 776.4526009163541, 788.9171636978116, 14275.571732848019, 15044.548663540085, 15293.2353382331, 15317.770233446507, 16261.674766504662, 13385.063045586812, 13393.732125357486, 13570.592882213525, 13631.931840340785, 13677.521286754965, 585.0609771317039, 701.9929800701979, 705.3863139068992, 714.2607401339602, 724.9927500725005, 725.8040329111137, 726.3208899678791, 735.5292612727858, 735.7020406735281, 735.8712225360567, 756.0511557994708, 770.0297624992522, 770.4606775257314, 774.9883751743729, 775.7013549783318, 625.1685258606043, 741.0625558668289, 760.277736150659, 766.9041369828772, 771.090113665874, 537.8305833662383, 540.9918851217235, 545.3346916761544, 547.3951283831389, 553.698234462219, 14717.116972981656, 14781.408743650241, 14805.925970370186, 14831.925840370837, 14869.628259293497, 14292.499762508261, 14635.560933172022, 14649.267536623232, 14705.338259778335, 14726.33731482086, 13013.349332533335, 13073.803892941614, 13081.542146024938, 13181.275029873354, 13646.317684115853, 4372.606465418127, 4478.932816007762, 4517.9774101129615, 4601.470830854461, 4633.72197668141, 76851.0, 77667.0, 77840.61079694622, 77908.61045694735, 77940.22059779442, 11194.272372295774, 11416.771664566828, 11537.826932596017, 11563.88436115628, 11814.35021073832, 20092.296769612993, 20145.899270503553, 20168.59662806765, 20170.59658806845, 20224.393268201977, 8577.656893724306, 8598.39811213209, 8641.092685268082, 8911.73264802057, 8987.011428742833, 4559.589636932692, 4646.883827904262, 4711.316859055486, 4773.427188737304, 4791.329213910055, 3421.1105112670884, 3508.649135086471, 3514.5079688843584, 3516.7889926604485, 3530.5586801649793, 550.3560982128329, 630.6594439002887, 643.954923155384, 658.4723441615406, 662.9105070815475, 582.6533212738414, 606.3633185155569, 650.8210242183437, 657.5857209957792, 692.3007762160255, 9923.404595724136, 10324.48377581133, 10340.276180667432, 10349.482525873827, 10658.467076646137, 614.1786972267663, 656.2846497317946, 719.5646633786588, 744.4491076603383, 781.355381810009, 4634.420697412824, 4966.90066198674, 4968.701877887338, 5063.822766203239, 5154.639175257696, 97902.0, 113633.4318328403, 114012.42993784978, 117408.0, 118071.0, 58269.41730582725, 58624.4137558619, 84206.26349891994, 98865.0, 99439.50280248553, 85086.574567128, 86789.0, 88894.55552722195, 91308.54345728362, 92583.53708231416, 9884.456354900549, 9924.1068303853, 10046.598136074475, 10465.9476702616, 10557.736056598647, 46103.769481152376, 46557.0, 53815.730921345144, 55301.170482441994, 55321.72339138279, 56833.14750278832, 59371.0, 75192.0, 76849.61575192088, 77372.61313693396, 12642.39158428581, 13021.153625014344, 13133.146345487512, 13218.60344189676, 13460.865391345962, 15218.771718424012, 15338.233088345314, 15358.462453814063, 15460.690786183988, 15618.843811562194, 13482.325883705971, 14731.33708983077, 14917.403303867724, 15032.323545440262, 15283.388664453742, 14186.219757913414, 14392.85607143957, 14555.92722036383, 14783.630409239855, 15057.623559411102, 14128.0, 14378.784318235445, 14567.781483277548, 14581.0, 14897.106173629616, 10870.510827012646, 11075.390853502813, 11177.105831533296, 11300.434978251218, 11428.94285528567, 11194.216404851582, 11377.20359574855, 11401.942990284995, 11682.649520514398, 11773.529058837894], "value": 7471.423531221532, "unit": "score"}], "name": "dromaeo_css", "value": 7087.63409424729, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 110.0, 110.0, 110.0, 108.0, 108.0, 110.0, 107.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 115.0, 119.0, 163.0, 121.0, 122.0, 143.0, 116.0, 173.0, 120.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 160.0, 162.0, 160.0, 159.0, 163.0, 162.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 126.0, 75.0, 76.0, 73.0, 73.0, 96.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 119.0, 85.0, 84.0, 85.0, 121.0, 84.0, 84.0, 121.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 52.0, 52.0, 53.0, 52.0, 57.0, 51.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 61.0, 62.0, 60.0, 62.0, 61.0, 60.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 85.0, 78.0, 76.0, 74.0, 75.0, 81.0, 75.0, 83.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 120.0, 127.0, 120.0, 121.0, 128.0, 119.0, 120.0, 208.0, 121.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 159.0, 158.0, 162.0, 158.0, 159.0, 164.0, 159.0, 158.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 62.0, 62.0, 62.0, 62.0, 62.0, 64.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1484.9, "alertThreshold": 2.0}]} 02:34:11 INFO - Return code: 0 02:34:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:34:11 INFO - # TBPL SUCCESS # 02:34:11 INFO - Running post-action listener: _resource_record_post_action 02:34:11 INFO - ##### 02:34:11 INFO - ##### Finished run-tests step (success) 02:34:11 INFO - ##### 02:34:11 INFO - Running post-run listener: _resource_record_post_run 02:34:11 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 554831872; Read time: 0; Write time: 559832 02:34:11 INFO - TinderboxPrint: CPU usage
13.0% 02:34:11 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:34:11 INFO - TinderboxPrint: I/O write bytes / time
554,831,872 / 559,832 02:34:11 INFO - TinderboxPrint: CPU idle
8,267.6 (87.0%) 02:34:11 INFO - TinderboxPrint: CPU user
1,194.4 (12.6%) 02:34:11 INFO - TinderboxPrint: Swap in / out
0 / 0 02:34:11 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240902144; Read time: 0; Write time: 322296 02:34:11 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 296775680; Read time: 0; Write time: 227632 02:34:11 INFO - Running post-run listener: _upload_blobber_files 02:34:11 INFO - Blob upload gear active. 02:34:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:34:11 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 02:34:11 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'] 02:34:11 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 02:34:12 INFO - (blobuploader) - INFO - Open directory for files ... 02:34:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:34:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:34:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:15 INFO - (blobuploader) - INFO - Done attempting. 02:34:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:34:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:34:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:16 INFO - (blobuploader) - INFO - Done attempting. 02:34:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:34:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:34:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:17 INFO - (blobuploader) - INFO - Done attempting. 02:34:17 INFO - (blobuploader) - INFO - Iteration through files over. 02:34:17 INFO - Return code: 0 02:34:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:34:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:34:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ad85644acfcfe8e4fb1010b79df18988a5db1ed274df747991bdce0e654c07f5a16359f21f5c59292b8a3c9148a09c6b02b4e680076cb93d065b1a9d634c861", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0c63001f6f196a93fbea5902ae9900357c211454e5b617feb9edefba12e4a0e01e1e06533ff072efbacc6d943d1f3d39cec929e5271ef097482c9ed1fff39e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f638f2c058838312206f5cda9d28ead24cea7937234721d3e8639265f65b010cb3169dde3cd899b27234acc4b9cd6c0c15587812239aa429d8c32d10a0a57572"} 02:34:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:34:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:34:17 INFO - Contents: 02:34:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ad85644acfcfe8e4fb1010b79df18988a5db1ed274df747991bdce0e654c07f5a16359f21f5c59292b8a3c9148a09c6b02b4e680076cb93d065b1a9d634c861", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0c63001f6f196a93fbea5902ae9900357c211454e5b617feb9edefba12e4a0e01e1e06533ff072efbacc6d943d1f3d39cec929e5271ef097482c9ed1fff39e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f638f2c058838312206f5cda9d28ead24cea7937234721d3e8639265f65b010cb3169dde3cd899b27234acc4b9cd6c0c15587812239aa429d8c32d10a0a57572"} 02:34:17 INFO - Running post-run listener: copy_logs_to_upload_dir 02:34:17 INFO - Copying logs to upload dir... 02:34:17 INFO - mkdir: /builds/slave/test/build/upload/logs 02:34:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.387962 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-07 02:34:17.137485) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 02:34:17.141417) ========= 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=db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691 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/7ad85644acfcfe8e4fb1010b79df18988a5db1ed274df747991bdce0e654c07f5a16359f21f5c59292b8a3c9148a09c6b02b4e680076cb93d065b1a9d634c861", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0c63001f6f196a93fbea5902ae9900357c211454e5b617feb9edefba12e4a0e01e1e06533ff072efbacc6d943d1f3d39cec929e5271ef097482c9ed1fff39e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f638f2c058838312206f5cda9d28ead24cea7937234721d3e8639265f65b010cb3169dde3cd899b27234acc4b9cd6c0c15587812239aa429d8c32d10a0a57572"} build_url:https://queue.taskcluster.net/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/CPH41onvT2OmrkiOvXl23w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ad85644acfcfe8e4fb1010b79df18988a5db1ed274df747991bdce0e654c07f5a16359f21f5c59292b8a3c9148a09c6b02b4e680076cb93d065b1a9d634c861", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0c63001f6f196a93fbea5902ae9900357c211454e5b617feb9edefba12e4a0e01e1e06533ff072efbacc6d943d1f3d39cec929e5271ef097482c9ed1fff39e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f638f2c058838312206f5cda9d28ead24cea7937234721d3e8639265f65b010cb3169dde3cd899b27234acc4b9cd6c0c15587812239aa429d8c32d10a0a57572"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 02:34:17.166263) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:34:17.166558) ========= 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=db0483c52d987ecb441a263b000001ad-1467882823.502666-1901929691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 02:34:17.249422) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 02:34:17.249694) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 02:34:17.249945) ========= ========= Total master_lag: 0.17 =========