builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1468509240.66 results: success (0) buildid: 20160714053013 builduid: 6219fd58294247a5a4715e9faa93dc3c revision: 1d5210d6f9614812ebdfad13a0d6e25d4513c03e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 08:14:00.662529) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 08:14:00.662991) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 08:14:00.663265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 08:14:00.678009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:14:00.678295) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 08:14:00-- 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% 34.2M=0s 2016-07-14 08:14:00 (34.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104440 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:14:00.805417) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:14:00.805760) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014724 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:14:00.855290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:14:00.855671) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1d5210d6f9614812ebdfad13a0d6e25d4513c03e --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 1d5210d6f9614812ebdfad13a0d6e25d4513c03e --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=78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 08:14:01,012 truncating revision to first 12 chars 2016-07-14 08:14:01,012 Setting DEBUG logging. 2016-07-14 08:14:01,012 attempt 1/10 2016-07-14 08:14:01,012 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1d5210d6f961?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 08:14:01,374 unpacking tar archive at: fx-team-1d5210d6f961/testing/mozharness/ program finished with exit code 0 elapsedTime=0.700360 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:14:01.589716) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 08:14:01.590022) ========= script_repo_revision: 1d5210d6f9614812ebdfad13a0d6e25d4513c03e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 08:14:01.590470) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 08:14:01.590759) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 08:14:01.600264) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-14 08:14:01.600631) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:01 INFO - MultiFileLogger online at 20160714 08:14:01 in /builds/slave/test 08:14:01 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 08:14:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:01 INFO - {'append_to_log': False, 08:14:01 INFO - 'base_work_dir': '/builds/slave/test', 08:14:01 INFO - 'blob_upload_branch': 'Fx-Team', 08:14:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:01 INFO - 'branch': 'Fx-Team', 08:14:01 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:01 INFO - 'config_files': ('talos/linux_config.py',), 08:14:01 INFO - 'default_actions': ('clobber', 08:14:01 INFO - 'read-buildbot-config', 08:14:01 INFO - 'download-and-extract', 08:14:01 INFO - 'populate-webroot', 08:14:01 INFO - 'create-virtualenv', 08:14:01 INFO - 'install', 08:14:01 INFO - 'run-tests'), 08:14:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:01 INFO - 'download_minidump_stackwalk': True, 08:14:01 INFO - 'download_symbols': 'ondemand', 08:14:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:01 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:01 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:01 INFO - 'installer_path': 'installer.exe', 08:14:01 INFO - 'log_level': 'info', 08:14:01 INFO - 'log_name': 'talos', 08:14:01 INFO - 'log_to_console': True, 08:14:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:01 INFO - 'opt_config_files': (), 08:14:01 INFO - 'pip_index': False, 08:14:01 INFO - 'sps_profile': False, 08:14:01 INFO - 'sps_profile_interval': 0, 08:14:01 INFO - 'suite': 'dromaeojs', 08:14:01 INFO - 'system_bits': '32', 08:14:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:01 INFO - 'title': 'talos-linux64-ix-019', 08:14:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:01 INFO - 'use_talos_json': True, 08:14:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:01 INFO - 'work_dir': 'build'} 08:14:01 INFO - ##### 08:14:01 INFO - ##### Running clobber step. 08:14:01 INFO - ##### 08:14:01 INFO - Running pre-action listener: _resource_record_pre_action 08:14:01 INFO - Running main action method: clobber 08:14:01 INFO - rmtree: /builds/slave/test/build 08:14:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:02 INFO - Running post-action listener: _resource_record_post_action 08:14:02 INFO - ##### 08:14:02 INFO - ##### Finished clobber step (success) 08:14:02 INFO - ##### 08:14:02 INFO - ##### 08:14:02 INFO - ##### Running read-buildbot-config step. 08:14:02 INFO - ##### 08:14:02 INFO - Running pre-action listener: _resource_record_pre_action 08:14:02 INFO - Running main action method: read_buildbot_config 08:14:02 INFO - Using buildbot properties: 08:14:02 INFO - { 08:14:02 INFO - "project": "", 08:14:02 INFO - "product": "firefox", 08:14:02 INFO - "script_repo_revision": "production", 08:14:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:14:02 INFO - "repository": "", 08:14:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:14:02 INFO - "buildid": "20160714053013", 08:14:02 INFO - "pgo_build": "True", 08:14:02 INFO - "basedir": "/builds/slave/test", 08:14:02 INFO - "buildnumber": 289, 08:14:02 INFO - "slavename": "talos-linux64-ix-019", 08:14:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:14:02 INFO - "platform": "ubuntu64_hw", 08:14:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:14:02 INFO - "branch": "fx-team", 08:14:02 INFO - "repo_path": "integration/fx-team", 08:14:02 INFO - "revision": "1d5210d6f9614812ebdfad13a0d6e25d4513c03e", 08:14:02 INFO - "stage_platform": "linux64-pgo", 08:14:02 INFO - "builduid": "6219fd58294247a5a4715e9faa93dc3c", 08:14:02 INFO - "slavebuilddir": "test" 08:14:02 INFO - } 08:14:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:14:02 INFO - Running post-action listener: _resource_record_post_action 08:14:02 INFO - ##### 08:14:02 INFO - ##### Finished read-buildbot-config step (success) 08:14:02 INFO - ##### 08:14:02 INFO - ##### 08:14:02 INFO - ##### Running download-and-extract step. 08:14:02 INFO - ##### 08:14:02 INFO - Running pre-action listener: _resource_record_pre_action 08:14:02 INFO - Running main action method: download_and_extract 08:14:02 INFO - mkdir: /builds/slave/test/build/tests 08:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:02 INFO - https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:14:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:14:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:14:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:14:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:14:08 INFO - Downloaded 1361 bytes. 08:14:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:14:08 INFO - Using the following test package requirements: 08:14:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:14:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:14:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:14:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:08 INFO - u'jsshell-linux-x86_64.zip'], 08:14:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:14:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:14:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:14:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:14:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:14:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:14:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:14:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:08 INFO - https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:14:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:14:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:14:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:14:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:14:09 INFO - Downloaded 24327085 bytes. 08:14:09 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'] 08:14:09 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 08:14:11 INFO - Return code: 0 08:14:11 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 08:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:11 INFO - https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:14:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:14:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:14:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:14:12 INFO - Downloaded 24327085 bytes. 08:14:12 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'] 08:14:12 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 08:14:14 INFO - Return code: 0 08:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:14 INFO - https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:14:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:14:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:14:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:14:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:14:15 INFO - Downloaded 14403317 bytes. 08:14:15 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'] 08:14:15 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 08:14:15 INFO - Return code: 0 08:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:15 INFO - https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:14:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:14:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:14:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:14:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FAsVQeQoRj2zL56XiX8OuA/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 08:14:16 INFO - Downloaded 60810775 bytes. 08:14:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:14:16 INFO - mkdir: /builds/slave/test/properties 08:14:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:16 INFO - Contents: 08:14:16 INFO - build_url:https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:14:17 INFO - Running post-action listener: _resource_record_post_action 08:14:17 INFO - Running post-action listener: set_extra_try_arguments 08:14:17 INFO - ##### 08:14:17 INFO - ##### Finished download-and-extract step (success) 08:14:17 INFO - ##### 08:14:17 INFO - ##### 08:14:17 INFO - ##### Running populate-webroot step. 08:14:17 INFO - ##### 08:14:17 INFO - Running pre-action listener: _resource_record_pre_action 08:14:17 INFO - Running main action method: populate_webroot 08:14:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:17 INFO - '--tppagecycles', 08:14:17 INFO - '7'], 08:14:17 INFO - 'tests': ['tsvgm']}}, 08:14:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:17 INFO - 'talos_options': ['--disable-e10s'], 08:14:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:17 INFO - 'talos_options': ['--disable-e10s'], 08:14:17 INFO - 'tests': ['damp', 'tps']}, 08:14:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:17 INFO - 'tests': ['damp', 'tps']}, 08:14:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:17 INFO - 'tests': ['dromaeo_dom']}, 08:14:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:14:17 INFO - 'tests': ['basic_compositor_video']}, 08:14:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:14:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:17 INFO - 'tests': ['a11yr', 08:14:17 INFO - 'ts_paint', 08:14:17 INFO - 'tpaint', 08:14:17 INFO - 'sessionrestore', 08:14:17 INFO - 'sessionrestore_no_auto_restore', 08:14:17 INFO - 'tabpaint']}, 08:14:17 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:17 INFO - 'ts_paint', 08:14:17 INFO - 'tpaint', 08:14:17 INFO - 'sessionrestore', 08:14:17 INFO - 'sessionrestore_no_auto_restore', 08:14:17 INFO - 'tabpaint']}, 08:14:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:17 INFO - 'ts_paint', 08:14:17 INFO - 'tpaint', 08:14:17 INFO - 'sessionrestore', 08:14:17 INFO - 'sessionrestore_no_auto_restore', 08:14:17 INFO - 'tabpaint']}, 08:14:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:17 INFO - 'ts_paint', 08:14:17 INFO - 'tpaint', 08:14:17 INFO - 'sessionrestore', 08:14:17 INFO - 'sessionrestore_no_auto_restore', 08:14:17 INFO - 'tabpaint']}, 08:14:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:17 INFO - 'tests': ['a11yr', 08:14:17 INFO - 'ts_paint', 08:14:17 INFO - 'tpaint', 08:14:17 INFO - 'sessionrestore', 08:14:17 INFO - 'sessionrestore_no_auto_restore', 08:14:17 INFO - 'tabpaint']}, 08:14:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:17 INFO - 'tests': ['a11yr', 08:14:17 INFO - 'ts_paint', 08:14:17 INFO - 'tpaint', 08:14:17 INFO - 'sessionrestore', 08:14:17 INFO - 'sessionrestore_no_auto_restore', 08:14:17 INFO - 'tabpaint']}, 08:14:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:17 INFO - 'tests': ['tsvgx', 08:14:17 INFO - 'tsvgr_opacity', 08:14:17 INFO - 'tart', 08:14:17 INFO - 'tscrollx', 08:14:17 INFO - 'cart']}, 08:14:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:17 INFO - 'tsvgr_opacity', 08:14:17 INFO - 'tart', 08:14:17 INFO - 'tscrollx', 08:14:17 INFO - 'cart']}, 08:14:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:17 INFO - 'talos_options': ['--disable-e10s'], 08:14:17 INFO - 'tests': ['tp5o']}, 08:14:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:17 INFO - 'tests': ['tp5o']}, 08:14:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:17 INFO - 'talos_options': ['--disable-e10s', 08:14:17 INFO - '--xperf_path', 08:14:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:17 INFO - 'tests': ['tp5n']}, 08:14:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:17 INFO - 'talos_options': ['--xperf_path', 08:14:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:17 INFO - 'tests': ['tp5n']}}, 08:14:17 INFO - 'talos.zip': {'path': '', 08:14:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:17 INFO - Running post-action listener: _resource_record_post_action 08:14:17 INFO - ##### 08:14:17 INFO - ##### Finished populate-webroot step (success) 08:14:17 INFO - ##### 08:14:17 INFO - ##### 08:14:17 INFO - ##### Running create-virtualenv step. 08:14:17 INFO - ##### 08:14:17 INFO - Running pre-action listener: _resource_record_pre_action 08:14:17 INFO - Running main action method: create_virtualenv 08:14:17 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:17 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 08:14:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:17 INFO - Using real prefix '/usr' 08:14:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:20 INFO - Installing pip.................done. 08:14:20 INFO - Return code: 0 08:14:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:20 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')]} 08:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:20 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')]} 08:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:20 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 0x21fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b93b0>, '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 0x24ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ba740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', '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 08:14:20 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 08:14:20 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 08:14:20 INFO - Using env: {'DISPLAY': ':0', 08:14:20 INFO - 'HOME': '/home/cltbld', 08:14:20 INFO - 'LANG': 'en_US.UTF-8', 08:14:20 INFO - 'LANGUAGE': 'en_US:en', 08:14:20 INFO - 'LOGNAME': 'cltbld', 08:14:20 INFO - 'MAIL': '/var/mail/cltbld', 08:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:20 INFO - 'MOZ_NO_REMOTE': '1', 08:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:20 INFO - 'NO_EM_RESTART': '1', 08:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:20 INFO - 'PWD': '/builds/slave/test', 08:14:20 INFO - 'SHELL': '/bin/bash', 08:14:20 INFO - 'SHLVL': '1', 08:14:20 INFO - 'TERM': 'linux', 08:14:20 INFO - 'TMOUT': '86400', 08:14:20 INFO - 'USER': 'cltbld', 08:14:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', 08:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:20 INFO - '_': '/tools/buildbot/bin/python'} 08:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:20 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 08:14:20 INFO - Cleaning up... 08:14:20 INFO - Return code: 0 08:14:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:14:20 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')]} 08:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:20 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')]} 08:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:20 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 0x21fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b93b0>, '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 0x24ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ba740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', '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 08:14:20 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 08:14:20 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 08:14:20 INFO - Using env: {'DISPLAY': ':0', 08:14:20 INFO - 'HOME': '/home/cltbld', 08:14:20 INFO - 'LANG': 'en_US.UTF-8', 08:14:20 INFO - 'LANGUAGE': 'en_US:en', 08:14:20 INFO - 'LOGNAME': 'cltbld', 08:14:20 INFO - 'MAIL': '/var/mail/cltbld', 08:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:20 INFO - 'MOZ_NO_REMOTE': '1', 08:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:20 INFO - 'NO_EM_RESTART': '1', 08:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:20 INFO - 'PWD': '/builds/slave/test', 08:14:20 INFO - 'SHELL': '/bin/bash', 08:14:20 INFO - 'SHLVL': '1', 08:14:20 INFO - 'TERM': 'linux', 08:14:20 INFO - 'TMOUT': '86400', 08:14:20 INFO - 'USER': 'cltbld', 08:14:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', 08:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:20 INFO - '_': '/tools/buildbot/bin/python'} 08:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:20 INFO - Downloading/unpacking psutil>=3.1.1 08:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:22 INFO - Installing collected packages: psutil 08:14:22 INFO - Running setup.py install for psutil 08:14:22 INFO - building 'psutil._psutil_linux' extension 08:14:22 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 08:14:22 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 08:14:22 INFO - building 'psutil._psutil_posix' extension 08:14:22 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 08:14:23 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 08:14:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:23 INFO - Successfully installed psutil 08:14:23 INFO - Cleaning up... 08:14:23 INFO - Return code: 0 08:14:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:14:23 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')]} 08:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:23 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')]} 08:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:23 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 0x21fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b93b0>, '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 0x24ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ba740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', '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 08:14:23 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 08:14:23 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 08:14:23 INFO - Using env: {'DISPLAY': ':0', 08:14:23 INFO - 'HOME': '/home/cltbld', 08:14:23 INFO - 'LANG': 'en_US.UTF-8', 08:14:23 INFO - 'LANGUAGE': 'en_US:en', 08:14:23 INFO - 'LOGNAME': 'cltbld', 08:14:23 INFO - 'MAIL': '/var/mail/cltbld', 08:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:23 INFO - 'MOZ_NO_REMOTE': '1', 08:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:23 INFO - 'NO_EM_RESTART': '1', 08:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:23 INFO - 'PWD': '/builds/slave/test', 08:14:23 INFO - 'SHELL': '/bin/bash', 08:14:23 INFO - 'SHLVL': '1', 08:14:23 INFO - 'TERM': 'linux', 08:14:23 INFO - 'TMOUT': '86400', 08:14:23 INFO - 'USER': 'cltbld', 08:14:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', 08:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:23 INFO - '_': '/tools/buildbot/bin/python'} 08:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:14:25 INFO - Installing collected packages: mozsystemmonitor 08:14:25 INFO - Running setup.py install for mozsystemmonitor 08:14:25 INFO - Successfully installed mozsystemmonitor 08:14:25 INFO - Cleaning up... 08:14:25 INFO - Return code: 0 08:14:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:25 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 0x21fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b93b0>, '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 0x24ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ba740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', '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 08:14:25 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 08:14:25 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 08:14:25 INFO - Using env: {'DISPLAY': ':0', 08:14:25 INFO - 'HOME': '/home/cltbld', 08:14:25 INFO - 'LANG': 'en_US.UTF-8', 08:14:25 INFO - 'LANGUAGE': 'en_US:en', 08:14:25 INFO - 'LOGNAME': 'cltbld', 08:14:25 INFO - 'MAIL': '/var/mail/cltbld', 08:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:25 INFO - 'MOZ_NO_REMOTE': '1', 08:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:25 INFO - 'NO_EM_RESTART': '1', 08:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:25 INFO - 'PWD': '/builds/slave/test', 08:14:25 INFO - 'SHELL': '/bin/bash', 08:14:25 INFO - 'SHLVL': '1', 08:14:25 INFO - 'TERM': 'linux', 08:14:25 INFO - 'TMOUT': '86400', 08:14:25 INFO - 'USER': 'cltbld', 08:14:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', 08:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:25 INFO - '_': '/tools/buildbot/bin/python'} 08:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:25 INFO - Downloading/unpacking jsonschema==2.5.1 08:14:25 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 08:14:25 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 08:14:25 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 08:14:25 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 08:14:25 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 08:14:25 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 08:14:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:14:27 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 08:14:27 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 08:14:27 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 08:14:27 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 08:14:27 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 08:14:27 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 08:14:27 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:27 INFO - warning: no files found matching '*.txt' 08:14:27 INFO - no previously-included directories found matching 'build' 08:14:27 INFO - no previously-included directories found matching 'dist' 08:14:27 INFO - no previously-included directories found matching '.git*' 08:14:27 INFO - Installing collected packages: jsonschema, functools32 08:14:27 INFO - Running setup.py install for functools32 08:14:28 INFO - warning: no files found matching '*.txt' 08:14:28 INFO - no previously-included directories found matching 'build' 08:14:28 INFO - no previously-included directories found matching 'dist' 08:14:28 INFO - no previously-included directories found matching '.git*' 08:14:28 INFO - Successfully installed jsonschema functools32 08:14:28 INFO - Cleaning up... 08:14:28 INFO - Return code: 0 08:14:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:28 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 0x21fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b93b0>, '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 0x24ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ba740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', '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 08:14:28 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 08:14:28 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 08:14:28 INFO - Using env: {'DISPLAY': ':0', 08:14:28 INFO - 'HOME': '/home/cltbld', 08:14:28 INFO - 'LANG': 'en_US.UTF-8', 08:14:28 INFO - 'LANGUAGE': 'en_US:en', 08:14:28 INFO - 'LOGNAME': 'cltbld', 08:14:28 INFO - 'MAIL': '/var/mail/cltbld', 08:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:28 INFO - 'MOZ_NO_REMOTE': '1', 08:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:28 INFO - 'NO_EM_RESTART': '1', 08:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:28 INFO - 'PWD': '/builds/slave/test', 08:14:28 INFO - 'SHELL': '/bin/bash', 08:14:28 INFO - 'SHLVL': '1', 08:14:28 INFO - 'TERM': 'linux', 08:14:28 INFO - 'TMOUT': '86400', 08:14:28 INFO - 'USER': 'cltbld', 08:14:28 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', 08:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:28 INFO - '_': '/tools/buildbot/bin/python'} 08:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:28 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:28 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 08:14:28 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 08:14:28 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 08:14:28 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 08:14:28 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 08:14:28 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 08:14:30 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:30 INFO - Downloading docopt-0.6.1.tar.gz 08:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:31 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:31 INFO - Running setup.py install for blobuploader 08:14:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:31 INFO - Running setup.py install for requests 08:14:31 INFO - Running setup.py install for docopt 08:14:31 INFO - Successfully installed blobuploader requests docopt 08:14:31 INFO - Cleaning up... 08:14:31 INFO - Return code: 0 08:14:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:31 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 0x21fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b93b0>, '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 0x24ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ba740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', '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 08:14:31 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 08:14:31 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 08:14:31 INFO - Using env: {'DISPLAY': ':0', 08:14:31 INFO - 'HOME': '/home/cltbld', 08:14:31 INFO - 'LANG': 'en_US.UTF-8', 08:14:31 INFO - 'LANGUAGE': 'en_US:en', 08:14:31 INFO - 'LOGNAME': 'cltbld', 08:14:31 INFO - 'MAIL': '/var/mail/cltbld', 08:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:31 INFO - 'MOZ_NO_REMOTE': '1', 08:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:31 INFO - 'NO_EM_RESTART': '1', 08:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:31 INFO - 'PWD': '/builds/slave/test', 08:14:31 INFO - 'SHELL': '/bin/bash', 08:14:31 INFO - 'SHLVL': '1', 08:14:31 INFO - 'TERM': 'linux', 08:14:31 INFO - 'TMOUT': '86400', 08:14:31 INFO - 'USER': 'cltbld', 08:14:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', 08:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:31 INFO - '_': '/tools/buildbot/bin/python'} 08:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:31 INFO - Running setup.py (path:/tmp/pip-1DJUPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:31 INFO - Running setup.py (path:/tmp/pip-dOumMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:31 INFO - Running setup.py (path:/tmp/pip-jvID2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:32 INFO - Running setup.py (path:/tmp/pip-dO9_fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:32 INFO - Running setup.py (path:/tmp/pip-lXi_xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:32 INFO - Running setup.py (path:/tmp/pip-EtCtUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:32 INFO - Running setup.py (path:/tmp/pip-apOykN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:32 INFO - Running setup.py (path:/tmp/pip-xM0Ms7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:32 INFO - Running setup.py (path:/tmp/pip-ZyFgHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:32 INFO - Running setup.py (path:/tmp/pip-YXXKe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:32 INFO - Running setup.py (path:/tmp/pip-IaRSbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:32 INFO - Running setup.py (path:/tmp/pip-GVBcPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:32 INFO - Running setup.py (path:/tmp/pip-XxR_fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:32 INFO - Running setup.py (path:/tmp/pip-vkBguC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:32 INFO - Running setup.py (path:/tmp/pip-y4M508-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:32 INFO - Running setup.py (path:/tmp/pip-4dfTd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:33 INFO - Running setup.py (path:/tmp/pip-TncPKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:33 INFO - Running setup.py install for manifestparser 08:14:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozcrash 08:14:33 INFO - Running setup.py install for mozdebug 08:14:33 INFO - Running setup.py install for mozdevice 08:14:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozfile 08:14:33 INFO - Running setup.py install for mozhttpd 08:14:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozinfo 08:14:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozInstall 08:14:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozleak 08:14:33 INFO - Running setup.py install for mozlog 08:14:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Running setup.py install for moznetwork 08:14:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Running setup.py install for mozprocess 08:14:34 INFO - Running setup.py install for mozprofile 08:14:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Running setup.py install for mozrunner 08:14:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Running setup.py install for mozscreenshot 08:14:34 INFO - Running setup.py install for moztest 08:14:34 INFO - Running setup.py install for mozversion 08:14:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:34 INFO - Cleaning up... 08:14:34 INFO - Return code: 0 08:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:34 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')]} 08:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 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')]} 08:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 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 0x21fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b93b0>, '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 0x24ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ba740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', '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 08:14:34 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 08:14:34 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 08:14:34 INFO - Using env: {'DISPLAY': ':0', 08:14:34 INFO - 'HOME': '/home/cltbld', 08:14:34 INFO - 'LANG': 'en_US.UTF-8', 08:14:34 INFO - 'LANGUAGE': 'en_US:en', 08:14:34 INFO - 'LOGNAME': 'cltbld', 08:14:34 INFO - 'MAIL': '/var/mail/cltbld', 08:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:34 INFO - 'MOZ_NO_REMOTE': '1', 08:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:34 INFO - 'NO_EM_RESTART': '1', 08:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:34 INFO - 'PWD': '/builds/slave/test', 08:14:34 INFO - 'SHELL': '/bin/bash', 08:14:34 INFO - 'SHLVL': '1', 08:14:34 INFO - 'TERM': 'linux', 08:14:34 INFO - 'TMOUT': '86400', 08:14:34 INFO - 'USER': 'cltbld', 08:14:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', 08:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:34 INFO - '_': '/tools/buildbot/bin/python'} 08:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:35 INFO - Running setup.py (path:/tmp/pip-vzoDCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:35 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)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:35 INFO - Running setup.py (path:/tmp/pip-ZZAlff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:35 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)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:35 INFO - Running setup.py (path:/tmp/pip-Ka9bWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:35 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)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:35 INFO - Running setup.py (path:/tmp/pip-G7f8ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:35 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)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:35 INFO - Running setup.py (path:/tmp/pip-tBRENf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:35 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)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:35 INFO - Running setup.py (path:/tmp/pip-I8qyML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:35 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)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:35 INFO - Running setup.py (path:/tmp/pip-ZB5nal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:35 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)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:35 INFO - Running setup.py (path:/tmp/pip-N82g0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:35 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)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:35 INFO - Running setup.py (path:/tmp/pip-e_1LJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:35 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)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:35 INFO - Running setup.py (path:/tmp/pip-sTexK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:35 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)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:35 INFO - Running setup.py (path:/tmp/pip-Hg45oI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:35 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)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:35 INFO - Running setup.py (path:/tmp/pip-ErN59P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:35 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)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:35 INFO - Running setup.py (path:/tmp/pip-aO_pc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:36 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)) 08:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:36 INFO - Running setup.py (path:/tmp/pip-rmSWX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:36 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)) 08:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:36 INFO - Running setup.py (path:/tmp/pip-QIV7n5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:36 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)) 08:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:36 INFO - Running setup.py (path:/tmp/pip-vpq_Fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:36 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)) 08:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:36 INFO - Running setup.py (path:/tmp/pip-jQwCY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:36 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)) 08:14:36 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)) 08:14:36 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)) 08:14:36 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)) 08:14:36 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)) 08:14:36 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)) 08:14:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:38 INFO - Downloading blessings-1.6.tar.gz 08:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:38 INFO - Installing collected packages: blessings 08:14:38 INFO - Running setup.py install for blessings 08:14:38 INFO - Successfully installed blessings 08:14:38 INFO - Cleaning up... 08:14:38 INFO - Return code: 0 08:14:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:38 INFO - Reading from file tmpfile_stdout 08:14:38 INFO - Current package versions: 08:14:38 INFO - argparse == 1.2.1 08:14:38 INFO - blessings == 1.6 08:14:38 INFO - blobuploader == 1.2.4 08:14:38 INFO - docopt == 0.6.1 08:14:38 INFO - functools32 == 3.2.3-2 08:14:38 INFO - jsonschema == 2.5.1 08:14:38 INFO - manifestparser == 1.1 08:14:38 INFO - mozInstall == 1.12 08:14:38 INFO - mozcrash == 0.17 08:14:38 INFO - mozdebug == 0.1 08:14:38 INFO - mozdevice == 0.48 08:14:38 INFO - mozfile == 1.2 08:14:38 INFO - mozhttpd == 0.7 08:14:38 INFO - mozinfo == 0.9 08:14:38 INFO - mozleak == 0.1 08:14:38 INFO - mozlog == 3.2 08:14:38 INFO - moznetwork == 0.27 08:14:38 INFO - mozprocess == 0.23 08:14:38 INFO - mozprofile == 0.28 08:14:38 INFO - mozrunner == 6.12 08:14:38 INFO - mozscreenshot == 0.1 08:14:38 INFO - mozsystemmonitor == 0.3 08:14:38 INFO - moztest == 0.7 08:14:38 INFO - mozversion == 1.4 08:14:38 INFO - psutil == 3.1.1 08:14:38 INFO - requests == 1.2.3 08:14:38 INFO - wsgiref == 0.1.2 08:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:38 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 0x21fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b93b0>, '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 0x24ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ba740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', '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 08:14:38 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 08:14:38 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 08:14:38 INFO - Using env: {'DISPLAY': ':0', 08:14:38 INFO - 'HOME': '/home/cltbld', 08:14:38 INFO - 'LANG': 'en_US.UTF-8', 08:14:38 INFO - 'LANGUAGE': 'en_US:en', 08:14:38 INFO - 'LOGNAME': 'cltbld', 08:14:38 INFO - 'MAIL': '/var/mail/cltbld', 08:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:38 INFO - 'MOZ_NO_REMOTE': '1', 08:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:38 INFO - 'NO_EM_RESTART': '1', 08:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:38 INFO - 'PWD': '/builds/slave/test', 08:14:38 INFO - 'SHELL': '/bin/bash', 08:14:38 INFO - 'SHLVL': '1', 08:14:38 INFO - 'TERM': 'linux', 08:14:38 INFO - 'TMOUT': '86400', 08:14:38 INFO - 'USER': 'cltbld', 08:14:38 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', 08:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:38 INFO - '_': '/tools/buildbot/bin/python'} 08:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:38 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)) 08:14:38 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)) 08:14:38 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)) 08:14:38 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)) 08:14:38 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)) 08:14:38 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)) 08:14:38 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)) 08:14:38 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)) 08:14:38 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)) 08:14:38 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)) 08:14:38 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)) 08:14:38 INFO - Cleaning up... 08:14:38 INFO - Return code: 0 08:14:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21fa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b93b0>, '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 0x24ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ba740>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', '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 08:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:14:38 INFO - Using env: {'DISPLAY': ':0', 08:14:38 INFO - 'HOME': '/home/cltbld', 08:14:38 INFO - 'LANG': 'en_US.UTF-8', 08:14:38 INFO - 'LANGUAGE': 'en_US:en', 08:14:38 INFO - 'LOGNAME': 'cltbld', 08:14:38 INFO - 'MAIL': '/var/mail/cltbld', 08:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:38 INFO - 'MOZ_NO_REMOTE': '1', 08:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:38 INFO - 'NO_EM_RESTART': '1', 08:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:38 INFO - 'PWD': '/builds/slave/test', 08:14:38 INFO - 'SHELL': '/bin/bash', 08:14:38 INFO - 'SHLVL': '1', 08:14:38 INFO - 'TERM': 'linux', 08:14:38 INFO - 'TMOUT': '86400', 08:14:38 INFO - 'USER': 'cltbld', 08:14:38 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', 08:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:38 INFO - '_': '/tools/buildbot/bin/python'} 08:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:14:39 INFO - Cleaning up... 08:14:39 INFO - Return code: 0 08:14:39 INFO - Running post-action listener: _resource_record_post_action 08:14:39 INFO - Running post-action listener: _start_resource_monitoring 08:14:39 INFO - Starting resource monitoring. 08:14:39 INFO - ##### 08:14:39 INFO - ##### Finished create-virtualenv step (success) 08:14:39 INFO - ##### 08:14:39 INFO - ##### 08:14:39 INFO - ##### Running install step. 08:14:39 INFO - ##### 08:14:39 INFO - Running pre-action listener: _resource_record_pre_action 08:14:39 INFO - Running main action method: install 08:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:39 INFO - Reading from file tmpfile_stdout 08:14:39 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:39 INFO - Reading from file tmpfile_stdout 08:14:39 INFO - Output received: 08:14:39 INFO - Usage: mozinstall [options] installer 08:14:39 INFO - Options: 08:14:39 INFO - -h, --help show this help message and exit 08:14:39 INFO - -d DEST, --destination=DEST 08:14:39 INFO - Directory to install application into. [default: 08:14:39 INFO - "/builds/slave/test"] 08:14:39 INFO - --app=APP Application being installed. [default: firefox] 08:14:39 INFO - mkdir: /builds/slave/test/build/application 08:14:39 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'] 08:14:39 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 08:14:56 INFO - Reading from file tmpfile_stdout 08:14:56 INFO - Output received: 08:14:56 INFO - /builds/slave/test/build/application/firefox/firefox 08:14:56 INFO - Running post-action listener: _resource_record_post_action 08:14:56 INFO - ##### 08:14:56 INFO - ##### Finished install step (success) 08:14:56 INFO - ##### 08:14:56 INFO - ##### 08:14:56 INFO - ##### Running run-tests step. 08:14:56 INFO - ##### 08:14:56 INFO - Running pre-action listener: _resource_record_pre_action 08:14:56 INFO - Running main action method: run_tests 08:14:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:14:56 INFO - Python 2.7.3 08:14:56 INFO - Return code: 0 08:14:56 INFO - grabbing minidump binary from tooltool 08:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:14:56 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 0x24b93b0>, '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 0x24ba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ba740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:14:56 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 08:14:56 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 08:14:56 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 08:14:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:14:56 INFO - Return code: 0 08:14:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:14:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:14:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:14:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:14:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:14:56 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/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 08:14:56 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/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 08:14:56 INFO - Using env: {'DISPLAY': ':0', 08:14:56 INFO - 'HOME': '/home/cltbld', 08:14:56 INFO - 'LANG': 'en_US.UTF-8', 08:14:56 INFO - 'LANGUAGE': 'en_US:en', 08:14:56 INFO - 'LOGNAME': 'cltbld', 08:14:56 INFO - 'MAIL': '/var/mail/cltbld', 08:14:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:14:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:56 INFO - 'MOZ_NO_REMOTE': '1', 08:14:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:56 INFO - 'NO_EM_RESTART': '1', 08:14:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:56 INFO - 'PWD': '/builds/slave/test', 08:14:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:14:56 INFO - 'SHELL': '/bin/bash', 08:14:56 INFO - 'SHLVL': '1', 08:14:56 INFO - 'TERM': 'linux', 08:14:56 INFO - 'TMOUT': '86400', 08:14:56 INFO - 'USER': 'cltbld', 08:14:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760', 08:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:56 INFO - '_': '/tools/buildbot/bin/python'} 08:14:56 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/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 08:14:57 INFO - mozversion application_buildid: 20160714053013 08:14:57 INFO - mozversion application_changeset: 1d5210d6f9614812ebdfad13a0d6e25d4513c03e 08:14:57 INFO - mozversion application_display_name: Nightly 08:14:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:14:57 INFO - mozversion application_name: Firefox 08:14:57 INFO - mozversion application_remotingname: firefox 08:14:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:14:57 INFO - mozversion application_vendor: Mozilla 08:14:57 INFO - mozversion application_version: 50.0a1 08:14:57 INFO - mozversion platform_buildid: 20160714053013 08:14:57 INFO - mozversion platform_changeset: 1d5210d6f9614812ebdfad13a0d6e25d4513c03e 08:14:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:14:57 INFO - mozversion platform_version: 50.0a1 08:14:57 INFO - using testdate: 1468509297 08:14:57 INFO - actual date: 1468509297 08:14:57 INFO - starting webserver on 'localhost:35980' 08:14:57 INFO - SUITE-START | Running 2 tests 08:14:57 INFO - TEST-START | dromaeo_css 08:14:57 INFO - operating with platform_type : linux_ 08:14:57 INFO - Initialising browser for dromaeo_css test... 08:14:57 INFO - TEST-INFO | started process 18813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE8YcUF/profile http://localhost:35980/getInfo.html) 08:15:01 INFO - PROCESS | 18813 | __metrics Screen width/height:1600/1200 08:15:01 INFO - PROCESS | 18813 | colorDepth:24 08:15:01 INFO - PROCESS | 18813 | Browser inner width/height: 1024/697 08:15:01 INFO - PROCESS | 18813 | __metrics 08:15:02 INFO - PROCESS | 18813 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:15:02 INFO - PROCESS | 18813 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:03 INFO - TEST-INFO | 18813: exit 0 08:15:03 INFO - Browser initialized. 08:15:03 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:03 INFO - TEST-INFO | started process 18897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE8YcUF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:14 INFO - PROCESS | 18897 | RSS: Main: 157671424 08:15:14 INFO - PROCESS | 18897 | 08:16:06 INFO - PROCESS | 18897 | 1468509366400 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] 08:18:14 INFO - PROCESS | 18897 | Cycle 1(1): loaded http://localhost:35980/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35980/tests/dromaeo/cssquery-ext.html) 08:18:15 INFO - PROCESS | 18897 | RSS: Main: 253562880 08:18:15 INFO - PROCESS | 18897 | 08:21:17 INFO - PROCESS | 18897 | Cycle 1(1): loaded http://localhost:35980/tests/dromaeo/cssquery-ext.html (next: http://localhost:35980/tests/dromaeo/cssquery-jquery.html) 08:21:18 INFO - PROCESS | 18897 | RSS: Main: 237338624 08:21:18 INFO - PROCESS | 18897 | 08:24:20 INFO - PROCESS | 18897 | Cycle 1(1): loaded http://localhost:35980/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35980/tests/dromaeo/cssquery-mootools.html) 08:24:21 INFO - PROCESS | 18897 | RSS: Main: 248049664 08:24:21 INFO - PROCESS | 18897 | 08:27:23 INFO - PROCESS | 18897 | Cycle 1(1): loaded http://localhost:35980/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35980/tests/dromaeo/cssquery-prototype.html) 08:27:23 INFO - PROCESS | 18897 | RSS: Main: 238698496 08:27:23 INFO - PROCESS | 18897 | 08:30:26 INFO - PROCESS | 18897 | Cycle 1(1): loaded http://localhost:35980/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35980/tests/dromaeo/cssquery-yui.html) 08:30:27 INFO - PROCESS | 18897 | RSS: Main: 220057600 08:30:27 INFO - PROCESS | 18897 | 08:33:29 INFO - PROCESS | 18897 | Cycle 1(1): loaded http://localhost:35980/tests/dromaeo/cssquery-yui.html (next: http://localhost:35980/tests/dromaeo/cssquery-dojo.html) 08:33:30 INFO - PROCESS | 18897 | RSS: Main: 300445696 08:33:30 INFO - PROCESS | 18897 | 08:33:30 INFO - PROCESS | 18897 | __start_tp_report 08:33:30 INFO - PROCESS | 18897 | _x_x_mozilla_page_load 08:33:30 INFO - PROCESS | 18897 | _x_x_mozilla_page_load_details 08:33:30 INFO - PROCESS | 18897 | |i|pagename|runs| 08:33:30 INFO - PROCESS | 18897 | |0;dojo.html;3016.230861130413;3032.9393412131753;3042.330687248806;3058.801177923436;3076.6769489203634;5204.557612602934;5204.583633309336;5219.45195754446;5299.947000529994;5319.441458646845;5277.261183434322;5324;5343.332083489564;5370.865728356793;5389.51494365507;4784.354112194861;4874.463808981027;4877.097736918681;4884.877878053042;5005.599552035828;4871.866517643311;4888.169011268093;4892.706437613737;4946.802127914879;4969.776360063788;4771.856844294677;4791;4802.23164293713;4830.275458681191;4846.127697014536;4788.473267940559;4803.471618122004;4853.22348424254;4855.101806165871;4899.118158731427;4768.880777980544;4801.207800712878;4833.685810422347;4838.983813399191;4866.099771542276;5268.130758424855;5330.307060082203;5363.249145119687;5400.405955344909;5413.160960051198;5742.598018138732;5770.7691692332255;5778.5377169826315;5791.391903850119;5798.333191682926;5527.751251193706;5580.023495888244;5810.4189581041555;5822.621529600562;5824.417558244142;5267.683938963636;5349.598780091509;5350.812721554766;5352.866178345573;5355.33058367708;5833.649981001154;5836.066229403275;5840.123981402823;5841.123831425235;5843.707814609253;5481.123020316731;5509.256250406224;5533.3083364579425;5604;5607.52336051432;5731.598788084877;5733.598648094593;5737.713114344266;5738.626989245686;5743.85640358986;5647.689377084218;5650.660960342392;5654.971725141348;5657.066584013592;5701.315842098975;5534.1975413564805;5640.520555752725;5685.147227915763;5693.373728889819;5697.059985102412;4364.585364390377;4386.912261754747;4390.582894625006;4391.6486681065435;4426.977865110718;3872.5546562145714;3907.765534067965;3928.9214215716097;3942.8619998299923;3961.1087505311652;5143.742812859342;5218.66078704883;5317.813876514303;5382.192671099367;5402.486763757437;5730.5129064030025;5731.083026715705;5732.6847023413275;5735.1684005818925;5797.449242321973;5404.621676482609;5407.486288802557;5409.756560954688;5415.945840541544;5421.701806400607;4815.831445899376;4912.263160525878;4968.130577148984;4970.304157417964;5000.449950505442;5949.732262048218;5958.821235362946;5962.135490353874;5964.373740757158;5966.403359663999;5600.523955463831;5764.07774756037;5778.711064446677;5780.248567686174;5780.306363236438;5783.681897495678;5810.157527158453;5843.211166492639;5894.233749612695;5938.376470470711;5575.972120139373;5607.747651355618;5616.410276920865;5617.522510586646;5618.988582055269;5548.750306236309;5716.5998380113;5727.083666613322;5729.197912292366;5733.254676892144;5540.750666219949;5602.159676048625;5605.32736071674;5621.213030175861;5629.211910332639;5530.695811730394;5570.832875013756;5571.415001424954;5575.581831362583;5576.581756368208;5366.034113859387;5476.069068258326;5561.777528898799;5572.442755724395;5615.438456154352;5613.943860561342;5647.955128301277;5651.689157096399;5704.030314846569;5704.686242256716;5464.562834973272;5500.944990550043;5513.393526712139;5514.61397702157;5518.172274158908 08:33:30 INFO - PROCESS | 18897 | |1;ext.html;606.9332373438921;626.6522080245463;635.5582869905414;636.7484843486823;637.1844039629276;32934.17664558387;43757;44513;44603.33095003569;44746.552534474606;45205.54794452054;45437.545624543745;45523.77238113805;45572.3164152538;45595.08809823802;8239.340852731768;8741.825163496742;8868.822623547525;8873.20141187293;10843.566257349696;10615.78768424631;10886.782264354708;10974.780504389908;10988.066014388787;10990.945045274762;11072.280301780398;11093.72265693356;11109.44452777358;11121.72195695106;11125.610603628875;10988.395638239894;11030.338179709242;11057.723556911062;11058.612948546843;11059.72350691231;10829.350238985608;10908.454577271104;10916.235863489559;10916.945415272952;10921.672349829518;43031.35452968208;43278.13443731139;43332;43356.13287734228;43368.3494747579;3511.122219445139;3552.964470355289;3648.7081033517256;3665.4135338346005;3756.6431189037;32255.51616725751;32913.506297405555;32914.6708532914;32952;32994.835025824716;4185.895352616179;4372.781360931941;4373.803178856959;4452.065066336073;4469.932951005738;358739;360254;360311;360583;360659.9999999974;59471.70264148652;59676;59686.70156649276;59704.40295596988;59830;64536.677316614056;64576.67711661412;64924.35075649183;64927.350726493074;64929.35070649328;14063.648408789863;15648.295826687827;15717.135557544216;15822.367105315889;15842.44551440694;11740.178187526963;11995.580154694544;12000.219985700902;12096.637100886988;12118.333491658044;18143.818561814478;18752.156152973148;18875.150618222215;18932.81067189338;19145.39102391814;7192.244814294424;7226;7234.493585448968;7370.926290737024;7473.215312392229;998.9750256243507;1007.9042490963346;1040.095117247984;1052.0163646989936;1136.9545218191179;32623.347533049207;34702;34708.65291347054;36624.599849178274;36677;1097.1716354152563;1103.9779204415868;1113.7661091170944;1117.6591139702468;1127.2785417332914;16972.74540881888;17264.913675431795;17394.82605173932;17441.47675569735;17662.381816636615;619396;620029;624283;624817;624827;58974;59365.70317148387;59462;59506;59533.10700339499;1255.2468518888593;1336.191604079518;1348.0698318160437;1359.6261028217123;1408.429586017644;32571.674283256863;33464.66535334616;33489.83255083709;33926.830365848014;34405.82797085999;50647.49352506575;61872.690636546526;63587.364126358145;63715.36284637095;63787.36212637814;546579;549204;550509;551519;551661;36897.81551092227;42375.152496950504;43446;44556.77721611371;45033.32450013187;49038;49167.26249106195;49533.752331238116;49551.752241238566;50404.74797625988;41671.37492937669;42009.369859452745;42586.5741342595;43410.78294608507;44086.77956610196;42179.789101054295;42536;42848.14303713971;42883;43380.56619433891;41126;41193;42279.154416912104;42297.577024229366;42577;33858.968461892364;36957;37261.81369093245;37935.81032094822;38265.80867095647;28097.578536321562;28102.71897281001;28305.292367690974;28320.71679283263;28540.85729571422 08:33:30 INFO - PROCESS | 18897 | |2;jquery.html;389.351729370598;397.4554859842016;404.62572120788263;409.41862555171656;413.9941981101564;14879.479218227338;18316.633667326645;18458.538536536595;19695.704564431526;19702;15130.394784208645;17436.56408589786;18956.905215473904;19062.428127156174;19560.217591296332;5757.42425757424;5960;5963.642181469126;5994.370591087938;5995.430434108753;4313.676474264427;5921.259842519685;5998.940010599904;5999.8200053998235;6464.353564643545;6813.318668133196;6815.693293801791;6823.795286141423;6826.317368263183;6833.487488438363;6429.678516074201;6649.567778094409;6659.766908158215;6662.467002639777;6759.391654751072;5658.321001479808;5810;5815.883682326372;5823.912641310384;5833.095870140135;23175;23257.30228093143;23286.30141095753;23454.64818027731;23572.410689732722;2393.9281821545383;2450.8529488230583;2533.7592928671747;2542.834715743471;2612.7779138773035;13946.93026534871;14566.563003109924;14688.412463501447;14760.335784889705;15098.471553495576;1945.805419458057;2003.6092961872441;2005.899705014758;2041.4079916824103;2075.2010475966863;85057.57471212666;85436;86081.56959215227;86169.56915215446;87048;10327.638532651472;10754.247202695737;10877.510512026978;10892.782144357068;10999.450027498753;14851.70296594062;14865.554033379016;14947.626309342353;14971.401143954337;14974.550763477113;7856.685732570633;8027.5584842834205;8099.06860711014;8183.71357002502;8205.138460461685;7865.292123708894;7874.881876771853;7920;7998;8051.63767630458;5952.583319167703;6276.937230627726;6354.142190804275;6544.312847151075;6611.933880661228;1912.3784769949543;1928.3443629166152;1961.8038196180553;1974.2991238110264;1977.9802201978084;983.8032393521181;1018.760591261053;1087.6573879228017;1104.6630777612745;1107.4960892793758;19136;19231.711524327147;19688.409347719593;20032.899835500728;21233.469163271042;976.2482888176065;1029.53156313877;1037.894642206048;1075.8224892892586;1094.7427354571669;10541.57833686644;11072.169587280987;11088.778224435466;11128.49921753523;11129.777404451866;545528;547827;548872;568496;569457;98244.50877745566;104808.47595761972;105549;105649.47175264075;106597;1040.7606250562565;1045.8274384726435;1045.9633912813015;1047.5652604169336;1058.1851973980147;17252;17365.131743413032;17401.216561967984;17635.20641571107;17667.646647067242;45895;46381;46596.53403466057;46881.531184687716;47578.3731942705;60610.09084863642;61207.387926120166;65240.347596523425;65755.67122164358;66953.33046669471;8344.582770861554;8613.397062205837;8684.26183774361;8736.170063843925;8861.202491775772;12440.440180191732;13214.801777973531;13293.933530332286;13301.80047299272;13334;11673.941630291794;11734.589289374831;11751.88248117542;11836.940815295868;12102;11515.53937842477;11614;11685.123615728684;11706.946374826306;11930.821037684615;11637.301761893974;11647.59233426826;11794;11943.880561194625;12190.146689731988;8639.222469977733;8655.783605409915;8669.523176225368;8777.824443511221;8790.516521591373;11290.209685321948;11399.715007124889;11586.131040171853;11804.881951180378;11954.641360759191 08:33:30 INFO - PROCESS | 18897 | |3;mootools.html;1225.5587988324196;1469.2653673163416;1507.0731500127422;1665.7168281392162;1808.61114860305;8307.58462076896;8597.355198360117;8628.352873534486;8840.77898052549;8861.64553417864;8562.871556926651;8798.956005219981;8803.735887923356;8805.163509466607;8807.95596022019;2066.235492867641;2285.268714011517;2346.038124369009;2346.2022912209886;2378.54807586558;2334.568104900599;2345.2377977157494;2346.0733010460945;2346.4485845826216;2346.8826558672085;2363.326451961183;2379.8691071991034;2387.6418537219383;2389.772971567707;2391.784739373456;1980.7226988221732;2041.530447996969;2044.1005957378854;2192.2984644913636;2305.9308220753405;2306.7001289832215;2339.5203983183405;2342.543204075206;2349.729781075181;2350.670906073151;8800.16398442147;8811.251043661232;8854.690085846965;8896.555172241362;8904.287656987426;5094.872628184288;5197.8440646780655;5202.4277329493725;5204.739763011834;5212.713300768456;3290.7367410607335;3462.2036931505895;3570.9107272318142;3574.803385813779;3618.620044895301;1105.7567335186327;1116.4083035990939;1116.4752566293828;1122.2256642916361;1137.2721458266717;12151.939240303831;12225.877741222563;12226.75546489074;12233.571824986171;12239.632811015685;4512.278035514302;4560.543945605479;4676.2985552166765;4680.297955306663;4761.40482439695;10271.9486402569;10287.434191119411;10293.794124117476;10311.432871192157;10333.328333658288;5302.178162384759;5331.306930099062;5345.599080069011;5350.063738845686;5352.705601191972;4257.595528424795;4752.691075080109;4844.273358996108;4850.248211527219;4905.043516514245;4023.5063663075416;4039.151778126626;4048.149888523384;4058.431819545266;4194.433751443577;1137.9886201137883;1229.6434034130002;1305.7323248733987;1312.3307113372248;1316.960491185266;893.8078313162702;991;998.4558415663481;1016.5832008876473;1019.9643012494527;5685.374608793029;5719.742611582489;6217.253929528486;6248.31268560458;6273.498120150377;972.3242346569208;980.2256217588168;998.1116806042628;1005.5369437468465;1053.9894601054045;4098.118904435561;4280.357946308017;4344.522102568715;4346.239408103569;4402.933955990663;10618.628348007782;10815.513301901434;11019.118470522339;11024.724381890517;11041.39272340029;10795.730106747236;10808.51361688726;10814.837777433344;10817.080548153337;10818.891811081789;7756.6509507072315;8091.029076510857;8138.3896207784655;8308.916910830936;8313.002439707274;6176.7838125665385;6257.687115644108;6306.905396419149;6352.205974253218;6385.680715964276;10038.548265328223;10351.482425878827;10478.476076196312;10503.47482625881;10504.26470147113;9793.216542676426;10082.54628541732;10586.258961872594;10611.8938810614;10612.204084693833;7692.615369231628;7707.653155608124;7809.726659566888;7853.410994175346;7870.449068565145;8288.088310285742;8437.831243374976;8440.324774017941;8456.746297611082;8465.915340846514;7507.962460187664;7531;7636.541807491568;7682.154962954182;7940.325072368913;7668.1181664109345;7683.116441609286;7686.730964416219;7693.153753087267;7734.99445072137;7131.572105673468;7139.500234983501;7185.461090418135;7189.928100718926;7193.676284567312;5077.086124497626;5213.608979326642;5218.9739051304505;5263.605229607718;5319.867003324948;5118.692878427306;5221.138512145453;5325.174597937326;5327.254184414108;5393.8921221574565 08:33:30 INFO - PROCESS | 18897 | |4;prototype.html;324.6850554961688;334.07128183649456;337.6555912968772;339.54500968701933;340.2158025750644;5337.599680023999;5343.091674415349;5345.412004679482;5347.839564813057;5377.569794416438;5308.071087559681;5324.787008519665;5354;5355.250264962909;5356.705381204042;3871.128995975911;3988.8005599719972;4113.218488487178;4114.177164567099;4151.564085770996;4087.1008378156907;4131.483564554431;4142.97928510357;4160.7087503874745;4161.9583804161875;4098.139390727951;4112.876613701579;4112.938305925413;4138.689598280126;4139.56534563871;3921.7254792164704;4054.9797251013556;4130.979345103286;4143.647789937859;4144.48193975753;3676.7242456815848;3680.392735198716;3684.3184010958057;3685.9126557665554;3690.7785532867847;5060.873478163038;5112.872178195537;5127.307813445174;5199.454057323965;5202.193659982709;4586.701864378805;4702.741349225791;4723.197056500403;4725.432948046222;4737.763111844429;5453.072977593779;5460.126379779216;5497.532709719639;5505.449455054502;5513.917291240635;4050.7772072536;4059.472268605092;4067.3695577185586;4069.4302797608357;4076.286649836267;5446.618736688433;5723.885522289531;5749.31008279005;5772.797952071699;5779.33537643168;4060.837566497307;4083.244599749056;4091.365838295069;4094.7952602369764;4097.323941549671;4140.60664236897;4145.2952997990415;4146.398772178018;4146.626803587692;4155.168966206771;4562.5665561771575;4673.696209746356;4720.905581888412;4730.219513780256;4732.73969931657;5486.1770734389365;5515.779368825282;5532.861678458071;5538.972305138529;5548.750306236229;1399.9720005599831;1415.577344768501;1424.3448013913717;1434.2971943747489;1436.102435977514;887.7083843008407;910.4673765847053;925.1118925831278;941.2470023980788;943.5518128888723;5238.816641417532;5330.360356757214;5386.326709161355;5403.216533602685;5413.593980451482;5685.914711279334;5697.316322041382;5698.1737648041635;5700.7719691212715;5739.598228124075;5155.53600175986;5351.57187425005;5391.466010974836;5394.514493695587;5418.810341638024;2994.446027484879;3015.638123425159;3019.9396012080074;3020.7130322619314;3035.681253468398;5860.736266867916;5866.325372582122;5867.618604790675;5880.529557635379;5904.291485021825;5638.154276858504;5799.217105690678;5803.564732645069;5818.429024163537;5823.650580965155;5780.277465316835;5826;5868.911966320508;5870.853228669317;5880.971299780702;5411.2153737708595;5684.232628595252;5689.34572524165;5714.485696287354;5726.398728133652;5609.046462101534;5627.155926610877;5651.971740141437;5671.688057156896;5698.2592263005545;5761.942380576141;5844.532437405082;5914.652730243354;5926.762929482772;5954.4938680210935;4098.795060246916;4154.480689913761;4156.688248381323;4165.75005499671;4172.269852775691;5625.240592519957;5643.3792282848035;5666.46168613981;5676.602637815313;5721.313442386941;5432.619716619799;5565.582581306499;5595.35653399848;5597.720113994203;5607.971960140337;5519.972400137974;5521.613487056028;5536.252605898152;5561.499465048165;5581.358143813513;5295.311609490742;5445.292112025411;5459.836204913859;5464.371597266365;5530.31779586892;5465.59008074388;5573.164025396223;5630.971845140748;5635.887282254414;5645.576581756302;5491.368492623399;5491.368492623399;5512.724363781715;5547.778088876561;5550.417206193453 08:33:30 INFO - PROCESS | 18897 | |5;yui.html;760.4790718357928;767.0143865133305;785.8467598818229;825.653225645229;850.8052263749619;15308.846911530894;15724.764128538052;15738.370465181379;15747.448839290613;15813.209339533021;15504.767428488554;16140.757888631651;16180.83819161808;16754.748678769796;16774.161291935416;675.6047712088434;804.1315379390245;822.5640410582386;835.9884539706962;843.236870632079;804.8148925747082;806.8587997100514;808.870580707087;810.7932477218301;842.1073661918356;850.5407080176728;851.6508231625035;852.1989330029783;852.4544291653347;853.0445900591346;702.8137543550963;831.1397703377036;847.690592933581;850.9320802393019;852.424613385962;627.009325266083;627.0594108836744;627.2723640576909;627.3475585391187;627.3632263252756;14967.476138335214;15016.699666006727;15043.172625505593;15043.623909402244;15052.54842354731;13829.377678004514;14195.290235488184;14239.475774424085;14260.714785704331;14664.340104695315;13468.93265533676;13469.663258418519;13720.93139534296;13784.862151378458;14058.507952221726;4490.304002879526;4530.524294949048;4576.656750743708;4608.976955115203;4629.213033784265;82732.58633706853;82869.58565207136;83157;84619;85112;11591;11610.535578576932;11647.242929209575;11783.175177737476;11797.88202117968;21114.683279750818;21289.36131916045;21317.29461643065;21343.67984480234;21408;8492.532910689848;8522.446041007315;8801.91198088011;9082.091790820998;9130.863037054449;4511.323301504801;4542.227821270326;4565.20108980927;4587.197240482902;4655.95344046562;3752.4371344298575;3890.4164375343926;3896.2402331545645;3902.180542086194;3917.7845218512684;606.3209205689568;660.207750699163;668.2749217099405;668.3149771484268;668.906353110565;585.9414058594192;643.7038962077403;705.0974752317043;712.3126183233205;716.9462290328246;10166.694999150037;10323.122534584645;10510.211734119972;10650.520726567323;10688;702.6311186627062;706.7879636109146;712.5012491256037;744.326384621918;746.559529877375;4856.17445034345;5113.360829896263;5208.374995000624;5212.609054320941;5246.16061430177;109008.45495772471;117617.41191293989;118529.40735296268;119627;120035;96638;98711.50644246733;99678.5016074915;101537.49231253796;102150.48924755477;87241.5637921819;87618.12381876227;87920;88807;88945;9563.713088607354;9644.662436814679;9756.85364719544;9812.460314682761;9830.852537212091;50794.74602626963;50912;51146.74426627843;52034;54386.728066359414;45880;50174.74912625414;50904.74547627386;54816;75254.24745752692;11970.042396608425;12019.699507512381;12173.087018473472;12205.816912746493;12236.327002014974;13314.866851331362;13861.861381386461;14203.64490887736;14204;15170.24148792534;12850.742985140057;12942.611721648365;12943.870561294267;13402.195868247936;13731.143746508005;12137.21108127969;12649.304288264233;12781.936090319488;12981.870181298065;13599.320033998458;12317.876821231674;12512.937435312766;12645.114841960974;13176.868231317565;13181.340932953506;9535.38020028696;9629.759256018655;9794.167495762655;10092.091711745978;10273.589056437659;10117.291789574954;10246.333988290737;10381.688549343531;10459.372437653765;10472.266941314036 08:33:30 INFO - PROCESS | 18897 | __end_tp_report 08:33:30 INFO - PROCESS | 18897 | __start_cc_report 08:33:30 INFO - PROCESS | 18897 | _x_x_mozilla_cycle_collect,867 08:33:30 INFO - PROCESS | 18897 | __end_cc_report 08:33:30 INFO - PROCESS | 18897 | __startTimestamp1468510410234__endTimestamp 08:33:30 INFO - PROCESS | 18897 | 08:33:30 INFO - PROCESS | 18897 | ------- Summary: start ------- 08:33:30 INFO - PROCESS | 18897 | Number of tests: 6 08:33:30 INFO - PROCESS | 18897 | 08:33:30 INFO - PROCESS | 18897 | [#0] dojo.html Cycles:165 Average:5300.66 Median:5514.61 stddev:604.96 (11.0%) stddev-sans-first:579.67 08:33:30 INFO - PROCESS | 18897 | Values: 3016.2 3032.9 3042.3 3058.8 3076.7 5204.6 5204.6 5219.5 5299.9 5319.4 5277.3 5324.0 5343.3 5370.9 5389.5 4784.4 4874.5 4877.1 4884.9 5005.6 4871.9 4888.2 4892.7 4946.8 4969.8 4771.9 4791.0 4802.2 4830.3 4846.1 4788.5 4803.5 4853.2 4855.1 4899.1 4768.9 4801.2 4833.7 4839.0 4866.1 5268.1 5330.3 5363.2 5400.4 5413.2 5742.6 5770.8 5778.5 5791.4 5798.3 5527.8 5580.0 5810.4 5822.6 5824.4 5267.7 5349.6 5350.8 5352.9 5355.3 5833.6 5836.1 5840.1 5841.1 5843.7 5481.1 5509.3 5533.3 5604.0 5607.5 5731.6 5733.6 5737.7 5738.6 5743.9 5647.7 5650.7 5655.0 5657.1 5701.3 5534.2 5640.5 5685.1 5693.4 5697.1 4364.6 4386.9 4390.6 4391.6 4427.0 3872.6 3907.8 3928.9 3942.9 3961.1 5143.7 5218.7 5317.8 5382.2 5402.5 5730.5 5731.1 5732.7 5735.2 5797.4 5404.6 5407.5 5409.8 5415.9 5421.7 4815.8 4912.3 4968.1 4970.3 5000.4 5949.7 5958.8 5962.1 5964.4 5966.4 5600.5 5764.1 5778.7 5780.2 5780.3 5783.7 5810.2 5843.2 5894.2 5938.4 5576.0 5607.7 5616.4 5617.5 5619.0 5548.8 5716.6 5727.1 5729.2 5733.3 5540.8 5602.2 5605.3 5621.2 5629.2 5530.7 5570.8 5571.4 5575.6 5576.6 5366.0 5476.1 5561.8 5572.4 5615.4 5613.9 5648.0 5651.7 5704.0 5704.7 5464.6 5500.9 5513.4 5514.6 5518.2 08:33:30 INFO - PROCESS | 18897 | 08:33:30 INFO - PROCESS | 18897 | [#1] ext.html Cycles:180 Average:67501.54 Median:38100.81 stddev:139177.03 (365.3%) stddev-sans-first:139476.83 08:33:30 INFO - PROCESS | 18897 | Values: 606.9 626.7 635.6 636.7 637.2 32934.2 43757.0 44513.0 44603.3 44746.6 45205.5 45437.5 45523.8 45572.3 45595.1 8239.3 8741.8 8868.8 8873.2 10843.6 10615.8 10886.8 10974.8 10988.1 10990.9 11072.3 11093.7 11109.4 11121.7 11125.6 10988.4 11030.3 11057.7 11058.6 11059.7 10829.4 10908.5 10916.2 10916.9 10921.7 43031.4 43278.1 43332.0 43356.1 43368.3 3511.1 3553.0 3648.7 3665.4 3756.6 32255.5 32913.5 32914.7 32952.0 32994.8 4185.9 4372.8 4373.8 4452.1 4469.9 358739.0 360254.0 360311.0 360583.0 360660.0 59471.7 59676.0 59686.7 59704.4 59830.0 64536.7 64576.7 64924.4 64927.4 64929.4 14063.6 15648.3 15717.1 15822.4 15842.4 11740.2 11995.6 12000.2 12096.6 12118.3 18143.8 18752.2 18875.2 18932.8 19145.4 7192.2 7226.0 7234.5 7370.9 7473.2 999.0 1007.9 1040.1 1052.0 1137.0 32623.3 34702.0 34708.7 36624.6 36677.0 1097.2 1104.0 1113.8 1117.7 1127.3 16972.7 17264.9 17394.8 17441.5 17662.4 619396.0 620029.0 624283.0 624817.0 624827.0 58974.0 59365.7 59462.0 59506.0 59533.1 1255.2 1336.2 1348.1 1359.6 1408.4 32571.7 33464.7 33489.8 33926.8 34405.8 50647.5 61872.7 63587.4 63715.4 63787.4 546579.0 549204.0 550509.0 551519.0 551661.0 36897.8 42375.2 43446.0 44556.8 45033.3 49038.0 49167.3 49533.8 49551.8 50404.7 41671.4 42009.4 42586.6 43410.8 44086.8 42179.8 42536.0 42848.1 42883.0 43380.6 41126.0 41193.0 42279.2 42297.6 42577.0 33859.0 36957.0 37261.8 37935.8 38265.8 28097.6 28102.7 28305.3 28320.7 28540.9 08:33:30 INFO - PROCESS | 18897 | 08:33:30 INFO - PROCESS | 18897 | [#2] jquery.html Cycles:180 Average:31826.04 Median:11654.34 stddev:91722.11 (787.0%) stddev-sans-first:91949.04 08:33:30 INFO - PROCESS | 18897 | Values: 389.4 397.5 404.6 409.4 414.0 14879.5 18316.6 18458.5 19695.7 19702.0 15130.4 17436.6 18956.9 19062.4 19560.2 5757.4 5960.0 5963.6 5994.4 5995.4 4313.7 5921.3 5998.9 5999.8 6464.4 6813.3 6815.7 6823.8 6826.3 6833.5 6429.7 6649.6 6659.8 6662.5 6759.4 5658.3 5810.0 5815.9 5823.9 5833.1 23175.0 23257.3 23286.3 23454.6 23572.4 2393.9 2450.9 2533.8 2542.8 2612.8 13946.9 14566.6 14688.4 14760.3 15098.5 1945.8 2003.6 2005.9 2041.4 2075.2 85057.6 85436.0 86081.6 86169.6 87048.0 10327.6 10754.2 10877.5 10892.8 10999.5 14851.7 14865.6 14947.6 14971.4 14974.6 7856.7 8027.6 8099.1 8183.7 8205.1 7865.3 7874.9 7920.0 7998.0 8051.6 5952.6 6276.9 6354.1 6544.3 6611.9 1912.4 1928.3 1961.8 1974.3 1978.0 983.8 1018.8 1087.7 1104.7 1107.5 19136.0 19231.7 19688.4 20032.9 21233.5 976.2 1029.5 1037.9 1075.8 1094.7 10541.6 11072.2 11088.8 11128.5 11129.8 545528.0 547827.0 548872.0 568496.0 569457.0 98244.5 104808.5 105549.0 105649.5 106597.0 1040.8 1045.8 1046.0 1047.6 1058.2 17252.0 17365.1 17401.2 17635.2 17667.6 45895.0 46381.0 46596.5 46881.5 47578.4 60610.1 61207.4 65240.3 65755.7 66953.3 8344.6 8613.4 8684.3 8736.2 8861.2 12440.4 13214.8 13293.9 13301.8 13334.0 11673.9 11734.6 11751.9 11836.9 12102.0 11515.5 11614.0 11685.1 11706.9 11930.8 11637.3 11647.6 11794.0 11943.9 12190.1 8639.2 8655.8 8669.5 8777.8 8790.5 11290.2 11399.7 11586.1 11804.9 11954.6 08:33:30 INFO - PROCESS | 18897 | 08:33:30 INFO - PROCESS | 18897 | [#3] mootools.html Cycles:180 Average:5832.75 Median:4618.42 stddev:3295.94 (71.4%) stddev-sans-first:3286.99 08:33:30 INFO - PROCESS | 18897 | Values: 1225.6 1469.3 1507.1 1665.7 1808.6 8307.6 8597.4 8628.4 8840.8 8861.6 8562.9 8799.0 8803.7 8805.2 8808.0 2066.2 2285.3 2346.0 2346.2 2378.5 2334.6 2345.2 2346.1 2346.4 2346.9 2363.3 2379.9 2387.6 2389.8 2391.8 1980.7 2041.5 2044.1 2192.3 2305.9 2306.7 2339.5 2342.5 2349.7 2350.7 8800.2 8811.3 8854.7 8896.6 8904.3 5094.9 5197.8 5202.4 5204.7 5212.7 3290.7 3462.2 3570.9 3574.8 3618.6 1105.8 1116.4 1116.5 1122.2 1137.3 12151.9 12225.9 12226.8 12233.6 12239.6 4512.3 4560.5 4676.3 4680.3 4761.4 10271.9 10287.4 10293.8 10311.4 10333.3 5302.2 5331.3 5345.6 5350.1 5352.7 4257.6 4752.7 4844.3 4850.2 4905.0 4023.5 4039.2 4048.1 4058.4 4194.4 1138.0 1229.6 1305.7 1312.3 1317.0 893.8 991.0 998.5 1016.6 1020.0 5685.4 5719.7 6217.3 6248.3 6273.5 972.3 980.2 998.1 1005.5 1054.0 4098.1 4280.4 4344.5 4346.2 4402.9 10618.6 10815.5 11019.1 11024.7 11041.4 10795.7 10808.5 10814.8 10817.1 10818.9 7756.7 8091.0 8138.4 8308.9 8313.0 6176.8 6257.7 6306.9 6352.2 6385.7 10038.5 10351.5 10478.5 10503.5 10504.3 9793.2 10082.5 10586.3 10611.9 10612.2 7692.6 7707.7 7809.7 7853.4 7870.4 8288.1 8437.8 8440.3 8456.7 8465.9 7508.0 7531.0 7636.5 7682.2 7940.3 7668.1 7683.1 7686.7 7693.2 7735.0 7131.6 7139.5 7185.5 7189.9 7193.7 5077.1 5213.6 5219.0 5263.6 5319.9 5118.7 5221.1 5325.2 5327.3 5393.9 08:33:30 INFO - PROCESS | 18897 | 08:33:30 INFO - PROCESS | 18897 | [#4] prototype.html Cycles:180 Average:4681.12 Median:5388.90 stddev:1373.00 (25.5%) stddev-sans-first:1337.35 08:33:30 INFO - PROCESS | 18897 | Values: 324.7 334.1 337.7 339.5 340.2 5337.6 5343.1 5345.4 5347.8 5377.6 5308.1 5324.8 5354.0 5355.3 5356.7 3871.1 3988.8 4113.2 4114.2 4151.6 4087.1 4131.5 4143.0 4160.7 4162.0 4098.1 4112.9 4112.9 4138.7 4139.6 3921.7 4055.0 4131.0 4143.6 4144.5 3676.7 3680.4 3684.3 3685.9 3690.8 5060.9 5112.9 5127.3 5199.5 5202.2 4586.7 4702.7 4723.2 4725.4 4737.8 5453.1 5460.1 5497.5 5505.4 5513.9 4050.8 4059.5 4067.4 4069.4 4076.3 5446.6 5723.9 5749.3 5772.8 5779.3 4060.8 4083.2 4091.4 4094.8 4097.3 4140.6 4145.3 4146.4 4146.6 4155.2 4562.6 4673.7 4720.9 4730.2 4732.7 5486.2 5515.8 5532.9 5539.0 5548.8 1400.0 1415.6 1424.3 1434.3 1436.1 887.7 910.5 925.1 941.2 943.6 5238.8 5330.4 5386.3 5403.2 5413.6 5685.9 5697.3 5698.2 5700.8 5739.6 5155.5 5351.6 5391.5 5394.5 5418.8 2994.4 3015.6 3019.9 3020.7 3035.7 5860.7 5866.3 5867.6 5880.5 5904.3 5638.2 5799.2 5803.6 5818.4 5823.7 5780.3 5826.0 5868.9 5870.9 5881.0 5411.2 5684.2 5689.3 5714.5 5726.4 5609.0 5627.2 5652.0 5671.7 5698.3 5761.9 5844.5 5914.7 5926.8 5954.5 4098.8 4154.5 4156.7 4165.8 4172.3 5625.2 5643.4 5666.5 5676.6 5721.3 5432.6 5565.6 5595.4 5597.7 5608.0 5520.0 5521.6 5536.3 5561.5 5581.4 5295.3 5445.3 5459.8 5464.4 5530.3 5465.6 5573.2 5631.0 5635.9 5645.6 5491.4 5491.4 5512.7 5547.8 5550.4 08:33:30 INFO - PROCESS | 18897 | 08:33:30 INFO - PROCESS | 18897 | [#5] yui.html Cycles:180 Average:20632.92 Median:25233.60 stddev:29944.31 (118.7%) stddev-sans-first:29991.13 08:33:30 INFO - PROCESS | 18897 | Values: 760.5 767.0 785.8 825.7 850.8 15308.8 15724.8 15738.4 15747.4 15813.2 15504.8 16140.8 16180.8 16754.7 16774.2 675.6 804.1 822.6 836.0 843.2 804.8 806.9 808.9 810.8 842.1 850.5 851.7 852.2 852.5 853.0 702.8 831.1 847.7 850.9 852.4 627.0 627.1 627.3 627.3 627.4 14967.5 15016.7 15043.2 15043.6 15052.5 13829.4 14195.3 14239.5 14260.7 14664.3 13468.9 13469.7 13720.9 13784.9 14058.5 4490.3 4530.5 4576.7 4609.0 4629.2 82732.6 82869.6 83157.0 84619.0 85112.0 11591.0 11610.5 11647.2 11783.2 11797.9 21114.7 21289.4 21317.3 21343.7 21408.0 8492.5 8522.4 8801.9 9082.1 9130.9 4511.3 4542.2 4565.2 4587.2 4656.0 3752.4 3890.4 3896.2 3902.2 3917.8 606.3 660.2 668.3 668.3 668.9 585.9 643.7 705.1 712.3 716.9 10166.7 10323.1 10510.2 10650.5 10688.0 702.6 706.8 712.5 744.3 746.6 4856.2 5113.4 5208.4 5212.6 5246.2 109008.5 117617.4 118529.4 119627.0 120035.0 96638.0 98711.5 99678.5 101537.5 102150.5 87241.6 87618.1 87920.0 88807.0 88945.0 9563.7 9644.7 9756.9 9812.5 9830.9 50794.7 50912.0 51146.7 52034.0 54386.7 45880.0 50174.7 50904.7 54816.0 75254.2 11970.0 12019.7 12173.1 12205.8 12236.3 13314.9 13861.9 14203.6 14204.0 15170.2 12850.7 12942.6 12943.9 13402.2 13731.1 12137.2 12649.3 12781.9 12981.9 13599.3 12317.9 12512.9 12645.1 13176.9 13181.3 9535.4 9629.8 9794.2 10092.1 10273.6 10117.3 10246.3 10381.7 10459.4 10472.3 08:33:30 INFO - PROCESS | 18897 | -------- Summary: end -------- 08:33:30 INFO - PROCESS | 18897 | 08:33:31 INFO - TEST-INFO | 18897: exit 0 08:33:31 INFO - TEST-OK | dromaeo_css | took 1114062ms 08:33:31 INFO - TEST-START | kraken 08:33:31 INFO - operating with platform_type : linux_ 08:33:31 INFO - Initialising browser for kraken test... 08:33:31 INFO - TEST-INFO | started process 19089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXeg_2M/profile http://localhost:35980/getInfo.html) 08:33:35 INFO - PROCESS | 19089 | __metrics Screen width/height:1600/1200 08:33:35 INFO - PROCESS | 19089 | colorDepth:24 08:33:35 INFO - PROCESS | 19089 | Browser inner width/height: 1024/697 08:33:35 INFO - PROCESS | 19089 | __metrics 08:33:36 INFO - PROCESS | 19089 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:33:36 INFO - PROCESS | 19089 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:36 INFO - TEST-INFO | 19089: exit 0 08:33:36 INFO - Browser initialized. 08:33:36 INFO - Running cycle 1/1 for kraken test... 08:33:37 INFO - TEST-INFO | started process 19170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXeg_2M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:48 INFO - PROCESS | 19170 | RSS: Main: 157470720 08:33:48 INFO - PROCESS | 19170 | 08:33:51 INFO - PROCESS | 19170 | Cycle 1(1): loaded http://localhost:35980/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35980/tests/kraken/driver.html?testName=audio-beat-detection) 08:33:52 INFO - PROCESS | 19170 | RSS: Main: 216125440 08:33:52 INFO - PROCESS | 19170 | 08:33:54 INFO - PROCESS | 19170 | Cycle 1(1): loaded http://localhost:35980/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35980/tests/kraken/driver.html?testName=audio-dft) 08:33:55 INFO - PROCESS | 19170 | RSS: Main: 203370496 08:33:55 INFO - PROCESS | 19170 | 08:33:58 INFO - PROCESS | 19170 | Cycle 1(1): loaded http://localhost:35980/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35980/tests/kraken/driver.html?testName=audio-fft) 08:33:59 INFO - PROCESS | 19170 | RSS: Main: 269697024 08:33:59 INFO - PROCESS | 19170 | 08:34:01 INFO - PROCESS | 19170 | Cycle 1(1): loaded http://localhost:35980/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35980/tests/kraken/driver.html?testName=audio-oscillator) 08:34:01 INFO - PROCESS | 19170 | RSS: Main: 180219904 08:34:01 INFO - PROCESS | 19170 | 08:34:03 INFO - PROCESS | 19170 | Cycle 1(1): loaded http://localhost:35980/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35980/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:04 INFO - PROCESS | 19170 | RSS: Main: 185253888 08:34:04 INFO - PROCESS | 19170 | 08:34:07 INFO - PROCESS | 19170 | Cycle 1(1): loaded http://localhost:35980/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35980/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:08 INFO - PROCESS | 19170 | RSS: Main: 219181056 08:34:08 INFO - PROCESS | 19170 | 08:34:11 INFO - PROCESS | 19170 | Cycle 1(1): loaded http://localhost:35980/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35980/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:12 INFO - PROCESS | 19170 | RSS: Main: 220512256 08:34:12 INFO - PROCESS | 19170 | 08:34:14 INFO - PROCESS | 19170 | Cycle 1(1): loaded http://localhost:35980/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35980/tests/kraken/driver.html?testName=json-parse-financial) 08:34:15 INFO - PROCESS | 19170 | RSS: Main: 221683712 08:34:15 INFO - PROCESS | 19170 | 08:34:16 INFO - PROCESS | 19170 | Cycle 1(1): loaded http://localhost:35980/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35980/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:17 INFO - PROCESS | 19170 | RSS: Main: 207990784 08:34:17 INFO - PROCESS | 19170 | 08:34:19 INFO - PROCESS | 19170 | Cycle 1(1): loaded http://localhost:35980/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35980/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:19 INFO - PROCESS | 19170 | RSS: Main: 213196800 08:34:19 INFO - PROCESS | 19170 | 08:34:21 INFO - PROCESS | 19170 | Cycle 1(1): loaded http://localhost:35980/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35980/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:22 INFO - PROCESS | 19170 | RSS: Main: 212455424 08:34:22 INFO - PROCESS | 19170 | 08:34:25 INFO - PROCESS | 19170 | Cycle 1(1): loaded http://localhost:35980/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35980/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:25 INFO - PROCESS | 19170 | RSS: Main: 223969280 08:34:25 INFO - PROCESS | 19170 | 08:34:28 INFO - PROCESS | 19170 | Cycle 1(1): loaded http://localhost:35980/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35980/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:28 INFO - PROCESS | 19170 | RSS: Main: 224788480 08:34:28 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | Cycle 1(1): loaded http://localhost:35980/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35980/tests/kraken/driver.html?testName=ai-astar) 08:34:30 INFO - PROCESS | 19170 | RSS: Main: 266993664 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | __start_tp_report 08:34:30 INFO - PROCESS | 19170 | _x_x_mozilla_page_load 08:34:30 INFO - PROCESS | 19170 | _x_x_mozilla_page_load_details 08:34:30 INFO - PROCESS | 19170 | |i|pagename|runs| 08:34:30 INFO - PROCESS | 19170 | |0;ai-astar;104;112;111;112;112;113;113;113;112;115 08:34:30 INFO - PROCESS | 19170 | |1;audio-beat-detection;142;117;118;165;115;123;145;122;166;120 08:34:30 INFO - PROCESS | 19170 | |2;audio-dft;160;160;161;161;162;159;160;160;161;163 08:34:30 INFO - PROCESS | 19170 | |3;audio-fft;74;73;74;112;75;76;75;74;101;74 08:34:30 INFO - PROCESS | 19170 | |4;audio-oscillator;83;85;116;84;83;84;123;84;84;129 08:34:30 INFO - PROCESS | 19170 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 08:34:30 INFO - PROCESS | 19170 | |6;imaging-darkroom;145;145;146;146;146;146;145;145;145;145 08:34:30 INFO - PROCESS | 19170 | |7;imaging-desaturate;95;95;95;94;94;95;95;95;95;95 08:34:30 INFO - PROCESS | 19170 | |8;json-parse-financial;52;51;51;51;51;51;53;51;50;50 08:34:30 INFO - PROCESS | 19170 | |9;json-stringify-tinderbox;62;60;61;62;62;61;60;61;62;62 08:34:30 INFO - PROCESS | 19170 | |10;stanford-crypto-aes;81;75;75;74;84;77;78;73;75;77 08:34:30 INFO - PROCESS | 19170 | |11;stanford-crypto-ccm;124;144;118;126;117;125;119;120;160;121 08:34:30 INFO - PROCESS | 19170 | |12;stanford-crypto-pbkdf2;152;162;157;156;156;157;155;157;159;155 08:34:30 INFO - PROCESS | 19170 | |13;stanford-crypto-sha256-iterative;63;64;66;64;63;65;66;62;60;61 08:34:30 INFO - PROCESS | 19170 | __end_tp_report 08:34:30 INFO - PROCESS | 19170 | __start_cc_report 08:34:30 INFO - PROCESS | 19170 | _x_x_mozilla_cycle_collect,1672 08:34:30 INFO - PROCESS | 19170 | __end_cc_report 08:34:30 INFO - PROCESS | 19170 | __startTimestamp1468510470790__endTimestamp 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | ------- Summary: start ------- 08:34:30 INFO - PROCESS | 19170 | Number of tests: 14 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:2.91 (2.6%) stddev-sans-first:1.13 08:34:30 INFO - PROCESS | 19170 | Values: 104.0 112.0 111.0 112.0 112.0 113.0 113.0 113.0 112.0 115.0 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:132.50 stddev:19.81 (15.0%) stddev-sans-first:20.76 08:34:30 INFO - PROCESS | 19170 | Values: 142.0 117.0 118.0 165.0 115.0 123.0 145.0 122.0 166.0 120.0 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 08:34:30 INFO - PROCESS | 19170 | Values: 160.0 160.0 161.0 161.0 162.0 159.0 160.0 160.0 161.0 163.0 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | [#3] audio-fft Cycles:10 Average:80.80 Median:74.00 stddev:13.81 (18.7%) stddev-sans-first:14.43 08:34:30 INFO - PROCESS | 19170 | Values: 74.0 73.0 74.0 112.0 75.0 76.0 75.0 74.0 101.0 74.0 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.00 stddev:19.00 (22.6%) stddev-sans-first:19.61 08:34:30 INFO - PROCESS | 19170 | Values: 83.0 85.0 116.0 84.0 83.0 84.0 123.0 84.0 84.0 129.0 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:34:30 INFO - PROCESS | 19170 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:34:30 INFO - PROCESS | 19170 | Values: 145.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:34:30 INFO - PROCESS | 19170 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:0.88 (1.7%) stddev-sans-first:0.87 08:34:30 INFO - PROCESS | 19170 | Values: 52.0 51.0 51.0 51.0 51.0 51.0 53.0 51.0 50.0 50.0 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 08:34:30 INFO - PROCESS | 19170 | Values: 62.0 60.0 61.0 62.0 62.0 61.0 60.0 61.0 62.0 62.0 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:77.00 stddev:3.38 (4.4%) stddev-sans-first:3.24 08:34:30 INFO - PROCESS | 19170 | Values: 81.0 75.0 75.0 74.0 84.0 77.0 78.0 73.0 75.0 77.0 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:124.50 stddev:13.83 (11.1%) stddev-sans-first:14.61 08:34:30 INFO - PROCESS | 19170 | Values: 124.0 144.0 118.0 126.0 117.0 125.0 119.0 120.0 160.0 121.0 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:157.00 stddev:2.63 (1.7%) stddev-sans-first:2.20 08:34:30 INFO - PROCESS | 19170 | Values: 152.0 162.0 157.0 156.0 156.0 157.0 155.0 157.0 159.0 155.0 08:34:30 INFO - PROCESS | 19170 | 08:34:30 INFO - PROCESS | 19170 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.00 stddev:2.01 (3.1%) stddev-sans-first:2.13 08:34:30 INFO - PROCESS | 19170 | Values: 63.0 64.0 66.0 64.0 63.0 65.0 66.0 62.0 60.0 61.0 08:34:30 INFO - PROCESS | 19170 | -------- Summary: end -------- 08:34:30 INFO - PROCESS | 19170 | 08:34:31 INFO - TEST-INFO | 19170: exit 0 08:34:31 INFO - TEST-OK | kraken | took 60718ms 08:34:31 INFO - SUITE-END | took 1174s 08:34:31 INFO - Completed test suite (00:19:34) 08:34:31 INFO - javascript benchmark 08:34:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3016.230861130413, 3032.9393412131753, 3042.330687248806, 3058.801177923436, 3076.6769489203634, 5204.557612602934, 5204.583633309336, 5219.45195754446, 5299.947000529994, 5319.441458646845, 5277.261183434322, 5324.0, 5343.332083489564, 5370.865728356793, 5389.51494365507, 4784.354112194861, 4874.463808981027, 4877.097736918681, 4884.877878053042, 5005.599552035828, 4871.866517643311, 4888.169011268093, 4892.706437613737, 4946.802127914879, 4969.776360063788, 4771.856844294677, 4791.0, 4802.23164293713, 4830.275458681191, 4846.127697014536, 4788.473267940559, 4803.471618122004, 4853.22348424254, 4855.101806165871, 4899.118158731427, 4768.880777980544, 4801.207800712878, 4833.685810422347, 4838.983813399191, 4866.099771542276, 5268.130758424855, 5330.307060082203, 5363.249145119687, 5400.405955344909, 5413.160960051198, 5742.598018138732, 5770.7691692332255, 5778.5377169826315, 5791.391903850119, 5798.333191682926, 5527.751251193706, 5580.023495888244, 5810.4189581041555, 5822.621529600562, 5824.417558244142, 5267.683938963636, 5349.598780091509, 5350.812721554766, 5352.866178345573, 5355.33058367708, 5833.649981001154, 5836.066229403275, 5840.123981402823, 5841.123831425235, 5843.707814609253, 5481.123020316731, 5509.256250406224, 5533.3083364579425, 5604.0, 5607.52336051432, 5731.598788084877, 5733.598648094593, 5737.713114344266, 5738.626989245686, 5743.85640358986, 5647.689377084218, 5650.660960342392, 5654.971725141348, 5657.066584013592, 5701.315842098975, 5534.1975413564805, 5640.520555752725, 5685.147227915763, 5693.373728889819, 5697.059985102412, 4364.585364390377, 4386.912261754747, 4390.582894625006, 4391.6486681065435, 4426.977865110718, 3872.5546562145714, 3907.765534067965, 3928.9214215716097, 3942.8619998299923, 3961.1087505311652, 5143.742812859342, 5218.66078704883, 5317.813876514303, 5382.192671099367, 5402.486763757437, 5730.5129064030025, 5731.083026715705, 5732.6847023413275, 5735.1684005818925, 5797.449242321973, 5404.621676482609, 5407.486288802557, 5409.756560954688, 5415.945840541544, 5421.701806400607, 4815.831445899376, 4912.263160525878, 4968.130577148984, 4970.304157417964, 5000.449950505442, 5949.732262048218, 5958.821235362946, 5962.135490353874, 5964.373740757158, 5966.403359663999, 5600.523955463831, 5764.07774756037, 5778.711064446677, 5780.248567686174, 5780.306363236438, 5783.681897495678, 5810.157527158453, 5843.211166492639, 5894.233749612695, 5938.376470470711, 5575.972120139373, 5607.747651355618, 5616.410276920865, 5617.522510586646, 5618.988582055269, 5548.750306236309, 5716.5998380113, 5727.083666613322, 5729.197912292366, 5733.254676892144, 5540.750666219949, 5602.159676048625, 5605.32736071674, 5621.213030175861, 5629.211910332639, 5530.695811730394, 5570.832875013756, 5571.415001424954, 5575.581831362583, 5576.581756368208, 5366.034113859387, 5476.069068258326, 5561.777528898799, 5572.442755724395, 5615.438456154352, 5613.943860561342, 5647.955128301277, 5651.689157096399, 5704.030314846569, 5704.686242256716, 5464.562834973272, 5500.944990550043, 5513.393526712139, 5514.61397702157, 5518.172274158908], "value": 5259.3962947477485, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.9332373438921, 626.6522080245463, 635.5582869905414, 636.7484843486823, 637.1844039629276, 32934.17664558387, 43757.0, 44513.0, 44603.33095003569, 44746.552534474606, 45205.54794452054, 45437.545624543745, 45523.77238113805, 45572.3164152538, 45595.08809823802, 8239.340852731768, 8741.825163496742, 8868.822623547525, 8873.20141187293, 10843.566257349696, 10615.78768424631, 10886.782264354708, 10974.780504389908, 10988.066014388787, 10990.945045274762, 11072.280301780398, 11093.72265693356, 11109.44452777358, 11121.72195695106, 11125.610603628875, 10988.395638239894, 11030.338179709242, 11057.723556911062, 11058.612948546843, 11059.72350691231, 10829.350238985608, 10908.454577271104, 10916.235863489559, 10916.945415272952, 10921.672349829518, 43031.35452968208, 43278.13443731139, 43332.0, 43356.13287734228, 43368.3494747579, 3511.122219445139, 3552.964470355289, 3648.7081033517256, 3665.4135338346005, 3756.6431189037, 32255.51616725751, 32913.506297405555, 32914.6708532914, 32952.0, 32994.835025824716, 4185.895352616179, 4372.781360931941, 4373.803178856959, 4452.065066336073, 4469.932951005738, 358739.0, 360254.0, 360311.0, 360583.0, 360659.9999999974, 59471.70264148652, 59676.0, 59686.70156649276, 59704.40295596988, 59830.0, 64536.677316614056, 64576.67711661412, 64924.35075649183, 64927.350726493074, 64929.35070649328, 14063.648408789863, 15648.295826687827, 15717.135557544216, 15822.367105315889, 15842.44551440694, 11740.178187526963, 11995.580154694544, 12000.219985700902, 12096.637100886988, 12118.333491658044, 18143.818561814478, 18752.156152973148, 18875.150618222215, 18932.81067189338, 19145.39102391814, 7192.244814294424, 7226.0, 7234.493585448968, 7370.926290737024, 7473.215312392229, 998.9750256243507, 1007.9042490963346, 1040.095117247984, 1052.0163646989936, 1136.9545218191179, 32623.347533049207, 34702.0, 34708.65291347054, 36624.599849178274, 36677.0, 1097.1716354152563, 1103.9779204415868, 1113.7661091170944, 1117.6591139702468, 1127.2785417332914, 16972.74540881888, 17264.913675431795, 17394.82605173932, 17441.47675569735, 17662.381816636615, 619396.0, 620029.0, 624283.0, 624817.0, 624827.0, 58974.0, 59365.70317148387, 59462.0, 59506.0, 59533.10700339499, 1255.2468518888593, 1336.191604079518, 1348.0698318160437, 1359.6261028217123, 1408.429586017644, 32571.674283256863, 33464.66535334616, 33489.83255083709, 33926.830365848014, 34405.82797085999, 50647.49352506575, 61872.690636546526, 63587.364126358145, 63715.36284637095, 63787.36212637814, 546579.0, 549204.0, 550509.0, 551519.0, 551661.0, 36897.81551092227, 42375.152496950504, 43446.0, 44556.77721611371, 45033.32450013187, 49038.0, 49167.26249106195, 49533.752331238116, 49551.752241238566, 50404.74797625988, 41671.37492937669, 42009.369859452745, 42586.5741342595, 43410.78294608507, 44086.77956610196, 42179.789101054295, 42536.0, 42848.14303713971, 42883.0, 43380.56619433891, 41126.0, 41193.0, 42279.154416912104, 42297.577024229366, 42577.0, 33858.968461892364, 36957.0, 37261.81369093245, 37935.81032094822, 38265.80867095647, 28097.578536321562, 28102.71897281001, 28305.292367690974, 28320.71679283263, 28540.85729571422], "value": 21440.913812791725, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.351729370598, 397.4554859842016, 404.62572120788263, 409.41862555171656, 413.9941981101564, 14879.479218227338, 18316.633667326645, 18458.538536536595, 19695.704564431526, 19702.0, 15130.394784208645, 17436.56408589786, 18956.905215473904, 19062.428127156174, 19560.217591296332, 5757.42425757424, 5960.0, 5963.642181469126, 5994.370591087938, 5995.430434108753, 4313.676474264427, 5921.259842519685, 5998.940010599904, 5999.8200053998235, 6464.353564643545, 6813.318668133196, 6815.693293801791, 6823.795286141423, 6826.317368263183, 6833.487488438363, 6429.678516074201, 6649.567778094409, 6659.766908158215, 6662.467002639777, 6759.391654751072, 5658.321001479808, 5810.0, 5815.883682326372, 5823.912641310384, 5833.095870140135, 23175.0, 23257.30228093143, 23286.30141095753, 23454.64818027731, 23572.410689732722, 2393.9281821545383, 2450.8529488230583, 2533.7592928671747, 2542.834715743471, 2612.7779138773035, 13946.93026534871, 14566.563003109924, 14688.412463501447, 14760.335784889705, 15098.471553495576, 1945.805419458057, 2003.6092961872441, 2005.899705014758, 2041.4079916824103, 2075.2010475966863, 85057.57471212666, 85436.0, 86081.56959215227, 86169.56915215446, 87048.0, 10327.638532651472, 10754.247202695737, 10877.510512026978, 10892.782144357068, 10999.450027498753, 14851.70296594062, 14865.554033379016, 14947.626309342353, 14971.401143954337, 14974.550763477113, 7856.685732570633, 8027.5584842834205, 8099.06860711014, 8183.71357002502, 8205.138460461685, 7865.292123708894, 7874.881876771853, 7920.0, 7998.0, 8051.63767630458, 5952.583319167703, 6276.937230627726, 6354.142190804275, 6544.312847151075, 6611.933880661228, 1912.3784769949543, 1928.3443629166152, 1961.8038196180553, 1974.2991238110264, 1977.9802201978084, 983.8032393521181, 1018.760591261053, 1087.6573879228017, 1104.6630777612745, 1107.4960892793758, 19136.0, 19231.711524327147, 19688.409347719593, 20032.899835500728, 21233.469163271042, 976.2482888176065, 1029.53156313877, 1037.894642206048, 1075.8224892892586, 1094.7427354571669, 10541.57833686644, 11072.169587280987, 11088.778224435466, 11128.49921753523, 11129.777404451866, 545528.0, 547827.0, 548872.0, 568496.0, 569457.0, 98244.50877745566, 104808.47595761972, 105549.0, 105649.47175264075, 106597.0, 1040.7606250562565, 1045.8274384726435, 1045.9633912813015, 1047.5652604169336, 1058.1851973980147, 17252.0, 17365.131743413032, 17401.216561967984, 17635.20641571107, 17667.646647067242, 45895.0, 46381.0, 46596.53403466057, 46881.531184687716, 47578.3731942705, 60610.09084863642, 61207.387926120166, 65240.347596523425, 65755.67122164358, 66953.33046669471, 8344.582770861554, 8613.397062205837, 8684.26183774361, 8736.170063843925, 8861.202491775772, 12440.440180191732, 13214.801777973531, 13293.933530332286, 13301.80047299272, 13334.0, 11673.941630291794, 11734.589289374831, 11751.88248117542, 11836.940815295868, 12102.0, 11515.53937842477, 11614.0, 11685.123615728684, 11706.946374826306, 11930.821037684615, 11637.301761893974, 11647.59233426826, 11794.0, 11943.880561194625, 12190.146689731988, 8639.222469977733, 8655.783605409915, 8669.523176225368, 8777.824443511221, 8790.516521591373, 11290.209685321948, 11399.715007124889, 11586.131040171853, 11804.881951180378, 11954.641360759191], "value": 9689.634662420252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.5587988324196, 1469.2653673163416, 1507.0731500127422, 1665.7168281392162, 1808.61114860305, 8307.58462076896, 8597.355198360117, 8628.352873534486, 8840.77898052549, 8861.64553417864, 8562.871556926651, 8798.956005219981, 8803.735887923356, 8805.163509466607, 8807.95596022019, 2066.235492867641, 2285.268714011517, 2346.038124369009, 2346.2022912209886, 2378.54807586558, 2334.568104900599, 2345.2377977157494, 2346.0733010460945, 2346.4485845826216, 2346.8826558672085, 2363.326451961183, 2379.8691071991034, 2387.6418537219383, 2389.772971567707, 2391.784739373456, 1980.7226988221732, 2041.530447996969, 2044.1005957378854, 2192.2984644913636, 2305.9308220753405, 2306.7001289832215, 2339.5203983183405, 2342.543204075206, 2349.729781075181, 2350.670906073151, 8800.16398442147, 8811.251043661232, 8854.690085846965, 8896.555172241362, 8904.287656987426, 5094.872628184288, 5197.8440646780655, 5202.4277329493725, 5204.739763011834, 5212.713300768456, 3290.7367410607335, 3462.2036931505895, 3570.9107272318142, 3574.803385813779, 3618.620044895301, 1105.7567335186327, 1116.4083035990939, 1116.4752566293828, 1122.2256642916361, 1137.2721458266717, 12151.939240303831, 12225.877741222563, 12226.75546489074, 12233.571824986171, 12239.632811015685, 4512.278035514302, 4560.543945605479, 4676.2985552166765, 4680.297955306663, 4761.40482439695, 10271.9486402569, 10287.434191119411, 10293.794124117476, 10311.432871192157, 10333.328333658288, 5302.178162384759, 5331.306930099062, 5345.599080069011, 5350.063738845686, 5352.705601191972, 4257.595528424795, 4752.691075080109, 4844.273358996108, 4850.248211527219, 4905.043516514245, 4023.5063663075416, 4039.151778126626, 4048.149888523384, 4058.431819545266, 4194.433751443577, 1137.9886201137883, 1229.6434034130002, 1305.7323248733987, 1312.3307113372248, 1316.960491185266, 893.8078313162702, 991.0, 998.4558415663481, 1016.5832008876473, 1019.9643012494527, 5685.374608793029, 5719.742611582489, 6217.253929528486, 6248.31268560458, 6273.498120150377, 972.3242346569208, 980.2256217588168, 998.1116806042628, 1005.5369437468465, 1053.9894601054045, 4098.118904435561, 4280.357946308017, 4344.522102568715, 4346.239408103569, 4402.933955990663, 10618.628348007782, 10815.513301901434, 11019.118470522339, 11024.724381890517, 11041.39272340029, 10795.730106747236, 10808.51361688726, 10814.837777433344, 10817.080548153337, 10818.891811081789, 7756.6509507072315, 8091.029076510857, 8138.3896207784655, 8308.916910830936, 8313.002439707274, 6176.7838125665385, 6257.687115644108, 6306.905396419149, 6352.205974253218, 6385.680715964276, 10038.548265328223, 10351.482425878827, 10478.476076196312, 10503.47482625881, 10504.26470147113, 9793.216542676426, 10082.54628541732, 10586.258961872594, 10611.8938810614, 10612.204084693833, 7692.615369231628, 7707.653155608124, 7809.726659566888, 7853.410994175346, 7870.449068565145, 8288.088310285742, 8437.831243374976, 8440.324774017941, 8456.746297611082, 8465.915340846514, 7507.962460187664, 7531.0, 7636.541807491568, 7682.154962954182, 7940.325072368913, 7668.1181664109345, 7683.116441609286, 7686.730964416219, 7693.153753087267, 7734.99445072137, 7131.572105673468, 7139.500234983501, 7185.461090418135, 7189.928100718926, 7193.676284567312, 5077.086124497626, 5213.608979326642, 5218.9739051304505, 5263.605229607718, 5319.867003324948, 5118.692878427306, 5221.138512145453, 5325.174597937326, 5327.254184414108, 5393.8921221574565], "value": 4671.035056859549, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.6850554961688, 334.07128183649456, 337.6555912968772, 339.54500968701933, 340.2158025750644, 5337.599680023999, 5343.091674415349, 5345.412004679482, 5347.839564813057, 5377.569794416438, 5308.071087559681, 5324.787008519665, 5354.0, 5355.250264962909, 5356.705381204042, 3871.128995975911, 3988.8005599719972, 4113.218488487178, 4114.177164567099, 4151.564085770996, 4087.1008378156907, 4131.483564554431, 4142.97928510357, 4160.7087503874745, 4161.9583804161875, 4098.139390727951, 4112.876613701579, 4112.938305925413, 4138.689598280126, 4139.56534563871, 3921.7254792164704, 4054.9797251013556, 4130.979345103286, 4143.647789937859, 4144.48193975753, 3676.7242456815848, 3680.392735198716, 3684.3184010958057, 3685.9126557665554, 3690.7785532867847, 5060.873478163038, 5112.872178195537, 5127.307813445174, 5199.454057323965, 5202.193659982709, 4586.701864378805, 4702.741349225791, 4723.197056500403, 4725.432948046222, 4737.763111844429, 5453.072977593779, 5460.126379779216, 5497.532709719639, 5505.449455054502, 5513.917291240635, 4050.7772072536, 4059.472268605092, 4067.3695577185586, 4069.4302797608357, 4076.286649836267, 5446.618736688433, 5723.885522289531, 5749.31008279005, 5772.797952071699, 5779.33537643168, 4060.837566497307, 4083.244599749056, 4091.365838295069, 4094.7952602369764, 4097.323941549671, 4140.60664236897, 4145.2952997990415, 4146.398772178018, 4146.626803587692, 4155.168966206771, 4562.5665561771575, 4673.696209746356, 4720.905581888412, 4730.219513780256, 4732.73969931657, 5486.1770734389365, 5515.779368825282, 5532.861678458071, 5538.972305138529, 5548.750306236229, 1399.9720005599831, 1415.577344768501, 1424.3448013913717, 1434.2971943747489, 1436.102435977514, 887.7083843008407, 910.4673765847053, 925.1118925831278, 941.2470023980788, 943.5518128888723, 5238.816641417532, 5330.360356757214, 5386.326709161355, 5403.216533602685, 5413.593980451482, 5685.914711279334, 5697.316322041382, 5698.1737648041635, 5700.7719691212715, 5739.598228124075, 5155.53600175986, 5351.57187425005, 5391.466010974836, 5394.514493695587, 5418.810341638024, 2994.446027484879, 3015.638123425159, 3019.9396012080074, 3020.7130322619314, 3035.681253468398, 5860.736266867916, 5866.325372582122, 5867.618604790675, 5880.529557635379, 5904.291485021825, 5638.154276858504, 5799.217105690678, 5803.564732645069, 5818.429024163537, 5823.650580965155, 5780.277465316835, 5826.0, 5868.911966320508, 5870.853228669317, 5880.971299780702, 5411.2153737708595, 5684.232628595252, 5689.34572524165, 5714.485696287354, 5726.398728133652, 5609.046462101534, 5627.155926610877, 5651.971740141437, 5671.688057156896, 5698.2592263005545, 5761.942380576141, 5844.532437405082, 5914.652730243354, 5926.762929482772, 5954.4938680210935, 4098.795060246916, 4154.480689913761, 4156.688248381323, 4165.75005499671, 4172.269852775691, 5625.240592519957, 5643.3792282848035, 5666.46168613981, 5676.602637815313, 5721.313442386941, 5432.619716619799, 5565.582581306499, 5595.35653399848, 5597.720113994203, 5607.971960140337, 5519.972400137974, 5521.613487056028, 5536.252605898152, 5561.499465048165, 5581.358143813513, 5295.311609490742, 5445.292112025411, 5459.836204913859, 5464.371597266365, 5530.31779586892, 5465.59008074388, 5573.164025396223, 5630.971845140748, 5635.887282254414, 5645.576581756302, 5491.368492623399, 5491.368492623399, 5512.724363781715, 5547.778088876561, 5550.417206193453], "value": 4241.875924318959, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.4790718357928, 767.0143865133305, 785.8467598818229, 825.653225645229, 850.8052263749619, 15308.846911530894, 15724.764128538052, 15738.370465181379, 15747.448839290613, 15813.209339533021, 15504.767428488554, 16140.757888631651, 16180.83819161808, 16754.748678769796, 16774.161291935416, 675.6047712088434, 804.1315379390245, 822.5640410582386, 835.9884539706962, 843.236870632079, 804.8148925747082, 806.8587997100514, 808.870580707087, 810.7932477218301, 842.1073661918356, 850.5407080176728, 851.6508231625035, 852.1989330029783, 852.4544291653347, 853.0445900591346, 702.8137543550963, 831.1397703377036, 847.690592933581, 850.9320802393019, 852.424613385962, 627.009325266083, 627.0594108836744, 627.2723640576909, 627.3475585391187, 627.3632263252756, 14967.476138335214, 15016.699666006727, 15043.172625505593, 15043.623909402244, 15052.54842354731, 13829.377678004514, 14195.290235488184, 14239.475774424085, 14260.714785704331, 14664.340104695315, 13468.93265533676, 13469.663258418519, 13720.93139534296, 13784.862151378458, 14058.507952221726, 4490.304002879526, 4530.524294949048, 4576.656750743708, 4608.976955115203, 4629.213033784265, 82732.58633706853, 82869.58565207136, 83157.0, 84619.0, 85112.0, 11591.0, 11610.535578576932, 11647.242929209575, 11783.175177737476, 11797.88202117968, 21114.683279750818, 21289.36131916045, 21317.29461643065, 21343.67984480234, 21408.0, 8492.532910689848, 8522.446041007315, 8801.91198088011, 9082.091790820998, 9130.863037054449, 4511.323301504801, 4542.227821270326, 4565.20108980927, 4587.197240482902, 4655.95344046562, 3752.4371344298575, 3890.4164375343926, 3896.2402331545645, 3902.180542086194, 3917.7845218512684, 606.3209205689568, 660.207750699163, 668.2749217099405, 668.3149771484268, 668.906353110565, 585.9414058594192, 643.7038962077403, 705.0974752317043, 712.3126183233205, 716.9462290328246, 10166.694999150037, 10323.122534584645, 10510.211734119972, 10650.520726567323, 10688.0, 702.6311186627062, 706.7879636109146, 712.5012491256037, 744.326384621918, 746.559529877375, 4856.17445034345, 5113.360829896263, 5208.374995000624, 5212.609054320941, 5246.16061430177, 109008.45495772471, 117617.41191293989, 118529.40735296268, 119627.0, 120035.0, 96638.0, 98711.50644246733, 99678.5016074915, 101537.49231253796, 102150.48924755477, 87241.5637921819, 87618.12381876227, 87920.0, 88807.0, 88945.0, 9563.713088607354, 9644.662436814679, 9756.85364719544, 9812.460314682761, 9830.852537212091, 50794.74602626963, 50912.0, 51146.74426627843, 52034.0, 54386.728066359414, 45880.0, 50174.74912625414, 50904.74547627386, 54816.0, 75254.24745752692, 11970.042396608425, 12019.699507512381, 12173.087018473472, 12205.816912746493, 12236.327002014974, 13314.866851331362, 13861.861381386461, 14203.64490887736, 14204.0, 15170.24148792534, 12850.742985140057, 12942.611721648365, 12943.870561294267, 13402.195868247936, 13731.143746508005, 12137.21108127969, 12649.304288264233, 12781.936090319488, 12981.870181298065, 13599.320033998458, 12317.876821231674, 12512.937435312766, 12645.114841960974, 13176.868231317565, 13181.340932953506, 9535.38020028696, 9629.759256018655, 9794.167495762655, 10092.091711745978, 10273.589056437659, 10117.291789574954, 10246.333988290737, 10381.688549343531, 10459.372437653765, 10472.266941314036], "value": 7580.920547002325, "unit": "score"}], "name": "dromaeo_css", "value": 7399.538357821017, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 112.0, 112.0, 113.0, 113.0, 113.0, 112.0, 115.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 118.0, 165.0, 115.0, 123.0, 145.0, 122.0, 166.0, 120.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 162.0, 159.0, 160.0, 160.0, 161.0, 163.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 112.0, 75.0, 76.0, 75.0, 74.0, 101.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 116.0, 84.0, 83.0, 84.0, 123.0, 84.0, 84.0, 129.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 51.0, 51.0, 53.0, 51.0, 50.0, 50.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 61.0, 62.0, 62.0, 61.0, 60.0, 61.0, 62.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 75.0, 74.0, 84.0, 77.0, 78.0, 73.0, 75.0, 77.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 144.0, 118.0, 126.0, 117.0, 125.0, 119.0, 120.0, 160.0, 121.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 162.0, 157.0, 156.0, 156.0, 157.0, 155.0, 157.0, 159.0, 155.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 64.0, 63.0, 65.0, 66.0, 62.0, 60.0, 61.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1475.8000000000002, "alertThreshold": 2.0}]} 08:34:32 INFO - Return code: 0 08:34:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:34:32 INFO - # TBPL SUCCESS # 08:34:32 INFO - Running post-action listener: _resource_record_post_action 08:34:32 INFO - ##### 08:34:32 INFO - ##### Finished run-tests step (success) 08:34:32 INFO - ##### 08:34:32 INFO - Running post-run listener: _resource_record_post_run 08:34:32 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 571260928; Read time: 12; Write time: 597828 08:34:32 INFO - TinderboxPrint: CPU usage
13.0% 08:34:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:34:32 INFO - TinderboxPrint: I/O write bytes / time
571,260,928 / 597,828 08:34:32 INFO - TinderboxPrint: CPU idle
8,276.2 (87.0%) 08:34:32 INFO - TinderboxPrint: CPU user
1,194.2 (12.6%) 08:34:32 INFO - TinderboxPrint: Swap in / out
0 / 0 08:34:32 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 274001920; Read time: 0; Write time: 276616 08:34:32 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296644608; Read time: 0; Write time: 321204 08:34:32 INFO - Running post-run listener: _upload_blobber_files 08:34:32 INFO - Blob upload gear active. 08:34:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:32 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 08:34:32 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'] 08:34:32 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 08:34:33 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:34:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:34:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:33 INFO - (blobuploader) - INFO - Done attempting. 08:34:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:34:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:34:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:34 INFO - (blobuploader) - INFO - Done attempting. 08:34:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:34:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:34:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:38 INFO - (blobuploader) - INFO - Done attempting. 08:34:38 INFO - (blobuploader) - INFO - Iteration through files over. 08:34:39 INFO - Return code: 0 08:34:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:34:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:34:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e30403a37e088a4f2e53fada14c508ecb5dc2308e09e4630e2d9980b64491bc4eb153172a732c0caadb4b0a9d6b82dd89007b5c94356ee433e3273e59666b2a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e0b3f844217571fb5903b1c68bb39107b13fe002eda75c15fc6d9e5d1762da8a566d7291eec161a90fef3a6bd4b0bb28465d6e8b440d7371f0e8a0886cb08e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91f02c44c918dfefd5aae34e360b9b52fd42b84877db6c589ae87172f3dcde90ca1c120612651f6a378dd8921847a2403cb211b2439b5cc014b01d50ffcc1215"} 08:34:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:39 INFO - Contents: 08:34:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e30403a37e088a4f2e53fada14c508ecb5dc2308e09e4630e2d9980b64491bc4eb153172a732c0caadb4b0a9d6b82dd89007b5c94356ee433e3273e59666b2a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e0b3f844217571fb5903b1c68bb39107b13fe002eda75c15fc6d9e5d1762da8a566d7291eec161a90fef3a6bd4b0bb28465d6e8b440d7371f0e8a0886cb08e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91f02c44c918dfefd5aae34e360b9b52fd42b84877db6c589ae87172f3dcde90ca1c120612651f6a378dd8921847a2403cb211b2439b5cc014b01d50ffcc1215"} 08:34:39 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:39 INFO - Copying logs to upload dir... 08:34:39 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.339723 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-14 08:34:38.957543) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 08:34:38.961045) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760 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/e30403a37e088a4f2e53fada14c508ecb5dc2308e09e4630e2d9980b64491bc4eb153172a732c0caadb4b0a9d6b82dd89007b5c94356ee433e3273e59666b2a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e0b3f844217571fb5903b1c68bb39107b13fe002eda75c15fc6d9e5d1762da8a566d7291eec161a90fef3a6bd4b0bb28465d6e8b440d7371f0e8a0886cb08e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91f02c44c918dfefd5aae34e360b9b52fd42b84877db6c589ae87172f3dcde90ca1c120612651f6a378dd8921847a2403cb211b2439b5cc014b01d50ffcc1215"} build_url:https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/FAsVQeQoRj2zL56XiX8OuA/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/e30403a37e088a4f2e53fada14c508ecb5dc2308e09e4630e2d9980b64491bc4eb153172a732c0caadb4b0a9d6b82dd89007b5c94356ee433e3273e59666b2a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e0b3f844217571fb5903b1c68bb39107b13fe002eda75c15fc6d9e5d1762da8a566d7291eec161a90fef3a6bd4b0bb28465d6e8b440d7371f0e8a0886cb08e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91f02c44c918dfefd5aae34e360b9b52fd42b84877db6c589ae87172f3dcde90ca1c120612651f6a378dd8921847a2403cb211b2439b5cc014b01d50ffcc1215"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 08:34:38.987029) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:34:38.987390) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468509156.267509-1183087760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:34:39.071561) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 08:34:39.071886) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 08:34:39.072196) ========= ========= Total master_lag: 0.20 =========