builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1468430142.93 results: success (0) buildid: 20160713083126 builduid: 838623d3e499482b867cd4683646df14 revision: 98e51699f47e171256a8eb54605bed04a0be5e71 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 10:15:42.926437) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 10:15:42.926906) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 10:15:42.927198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 10:15:42.942267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:15:42.942700) ========= 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-1468430142.546538-984550515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 10:15:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 687K=0.02s 2016-07-13 10:15:43 (687 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:15:43.057802) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:15:43.058134) ========= 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-1468430142.546538-984550515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017071 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:15:43.107656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:15:43.108010) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98e51699f47e171256a8eb54605bed04a0be5e71 --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 98e51699f47e171256a8eb54605bed04a0be5e71 --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-1468430142.546538-984550515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 10:15:43,516 truncating revision to first 12 chars 2016-07-13 10:15:43,516 Setting DEBUG logging. 2016-07-13 10:15:43,516 attempt 1/10 2016-07-13 10:15:43,516 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98e51699f47e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 10:15:43,834 unpacking tar archive at: fx-team-98e51699f47e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.692722 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:15:43.814364) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 10:15:43.814717) ========= script_repo_revision: 98e51699f47e171256a8eb54605bed04a0be5e71 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 10:15:43.815100) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 10:15:43.815366) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 10:15:43.826479) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-13 10:15:43.826924) ========= /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-1468430142.546538-984550515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:15:44 INFO - MultiFileLogger online at 20160713 10:15:44 in /builds/slave/test 10:15:44 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 10:15:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:44 INFO - {'append_to_log': False, 10:15:44 INFO - 'base_work_dir': '/builds/slave/test', 10:15:44 INFO - 'blob_upload_branch': 'Fx-Team', 10:15:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:44 INFO - 'branch': 'Fx-Team', 10:15:44 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:44 INFO - 'config_files': ('talos/linux_config.py',), 10:15:44 INFO - 'default_actions': ('clobber', 10:15:44 INFO - 'read-buildbot-config', 10:15:44 INFO - 'download-and-extract', 10:15:44 INFO - 'populate-webroot', 10:15:44 INFO - 'create-virtualenv', 10:15:44 INFO - 'install', 10:15:44 INFO - 'run-tests'), 10:15:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:44 INFO - 'download_minidump_stackwalk': True, 10:15:44 INFO - 'download_symbols': 'ondemand', 10:15:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:44 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:44 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:44 INFO - 'installer_path': 'installer.exe', 10:15:44 INFO - 'log_level': 'info', 10:15:44 INFO - 'log_name': 'talos', 10:15:44 INFO - 'log_to_console': True, 10:15:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:15:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:15:44 INFO - 'opt_config_files': (), 10:15:44 INFO - 'pip_index': False, 10:15:44 INFO - 'sps_profile': False, 10:15:44 INFO - 'sps_profile_interval': 0, 10:15:44 INFO - 'suite': 'dromaeojs', 10:15:44 INFO - 'system_bits': '32', 10:15:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:44 INFO - 'title': 'talos-linux64-ix-019', 10:15:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:44 INFO - 'use_talos_json': True, 10:15:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:44 INFO - 'work_dir': 'build'} 10:15:44 INFO - ##### 10:15:44 INFO - ##### Running clobber step. 10:15:44 INFO - ##### 10:15:44 INFO - Running pre-action listener: _resource_record_pre_action 10:15:44 INFO - Running main action method: clobber 10:15:44 INFO - rmtree: /builds/slave/test/build 10:15:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:15:44 INFO - Running post-action listener: _resource_record_post_action 10:15:44 INFO - ##### 10:15:44 INFO - ##### Finished clobber step (success) 10:15:44 INFO - ##### 10:15:44 INFO - ##### 10:15:44 INFO - ##### Running read-buildbot-config step. 10:15:44 INFO - ##### 10:15:44 INFO - Running pre-action listener: _resource_record_pre_action 10:15:44 INFO - Running main action method: read_buildbot_config 10:15:44 INFO - Using buildbot properties: 10:15:44 INFO - { 10:15:44 INFO - "project": "", 10:15:44 INFO - "product": "firefox", 10:15:44 INFO - "script_repo_revision": "production", 10:15:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:15:44 INFO - "repository": "", 10:15:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:15:44 INFO - "buildid": "20160713083126", 10:15:44 INFO - "pgo_build": "True", 10:15:44 INFO - "basedir": "/builds/slave/test", 10:15:44 INFO - "buildnumber": 279, 10:15:44 INFO - "slavename": "talos-linux64-ix-019", 10:15:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:15:44 INFO - "platform": "ubuntu64_hw", 10:15:44 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:15:44 INFO - "branch": "fx-team", 10:15:44 INFO - "repo_path": "integration/fx-team", 10:15:44 INFO - "revision": "98e51699f47e171256a8eb54605bed04a0be5e71", 10:15:44 INFO - "stage_platform": "linux64-pgo", 10:15:44 INFO - "builduid": "838623d3e499482b867cd4683646df14", 10:15:44 INFO - "slavebuilddir": "test" 10:15:44 INFO - } 10:15:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:15:44 INFO - Running post-action listener: _resource_record_post_action 10:15:44 INFO - ##### 10:15:44 INFO - ##### Finished read-buildbot-config step (success) 10:15:44 INFO - ##### 10:15:44 INFO - ##### 10:15:44 INFO - ##### Running download-and-extract step. 10:15:44 INFO - ##### 10:15:44 INFO - Running pre-action listener: _resource_record_pre_action 10:15:44 INFO - Running main action method: download_and_extract 10:15:44 INFO - mkdir: /builds/slave/test/build/tests 10:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:44 INFO - https://queue.taskcluster.net/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:15:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:15:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:15:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/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 10:15:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/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 10:15:45 INFO - Downloaded 1361 bytes. 10:15:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:15:45 INFO - Using the following test package requirements: 10:15:45 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:45 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:15:45 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:15:45 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:45 INFO - u'jsshell-linux-x86_64.zip'], 10:15:45 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:15:45 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:45 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:15:45 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:15:45 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:15:45 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:15:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:15:45 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')]} 10:15:45 INFO - https://queue.taskcluster.net/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:15:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:15:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:15:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/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 10:15:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/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 10:15:46 INFO - Downloaded 24320850 bytes. 10:15:46 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'] 10:15:46 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 10:15:47 INFO - Return code: 0 10:15:47 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 10:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:47 INFO - https://queue.taskcluster.net/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:15:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:15:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:15:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/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 10:15:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/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 10:15:49 INFO - Downloaded 24320850 bytes. 10:15:49 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'] 10:15:49 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 10:15:51 INFO - Return code: 0 10:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:51 INFO - https://queue.taskcluster.net/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:15:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/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 10:15:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/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 10:15:52 INFO - Downloaded 14403317 bytes. 10:15:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:15:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:15:52 INFO - Return code: 0 10:15:52 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')]} 10:15:52 INFO - https://queue.taskcluster.net/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:15:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:15:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:15:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/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 10:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J8gRRH7GTOab8GmjclrLcw/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 10:15:53 INFO - Downloaded 60758377 bytes. 10:15:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:15:53 INFO - mkdir: /builds/slave/test/properties 10:15:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:15:53 INFO - Writing to file /builds/slave/test/properties/build_url 10:15:53 INFO - Contents: 10:15:53 INFO - build_url:https://queue.taskcluster.net/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:15:54 INFO - Running post-action listener: _resource_record_post_action 10:15:54 INFO - Running post-action listener: set_extra_try_arguments 10:15:54 INFO - ##### 10:15:54 INFO - ##### Finished download-and-extract step (success) 10:15:54 INFO - ##### 10:15:54 INFO - ##### 10:15:54 INFO - ##### Running populate-webroot step. 10:15:54 INFO - ##### 10:15:54 INFO - Running pre-action listener: _resource_record_pre_action 10:15:54 INFO - Running main action method: populate_webroot 10:15:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:15:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:15:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:15:54 INFO - '--tppagecycles', 10:15:54 INFO - '7'], 10:15:54 INFO - 'tests': ['tsvgm']}}, 10:15:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:15:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:15:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:15:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:15:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['damp', 'tps']}, 10:15:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'tests': ['damp', 'tps']}, 10:15:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['dromaeo_dom']}, 10:15:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:15:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['basic_compositor_video']}, 10:15:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:15:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['a11yr', 10:15:54 INFO - 'ts_paint', 10:15:54 INFO - 'tpaint', 10:15:54 INFO - 'sessionrestore', 10:15:54 INFO - 'sessionrestore_no_auto_restore', 10:15:54 INFO - 'tabpaint']}, 10:15:54 INFO - 'other-e10s': {'tests': ['a11yr', 10:15:54 INFO - 'ts_paint', 10:15:54 INFO - 'tpaint', 10:15:54 INFO - 'sessionrestore', 10:15:54 INFO - 'sessionrestore_no_auto_restore', 10:15:54 INFO - 'tabpaint']}, 10:15:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:15:54 INFO - 'ts_paint', 10:15:54 INFO - 'tpaint', 10:15:54 INFO - 'sessionrestore', 10:15:54 INFO - 'sessionrestore_no_auto_restore', 10:15:54 INFO - 'tabpaint']}, 10:15:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:15:54 INFO - 'ts_paint', 10:15:54 INFO - 'tpaint', 10:15:54 INFO - 'sessionrestore', 10:15:54 INFO - 'sessionrestore_no_auto_restore', 10:15:54 INFO - 'tabpaint']}, 10:15:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['a11yr', 10:15:54 INFO - 'ts_paint', 10:15:54 INFO - 'tpaint', 10:15:54 INFO - 'sessionrestore', 10:15:54 INFO - 'sessionrestore_no_auto_restore', 10:15:54 INFO - 'tabpaint']}, 10:15:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['a11yr', 10:15:54 INFO - 'ts_paint', 10:15:54 INFO - 'tpaint', 10:15:54 INFO - 'sessionrestore', 10:15:54 INFO - 'sessionrestore_no_auto_restore', 10:15:54 INFO - 'tabpaint']}, 10:15:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['tsvgx', 10:15:54 INFO - 'tsvgr_opacity', 10:15:54 INFO - 'tart', 10:15:54 INFO - 'tscrollx', 10:15:54 INFO - 'cart']}, 10:15:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:15:54 INFO - 'tsvgr_opacity', 10:15:54 INFO - 'tart', 10:15:54 INFO - 'tscrollx', 10:15:54 INFO - 'cart']}, 10:15:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'talos_options': ['--disable-e10s'], 10:15:54 INFO - 'tests': ['tp5o']}, 10:15:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'tests': ['tp5o']}, 10:15:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'talos_options': ['--disable-e10s', 10:15:54 INFO - '--xperf_path', 10:15:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:54 INFO - 'tests': ['tp5n']}, 10:15:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:54 INFO - 'talos_options': ['--xperf_path', 10:15:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:54 INFO - 'tests': ['tp5n']}}, 10:15:54 INFO - 'talos.zip': {'path': '', 10:15:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:15:54 INFO - Running post-action listener: _resource_record_post_action 10:15:54 INFO - ##### 10:15:54 INFO - ##### Finished populate-webroot step (success) 10:15:54 INFO - ##### 10:15:54 INFO - ##### 10:15:54 INFO - ##### Running create-virtualenv step. 10:15:54 INFO - ##### 10:15:54 INFO - Running pre-action listener: _resource_record_pre_action 10:15:54 INFO - Running main action method: create_virtualenv 10:15:54 INFO - Creating virtualenv /builds/slave/test/build/venv 10:15:54 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 10:15:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:15:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:15:54 INFO - Using real prefix '/usr' 10:15:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:15:54 INFO - Installing distribute.............................................................................................................................................................................................done. 10:15:56 INFO - Installing pip.................done. 10:15:56 INFO - Return code: 0 10:15:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:56 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 0x19c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f3b0>, '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 0x1c802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80740>, '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-1468430142.546538-984550515', '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 10:15:56 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 10:15:56 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 10:15:56 INFO - Using env: {'DISPLAY': ':0', 10:15:56 INFO - 'HOME': '/home/cltbld', 10:15:56 INFO - 'LANG': 'en_US.UTF-8', 10:15:56 INFO - 'LANGUAGE': 'en_US:en', 10:15:56 INFO - 'LOGNAME': 'cltbld', 10:15:56 INFO - 'MAIL': '/var/mail/cltbld', 10:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:56 INFO - 'MOZ_NO_REMOTE': '1', 10:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:56 INFO - 'NO_EM_RESTART': '1', 10:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:56 INFO - 'PWD': '/builds/slave/test', 10:15:56 INFO - 'SHELL': '/bin/bash', 10:15:56 INFO - 'SHLVL': '1', 10:15:56 INFO - 'TERM': 'linux', 10:15:56 INFO - 'TMOUT': '86400', 10:15:56 INFO - 'USER': 'cltbld', 10:15:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468430142.546538-984550515', 10:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:56 INFO - '_': '/tools/buildbot/bin/python'} 10:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:57 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 10:15:57 INFO - Cleaning up... 10:15:57 INFO - Return code: 0 10:15:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f3b0>, '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 0x1c802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80740>, '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-1468430142.546538-984550515', '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 10:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:15:57 INFO - Using env: {'DISPLAY': ':0', 10:15:57 INFO - 'HOME': '/home/cltbld', 10:15:57 INFO - 'LANG': 'en_US.UTF-8', 10:15:57 INFO - 'LANGUAGE': 'en_US:en', 10:15:57 INFO - 'LOGNAME': 'cltbld', 10:15:57 INFO - 'MAIL': '/var/mail/cltbld', 10:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:57 INFO - 'MOZ_NO_REMOTE': '1', 10:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:57 INFO - 'NO_EM_RESTART': '1', 10:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:57 INFO - 'PWD': '/builds/slave/test', 10:15:57 INFO - 'SHELL': '/bin/bash', 10:15:57 INFO - 'SHLVL': '1', 10:15:57 INFO - 'TERM': 'linux', 10:15:57 INFO - 'TMOUT': '86400', 10:15:57 INFO - 'USER': 'cltbld', 10:15:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468430142.546538-984550515', 10:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:57 INFO - '_': '/tools/buildbot/bin/python'} 10:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:57 INFO - Downloading/unpacking psutil>=3.1.1 10:15:57 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 10:15:57 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 10:15:57 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 10:15:57 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 10:15:57 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 10:15:57 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 10:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:15:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:59 INFO - Installing collected packages: psutil 10:15:59 INFO - Running setup.py install for psutil 10:15:59 INFO - building 'psutil._psutil_linux' extension 10:15:59 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 10:15:59 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 10:15:59 INFO - building 'psutil._psutil_posix' extension 10:15:59 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 10:15:59 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 10:15:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:59 INFO - Successfully installed psutil 10:15:59 INFO - Cleaning up... 10:15:59 INFO - Return code: 0 10:15:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:59 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 0x19c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f3b0>, '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 0x1c802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80740>, '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-1468430142.546538-984550515', '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 10:15:59 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 10:15:59 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 10:15:59 INFO - Using env: {'DISPLAY': ':0', 10:15:59 INFO - 'HOME': '/home/cltbld', 10:15:59 INFO - 'LANG': 'en_US.UTF-8', 10:15:59 INFO - 'LANGUAGE': 'en_US:en', 10:15:59 INFO - 'LOGNAME': 'cltbld', 10:15:59 INFO - 'MAIL': '/var/mail/cltbld', 10:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:59 INFO - 'MOZ_NO_REMOTE': '1', 10:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:59 INFO - 'NO_EM_RESTART': '1', 10:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:59 INFO - 'PWD': '/builds/slave/test', 10:15:59 INFO - 'SHELL': '/bin/bash', 10:15:59 INFO - 'SHLVL': '1', 10:15:59 INFO - 'TERM': 'linux', 10:15:59 INFO - 'TMOUT': '86400', 10:15:59 INFO - 'USER': 'cltbld', 10:15:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468430142.546538-984550515', 10:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:59 INFO - '_': '/tools/buildbot/bin/python'} 10:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:16:00 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 10:16:00 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 10:16:00 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 10:16:00 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 10:16:00 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 10:16:00 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 10:16:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:16:02 INFO - Installing collected packages: mozsystemmonitor 10:16:02 INFO - Running setup.py install for mozsystemmonitor 10:16:02 INFO - Successfully installed mozsystemmonitor 10:16:02 INFO - Cleaning up... 10:16:02 INFO - Return code: 0 10:16:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:02 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 0x19c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f3b0>, '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 0x1c802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80740>, '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-1468430142.546538-984550515', '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 10:16:02 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 10:16:02 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 10:16:02 INFO - Using env: {'DISPLAY': ':0', 10:16:02 INFO - 'HOME': '/home/cltbld', 10:16:02 INFO - 'LANG': 'en_US.UTF-8', 10:16:02 INFO - 'LANGUAGE': 'en_US:en', 10:16:02 INFO - 'LOGNAME': 'cltbld', 10:16:02 INFO - 'MAIL': '/var/mail/cltbld', 10:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:02 INFO - 'MOZ_NO_REMOTE': '1', 10:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:02 INFO - 'NO_EM_RESTART': '1', 10:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:02 INFO - 'PWD': '/builds/slave/test', 10:16:02 INFO - 'SHELL': '/bin/bash', 10:16:02 INFO - 'SHLVL': '1', 10:16:02 INFO - 'TERM': 'linux', 10:16:02 INFO - 'TMOUT': '86400', 10:16:02 INFO - 'USER': 'cltbld', 10:16:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468430142.546538-984550515', 10:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:02 INFO - '_': '/tools/buildbot/bin/python'} 10:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:02 INFO - Downloading/unpacking jsonschema==2.5.1 10:16:02 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 10:16:02 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 10:16:02 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 10:16:02 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 10:16:02 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 10:16:02 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 10:16:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:16:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:16:04 INFO - warning: no files found matching '*.txt' 10:16:04 INFO - no previously-included directories found matching 'build' 10:16:04 INFO - no previously-included directories found matching 'dist' 10:16:04 INFO - no previously-included directories found matching '.git*' 10:16:04 INFO - Installing collected packages: jsonschema, functools32 10:16:04 INFO - Running setup.py install for functools32 10:16:04 INFO - warning: no files found matching '*.txt' 10:16:04 INFO - no previously-included directories found matching 'build' 10:16:04 INFO - no previously-included directories found matching 'dist' 10:16:04 INFO - no previously-included directories found matching '.git*' 10:16:04 INFO - Successfully installed jsonschema functools32 10:16:04 INFO - Cleaning up... 10:16:04 INFO - Return code: 0 10:16:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:16:04 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')]} 10:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:04 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')]} 10:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:04 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 0x19c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f3b0>, '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 0x1c802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80740>, '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-1468430142.546538-984550515', '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 10:16:04 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 10:16:04 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 10:16:04 INFO - Using env: {'DISPLAY': ':0', 10:16:04 INFO - 'HOME': '/home/cltbld', 10:16:04 INFO - 'LANG': 'en_US.UTF-8', 10:16:04 INFO - 'LANGUAGE': 'en_US:en', 10:16:04 INFO - 'LOGNAME': 'cltbld', 10:16:04 INFO - 'MAIL': '/var/mail/cltbld', 10:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:04 INFO - 'MOZ_NO_REMOTE': '1', 10:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:04 INFO - 'NO_EM_RESTART': '1', 10:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:04 INFO - 'PWD': '/builds/slave/test', 10:16:04 INFO - 'SHELL': '/bin/bash', 10:16:04 INFO - 'SHLVL': '1', 10:16:04 INFO - 'TERM': 'linux', 10:16:04 INFO - 'TMOUT': '86400', 10:16:04 INFO - 'USER': 'cltbld', 10:16:04 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468430142.546538-984550515', 10:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:04 INFO - '_': '/tools/buildbot/bin/python'} 10:16:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:05 INFO - Downloading/unpacking blobuploader==1.2.4 10:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:06 INFO - Downloading blobuploader-1.2.4.tar.gz 10:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:16:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:16:07 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 10:16:07 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 10:16:07 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 10:16:07 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 10:16:07 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 10:16:07 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 10:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:16:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:16:07 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 10:16:07 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 10:16:07 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 10:16:07 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 10:16:07 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 10:16:07 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 10:16:07 INFO - Downloading docopt-0.6.1.tar.gz 10:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:16:07 INFO - Installing collected packages: blobuploader, requests, docopt 10:16:07 INFO - Running setup.py install for blobuploader 10:16:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:16:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:16:07 INFO - Running setup.py install for requests 10:16:08 INFO - Running setup.py install for docopt 10:16:08 INFO - Successfully installed blobuploader requests docopt 10:16:08 INFO - Cleaning up... 10:16:08 INFO - Return code: 0 10:16:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:08 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 0x19c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f3b0>, '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 0x1c802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80740>, '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-1468430142.546538-984550515', '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 10:16:08 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 10:16:08 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 10:16:08 INFO - Using env: {'DISPLAY': ':0', 10:16:08 INFO - 'HOME': '/home/cltbld', 10:16:08 INFO - 'LANG': 'en_US.UTF-8', 10:16:08 INFO - 'LANGUAGE': 'en_US:en', 10:16:08 INFO - 'LOGNAME': 'cltbld', 10:16:08 INFO - 'MAIL': '/var/mail/cltbld', 10:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:08 INFO - 'MOZ_NO_REMOTE': '1', 10:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:08 INFO - 'NO_EM_RESTART': '1', 10:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:08 INFO - 'PWD': '/builds/slave/test', 10:16:08 INFO - 'SHELL': '/bin/bash', 10:16:08 INFO - 'SHLVL': '1', 10:16:08 INFO - 'TERM': 'linux', 10:16:08 INFO - 'TMOUT': '86400', 10:16:08 INFO - 'USER': 'cltbld', 10:16:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468430142.546538-984550515', 10:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:08 INFO - '_': '/tools/buildbot/bin/python'} 10:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:08 INFO - Running setup.py (path:/tmp/pip-08_fRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:08 INFO - Running setup.py (path:/tmp/pip-ZWSJCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:08 INFO - Running setup.py (path:/tmp/pip-qA7UQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:08 INFO - Running setup.py (path:/tmp/pip-MpQqGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:08 INFO - Running setup.py (path:/tmp/pip-m9jdbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:08 INFO - Running setup.py (path:/tmp/pip-n2J42I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:09 INFO - Running setup.py (path:/tmp/pip-iFnItN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:09 INFO - Running setup.py (path:/tmp/pip-Vvdk7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:09 INFO - Running setup.py (path:/tmp/pip-aY0gG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:09 INFO - Running setup.py (path:/tmp/pip-1dXPc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:09 INFO - Running setup.py (path:/tmp/pip-pXsanp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:09 INFO - Running setup.py (path:/tmp/pip-9bTvOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:09 INFO - Running setup.py (path:/tmp/pip-osCola-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:09 INFO - Running setup.py (path:/tmp/pip-RuMPlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:09 INFO - Running setup.py (path:/tmp/pip-iVLGZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:09 INFO - Running setup.py (path:/tmp/pip-CFJYzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:09 INFO - Running setup.py (path:/tmp/pip-m2tRtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:16:09 INFO - Running setup.py install for manifestparser 10:16:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:16:09 INFO - Running setup.py install for mozcrash 10:16:10 INFO - Running setup.py install for mozdebug 10:16:10 INFO - Running setup.py install for mozdevice 10:16:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozfile 10:16:10 INFO - Running setup.py install for mozhttpd 10:16:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozinfo 10:16:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozInstall 10:16:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozleak 10:16:10 INFO - Running setup.py install for mozlog 10:16:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for moznetwork 10:16:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:16:10 INFO - Running setup.py install for mozprocess 10:16:11 INFO - Running setup.py install for mozprofile 10:16:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Running setup.py install for mozrunner 10:16:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Running setup.py install for mozscreenshot 10:16:11 INFO - Running setup.py install for moztest 10:16:11 INFO - Running setup.py install for mozversion 10:16:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:16:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:16:11 INFO - Cleaning up... 10:16:11 INFO - Return code: 0 10:16:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:11 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 0x19c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f3b0>, '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 0x1c802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80740>, '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-1468430142.546538-984550515', '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 10:16:11 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 10:16:11 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 10:16:11 INFO - Using env: {'DISPLAY': ':0', 10:16:11 INFO - 'HOME': '/home/cltbld', 10:16:11 INFO - 'LANG': 'en_US.UTF-8', 10:16:11 INFO - 'LANGUAGE': 'en_US:en', 10:16:11 INFO - 'LOGNAME': 'cltbld', 10:16:11 INFO - 'MAIL': '/var/mail/cltbld', 10:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:11 INFO - 'MOZ_NO_REMOTE': '1', 10:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:11 INFO - 'NO_EM_RESTART': '1', 10:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:11 INFO - 'PWD': '/builds/slave/test', 10:16:11 INFO - 'SHELL': '/bin/bash', 10:16:11 INFO - 'SHLVL': '1', 10:16:11 INFO - 'TERM': 'linux', 10:16:11 INFO - 'TMOUT': '86400', 10:16:11 INFO - 'USER': 'cltbld', 10:16:11 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468430142.546538-984550515', 10:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:11 INFO - '_': '/tools/buildbot/bin/python'} 10:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:11 INFO - Running setup.py (path:/tmp/pip-TMe7NC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:11 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)) 10:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:11 INFO - Running setup.py (path:/tmp/pip-hhb1Wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:11 INFO - Running setup.py (path:/tmp/pip-S1NhiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:12 INFO - Running setup.py (path:/tmp/pip-pNxRwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:12 INFO - Running setup.py (path:/tmp/pip-uIFqD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:12 INFO - Running setup.py (path:/tmp/pip-eteUtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:12 INFO - Running setup.py (path:/tmp/pip-VKnejQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:12 INFO - Running setup.py (path:/tmp/pip-NullW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:12 INFO - Running setup.py (path:/tmp/pip-SNcrzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:12 INFO - Running setup.py (path:/tmp/pip-MClMtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:12 INFO - Running setup.py (path:/tmp/pip-K9NiFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:12 INFO - Running setup.py (path:/tmp/pip-M6iPQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:12 INFO - Running setup.py (path:/tmp/pip-IZbzY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:12 INFO - Running setup.py (path:/tmp/pip-2CKugT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:12 INFO - Running setup.py (path:/tmp/pip-x0OrkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:12 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)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:12 INFO - Running setup.py (path:/tmp/pip-uUIL8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:12 INFO - Running setup.py (path:/tmp/pip-_6RpKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:13 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)) 10:16:13 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)) 10:16:13 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)) 10:16:13 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)) 10:16:13 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)) 10:16:13 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)) 10:16:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:14 INFO - Downloading blessings-1.6.tar.gz 10:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:16:15 INFO - Installing collected packages: blessings 10:16:15 INFO - Running setup.py install for blessings 10:16:15 INFO - Successfully installed blessings 10:16:15 INFO - Cleaning up... 10:16:15 INFO - Return code: 0 10:16:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:15 INFO - Reading from file tmpfile_stdout 10:16:15 INFO - Current package versions: 10:16:15 INFO - argparse == 1.2.1 10:16:15 INFO - blessings == 1.6 10:16:15 INFO - blobuploader == 1.2.4 10:16:15 INFO - docopt == 0.6.1 10:16:15 INFO - functools32 == 3.2.3-2 10:16:15 INFO - jsonschema == 2.5.1 10:16:15 INFO - manifestparser == 1.1 10:16:15 INFO - mozInstall == 1.12 10:16:15 INFO - mozcrash == 0.17 10:16:15 INFO - mozdebug == 0.1 10:16:15 INFO - mozdevice == 0.48 10:16:15 INFO - mozfile == 1.2 10:16:15 INFO - mozhttpd == 0.7 10:16:15 INFO - mozinfo == 0.9 10:16:15 INFO - mozleak == 0.1 10:16:15 INFO - mozlog == 3.2 10:16:15 INFO - moznetwork == 0.27 10:16:15 INFO - mozprocess == 0.23 10:16:15 INFO - mozprofile == 0.28 10:16:15 INFO - mozrunner == 6.12 10:16:15 INFO - mozscreenshot == 0.1 10:16:15 INFO - mozsystemmonitor == 0.3 10:16:15 INFO - moztest == 0.7 10:16:15 INFO - mozversion == 1.4 10:16:15 INFO - psutil == 3.1.1 10:16:15 INFO - requests == 1.2.3 10:16:15 INFO - wsgiref == 0.1.2 10:16:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 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 0x19c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f3b0>, '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 0x1c802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80740>, '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-1468430142.546538-984550515', '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 10:16:15 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 10:16:15 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 10:16:15 INFO - Using env: {'DISPLAY': ':0', 10:16:15 INFO - 'HOME': '/home/cltbld', 10:16:15 INFO - 'LANG': 'en_US.UTF-8', 10:16:15 INFO - 'LANGUAGE': 'en_US:en', 10:16:15 INFO - 'LOGNAME': 'cltbld', 10:16:15 INFO - 'MAIL': '/var/mail/cltbld', 10:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:15 INFO - 'MOZ_NO_REMOTE': '1', 10:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:15 INFO - 'NO_EM_RESTART': '1', 10:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:15 INFO - 'PWD': '/builds/slave/test', 10:16:15 INFO - 'SHELL': '/bin/bash', 10:16:15 INFO - 'SHLVL': '1', 10:16:15 INFO - 'TERM': 'linux', 10:16:15 INFO - 'TMOUT': '86400', 10:16:15 INFO - 'USER': 'cltbld', 10:16:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468430142.546538-984550515', 10:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:15 INFO - '_': '/tools/buildbot/bin/python'} 10:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 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)) 10:16:15 INFO - Cleaning up... 10:16:15 INFO - Return code: 0 10:16:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c81180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7f3b0>, '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 0x1c802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80740>, '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-1468430142.546538-984550515', '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 10:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:16:15 INFO - Using env: {'DISPLAY': ':0', 10:16:15 INFO - 'HOME': '/home/cltbld', 10:16:15 INFO - 'LANG': 'en_US.UTF-8', 10:16:15 INFO - 'LANGUAGE': 'en_US:en', 10:16:15 INFO - 'LOGNAME': 'cltbld', 10:16:15 INFO - 'MAIL': '/var/mail/cltbld', 10:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:15 INFO - 'MOZ_NO_REMOTE': '1', 10:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:15 INFO - 'NO_EM_RESTART': '1', 10:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:15 INFO - 'PWD': '/builds/slave/test', 10:16:15 INFO - 'SHELL': '/bin/bash', 10:16:15 INFO - 'SHLVL': '1', 10:16:15 INFO - 'TERM': 'linux', 10:16:15 INFO - 'TMOUT': '86400', 10:16:15 INFO - 'USER': 'cltbld', 10:16:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468430142.546538-984550515', 10:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:15 INFO - '_': '/tools/buildbot/bin/python'} 10:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:16:15 INFO - Cleaning up... 10:16:15 INFO - Return code: 0 10:16:15 INFO - Running post-action listener: _resource_record_post_action 10:16:15 INFO - Running post-action listener: _start_resource_monitoring 10:16:15 INFO - Starting resource monitoring. 10:16:15 INFO - ##### 10:16:15 INFO - ##### Finished create-virtualenv step (success) 10:16:15 INFO - ##### 10:16:15 INFO - ##### 10:16:15 INFO - ##### Running install step. 10:16:15 INFO - ##### 10:16:15 INFO - Running pre-action listener: _resource_record_pre_action 10:16:15 INFO - Running main action method: install 10:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:16 INFO - Reading from file tmpfile_stdout 10:16:16 INFO - Detecting whether we're running mozinstall >=1.0... 10:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:16:16 INFO - Reading from file tmpfile_stdout 10:16:16 INFO - Output received: 10:16:16 INFO - Usage: mozinstall [options] installer 10:16:16 INFO - Options: 10:16:16 INFO - -h, --help show this help message and exit 10:16:16 INFO - -d DEST, --destination=DEST 10:16:16 INFO - Directory to install application into. [default: 10:16:16 INFO - "/builds/slave/test"] 10:16:16 INFO - --app=APP Application being installed. [default: firefox] 10:16:16 INFO - mkdir: /builds/slave/test/build/application 10:16:16 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'] 10:16:16 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 10:16:33 INFO - Reading from file tmpfile_stdout 10:16:33 INFO - Output received: 10:16:33 INFO - /builds/slave/test/build/application/firefox/firefox 10:16:33 INFO - Running post-action listener: _resource_record_post_action 10:16:33 INFO - ##### 10:16:33 INFO - ##### Finished install step (success) 10:16:33 INFO - ##### 10:16:33 INFO - ##### 10:16:33 INFO - ##### Running run-tests step. 10:16:33 INFO - ##### 10:16:33 INFO - Running pre-action listener: _resource_record_pre_action 10:16:33 INFO - Running main action method: run_tests 10:16:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:16:33 INFO - Python 2.7.3 10:16:33 INFO - Return code: 0 10:16:33 INFO - grabbing minidump binary from tooltool 10:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:16:33 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 0x1c7f3b0>, '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 0x1c802b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c80740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:16:33 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 10:16:33 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 10:16:33 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 10:16:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:33 INFO - Return code: 0 10:16:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:16:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:16:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:16:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:16:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:16:33 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/J8gRRH7GTOab8GmjclrLcw/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 10:16:33 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/J8gRRH7GTOab8GmjclrLcw/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 10:16:33 INFO - Using env: {'DISPLAY': ':0', 10:16:33 INFO - 'HOME': '/home/cltbld', 10:16:33 INFO - 'LANG': 'en_US.UTF-8', 10:16:33 INFO - 'LANGUAGE': 'en_US:en', 10:16:33 INFO - 'LOGNAME': 'cltbld', 10:16:33 INFO - 'MAIL': '/var/mail/cltbld', 10:16:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:16:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:33 INFO - 'MOZ_NO_REMOTE': '1', 10:16:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:33 INFO - 'NO_EM_RESTART': '1', 10:16:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:33 INFO - 'PWD': '/builds/slave/test', 10:16:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:16:33 INFO - 'SHELL': '/bin/bash', 10:16:33 INFO - 'SHLVL': '1', 10:16:33 INFO - 'TERM': 'linux', 10:16:33 INFO - 'TMOUT': '86400', 10:16:33 INFO - 'USER': 'cltbld', 10:16:33 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468430142.546538-984550515', 10:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:33 INFO - '_': '/tools/buildbot/bin/python'} 10:16:33 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/J8gRRH7GTOab8GmjclrLcw/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 10:16:33 INFO - mozversion application_buildid: 20160713083126 10:16:33 INFO - mozversion application_changeset: 98e51699f47e171256a8eb54605bed04a0be5e71 10:16:33 INFO - mozversion application_display_name: Nightly 10:16:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:33 INFO - mozversion application_name: Firefox 10:16:33 INFO - mozversion application_remotingname: firefox 10:16:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:16:33 INFO - mozversion application_vendor: Mozilla 10:16:33 INFO - mozversion application_version: 50.0a1 10:16:33 INFO - mozversion platform_buildid: 20160713083126 10:16:33 INFO - mozversion platform_changeset: 98e51699f47e171256a8eb54605bed04a0be5e71 10:16:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:16:33 INFO - mozversion platform_version: 50.0a1 10:16:33 INFO - using testdate: 1468430193 10:16:33 INFO - actual date: 1468430193 10:16:33 INFO - starting webserver on 'localhost:58921' 10:16:33 INFO - SUITE-START | Running 2 tests 10:16:33 INFO - TEST-START | dromaeo_css 10:16:33 INFO - operating with platform_type : linux_ 10:16:33 INFO - Initialising browser for dromaeo_css test... 10:16:33 INFO - TEST-INFO | started process 9776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKyMgSw/profile http://localhost:58921/getInfo.html) 10:16:37 INFO - PROCESS | 9776 | __metrics Screen width/height:1600/1200 10:16:37 INFO - PROCESS | 9776 | colorDepth:24 10:16:37 INFO - PROCESS | 9776 | Browser inner width/height: 1024/697 10:16:37 INFO - PROCESS | 9776 | __metrics 10:16:39 INFO - PROCESS | 9776 | 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" 10:16:39 INFO - PROCESS | 9776 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:16:39 INFO - TEST-INFO | 9776: exit 0 10:16:39 INFO - Browser initialized. 10:16:39 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:39 INFO - TEST-INFO | started process 9860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKyMgSw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:51 INFO - PROCESS | 9860 | RSS: Main: 157794304 10:16:51 INFO - PROCESS | 9860 | 10:17:43 INFO - PROCESS | 9860 | 1468430263241 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] 10:19:51 INFO - PROCESS | 9860 | Cycle 1(1): loaded http://localhost:58921/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58921/tests/dromaeo/cssquery-ext.html) 10:19:52 INFO - PROCESS | 9860 | RSS: Main: 290070528 10:19:52 INFO - PROCESS | 9860 | 10:22:55 INFO - PROCESS | 9860 | Cycle 1(1): loaded http://localhost:58921/tests/dromaeo/cssquery-ext.html (next: http://localhost:58921/tests/dromaeo/cssquery-jquery.html) 10:22:55 INFO - PROCESS | 9860 | RSS: Main: 242880512 10:22:55 INFO - PROCESS | 9860 | 10:25:57 INFO - PROCESS | 9860 | Cycle 1(1): loaded http://localhost:58921/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58921/tests/dromaeo/cssquery-mootools.html) 10:25:58 INFO - PROCESS | 9860 | RSS: Main: 240209920 10:25:58 INFO - PROCESS | 9860 | 10:29:00 INFO - PROCESS | 9860 | Cycle 1(1): loaded http://localhost:58921/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58921/tests/dromaeo/cssquery-prototype.html) 10:29:01 INFO - PROCESS | 9860 | RSS: Main: 233775104 10:29:01 INFO - PROCESS | 9860 | 10:32:04 INFO - PROCESS | 9860 | Cycle 1(1): loaded http://localhost:58921/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58921/tests/dromaeo/cssquery-yui.html) 10:32:04 INFO - PROCESS | 9860 | RSS: Main: 209080320 10:32:04 INFO - PROCESS | 9860 | 10:35:07 INFO - PROCESS | 9860 | Cycle 1(1): loaded http://localhost:58921/tests/dromaeo/cssquery-yui.html (next: http://localhost:58921/tests/dromaeo/cssquery-dojo.html) 10:35:07 INFO - PROCESS | 9860 | RSS: Main: 301010944 10:35:07 INFO - PROCESS | 9860 | 10:35:07 INFO - PROCESS | 9860 | __start_tp_report 10:35:07 INFO - PROCESS | 9860 | _x_x_mozilla_page_load 10:35:07 INFO - PROCESS | 9860 | _x_x_mozilla_page_load_details 10:35:07 INFO - PROCESS | 9860 | |i|pagename|runs| 10:35:07 INFO - PROCESS | 9860 | |0;dojo.html;3029.742471889889;3048.1008102609726;3071.4932036214027;3074.5080787074066;3087.058447173611;5152.124138896387;5256.973715131428;5263.210518422238;5388.730563471825;5403.78384864605;5313.256144139824;5365.168398898168;5381.300430943981;5453.318335208099;5482.479164479378;4829.541193586604;4837.903241935151;4919.532644398794;4919.704817710931;5084.211947148198;4999.4000719913665;5049.293098966147;5052.520010598987;5065.544101030907;5067.543921047105;4721.740304283263;4757.476677565465;4825.131476334259;4897.069556784199;5023.271625614284;4882.902341953177;4892.828750993734;4902.240152776325;4902.534259245366;4964.950350496485;4908.9263661045115;4930.926036109461;4950.133726597831;4959.305697202394;4966.925496117561;5205.869853253699;5253.711045892474;5262.158054711228;5360.517553420211;5497.862553436196;5767.990601644696;5795.130730390433;5812.505936995361;5813.040848260032;5816.912746308809;5825.7378417971295;5829.650220986754;5832.270966129234;5833.445822646841;5844.853878653025;5225.790968361261;5345.492178243061;5398.946010539884;5405.027095122916;5411.404745477994;5956.434138756811;5969.044952807617;5970.313413957364;6008.158857759917;6010.519158467312;5764.365919748824;5776.653400795965;5776.826695199151;5779.479846813807;5781.797637082682;5572.721363931787;5699.544036477072;5738.885222295531;5750.856228594319;5852.648841069549;5746.540276777848;5748.19525266463;5748.9425105748405;5807.128930660435;5828.6211396259105;5548.306461692288;5711.143328500758;5789.421057894261;5794.333651630117;5800.5939584229545;4254.765987870697;4350.412694286231;4365.301551751704;4382.342648602735;4413.7351758894565;3910.804459777;3919.1377896862646;3928.2143571285856;3957.445957565943;3960.4257382679352;5304.575633949275;5483.040467918098;5487.945120548743;5489.560835133179;5500.037493438632;5662.235598194191;5713.685747283939;5726.541876649858;5734.856628584235;5775.364709881909;5419;5422.213779002022;5424.891502169935;5427.375851777097;5427.972860135674;4878.902421951541;4906.092372911023;4963.429205641398;4973.55238028572;5023;5864.853378665567;5911.91132133027;5926.644401335933;5929.940700593025;5986.311574168939;5753.223314852441;5758.769649214152;5762.481376676119;5764.250647415809;5767.971160144172;5783.450572195635;5903.26209223847;5905.675187864536;5906.291245050621;5970.313413957277;5732.885342293214;5746.741396637245;5752.482276595127;5752.568557358299;5792.82621521355;5806.506446952057;5811.883762324815;5839.299284085937;5852.912206316993;5862.706864656835;5428.592855535771;5590.0496915523645;5662.122371032497;5666.971665141813;5700.429957004267;5696.772129114955;5711.514521265739;5719.113537401709;5721.25623668937;5723.399043100415;5614.6631202128;5625.831225063254;5626;5627.831165065055;5630.23991761107;5449.100898351728;5489.039418101736;5530.529904958124;5606.411326810789;5660.264165658438;5425.13197888336;5427.810026649048;5460.91808622863;5484.177373394023;5538.224648549126 10:35:07 INFO - PROCESS | 9860 | |1;ext.html;591.299310317274;623.8908191066565;629.0564153769346;645.5223134880189;652.1066139389038;31251.68748312519;43608.56391436085;44771.328430073576;45095;45127.548724512744;45672.543274567244;45851.312230316486;46316.536834631646;46327;46398;8061.758147255592;8922.509261990588;9085;10709.518071686793;10997.890021099767;10655.84016239757;11090.33457992519;11092.1126309895;11143.498542565563;11153.219274650777;11080;11120.888791112066;11138.108951283877;11147.331160130418;11153.498092585853;11091.445427728622;11140.387278699669;11161.553537858475;11173.944130279378;11177.832332514938;10839.458027098613;10890.183236257313;10938.945305273503;10949.726256843564;10954.123670106372;44848.77575612101;45165.774171128935;45230.095398092184;45236.3214551782;45334.54665453369;3168.4138434389483;3168.413843438971;3174.3809957058384;3207.711305982473;3326.900192994214;34528.13679658004;34717;34785.30429391423;35372.93211280684;36233.63766362329;4264.744115353058;4364.694471387004;4383.949614782834;4393.033532622818;4418.028033832552;362345.9999999974;363318.28386006627;366830;367447;367632;58069.709651452315;58803;65093.67453162704;65795.67102164554;66061.33938660649;68434.65782671055;68573.31426685769;68781.3121868785;68994.65502672555;69220;16416.75374869378;16769.664606707796;16808.327666893187;16857.325706971827;16857.831421685627;12617.49530018789;12676.556320528738;12690.969444888959;12737.235765853893;12738.363081846055;20066.398008059783;20764.48088797762;20813.89593052025;20959.90400959892;20982.89508552478;7486.4759466836795;7757.340626046849;7766.572838493824;7807.7657670268845;7874.803129921798;1021.3769600543662;1061.8035663402295;1147.1511081799574;1159.4202898550725;1197.8742232065508;33206.83396583002;33401.49897751536;33602;33699.663003370144;34168.48747268793;946.5787724462548;1085.0288991352695;1102.795982743195;1111.5109351885144;1179.4928180882132;17105.82894171067;17269.56826079333;17323.39368122135;17463.65072698539;17479.300827966737;493405;498610;499310;502347;505229;60947;61617.69191154105;61706;62241;62308.68845655743;1221.44424286951;1336.5054929676082;1361.3465536542317;1363.12078709232;1377.201223290469;32961.505577415875;34397.484037738956;34481;34594.30811383809;34612;50616.74691626518;51026;51101;51218;51244.487555125466;389611;390875;391072;394249;395933;36886.26227475489;44813;48778.512214877395;49847.75076124596;49933.500664992884;45775.31337030014;46223;46258.537414625425;51139.488605113474;51190.48809511857;39585;43016.354754679334;43995.78002109969;44715.32927006033;45151;41992.37011444892;42626;42998.570014299454;43453.97497901554;44254.77872610616;43620;44642;44675.32987005263;44856.775716121214;45328.77335613301;37872.81063594665;39562.2087558253;39805.23371953725;39992.40011399773;41019.384709229984;29424.705752943053;29489.76049982628;29683.40633187281;29748.851255743582;30005.099847004625 10:35:07 INFO - PROCESS | 9860 | |2;jquery.html;381.5175922000845;383.34448093759653;385.72035274426037;398.9002749312672;412.35672351132234;14403.855961440382;18675.906620466878;18747.718784218247;20520.179192832307;20523.589528209446;16181.91909040456;18948.905255473703;19893.900530497365;19992.200311987504;20006;5711.600187986832;5868.794592189274;5878.177055212273;5878.911816322759;5879.118132280149;4116.464859568267;5836.5038971687245;5845.766169353221;6060.2121724175795;6356.68216589171;6377.936220637781;6378.776742814002;6417.518686098538;6421.8715625687455;6424.807255782334;6214.254289485268;6384.07430922516;6385.968070159666;6387.169667943184;6396.584222025554;5569.888602227933;5761.855953601152;5764.855878603026;5782.913256301159;5802.65184088956;24073.27780166598;24721.505569888683;24887.875560622262;24935.251942441755;24959.251222463172;2490.7260201377835;2497.3881399057163;2537.4544472938405;2941.485240082998;3111.934531476025;14598.781018284628;15003.399864005427;15175;15427.460038898696;15623.453179138676;1981.1184023109722;2006.9598608027757;2048.6722124460016;2064.5148390128306;2074.972888420242;83567.5821620888;86066.5696671519;86164;86479.13520864774;87251.56374218152;10854.240203185858;11125;11149.609763658233;11189.832152517718;11292.717682058013;15299.388024479118;15375.308111134802;15376.384944602314;15387;15430.5370838875;8325.333973282122;8329.750107496784;8448.366372522085;8461.303976293217;8567.443116197428;6878.7248510059035;8025.117237103914;8149.796255093552;8172.264496195371;8197.631106600098;6434.549581529248;6787.117674702257;6790.32096790317;6861.313868613099;6955.89566156508;1840.2822899069374;1921.9807801922082;1929.4308179087202;1988.5227545389002;2023.716679664848;921.2583869984727;992.6972273456665;1068.4764465411893;1075.5267682219799;1077.9892201078046;19570.80429195718;20273;20756.481087972923;20770.699652492218;21188.364349069554;1043.139409986764;1053.8103141434462;1103.2056919018294;1103.448275862069;1154.1228666213738;11438.428078596036;11915.344656043828;11928.284302941851;12084.697882552831;12120.151589388834;459873;461411;461432;472765;473084;81120.59439702764;84530;84765.57617211874;84894.57552712197;85836;1049.0068869148527;1049.6378749331468;1053.2153545608417;1057.1754031855164;1081.8214994525815;17131.314747410463;17731.379401721395;17782;18290.725639115157;18496.537586560444;41541.37687934744;43822;43866.56133438625;44152.7792361049;45426.09147816959;58544.12183817331;59762.40237597568;60504.39495604987;60903.39096608977;62503;8456.534890581077;8660.438314849745;8729.345299102466;8742.781430464289;9008.504532250789;9432.528373581155;13987.860121399062;14386.712265754417;14622.70754584881;14801.259937002891;12538.749225015632;12641.747165056464;12648.494060237488;12853.421596028014;12862.807057893951;12107.576234831738;12293.139480236297;12531.812022819848;12578.748425031632;12706.491740330282;12473.126881118598;12563;12601.684957876127;12849.614511564669;12903.161294515827;7553.433492488195;8635.6977505787;8836.867446988172;8853.778655533406;9178.632854685738;11850.822237666614;12551.623451296477;12575.685607859878;12732.618021459371;12771.872281277068 10:35:07 INFO - PROCESS | 9860 | |3;mootools.html;1330.9134906231088;1484.0650390254139;1504.2779465856388;1667.341400146942;1799.6580649676569;8466.280366168876;8897.377183597151;8916.554172291391;9137.314701397388;9157.038510956354;8841.5579221039;9053.637854485813;9055.954720226406;9058.864117038249;9061.909380906189;1973.5756812285356;2016;2034.3083351660432;2274.2949685597437;2297.425643589103;2295.3687735872686;2367.1241640593003;2378.1795280628157;2395.317334559651;2395.73646898841;2298.092253559851;2308.503671710582;2321.1527792355837;2321.3036089173265;2349.635806450003;1889.2915156816193;2158.4495953531828;2165.2421652421685;2166.620841352773;2228.832837537191;2312.09828167015;2342.5900467418305;2352.176738141654;2353.9176128835406;2356.7996720278798;8873.51195684237;8882.245009174228;8892.3330750194;8894.777630559223;8908.198262156373;5059.241113832918;5171.3535808024;5182.611304152204;5186;5190.325257716473;3299.307145499424;3345.330933813247;3441.1569165554347;3445.4487282035007;3450.189205536697;1105.3202280597454;1138.5559631743627;1138.9487473063732;1168.4625072466677;1170.5844425229006;12263.26420414778;12276.754464910651;12277.324747138815;12370.072244581692;12391.256524608461;4395.604395604411;4552.248878934939;4602.930956035595;4618.284165954283;4657.441107067174;10395.220358472994;10441.269111162146;10471.21465890046;10472.162227021972;10490.31812932157;5246.449122842047;5258.658187217895;5259.526642602184;5260.473952604709;5262.079136151235;4245.808938597709;4662.7668616569035;4795.640326975491;4795.880102997453;4826.638002149853;3938.2911076006594;4031.314676505001;4032.919341613151;4071.3078776607454;4084.509858816961;1229.6188181663713;1235.9814602780966;1239.7086684629105;1241.5592464675092;1255.9434825432877;639.6705696566272;896.3725392225468;944.9244060475146;953.4041224234853;974.2741657465092;5966.463018328372;6368.681565921685;6440.194975628046;6505.121808555785;6632.535722499379;967.4098799732158;974.3179774158118;975.9072888075622;989.248171389749;1004.4525733475274;3990.4014397840556;4064.7561146331313;4070.3283958147167;4095.385692146202;4122.773247471418;10712.78574428507;11051.889481105247;11175.552977880794;11189.664310070712;11199;10965.232433729563;10969.177311701655;11006.394648294261;11036.558537658404;11042.171837112248;7861.567613781182;8261.8347633047;8412.747617571482;8416.579171041423;8417.242448179572;6032.8793424132145;6163.137160797402;6267.1539342188225;6334.588251763621;6449.677516124269;10358.119559837498;10385.117265032557;10497;10506.106980906708;10530.420826854597;9800.705978820646;10227.232957528364;10244.231682623684;10387.324823886423;10431.165506759593;7292.453066019963;7636;7912.881306780518;8072.394570407126;8242;8481.10948350439;8520.786980325542;8541.017782954792;8542.615582298688;8549.957250213709;7704.544434526341;7772.339351155215;7799.45403821727;7819.178986206366;8028.31759300466;7737.535747855147;7791.727289544839;7839.764807055797;7861.567613781297;7983.361331093382;6894.24163342042;6942.201646810681;6949.7567585134275;6962.791116266318;6969.2682268361095;4940.901181976268;5144.279800827812;5199.74001299941;5248.1340578804065;5352.367527903871;5355.785768569213;5380.300916995559;5381.1121165007335;5463.098588732973;5525.861853453695 10:35:07 INFO - PROCESS | 9860 | |4;prototype.html;291.13823083672315;293.9867705953232;300.2089494182828;308.5849532378951;309.8806959320664;5151.716655583941;5229.660072095311;5265.3155089838365;5319.547838433733;5321.840344789653;5150.562202212816;5168.819091331804;5197.974010129944;5212.609054320932;5255.527002569768;4159.604837540436;4161.731856138396;4166.895827604319;4180.850266176811;4181.60274773896;3963.128111815396;4016.5581786003518;4178.080822219122;4186.685998550106;4223.725457845246;4133.256013917494;4148.651688201347;4163.125743593849;4167.416561681367;4168.7707176105305;4125.1131006833375;4132.442120313749;4139.254934111874;4171.6036976487485;4183.1215444756635;3514.5606799150105;3693.2059607184583;3693.778373297611;3706.2958037972967;3709.7943168470356;5105.566026887719;5110.386753589556;5118.513741194581;5127.077126117298;5200.219967004941;4724.7401392923375;4751.928721069186;4765.21373973294;4766.118268120409;4785.8564243072415;5320.882614650928;5488.835334939959;5492.203630473599;5507.366652834935;5574;3965.504311961005;3971.344728119857;3975.940360894589;3984.8406063757416;3988.8432354617125;5688.914666280009;5731.742071606787;5767.423257674241;5777;5806.21616081832;4048.1296521248073;4145.937810932838;4147.486167548884;4155.376693495939;4180.749155050707;4202.34863596137;4208.347706105558;4222.852200172979;4225.68307376948;4231.851885184004;4772.689775164673;4779.761011949388;4787.736674482937;4788.018456216468;4792.113459010025;5286.577073834084;5511.614187006871;5529.4470552944385;5530.253415788898;5628.6622802631155;1361.5234667866366;1402.2427888939858;1431.6277767780452;1454.534548944349;1456.3155317000992;982.4841957972122;1008.3395376028712;1016.506994107857;1016.9084782369622;1019.2712210769336;5217.2695822584865;5268.736563171826;5271.182966640177;5305.681659100389;5308.548773354231;5536.141898005815;5540.667559946416;5557.3331200256225;5598.4961353477565;5606.971965140148;5154.53609175176;5208.192730126761;5265.631405801634;5323.068463018956;5348.331458567679;2634.8670071868896;2660.7627453233954;2686.804372054417;2706.3356036037694;2714.782817374605;5177.585793136615;5204.9219261711105;5232.843014709565;5240.816571419982;5298.682079075268;4745.288206768943;4959.231319145538;5067.479756073163;5086.338775959101;5108.770105345268;4964.329815474937;4971.925421118686;5092.8472145835685;5110.882361759323;5149.48505149482;5004.749762511933;5005.924911126263;5019.52314530119;5039.395272567315;5071.290019397361;4903.779329930233;5270.8155214567305;5663.66018038919;5672.602917795714;5686.203931449518;5818.7090645466715;5865.560082993878;5867.413258674099;5895.145203945318;5899.734511946886;4028.9798551007057;4064.9593504064583;4066.1461093170765;4079.714419990572;4080.735191968486;5407.864803379947;5418.376886658085;5589.021921163861;5691.658500489983;5704.80033198836;5412.8105516308315;5419.458054194707;5419.864503387447;5446.809361672323;5452.100403433389;5524.309461317335;5546.7781288748;5554.6944918028275;5557.749901254372;5570.275864137636;5304.204369344629;5463.207834864002;5471.72641367938;5502.257195278587;5507.889842203213;5326.280952071421;5428.592855535771;5520.1443776214755;5572.631631556654;5597.692126933058;5444.210589464585;5446.373667028342;5464.726763661722;5467.5625949923115;5468.125099983983 10:35:07 INFO - PROCESS | 9860 | |5;yui.html;657.4707360574737;671.1476424940323;676.6143298319956;681.9215790184127;747.3274053351983;13953.372098255577;15719.292631831566;15752.448664296751;15754.842451575481;15771.290291936863;14800.11199328041;14852.405903763864;14890.329935152917;14911.552653420415;14935.17856517891;683.4600665474269;796.3828033274201;813.1461964936822;814.9022117345912;826.904905935816;831.8960129983752;834.9540775257359;836.1471299274737;838.4801423117675;839.5508403004363;707.5365635508724;883.1786438612088;884.8584226523758;885.0883589902379;885.2431171348501;844.4089137603671;873.1704880363679;873.2446433834688;878.9077146899548;880.2913654508119;638.5306799502362;639.1531221132019;639.3606393606393;639.4309064932214;639.5011890725242;15006.924965375212;15033.699326013419;15116.319765610573;15129.167895765728;15141.621459463602;14960.102393856294;15072.397104115822;15091.849081509265;15119.412461691583;15165.938384313102;12389.318587477685;12400.441980110916;12435.253884766942;12521.436535355931;12627.500711457667;4625.629949604024;4651.162790697673;4669.276262179367;4800.35195248644;4817.060673168733;68818;72490.63754681246;79497;80229.59885200537;80578;12630.305333206577;12761.872381276069;12770.23378597287;12818.80771788424;12873.163244389085;21476.570468590853;21510.46223844385;21513.89243053806;21522;21566.676499852514;8630.84973984491;8655.870161947576;8882.333824963154;8920.687775927812;9085.636574536944;4645.976770116195;4698.859034228979;4734;4747.192977193886;4917.311576379309;3505.2814173094453;3607.404778211566;3608.0979755061235;3608.260306637133;3611.223586928823;626.5175814622716;636.9490440764728;641.682367228225;644.3073695776965;644.6518879804946;602.4036204157852;615.0896672924098;633.3223450907485;663.9966800165968;673.3703986772383;9060.184583387527;9335.206507446943;9526.142647161789;9529.809403811885;9613.327067105236;595.4105435618793;610.6214147228746;644.1786721929484;648.4391001783517;674.7435974329724;4206.705530612889;4368.803403846835;4419.337099435046;4446.3108218226225;4503.369528266046;65598;65751.67124164444;65970.34029659738;66270;97913.5104324488;90282;94091;94197;94377.69678061234;94594;82171.5891420551;83653.58173209096;84148.57925710455;84191.5790421044;85636;8365.330773538224;8479.321654267767;8508.532030738368;8599.91400086016;8681.435706679045;49619.7519012417;50248.74875625598;51093.48906510887;51207.23189152091;52667.473325266255;69147;73742.63128684323;74866;75101.24898750943;76780;12627.494900204256;12632.810507842207;12871.420786064837;12938.223706577635;13248.271345076113;13401.731965360834;13527;13608.591742247749;13835.377408016462;14411.639709006939;12545.686357841127;12549.184303020274;12830.743385132431;13221.140625859289;13336.533221337206;12238.571649992207;12383.133180677267;12514.374281285716;12660.366981650697;12867.163634363736;11517.942410287895;11784.234024788362;11927.165098443025;12080.39598020078;12220;9536.189423899046;9741.366811157252;9792.118709316195;9819.950900245452;9936.354136981074;9033.50315732641;9333.813323733622;9390.577424015799;9909.702708918743;9992.850107248543 10:35:07 INFO - PROCESS | 9860 | __end_tp_report 10:35:07 INFO - PROCESS | 9860 | __start_cc_report 10:35:07 INFO - PROCESS | 9860 | _x_x_mozilla_cycle_collect,1156 10:35:07 INFO - PROCESS | 9860 | __end_cc_report 10:35:07 INFO - PROCESS | 9860 | __startTimestamp1468431307789__endTimestamp 10:35:07 INFO - PROCESS | 9860 | 10:35:07 INFO - PROCESS | 9860 | ------- Summary: start ------- 10:35:07 INFO - PROCESS | 9860 | Number of tests: 6 10:35:07 INFO - PROCESS | 9860 | 10:35:07 INFO - PROCESS | 9860 | [#0] dojo.html Cycles:165 Average:5353.95 Median:5530.53 stddev:618.70 (11.2%) stddev-sans-first:593.12 10:35:07 INFO - PROCESS | 9860 | Values: 3029.7 3048.1 3071.5 3074.5 3087.1 5152.1 5257.0 5263.2 5388.7 5403.8 5313.3 5365.2 5381.3 5453.3 5482.5 4829.5 4837.9 4919.5 4919.7 5084.2 4999.4 5049.3 5052.5 5065.5 5067.5 4721.7 4757.5 4825.1 4897.1 5023.3 4882.9 4892.8 4902.2 4902.5 4965.0 4908.9 4930.9 4950.1 4959.3 4966.9 5205.9 5253.7 5262.2 5360.5 5497.9 5768.0 5795.1 5812.5 5813.0 5816.9 5825.7 5829.7 5832.3 5833.4 5844.9 5225.8 5345.5 5398.9 5405.0 5411.4 5956.4 5969.0 5970.3 6008.2 6010.5 5764.4 5776.7 5776.8 5779.5 5781.8 5572.7 5699.5 5738.9 5750.9 5852.6 5746.5 5748.2 5748.9 5807.1 5828.6 5548.3 5711.1 5789.4 5794.3 5800.6 4254.8 4350.4 4365.3 4382.3 4413.7 3910.8 3919.1 3928.2 3957.4 3960.4 5304.6 5483.0 5487.9 5489.6 5500.0 5662.2 5713.7 5726.5 5734.9 5775.4 5419.0 5422.2 5424.9 5427.4 5428.0 4878.9 4906.1 4963.4 4973.6 5023.0 5864.9 5911.9 5926.6 5929.9 5986.3 5753.2 5758.8 5762.5 5764.3 5768.0 5783.5 5903.3 5905.7 5906.3 5970.3 5732.9 5746.7 5752.5 5752.6 5792.8 5806.5 5811.9 5839.3 5852.9 5862.7 5428.6 5590.0 5662.1 5667.0 5700.4 5696.8 5711.5 5719.1 5721.3 5723.4 5614.7 5625.8 5626.0 5627.8 5630.2 5449.1 5489.0 5530.5 5606.4 5660.3 5425.1 5427.8 5460.9 5484.2 5538.2 10:35:07 INFO - PROCESS | 9860 | 10:35:07 INFO - PROCESS | 9860 | [#1] ext.html Cycles:180 Average:60372.63 Median:390973.50 stddev:111518.13 (28.5%) stddev-sans-first:111740.64 10:35:07 INFO - PROCESS | 9860 | Values: 591.3 623.9 629.1 645.5 652.1 31251.7 43608.6 44771.3 45095.0 45127.5 45672.5 45851.3 46316.5 46327.0 46398.0 8061.8 8922.5 9085.0 10709.5 10997.9 10655.8 11090.3 11092.1 11143.5 11153.2 11080.0 11120.9 11138.1 11147.3 11153.5 11091.4 11140.4 11161.6 11173.9 11177.8 10839.5 10890.2 10938.9 10949.7 10954.1 44848.8 45165.8 45230.1 45236.3 45334.5 3168.4 3168.4 3174.4 3207.7 3326.9 34528.1 34717.0 34785.3 35372.9 36233.6 4264.7 4364.7 4383.9 4393.0 4418.0 362346.0 363318.3 366830.0 367447.0 367632.0 58069.7 58803.0 65093.7 65795.7 66061.3 68434.7 68573.3 68781.3 68994.7 69220.0 16416.8 16769.7 16808.3 16857.3 16857.8 12617.5 12676.6 12691.0 12737.2 12738.4 20066.4 20764.5 20813.9 20959.9 20982.9 7486.5 7757.3 7766.6 7807.8 7874.8 1021.4 1061.8 1147.2 1159.4 1197.9 33206.8 33401.5 33602.0 33699.7 34168.5 946.6 1085.0 1102.8 1111.5 1179.5 17105.8 17269.6 17323.4 17463.7 17479.3 493405.0 498610.0 499310.0 502347.0 505229.0 60947.0 61617.7 61706.0 62241.0 62308.7 1221.4 1336.5 1361.3 1363.1 1377.2 32961.5 34397.5 34481.0 34594.3 34612.0 50616.7 51026.0 51101.0 51218.0 51244.5 389611.0 390875.0 391072.0 394249.0 395933.0 36886.3 44813.0 48778.5 49847.8 49933.5 45775.3 46223.0 46258.5 51139.5 51190.5 39585.0 43016.4 43995.8 44715.3 45151.0 41992.4 42626.0 42998.6 43454.0 44254.8 43620.0 44642.0 44675.3 44856.8 45328.8 37872.8 39562.2 39805.2 39992.4 41019.4 29424.7 29489.8 29683.4 29748.9 30005.1 10:35:07 INFO - PROCESS | 9860 | 10:35:07 INFO - PROCESS | 9860 | [#2] jquery.html Cycles:180 Average:28853.56 Median:13712.99 stddev:76798.39 (560.0%) stddev-sans-first:76984.07 10:35:07 INFO - PROCESS | 9860 | Values: 381.5 383.3 385.7 398.9 412.4 14403.9 18675.9 18747.7 20520.2 20523.6 16181.9 18948.9 19893.9 19992.2 20006.0 5711.6 5868.8 5878.2 5878.9 5879.1 4116.5 5836.5 5845.8 6060.2 6356.7 6377.9 6378.8 6417.5 6421.9 6424.8 6214.3 6384.1 6386.0 6387.2 6396.6 5569.9 5761.9 5764.9 5782.9 5802.7 24073.3 24721.5 24887.9 24935.3 24959.3 2490.7 2497.4 2537.5 2941.5 3111.9 14598.8 15003.4 15175.0 15427.5 15623.5 1981.1 2007.0 2048.7 2064.5 2075.0 83567.6 86066.6 86164.0 86479.1 87251.6 10854.2 11125.0 11149.6 11189.8 11292.7 15299.4 15375.3 15376.4 15387.0 15430.5 8325.3 8329.8 8448.4 8461.3 8567.4 6878.7 8025.1 8149.8 8172.3 8197.6 6434.5 6787.1 6790.3 6861.3 6955.9 1840.3 1922.0 1929.4 1988.5 2023.7 921.3 992.7 1068.5 1075.5 1078.0 19570.8 20273.0 20756.5 20770.7 21188.4 1043.1 1053.8 1103.2 1103.4 1154.1 11438.4 11915.3 11928.3 12084.7 12120.2 459873.0 461411.0 461432.0 472765.0 473084.0 81120.6 84530.0 84765.6 84894.6 85836.0 1049.0 1049.6 1053.2 1057.2 1081.8 17131.3 17731.4 17782.0 18290.7 18496.5 41541.4 43822.0 43866.6 44152.8 45426.1 58544.1 59762.4 60504.4 60903.4 62503.0 8456.5 8660.4 8729.3 8742.8 9008.5 9432.5 13987.9 14386.7 14622.7 14801.3 12538.7 12641.7 12648.5 12853.4 12862.8 12107.6 12293.1 12531.8 12578.7 12706.5 12473.1 12563.0 12601.7 12849.6 12903.2 7553.4 8635.7 8836.9 8853.8 9178.6 11850.8 12551.6 12575.7 12732.6 12771.9 10:35:07 INFO - PROCESS | 9860 | 10:35:07 INFO - PROCESS | 9860 | [#3] mootools.html Cycles:180 Average:5861.82 Median:4660.10 stddev:3362.18 (72.1%) stddev-sans-first:3354.37 10:35:07 INFO - PROCESS | 9860 | Values: 1330.9 1484.1 1504.3 1667.3 1799.7 8466.3 8897.4 8916.6 9137.3 9157.0 8841.6 9053.6 9056.0 9058.9 9061.9 1973.6 2016.0 2034.3 2274.3 2297.4 2295.4 2367.1 2378.2 2395.3 2395.7 2298.1 2308.5 2321.2 2321.3 2349.6 1889.3 2158.4 2165.2 2166.6 2228.8 2312.1 2342.6 2352.2 2353.9 2356.8 8873.5 8882.2 8892.3 8894.8 8908.2 5059.2 5171.4 5182.6 5186.0 5190.3 3299.3 3345.3 3441.2 3445.4 3450.2 1105.3 1138.6 1138.9 1168.5 1170.6 12263.3 12276.8 12277.3 12370.1 12391.3 4395.6 4552.2 4602.9 4618.3 4657.4 10395.2 10441.3 10471.2 10472.2 10490.3 5246.4 5258.7 5259.5 5260.5 5262.1 4245.8 4662.8 4795.6 4795.9 4826.6 3938.3 4031.3 4032.9 4071.3 4084.5 1229.6 1236.0 1239.7 1241.6 1255.9 639.7 896.4 944.9 953.4 974.3 5966.5 6368.7 6440.2 6505.1 6632.5 967.4 974.3 975.9 989.2 1004.5 3990.4 4064.8 4070.3 4095.4 4122.8 10712.8 11051.9 11175.6 11189.7 11199.0 10965.2 10969.2 11006.4 11036.6 11042.2 7861.6 8261.8 8412.7 8416.6 8417.2 6032.9 6163.1 6267.2 6334.6 6449.7 10358.1 10385.1 10497.0 10506.1 10530.4 9800.7 10227.2 10244.2 10387.3 10431.2 7292.5 7636.0 7912.9 8072.4 8242.0 8481.1 8520.8 8541.0 8542.6 8550.0 7704.5 7772.3 7799.5 7819.2 8028.3 7737.5 7791.7 7839.8 7861.6 7983.4 6894.2 6942.2 6949.8 6962.8 6969.3 4940.9 5144.3 5199.7 5248.1 5352.4 5355.8 5380.3 5381.1 5463.1 5525.9 10:35:07 INFO - PROCESS | 9860 | 10:35:07 INFO - PROCESS | 9860 | [#4] prototype.html Cycles:180 Average:4571.68 Median:5114.70 stddev:1315.80 (25.7%) stddev-sans-first:1279.67 10:35:07 INFO - PROCESS | 9860 | Values: 291.1 294.0 300.2 308.6 309.9 5151.7 5229.7 5265.3 5319.5 5321.8 5150.6 5168.8 5198.0 5212.6 5255.5 4159.6 4161.7 4166.9 4180.9 4181.6 3963.1 4016.6 4178.1 4186.7 4223.7 4133.3 4148.7 4163.1 4167.4 4168.8 4125.1 4132.4 4139.3 4171.6 4183.1 3514.6 3693.2 3693.8 3706.3 3709.8 5105.6 5110.4 5118.5 5127.1 5200.2 4724.7 4751.9 4765.2 4766.1 4785.9 5320.9 5488.8 5492.2 5507.4 5574.0 3965.5 3971.3 3975.9 3984.8 3988.8 5688.9 5731.7 5767.4 5777.0 5806.2 4048.1 4145.9 4147.5 4155.4 4180.7 4202.3 4208.3 4222.9 4225.7 4231.9 4772.7 4779.8 4787.7 4788.0 4792.1 5286.6 5511.6 5529.4 5530.3 5628.7 1361.5 1402.2 1431.6 1454.5 1456.3 982.5 1008.3 1016.5 1016.9 1019.3 5217.3 5268.7 5271.2 5305.7 5308.5 5536.1 5540.7 5557.3 5598.5 5607.0 5154.5 5208.2 5265.6 5323.1 5348.3 2634.9 2660.8 2686.8 2706.3 2714.8 5177.6 5204.9 5232.8 5240.8 5298.7 4745.3 4959.2 5067.5 5086.3 5108.8 4964.3 4971.9 5092.8 5110.9 5149.5 5004.7 5005.9 5019.5 5039.4 5071.3 4903.8 5270.8 5663.7 5672.6 5686.2 5818.7 5865.6 5867.4 5895.1 5899.7 4029.0 4065.0 4066.1 4079.7 4080.7 5407.9 5418.4 5589.0 5691.7 5704.8 5412.8 5419.5 5419.9 5446.8 5452.1 5524.3 5546.8 5554.7 5557.7 5570.3 5304.2 5463.2 5471.7 5502.3 5507.9 5326.3 5428.6 5520.1 5572.6 5597.7 5444.2 5446.4 5464.7 5467.6 5468.1 10:35:07 INFO - PROCESS | 9860 | 10:35:07 INFO - PROCESS | 9860 | [#5] yui.html Cycles:180 Average:19228.66 Median:635.14 stddev:26330.45 (4145.6%) stddev-sans-first:26367.39 10:35:07 INFO - PROCESS | 9860 | Values: 657.5 671.1 676.6 681.9 747.3 13953.4 15719.3 15752.4 15754.8 15771.3 14800.1 14852.4 14890.3 14911.6 14935.2 683.5 796.4 813.1 814.9 826.9 831.9 835.0 836.1 838.5 839.6 707.5 883.2 884.9 885.1 885.2 844.4 873.2 873.2 878.9 880.3 638.5 639.2 639.4 639.4 639.5 15006.9 15033.7 15116.3 15129.2 15141.6 14960.1 15072.4 15091.8 15119.4 15165.9 12389.3 12400.4 12435.3 12521.4 12627.5 4625.6 4651.2 4669.3 4800.4 4817.1 68818.0 72490.6 79497.0 80229.6 80578.0 12630.3 12761.9 12770.2 12818.8 12873.2 21476.6 21510.5 21513.9 21522.0 21566.7 8630.8 8655.9 8882.3 8920.7 9085.6 4646.0 4698.9 4734.0 4747.2 4917.3 3505.3 3607.4 3608.1 3608.3 3611.2 626.5 636.9 641.7 644.3 644.7 602.4 615.1 633.3 664.0 673.4 9060.2 9335.2 9526.1 9529.8 9613.3 595.4 610.6 644.2 648.4 674.7 4206.7 4368.8 4419.3 4446.3 4503.4 65598.0 65751.7 65970.3 66270.0 97913.5 90282.0 94091.0 94197.0 94377.7 94594.0 82171.6 83653.6 84148.6 84191.6 85636.0 8365.3 8479.3 8508.5 8599.9 8681.4 49619.8 50248.7 51093.5 51207.2 52667.5 69147.0 73742.6 74866.0 75101.2 76780.0 12627.5 12632.8 12871.4 12938.2 13248.3 13401.7 13527.0 13608.6 13835.4 14411.6 12545.7 12549.2 12830.7 13221.1 13336.5 12238.6 12383.1 12514.4 12660.4 12867.2 11517.9 11784.2 11927.2 12080.4 12220.0 9536.2 9741.4 9792.1 9820.0 9936.4 9033.5 9333.8 9390.6 9909.7 9992.9 10:35:07 INFO - PROCESS | 9860 | -------- Summary: end -------- 10:35:07 INFO - PROCESS | 9860 | 10:35:08 INFO - TEST-INFO | 9860: exit 0 10:35:08 INFO - TEST-OK | dromaeo_css | took 1114913ms 10:35:08 INFO - TEST-START | kraken 10:35:08 INFO - operating with platform_type : linux_ 10:35:08 INFO - Initialising browser for kraken test... 10:35:08 INFO - TEST-INFO | started process 10051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdTgUiC/profile http://localhost:58921/getInfo.html) 10:35:12 INFO - PROCESS | 10051 | __metrics Screen width/height:1600/1200 10:35:12 INFO - PROCESS | 10051 | colorDepth:24 10:35:12 INFO - PROCESS | 10051 | Browser inner width/height: 1024/697 10:35:12 INFO - PROCESS | 10051 | __metrics 10:35:13 INFO - PROCESS | 10051 | 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" 10:35:13 INFO - PROCESS | 10051 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:35:14 INFO - PROCESS | 10051 | console.error: PushService: 10:35:14 INFO - PROCESS | 10051 | stateChangeProcessEnqueue: Error transitioning state 10:35:14 INFO - PROCESS | 10051 | UnknownError 10:35:14 INFO - TEST-INFO | 10051: exit 0 10:35:14 INFO - Browser initialized. 10:35:14 INFO - Running cycle 1/1 for kraken test... 10:35:14 INFO - TEST-INFO | started process 10134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdTgUiC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:26 INFO - PROCESS | 10134 | RSS: Main: 157544448 10:35:26 INFO - PROCESS | 10134 | 10:35:29 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:58921/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58921/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:29 INFO - PROCESS | 10134 | RSS: Main: 215801856 10:35:29 INFO - PROCESS | 10134 | 10:35:32 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:58921/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58921/tests/kraken/driver.html?testName=audio-dft) 10:35:33 INFO - PROCESS | 10134 | RSS: Main: 203354112 10:35:33 INFO - PROCESS | 10134 | 10:35:36 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:58921/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58921/tests/kraken/driver.html?testName=audio-fft) 10:35:36 INFO - PROCESS | 10134 | RSS: Main: 269164544 10:35:36 INFO - PROCESS | 10134 | 10:35:38 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:58921/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58921/tests/kraken/driver.html?testName=audio-oscillator) 10:35:39 INFO - PROCESS | 10134 | RSS: Main: 180473856 10:35:39 INFO - PROCESS | 10134 | 10:35:41 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:58921/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58921/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:42 INFO - PROCESS | 10134 | RSS: Main: 185331712 10:35:42 INFO - PROCESS | 10134 | 10:35:45 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:58921/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58921/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:45 INFO - PROCESS | 10134 | RSS: Main: 219312128 10:35:45 INFO - PROCESS | 10134 | 10:35:49 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:58921/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58921/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:49 INFO - PROCESS | 10134 | RSS: Main: 220942336 10:35:49 INFO - PROCESS | 10134 | 10:35:52 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:58921/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58921/tests/kraken/driver.html?testName=json-parse-financial) 10:35:53 INFO - PROCESS | 10134 | RSS: Main: 221913088 10:35:53 INFO - PROCESS | 10134 | 10:35:54 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:58921/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58921/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:35:55 INFO - PROCESS | 10134 | RSS: Main: 208150528 10:35:55 INFO - PROCESS | 10134 | 10:35:57 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:58921/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58921/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:35:57 INFO - PROCESS | 10134 | RSS: Main: 211238912 10:35:57 INFO - PROCESS | 10134 | 10:35:59 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:58921/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58921/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:36:00 INFO - PROCESS | 10134 | RSS: Main: 212250624 10:36:00 INFO - PROCESS | 10134 | 10:36:03 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:58921/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58921/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:36:03 INFO - PROCESS | 10134 | RSS: Main: 224395264 10:36:03 INFO - PROCESS | 10134 | 10:36:06 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:58921/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58921/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:36:06 INFO - PROCESS | 10134 | RSS: Main: 227196928 10:36:06 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | Cycle 1(1): loaded http://localhost:58921/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58921/tests/kraken/driver.html?testName=ai-astar) 10:36:08 INFO - PROCESS | 10134 | RSS: Main: 269357056 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | __start_tp_report 10:36:08 INFO - PROCESS | 10134 | _x_x_mozilla_page_load 10:36:08 INFO - PROCESS | 10134 | _x_x_mozilla_page_load_details 10:36:08 INFO - PROCESS | 10134 | |i|pagename|runs| 10:36:08 INFO - PROCESS | 10134 | |0;ai-astar;101;113;111;112;110;111;110;112;112;110 10:36:08 INFO - PROCESS | 10134 | |1;audio-beat-detection;149;122;120;180;119;118;141;116;147;119 10:36:08 INFO - PROCESS | 10134 | |2;audio-dft;161;164;160;161;161;161;162;162;163;161 10:36:08 INFO - PROCESS | 10134 | |3;audio-fft;73;75;75;124;75;75;76;73;101;76 10:36:08 INFO - PROCESS | 10134 | |4;audio-oscillator;84;85;108;85;85;84;123;85;84;120 10:36:08 INFO - PROCESS | 10134 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;116;117;116 10:36:08 INFO - PROCESS | 10134 | |6;imaging-darkroom;146;146;146;145;145;145;145;145;146;145 10:36:08 INFO - PROCESS | 10134 | |7;imaging-desaturate;95;96;95;95;96;95;95;95;96;95 10:36:08 INFO - PROCESS | 10134 | |8;json-parse-financial;52;53;54;53;51;53;53;53;53;53 10:36:08 INFO - PROCESS | 10134 | |9;json-stringify-tinderbox;62;63;62;62;63;63;61;62;63;63 10:36:08 INFO - PROCESS | 10134 | |10;stanford-crypto-aes;76;76;84;86;75;75;75;77;76;81 10:36:08 INFO - PROCESS | 10134 | |11;stanford-crypto-ccm;126;118;118;118;118;125;119;120;207;133 10:36:08 INFO - PROCESS | 10134 | |12;stanford-crypto-pbkdf2;159;160;159;159;158;161;158;160;161;156 10:36:08 INFO - PROCESS | 10134 | |13;stanford-crypto-sha256-iterative;63;64;65;63;62;64;62;61;64;63 10:36:08 INFO - PROCESS | 10134 | __end_tp_report 10:36:08 INFO - PROCESS | 10134 | __start_cc_report 10:36:08 INFO - PROCESS | 10134 | _x_x_mozilla_cycle_collect,1673 10:36:08 INFO - PROCESS | 10134 | __end_cc_report 10:36:08 INFO - PROCESS | 10134 | __startTimestamp1468431368846__endTimestamp 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | ------- Summary: start ------- 10:36:08 INFO - PROCESS | 10134 | Number of tests: 14 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.39 (3.0%) stddev-sans-first:1.09 10:36:08 INFO - PROCESS | 10134 | Values: 101.0 113.0 111.0 112.0 110.0 111.0 110.0 112.0 112.0 110.0 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:131.50 stddev:20.87 (15.9%) stddev-sans-first:21.33 10:36:08 INFO - PROCESS | 10134 | Values: 149.0 122.0 120.0 180.0 119.0 118.0 141.0 116.0 147.0 119.0 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 10:36:08 INFO - PROCESS | 10134 | Values: 161.0 164.0 160.0 161.0 161.0 161.0 162.0 162.0 163.0 161.0 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:16.85 (22.5%) stddev-sans-first:17.53 10:36:08 INFO - PROCESS | 10134 | Values: 73.0 75.0 75.0 124.0 75.0 75.0 76.0 73.0 101.0 76.0 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:84.50 stddev:16.11 (19.1%) stddev-sans-first:16.65 10:36:08 INFO - PROCESS | 10134 | Values: 84.0 85.0 108.0 85.0 85.0 84.0 123.0 85.0 84.0 120.0 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:36:08 INFO - PROCESS | 10134 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:36:08 INFO - PROCESS | 10134 | Values: 146.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:36:08 INFO - PROCESS | 10134 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:0.79 (1.5%) stddev-sans-first:0.78 10:36:08 INFO - PROCESS | 10134 | Values: 52.0 53.0 54.0 53.0 51.0 53.0 53.0 53.0 53.0 53.0 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 10:36:08 INFO - PROCESS | 10134 | Values: 62.0 63.0 62.0 62.0 63.0 63.0 61.0 62.0 63.0 63.0 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:76.50 stddev:4.07 (5.3%) stddev-sans-first:4.24 10:36:08 INFO - PROCESS | 10134 | Values: 76.0 76.0 84.0 86.0 75.0 75.0 75.0 77.0 76.0 81.0 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:122.50 stddev:27.44 (22.4%) stddev-sans-first:29.06 10:36:08 INFO - PROCESS | 10134 | Values: 126.0 118.0 118.0 118.0 118.0 125.0 119.0 120.0 207.0 133.0 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:159.50 stddev:1.52 (1.0%) stddev-sans-first:1.62 10:36:08 INFO - PROCESS | 10134 | Values: 159.0 160.0 159.0 159.0 158.0 161.0 158.0 160.0 161.0 156.0 10:36:08 INFO - PROCESS | 10134 | 10:36:08 INFO - PROCESS | 10134 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.20 (1.9%) stddev-sans-first:1.27 10:36:08 INFO - PROCESS | 10134 | Values: 63.0 64.0 65.0 63.0 62.0 64.0 62.0 61.0 64.0 63.0 10:36:08 INFO - PROCESS | 10134 | -------- Summary: end -------- 10:36:08 INFO - PROCESS | 10134 | 10:36:09 INFO - TEST-INFO | 10134: exit 0 10:36:09 INFO - TEST-OK | kraken | took 61293ms 10:36:09 INFO - SUITE-END | took 1176s 10:36:10 INFO - Completed test suite (00:19:36) 10:36:10 INFO - javascript benchmark 10:36:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3029.742471889889, 3048.1008102609726, 3071.4932036214027, 3074.5080787074066, 3087.058447173611, 5152.124138896387, 5256.973715131428, 5263.210518422238, 5388.730563471825, 5403.78384864605, 5313.256144139824, 5365.168398898168, 5381.300430943981, 5453.318335208099, 5482.479164479378, 4829.541193586604, 4837.903241935151, 4919.532644398794, 4919.704817710931, 5084.211947148198, 4999.4000719913665, 5049.293098966147, 5052.520010598987, 5065.544101030907, 5067.543921047105, 4721.740304283263, 4757.476677565465, 4825.131476334259, 4897.069556784199, 5023.271625614284, 4882.902341953177, 4892.828750993734, 4902.240152776325, 4902.534259245366, 4964.950350496485, 4908.9263661045115, 4930.926036109461, 4950.133726597831, 4959.305697202394, 4966.925496117561, 5205.869853253699, 5253.711045892474, 5262.158054711228, 5360.517553420211, 5497.862553436196, 5767.990601644696, 5795.130730390433, 5812.505936995361, 5813.040848260032, 5816.912746308809, 5825.7378417971295, 5829.650220986754, 5832.270966129234, 5833.445822646841, 5844.853878653025, 5225.790968361261, 5345.492178243061, 5398.946010539884, 5405.027095122916, 5411.404745477994, 5956.434138756811, 5969.044952807617, 5970.313413957364, 6008.158857759917, 6010.519158467312, 5764.365919748824, 5776.653400795965, 5776.826695199151, 5779.479846813807, 5781.797637082682, 5572.721363931787, 5699.544036477072, 5738.885222295531, 5750.856228594319, 5852.648841069549, 5746.540276777848, 5748.19525266463, 5748.9425105748405, 5807.128930660435, 5828.6211396259105, 5548.306461692288, 5711.143328500758, 5789.421057894261, 5794.333651630117, 5800.5939584229545, 4254.765987870697, 4350.412694286231, 4365.301551751704, 4382.342648602735, 4413.7351758894565, 3910.804459777, 3919.1377896862646, 3928.2143571285856, 3957.445957565943, 3960.4257382679352, 5304.575633949275, 5483.040467918098, 5487.945120548743, 5489.560835133179, 5500.037493438632, 5662.235598194191, 5713.685747283939, 5726.541876649858, 5734.856628584235, 5775.364709881909, 5419.0, 5422.213779002022, 5424.891502169935, 5427.375851777097, 5427.972860135674, 4878.902421951541, 4906.092372911023, 4963.429205641398, 4973.55238028572, 5023.0, 5864.853378665567, 5911.91132133027, 5926.644401335933, 5929.940700593025, 5986.311574168939, 5753.223314852441, 5758.769649214152, 5762.481376676119, 5764.250647415809, 5767.971160144172, 5783.450572195635, 5903.26209223847, 5905.675187864536, 5906.291245050621, 5970.313413957277, 5732.885342293214, 5746.741396637245, 5752.482276595127, 5752.568557358299, 5792.82621521355, 5806.506446952057, 5811.883762324815, 5839.299284085937, 5852.912206316993, 5862.706864656835, 5428.592855535771, 5590.0496915523645, 5662.122371032497, 5666.971665141813, 5700.429957004267, 5696.772129114955, 5711.514521265739, 5719.113537401709, 5721.25623668937, 5723.399043100415, 5614.6631202128, 5625.831225063254, 5626.0, 5627.831165065055, 5630.23991761107, 5449.100898351728, 5489.039418101736, 5530.529904958124, 5606.411326810789, 5660.264165658438, 5425.13197888336, 5427.810026649048, 5460.91808622863, 5484.177373394023, 5538.224648549126], "value": 5311.192633356217, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.299310317274, 623.8908191066565, 629.0564153769346, 645.5223134880189, 652.1066139389038, 31251.68748312519, 43608.56391436085, 44771.328430073576, 45095.0, 45127.548724512744, 45672.543274567244, 45851.312230316486, 46316.536834631646, 46327.0, 46398.0, 8061.758147255592, 8922.509261990588, 9085.0, 10709.518071686793, 10997.890021099767, 10655.84016239757, 11090.33457992519, 11092.1126309895, 11143.498542565563, 11153.219274650777, 11080.0, 11120.888791112066, 11138.108951283877, 11147.331160130418, 11153.498092585853, 11091.445427728622, 11140.387278699669, 11161.553537858475, 11173.944130279378, 11177.832332514938, 10839.458027098613, 10890.183236257313, 10938.945305273503, 10949.726256843564, 10954.123670106372, 44848.77575612101, 45165.774171128935, 45230.095398092184, 45236.3214551782, 45334.54665453369, 3168.4138434389483, 3168.413843438971, 3174.3809957058384, 3207.711305982473, 3326.900192994214, 34528.13679658004, 34717.0, 34785.30429391423, 35372.93211280684, 36233.63766362329, 4264.744115353058, 4364.694471387004, 4383.949614782834, 4393.033532622818, 4418.028033832552, 362345.9999999974, 363318.28386006627, 366830.0, 367447.0, 367632.0, 58069.709651452315, 58803.0, 65093.67453162704, 65795.67102164554, 66061.33938660649, 68434.65782671055, 68573.31426685769, 68781.3121868785, 68994.65502672555, 69220.0, 16416.75374869378, 16769.664606707796, 16808.327666893187, 16857.325706971827, 16857.831421685627, 12617.49530018789, 12676.556320528738, 12690.969444888959, 12737.235765853893, 12738.363081846055, 20066.398008059783, 20764.48088797762, 20813.89593052025, 20959.90400959892, 20982.89508552478, 7486.4759466836795, 7757.340626046849, 7766.572838493824, 7807.7657670268845, 7874.803129921798, 1021.3769600543662, 1061.8035663402295, 1147.1511081799574, 1159.4202898550725, 1197.8742232065508, 33206.83396583002, 33401.49897751536, 33602.0, 33699.663003370144, 34168.48747268793, 946.5787724462548, 1085.0288991352695, 1102.795982743195, 1111.5109351885144, 1179.4928180882132, 17105.82894171067, 17269.56826079333, 17323.39368122135, 17463.65072698539, 17479.300827966737, 493405.0, 498610.0, 499310.0, 502347.0, 505229.0, 60947.0, 61617.69191154105, 61706.0, 62241.0, 62308.68845655743, 1221.44424286951, 1336.5054929676082, 1361.3465536542317, 1363.12078709232, 1377.201223290469, 32961.505577415875, 34397.484037738956, 34481.0, 34594.30811383809, 34612.0, 50616.74691626518, 51026.0, 51101.0, 51218.0, 51244.487555125466, 389611.0, 390875.0, 391072.0, 394249.0, 395933.0, 36886.26227475489, 44813.0, 48778.512214877395, 49847.75076124596, 49933.500664992884, 45775.31337030014, 46223.0, 46258.537414625425, 51139.488605113474, 51190.48809511857, 39585.0, 43016.354754679334, 43995.78002109969, 44715.32927006033, 45151.0, 41992.37011444892, 42626.0, 42998.570014299454, 43453.97497901554, 44254.77872610616, 43620.0, 44642.0, 44675.32987005263, 44856.775716121214, 45328.77335613301, 37872.81063594665, 39562.2087558253, 39805.23371953725, 39992.40011399773, 41019.384709229984, 29424.705752943053, 29489.76049982628, 29683.40633187281, 29748.851255743582, 30005.099847004625], "value": 21480.41063474765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.5175922000845, 383.34448093759653, 385.72035274426037, 398.9002749312672, 412.35672351132234, 14403.855961440382, 18675.906620466878, 18747.718784218247, 20520.179192832307, 20523.589528209446, 16181.91909040456, 18948.905255473703, 19893.900530497365, 19992.200311987504, 20006.0, 5711.600187986832, 5868.794592189274, 5878.177055212273, 5878.911816322759, 5879.118132280149, 4116.464859568267, 5836.5038971687245, 5845.766169353221, 6060.2121724175795, 6356.68216589171, 6377.936220637781, 6378.776742814002, 6417.518686098538, 6421.8715625687455, 6424.807255782334, 6214.254289485268, 6384.07430922516, 6385.968070159666, 6387.169667943184, 6396.584222025554, 5569.888602227933, 5761.855953601152, 5764.855878603026, 5782.913256301159, 5802.65184088956, 24073.27780166598, 24721.505569888683, 24887.875560622262, 24935.251942441755, 24959.251222463172, 2490.7260201377835, 2497.3881399057163, 2537.4544472938405, 2941.485240082998, 3111.934531476025, 14598.781018284628, 15003.399864005427, 15175.0, 15427.460038898696, 15623.453179138676, 1981.1184023109722, 2006.9598608027757, 2048.6722124460016, 2064.5148390128306, 2074.972888420242, 83567.5821620888, 86066.5696671519, 86164.0, 86479.13520864774, 87251.56374218152, 10854.240203185858, 11125.0, 11149.609763658233, 11189.832152517718, 11292.717682058013, 15299.388024479118, 15375.308111134802, 15376.384944602314, 15387.0, 15430.5370838875, 8325.333973282122, 8329.750107496784, 8448.366372522085, 8461.303976293217, 8567.443116197428, 6878.7248510059035, 8025.117237103914, 8149.796255093552, 8172.264496195371, 8197.631106600098, 6434.549581529248, 6787.117674702257, 6790.32096790317, 6861.313868613099, 6955.89566156508, 1840.2822899069374, 1921.9807801922082, 1929.4308179087202, 1988.5227545389002, 2023.716679664848, 921.2583869984727, 992.6972273456665, 1068.4764465411893, 1075.5267682219799, 1077.9892201078046, 19570.80429195718, 20273.0, 20756.481087972923, 20770.699652492218, 21188.364349069554, 1043.139409986764, 1053.8103141434462, 1103.2056919018294, 1103.448275862069, 1154.1228666213738, 11438.428078596036, 11915.344656043828, 11928.284302941851, 12084.697882552831, 12120.151589388834, 459873.0, 461411.0, 461432.0, 472765.0, 473084.0, 81120.59439702764, 84530.0, 84765.57617211874, 84894.57552712197, 85836.0, 1049.0068869148527, 1049.6378749331468, 1053.2153545608417, 1057.1754031855164, 1081.8214994525815, 17131.314747410463, 17731.379401721395, 17782.0, 18290.725639115157, 18496.537586560444, 41541.37687934744, 43822.0, 43866.56133438625, 44152.7792361049, 45426.09147816959, 58544.12183817331, 59762.40237597568, 60504.39495604987, 60903.39096608977, 62503.0, 8456.534890581077, 8660.438314849745, 8729.345299102466, 8742.781430464289, 9008.504532250789, 9432.528373581155, 13987.860121399062, 14386.712265754417, 14622.70754584881, 14801.259937002891, 12538.749225015632, 12641.747165056464, 12648.494060237488, 12853.421596028014, 12862.807057893951, 12107.576234831738, 12293.139480236297, 12531.812022819848, 12578.748425031632, 12706.491740330282, 12473.126881118598, 12563.0, 12601.684957876127, 12849.614511564669, 12903.161294515827, 7553.433492488195, 8635.6977505787, 8836.867446988172, 8853.778655533406, 9178.632854685738, 11850.822237666614, 12551.623451296477, 12575.685607859878, 12732.618021459371, 12771.872281277068], "value": 9739.658310400806, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.9134906231088, 1484.0650390254139, 1504.2779465856388, 1667.341400146942, 1799.6580649676569, 8466.280366168876, 8897.377183597151, 8916.554172291391, 9137.314701397388, 9157.038510956354, 8841.5579221039, 9053.637854485813, 9055.954720226406, 9058.864117038249, 9061.909380906189, 1973.5756812285356, 2016.0, 2034.3083351660432, 2274.2949685597437, 2297.425643589103, 2295.3687735872686, 2367.1241640593003, 2378.1795280628157, 2395.317334559651, 2395.73646898841, 2298.092253559851, 2308.503671710582, 2321.1527792355837, 2321.3036089173265, 2349.635806450003, 1889.2915156816193, 2158.4495953531828, 2165.2421652421685, 2166.620841352773, 2228.832837537191, 2312.09828167015, 2342.5900467418305, 2352.176738141654, 2353.9176128835406, 2356.7996720278798, 8873.51195684237, 8882.245009174228, 8892.3330750194, 8894.777630559223, 8908.198262156373, 5059.241113832918, 5171.3535808024, 5182.611304152204, 5186.0, 5190.325257716473, 3299.307145499424, 3345.330933813247, 3441.1569165554347, 3445.4487282035007, 3450.189205536697, 1105.3202280597454, 1138.5559631743627, 1138.9487473063732, 1168.4625072466677, 1170.5844425229006, 12263.26420414778, 12276.754464910651, 12277.324747138815, 12370.072244581692, 12391.256524608461, 4395.604395604411, 4552.248878934939, 4602.930956035595, 4618.284165954283, 4657.441107067174, 10395.220358472994, 10441.269111162146, 10471.21465890046, 10472.162227021972, 10490.31812932157, 5246.449122842047, 5258.658187217895, 5259.526642602184, 5260.473952604709, 5262.079136151235, 4245.808938597709, 4662.7668616569035, 4795.640326975491, 4795.880102997453, 4826.638002149853, 3938.2911076006594, 4031.314676505001, 4032.919341613151, 4071.3078776607454, 4084.509858816961, 1229.6188181663713, 1235.9814602780966, 1239.7086684629105, 1241.5592464675092, 1255.9434825432877, 639.6705696566272, 896.3725392225468, 944.9244060475146, 953.4041224234853, 974.2741657465092, 5966.463018328372, 6368.681565921685, 6440.194975628046, 6505.121808555785, 6632.535722499379, 967.4098799732158, 974.3179774158118, 975.9072888075622, 989.248171389749, 1004.4525733475274, 3990.4014397840556, 4064.7561146331313, 4070.3283958147167, 4095.385692146202, 4122.773247471418, 10712.78574428507, 11051.889481105247, 11175.552977880794, 11189.664310070712, 11199.0, 10965.232433729563, 10969.177311701655, 11006.394648294261, 11036.558537658404, 11042.171837112248, 7861.567613781182, 8261.8347633047, 8412.747617571482, 8416.579171041423, 8417.242448179572, 6032.8793424132145, 6163.137160797402, 6267.1539342188225, 6334.588251763621, 6449.677516124269, 10358.119559837498, 10385.117265032557, 10497.0, 10506.106980906708, 10530.420826854597, 9800.705978820646, 10227.232957528364, 10244.231682623684, 10387.324823886423, 10431.165506759593, 7292.453066019963, 7636.0, 7912.881306780518, 8072.394570407126, 8242.0, 8481.10948350439, 8520.786980325542, 8541.017782954792, 8542.615582298688, 8549.957250213709, 7704.544434526341, 7772.339351155215, 7799.45403821727, 7819.178986206366, 8028.31759300466, 7737.535747855147, 7791.727289544839, 7839.764807055797, 7861.567613781297, 7983.361331093382, 6894.24163342042, 6942.201646810681, 6949.7567585134275, 6962.791116266318, 6969.2682268361095, 4940.901181976268, 5144.279800827812, 5199.74001299941, 5248.1340578804065, 5352.367527903871, 5355.785768569213, 5380.300916995559, 5381.1121165007335, 5463.098588732973, 5525.861853453695], "value": 4657.050557584186, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.13823083672315, 293.9867705953232, 300.2089494182828, 308.5849532378951, 309.8806959320664, 5151.716655583941, 5229.660072095311, 5265.3155089838365, 5319.547838433733, 5321.840344789653, 5150.562202212816, 5168.819091331804, 5197.974010129944, 5212.609054320932, 5255.527002569768, 4159.604837540436, 4161.731856138396, 4166.895827604319, 4180.850266176811, 4181.60274773896, 3963.128111815396, 4016.5581786003518, 4178.080822219122, 4186.685998550106, 4223.725457845246, 4133.256013917494, 4148.651688201347, 4163.125743593849, 4167.416561681367, 4168.7707176105305, 4125.1131006833375, 4132.442120313749, 4139.254934111874, 4171.6036976487485, 4183.1215444756635, 3514.5606799150105, 3693.2059607184583, 3693.778373297611, 3706.2958037972967, 3709.7943168470356, 5105.566026887719, 5110.386753589556, 5118.513741194581, 5127.077126117298, 5200.219967004941, 4724.7401392923375, 4751.928721069186, 4765.21373973294, 4766.118268120409, 4785.8564243072415, 5320.882614650928, 5488.835334939959, 5492.203630473599, 5507.366652834935, 5574.0, 3965.504311961005, 3971.344728119857, 3975.940360894589, 3984.8406063757416, 3988.8432354617125, 5688.914666280009, 5731.742071606787, 5767.423257674241, 5777.0, 5806.21616081832, 4048.1296521248073, 4145.937810932838, 4147.486167548884, 4155.376693495939, 4180.749155050707, 4202.34863596137, 4208.347706105558, 4222.852200172979, 4225.68307376948, 4231.851885184004, 4772.689775164673, 4779.761011949388, 4787.736674482937, 4788.018456216468, 4792.113459010025, 5286.577073834084, 5511.614187006871, 5529.4470552944385, 5530.253415788898, 5628.6622802631155, 1361.5234667866366, 1402.2427888939858, 1431.6277767780452, 1454.534548944349, 1456.3155317000992, 982.4841957972122, 1008.3395376028712, 1016.506994107857, 1016.9084782369622, 1019.2712210769336, 5217.2695822584865, 5268.736563171826, 5271.182966640177, 5305.681659100389, 5308.548773354231, 5536.141898005815, 5540.667559946416, 5557.3331200256225, 5598.4961353477565, 5606.971965140148, 5154.53609175176, 5208.192730126761, 5265.631405801634, 5323.068463018956, 5348.331458567679, 2634.8670071868896, 2660.7627453233954, 2686.804372054417, 2706.3356036037694, 2714.782817374605, 5177.585793136615, 5204.9219261711105, 5232.843014709565, 5240.816571419982, 5298.682079075268, 4745.288206768943, 4959.231319145538, 5067.479756073163, 5086.338775959101, 5108.770105345268, 4964.329815474937, 4971.925421118686, 5092.8472145835685, 5110.882361759323, 5149.48505149482, 5004.749762511933, 5005.924911126263, 5019.52314530119, 5039.395272567315, 5071.290019397361, 4903.779329930233, 5270.8155214567305, 5663.66018038919, 5672.602917795714, 5686.203931449518, 5818.7090645466715, 5865.560082993878, 5867.413258674099, 5895.145203945318, 5899.734511946886, 4028.9798551007057, 4064.9593504064583, 4066.1461093170765, 4079.714419990572, 4080.735191968486, 5407.864803379947, 5418.376886658085, 5589.021921163861, 5691.658500489983, 5704.80033198836, 5412.8105516308315, 5419.458054194707, 5419.864503387447, 5446.809361672323, 5452.100403433389, 5524.309461317335, 5546.7781288748, 5554.6944918028275, 5557.749901254372, 5570.275864137636, 5304.204369344629, 5463.207834864002, 5471.72641367938, 5502.257195278587, 5507.889842203213, 5326.280952071421, 5428.592855535771, 5520.1443776214755, 5572.631631556654, 5597.692126933058, 5444.210589464585, 5446.373667028342, 5464.726763661722, 5467.5625949923115, 5468.125099983983], "value": 4148.770280354059, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.4707360574737, 671.1476424940323, 676.6143298319956, 681.9215790184127, 747.3274053351983, 13953.372098255577, 15719.292631831566, 15752.448664296751, 15754.842451575481, 15771.290291936863, 14800.11199328041, 14852.405903763864, 14890.329935152917, 14911.552653420415, 14935.17856517891, 683.4600665474269, 796.3828033274201, 813.1461964936822, 814.9022117345912, 826.904905935816, 831.8960129983752, 834.9540775257359, 836.1471299274737, 838.4801423117675, 839.5508403004363, 707.5365635508724, 883.1786438612088, 884.8584226523758, 885.0883589902379, 885.2431171348501, 844.4089137603671, 873.1704880363679, 873.2446433834688, 878.9077146899548, 880.2913654508119, 638.5306799502362, 639.1531221132019, 639.3606393606393, 639.4309064932214, 639.5011890725242, 15006.924965375212, 15033.699326013419, 15116.319765610573, 15129.167895765728, 15141.621459463602, 14960.102393856294, 15072.397104115822, 15091.849081509265, 15119.412461691583, 15165.938384313102, 12389.318587477685, 12400.441980110916, 12435.253884766942, 12521.436535355931, 12627.500711457667, 4625.629949604024, 4651.162790697673, 4669.276262179367, 4800.35195248644, 4817.060673168733, 68818.0, 72490.63754681246, 79497.0, 80229.59885200537, 80578.0, 12630.305333206577, 12761.872381276069, 12770.23378597287, 12818.80771788424, 12873.163244389085, 21476.570468590853, 21510.46223844385, 21513.89243053806, 21522.0, 21566.676499852514, 8630.84973984491, 8655.870161947576, 8882.333824963154, 8920.687775927812, 9085.636574536944, 4645.976770116195, 4698.859034228979, 4734.0, 4747.192977193886, 4917.311576379309, 3505.2814173094453, 3607.404778211566, 3608.0979755061235, 3608.260306637133, 3611.223586928823, 626.5175814622716, 636.9490440764728, 641.682367228225, 644.3073695776965, 644.6518879804946, 602.4036204157852, 615.0896672924098, 633.3223450907485, 663.9966800165968, 673.3703986772383, 9060.184583387527, 9335.206507446943, 9526.142647161789, 9529.809403811885, 9613.327067105236, 595.4105435618793, 610.6214147228746, 644.1786721929484, 648.4391001783517, 674.7435974329724, 4206.705530612889, 4368.803403846835, 4419.337099435046, 4446.3108218226225, 4503.369528266046, 65598.0, 65751.67124164444, 65970.34029659738, 66270.0, 97913.5104324488, 90282.0, 94091.0, 94197.0, 94377.69678061234, 94594.0, 82171.5891420551, 83653.58173209096, 84148.57925710455, 84191.5790421044, 85636.0, 8365.330773538224, 8479.321654267767, 8508.532030738368, 8599.91400086016, 8681.435706679045, 49619.7519012417, 50248.74875625598, 51093.48906510887, 51207.23189152091, 52667.473325266255, 69147.0, 73742.63128684323, 74866.0, 75101.24898750943, 76780.0, 12627.494900204256, 12632.810507842207, 12871.420786064837, 12938.223706577635, 13248.271345076113, 13401.731965360834, 13527.0, 13608.591742247749, 13835.377408016462, 14411.639709006939, 12545.686357841127, 12549.184303020274, 12830.743385132431, 13221.140625859289, 13336.533221337206, 12238.571649992207, 12383.133180677267, 12514.374281285716, 12660.366981650697, 12867.163634363736, 11517.942410287895, 11784.234024788362, 11927.165098443025, 12080.39598020078, 12220.0, 9536.189423899046, 9741.366811157252, 9792.118709316195, 9819.950900245452, 9936.354136981074, 9033.50315732641, 9333.813323733622, 9390.577424015799, 9909.702708918743, 9992.850107248543], "value": 7314.040957674649, "unit": "score"}], "name": "dromaeo_css", "value": 7345.1815361554045, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 111.0, 112.0, 110.0, 111.0, 110.0, 112.0, 112.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 120.0, 180.0, 119.0, 118.0, 141.0, 116.0, 147.0, 119.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 160.0, 161.0, 161.0, 161.0, 162.0, 162.0, 163.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 124.0, 75.0, 75.0, 76.0, 73.0, 101.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 108.0, 85.0, 85.0, 84.0, 123.0, 85.0, 84.0, 120.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 54.0, 53.0, 51.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 61.0, 62.0, 63.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 84.0, 86.0, 75.0, 75.0, 75.0, 77.0, 76.0, 81.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 118.0, 118.0, 118.0, 118.0, 125.0, 119.0, 120.0, 207.0, 133.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 159.0, 159.0, 158.0, 161.0, 158.0, 160.0, 161.0, 156.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 63.0, 62.0, 64.0, 62.0, 61.0, 64.0, 63.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1484.3999999999996, "alertThreshold": 2.0}]} 10:36:10 INFO - Return code: 0 10:36:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:36:10 INFO - # TBPL SUCCESS # 10:36:10 INFO - Running post-action listener: _resource_record_post_action 10:36:10 INFO - ##### 10:36:10 INFO - ##### Finished run-tests step (success) 10:36:10 INFO - ##### 10:36:10 INFO - Running post-run listener: _resource_record_post_run 10:36:10 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 559398912; Read time: 0; Write time: 408272 10:36:10 INFO - TinderboxPrint: CPU usage
13.0% 10:36:10 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:36:10 INFO - TinderboxPrint: I/O write bytes / time
559,398,912 / 408,272 10:36:10 INFO - TinderboxPrint: CPU idle
8,286.5 (86.9%) 10:36:10 INFO - TinderboxPrint: CPU user
1,199.3 (12.6%) 10:36:10 INFO - TinderboxPrint: Swap in / out
0 / 0 10:36:10 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 264949760; Read time: 0; Write time: 206208 10:36:10 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 294449152; Read time: 0; Write time: 202064 10:36:10 INFO - Running post-run listener: _upload_blobber_files 10:36:10 INFO - Blob upload gear active. 10:36:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:36:10 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 10:36:10 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'] 10:36:10 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 10:36:11 INFO - (blobuploader) - INFO - Open directory for files ... 10:36:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:36:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:36:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:11 INFO - (blobuploader) - INFO - Done attempting. 10:36:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:36:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:36:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:12 INFO - (blobuploader) - INFO - Done attempting. 10:36:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:36:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:36:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:36:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:36:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:36:16 INFO - (blobuploader) - INFO - Done attempting. 10:36:16 INFO - (blobuploader) - INFO - Iteration through files over. 10:36:16 INFO - Return code: 0 10:36:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:36:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:36:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12839da62059cea74363ecc2aaf02532f2bdf8188658a3495626ff200b0449ee3ba4bbae45e19948a54249617ee2a0c8d057b3becfd792e581acad354420c7b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1b0c37a6826755321b50b9b836278616ce1c11c934ab713016c66a02f5f5dfab7a1ed413bacdb47dca0731533cec6c29481976b47af4190b0945d10a39e9780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90a962e070fc9d675cbdd13852cb18556d25346d4b8968b6e1a2a37f8c63b89d0dee776ec920d5391e31820b0c353910b389c5507f52761d343947e9c5cc6225"} 10:36:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:36:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:36:16 INFO - Contents: 10:36:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/12839da62059cea74363ecc2aaf02532f2bdf8188658a3495626ff200b0449ee3ba4bbae45e19948a54249617ee2a0c8d057b3becfd792e581acad354420c7b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1b0c37a6826755321b50b9b836278616ce1c11c934ab713016c66a02f5f5dfab7a1ed413bacdb47dca0731533cec6c29481976b47af4190b0945d10a39e9780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90a962e070fc9d675cbdd13852cb18556d25346d4b8968b6e1a2a37f8c63b89d0dee776ec920d5391e31820b0c353910b389c5507f52761d343947e9c5cc6225"} 10:36:16 INFO - Running post-run listener: copy_logs_to_upload_dir 10:36:16 INFO - Copying logs to upload dir... 10:36:16 INFO - mkdir: /builds/slave/test/build/upload/logs 10:36:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.221531 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-13 10:36:16.067269) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 10:36:16.071021) ========= 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-1468430142.546538-984550515 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/12839da62059cea74363ecc2aaf02532f2bdf8188658a3495626ff200b0449ee3ba4bbae45e19948a54249617ee2a0c8d057b3becfd792e581acad354420c7b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1b0c37a6826755321b50b9b836278616ce1c11c934ab713016c66a02f5f5dfab7a1ed413bacdb47dca0731533cec6c29481976b47af4190b0945d10a39e9780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90a962e070fc9d675cbdd13852cb18556d25346d4b8968b6e1a2a37f8c63b89d0dee776ec920d5391e31820b0c353910b389c5507f52761d343947e9c5cc6225"} build_url:https://queue.taskcluster.net/v1/task/J8gRRH7GTOab8GmjclrLcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/J8gRRH7GTOab8GmjclrLcw/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/12839da62059cea74363ecc2aaf02532f2bdf8188658a3495626ff200b0449ee3ba4bbae45e19948a54249617ee2a0c8d057b3becfd792e581acad354420c7b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1b0c37a6826755321b50b9b836278616ce1c11c934ab713016c66a02f5f5dfab7a1ed413bacdb47dca0731533cec6c29481976b47af4190b0945d10a39e9780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90a962e070fc9d675cbdd13852cb18556d25346d4b8968b6e1a2a37f8c63b89d0dee776ec920d5391e31820b0c353910b389c5507f52761d343947e9c5cc6225"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 10:36:16.096516) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:36:16.096858) ========= 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-1468430142.546538-984550515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:36:16.179473) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 10:36:16.179860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 10:36:16.180302) ========= ========= Total master_lag: 0.17 =========