builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1467920799.38 results: success (0) buildid: 20160707112723 builduid: 7c832758263d46b49cbba756a95a61ae revision: 94cce4e79310565ff5b169f890842499ea713f8a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 12:46:39.377370) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 12:46:39.378226) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 12:46:39.378798) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 12:46:39.395343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 12:46:39.395968) ========= 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=7de08804244eb36560b44971000001c3-1467920798.662274-898473575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 12:46:39-- 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% 70.2M=0s 2016-07-07 12:46:39 (70.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079456 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 12:46:39.494378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 12:46:39.494958) ========= 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=7de08804244eb36560b44971000001c3-1467920798.662274-898473575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015485 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 12:46:39.548992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 12:46:39.549813) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 94cce4e79310565ff5b169f890842499ea713f8a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 94cce4e79310565ff5b169f890842499ea713f8a --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=7de08804244eb36560b44971000001c3-1467920798.662274-898473575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 12:46:39,636 truncating revision to first 12 chars 2016-07-07 12:46:39,636 Setting DEBUG logging. 2016-07-07 12:46:39,636 attempt 1/10 2016-07-07 12:46:39,636 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/94cce4e79310?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 12:46:40,727 unpacking tar archive at: mozilla-central-94cce4e79310/testing/mozharness/ program finished with exit code 0 elapsedTime=1.406404 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 12:46:41.042784) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 12:46:41.043183) ========= script_repo_revision: 94cce4e79310565ff5b169f890842499ea713f8a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 12:46:41.043634) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 12:46:41.043981) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 12:46:41.054892) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-07 12:46:41.055214) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=7de08804244eb36560b44971000001c3-1467920798.662274-898473575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:46:41 INFO - MultiFileLogger online at 20160707 12:46:41 in /builds/slave/test 12:46:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 12:46:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:46:41 INFO - {'append_to_log': False, 12:46:41 INFO - 'base_work_dir': '/builds/slave/test', 12:46:41 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:46:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:46:41 INFO - 'branch': 'Firefox-Non-PGO', 12:46:41 INFO - 'buildbot_json_path': 'buildprops.json', 12:46:41 INFO - 'config_files': ('talos/linux_config.py',), 12:46:41 INFO - 'default_actions': ('clobber', 12:46:41 INFO - 'read-buildbot-config', 12:46:41 INFO - 'download-and-extract', 12:46:41 INFO - 'populate-webroot', 12:46:41 INFO - 'create-virtualenv', 12:46:41 INFO - 'install', 12:46:41 INFO - 'run-tests'), 12:46:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:46:41 INFO - 'download_minidump_stackwalk': True, 12:46:41 INFO - 'download_symbols': 'ondemand', 12:46:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:46:41 INFO - 'tooltool.py': '/tools/tooltool.py', 12:46:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:46:41 INFO - '/tools/misc-python/virtualenv.py')}, 12:46:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:46:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:46:41 INFO - 'installer_path': 'installer.exe', 12:46:41 INFO - 'log_level': 'info', 12:46:41 INFO - 'log_name': 'talos', 12:46:41 INFO - 'log_to_console': True, 12:46:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:46:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:46:41 INFO - 'opt_config_files': (), 12:46:41 INFO - 'pip_index': False, 12:46:41 INFO - 'sps_profile': False, 12:46:41 INFO - 'sps_profile_interval': 0, 12:46:41 INFO - 'suite': 'dromaeojs', 12:46:41 INFO - 'system_bits': '32', 12:46:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:46:41 INFO - 'title': 'talos-linux64-ix-003', 12:46:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:46:41 INFO - 'use_talos_json': True, 12:46:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:46:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:46:41 INFO - 'work_dir': 'build'} 12:46:41 INFO - ##### 12:46:41 INFO - ##### Running clobber step. 12:46:41 INFO - ##### 12:46:41 INFO - Running pre-action listener: _resource_record_pre_action 12:46:41 INFO - Running main action method: clobber 12:46:41 INFO - rmtree: /builds/slave/test/build 12:46:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:46:42 INFO - Running post-action listener: _resource_record_post_action 12:46:42 INFO - ##### 12:46:42 INFO - ##### Finished clobber step (success) 12:46:42 INFO - ##### 12:46:42 INFO - ##### 12:46:42 INFO - ##### Running read-buildbot-config step. 12:46:42 INFO - ##### 12:46:42 INFO - Running pre-action listener: _resource_record_pre_action 12:46:42 INFO - Running main action method: read_buildbot_config 12:46:42 INFO - Using buildbot properties: 12:46:42 INFO - { 12:46:42 INFO - "project": "", 12:46:42 INFO - "product": "firefox", 12:46:42 INFO - "script_repo_revision": "production", 12:46:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:46:42 INFO - "repository": "", 12:46:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 12:46:42 INFO - "buildid": "20160707112723", 12:46:42 INFO - "pgo_build": "False", 12:46:42 INFO - "basedir": "/builds/slave/test", 12:46:42 INFO - "buildnumber": 641, 12:46:42 INFO - "slavename": "talos-linux64-ix-003", 12:46:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:46:42 INFO - "platform": "ubuntu64_hw", 12:46:42 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 12:46:42 INFO - "branch": "mozilla-central", 12:46:42 INFO - "repo_path": "mozilla-central", 12:46:42 INFO - "revision": "94cce4e79310565ff5b169f890842499ea713f8a", 12:46:42 INFO - "stage_platform": "linux64", 12:46:42 INFO - "builduid": "7c832758263d46b49cbba756a95a61ae", 12:46:42 INFO - "slavebuilddir": "test" 12:46:42 INFO - } 12:46:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:46:42 INFO - Running post-action listener: _resource_record_post_action 12:46:42 INFO - ##### 12:46:42 INFO - ##### Finished read-buildbot-config step (success) 12:46:42 INFO - ##### 12:46:42 INFO - ##### 12:46:42 INFO - ##### Running download-and-extract step. 12:46:42 INFO - ##### 12:46:42 INFO - Running pre-action listener: _resource_record_pre_action 12:46:42 INFO - Running main action method: download_and_extract 12:46:42 INFO - mkdir: /builds/slave/test/build/tests 12:46:42 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')]} 12:46:42 INFO - https://queue.taskcluster.net/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:46:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:46:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:46:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/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 12:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/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 12:46:42 INFO - Downloaded 1361 bytes. 12:46:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:46:42 INFO - Using the following test package requirements: 12:46:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:46:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:46:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:46:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:46:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:46:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:46:42 INFO - u'jsshell-linux-x86_64.zip'], 12:46:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:46:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:46:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:46:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:46:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:46:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:46:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:46:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:46:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:46:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:46:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:46:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:46:42 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')]} 12:46:42 INFO - https://queue.taskcluster.net/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:46:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:46:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:46:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/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 12:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/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 12:46:44 INFO - Downloaded 22734691 bytes. 12:46:44 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'] 12:46:44 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 12:46:45 INFO - Return code: 0 12:46:45 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 12:46: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')]} 12:46:45 INFO - https://queue.taskcluster.net/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:46:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:46:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:46:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/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 12:46:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/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 12:46:46 INFO - Downloaded 22734691 bytes. 12:46: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'] 12:46: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 12:46:47 INFO - Return code: 0 12:46: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')]} 12:46:47 INFO - https://queue.taskcluster.net/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:46:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:46:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:46:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/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 12:46:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/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 12:46:57 INFO - Downloaded 14403333 bytes. 12:46:57 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'] 12:46:57 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 12:46:57 INFO - Return code: 0 12:46: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')]} 12:46:57 INFO - https://queue.taskcluster.net/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:46:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:46:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:46:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/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 12:46:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHryqjOxRjutCCJXVZtgwg/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 12:47:00 INFO - Downloaded 56640539 bytes. 12:47:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:47:00 INFO - mkdir: /builds/slave/test/properties 12:47:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:47:00 INFO - Writing to file /builds/slave/test/properties/build_url 12:47:00 INFO - Contents: 12:47:00 INFO - build_url:https://queue.taskcluster.net/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:47:01 INFO - Running post-action listener: _resource_record_post_action 12:47:01 INFO - Running post-action listener: set_extra_try_arguments 12:47:01 INFO - ##### 12:47:01 INFO - ##### Finished download-and-extract step (success) 12:47:01 INFO - ##### 12:47:01 INFO - ##### 12:47:01 INFO - ##### Running populate-webroot step. 12:47:01 INFO - ##### 12:47:01 INFO - Running pre-action listener: _resource_record_pre_action 12:47:01 INFO - Running main action method: populate_webroot 12:47:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:47:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:47:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:47:01 INFO - '--tppagecycles', 12:47:01 INFO - '7'], 12:47:01 INFO - 'tests': ['tsvgm']}}, 12:47:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:47:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:47:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:47:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:47:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:47:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:47:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:01 INFO - 'talos_options': ['--disable-e10s'], 12:47:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:47:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:47:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:01 INFO - 'talos_options': ['--disable-e10s'], 12:47:01 INFO - 'tests': ['damp', 'tps']}, 12:47:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:01 INFO - 'tests': ['damp', 'tps']}, 12:47:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:47:01 INFO - 'tests': ['dromaeo_dom']}, 12:47:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:47:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:47:01 INFO - 'tests': ['basic_compositor_video']}, 12:47:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:47:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:47:01 INFO - 'tests': ['a11yr', 12:47:01 INFO - 'ts_paint', 12:47:01 INFO - 'tpaint', 12:47:01 INFO - 'sessionrestore', 12:47:01 INFO - 'sessionrestore_no_auto_restore', 12:47:01 INFO - 'tabpaint']}, 12:47:01 INFO - 'other-e10s': {'tests': ['a11yr', 12:47:01 INFO - 'ts_paint', 12:47:01 INFO - 'tpaint', 12:47:01 INFO - 'sessionrestore', 12:47:01 INFO - 'sessionrestore_no_auto_restore', 12:47:01 INFO - 'tabpaint']}, 12:47:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:47:01 INFO - 'ts_paint', 12:47:01 INFO - 'tpaint', 12:47:01 INFO - 'sessionrestore', 12:47:01 INFO - 'sessionrestore_no_auto_restore', 12:47:01 INFO - 'tabpaint']}, 12:47:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:47:01 INFO - 'ts_paint', 12:47:01 INFO - 'tpaint', 12:47:01 INFO - 'sessionrestore', 12:47:01 INFO - 'sessionrestore_no_auto_restore', 12:47:01 INFO - 'tabpaint']}, 12:47:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:47:01 INFO - 'tests': ['a11yr', 12:47:01 INFO - 'ts_paint', 12:47:01 INFO - 'tpaint', 12:47:01 INFO - 'sessionrestore', 12:47:01 INFO - 'sessionrestore_no_auto_restore', 12:47:01 INFO - 'tabpaint']}, 12:47:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:47:01 INFO - 'tests': ['a11yr', 12:47:01 INFO - 'ts_paint', 12:47:01 INFO - 'tpaint', 12:47:01 INFO - 'sessionrestore', 12:47:01 INFO - 'sessionrestore_no_auto_restore', 12:47:01 INFO - 'tabpaint']}, 12:47:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:47:01 INFO - 'tests': ['tsvgx', 12:47:01 INFO - 'tsvgr_opacity', 12:47:01 INFO - 'tart', 12:47:01 INFO - 'tscrollx', 12:47:01 INFO - 'cart']}, 12:47:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:47:01 INFO - 'tsvgr_opacity', 12:47:01 INFO - 'tart', 12:47:01 INFO - 'tscrollx', 12:47:01 INFO - 'cart']}, 12:47:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:01 INFO - 'talos_options': ['--disable-e10s'], 12:47:01 INFO - 'tests': ['tp5o']}, 12:47:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:01 INFO - 'tests': ['tp5o']}, 12:47:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:01 INFO - 'talos_options': ['--disable-e10s', 12:47:01 INFO - '--xperf_path', 12:47:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:47:01 INFO - 'tests': ['tp5n']}, 12:47:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:47:01 INFO - 'talos_options': ['--xperf_path', 12:47:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:47:01 INFO - 'tests': ['tp5n']}}, 12:47:01 INFO - 'talos.zip': {'path': '', 12:47:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:47:01 INFO - Running post-action listener: _resource_record_post_action 12:47:01 INFO - ##### 12:47:01 INFO - ##### Finished populate-webroot step (success) 12:47:01 INFO - ##### 12:47:01 INFO - ##### 12:47:01 INFO - ##### Running create-virtualenv step. 12:47:01 INFO - ##### 12:47:01 INFO - Running pre-action listener: _resource_record_pre_action 12:47:01 INFO - Running main action method: create_virtualenv 12:47:01 INFO - Creating virtualenv /builds/slave/test/build/venv 12:47:01 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 12:47:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:47:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:47:01 INFO - Using real prefix '/usr' 12:47:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:47:01 INFO - Installing distribute.............................................................................................................................................................................................done. 12:47:03 INFO - Installing pip.................done. 12:47:03 INFO - Return code: 0 12:47:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9b3b0>, '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 0xe9c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c740>, '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': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', '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 12:47:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:47:03 INFO - Using env: {'DISPLAY': ':0', 12:47:03 INFO - 'HOME': '/home/cltbld', 12:47:03 INFO - 'LANG': 'en_US.UTF-8', 12:47:03 INFO - 'LANGUAGE': 'en_US:en', 12:47:03 INFO - 'LOGNAME': 'cltbld', 12:47:03 INFO - 'MAIL': '/var/mail/cltbld', 12:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:03 INFO - 'MOZ_NO_REMOTE': '1', 12:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:03 INFO - 'NO_EM_RESTART': '1', 12:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:03 INFO - 'PWD': '/builds/slave/test', 12:47:03 INFO - 'SHELL': '/bin/bash', 12:47:03 INFO - 'SHLVL': '1', 12:47:03 INFO - 'TERM': 'linux', 12:47:03 INFO - 'TMOUT': '86400', 12:47:03 INFO - 'USER': 'cltbld', 12:47:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', 12:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:03 INFO - '_': '/tools/buildbot/bin/python'} 12:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:04 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 12:47:04 INFO - Cleaning up... 12:47:04 INFO - Return code: 0 12:47:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:47: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')]} 12:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47: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')]} 12:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47: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', '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 0xbdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9b3b0>, '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 0xe9c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c740>, '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': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', '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 12:47: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:47: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 psutil>=3.1.1 12:47:04 INFO - Using env: {'DISPLAY': ':0', 12:47:04 INFO - 'HOME': '/home/cltbld', 12:47:04 INFO - 'LANG': 'en_US.UTF-8', 12:47:04 INFO - 'LANGUAGE': 'en_US:en', 12:47:04 INFO - 'LOGNAME': 'cltbld', 12:47:04 INFO - 'MAIL': '/var/mail/cltbld', 12:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:04 INFO - 'MOZ_NO_REMOTE': '1', 12:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:04 INFO - 'NO_EM_RESTART': '1', 12:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:04 INFO - 'PWD': '/builds/slave/test', 12:47:04 INFO - 'SHELL': '/bin/bash', 12:47:04 INFO - 'SHLVL': '1', 12:47:04 INFO - 'TERM': 'linux', 12:47:04 INFO - 'TMOUT': '86400', 12:47:04 INFO - 'USER': 'cltbld', 12:47:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', 12:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:04 INFO - '_': '/tools/buildbot/bin/python'} 12:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:04 INFO - Downloading/unpacking psutil>=3.1.1 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:47:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:06 INFO - Installing collected packages: psutil 12:47:06 INFO - Running setup.py install for psutil 12:47:06 INFO - building 'psutil._psutil_linux' extension 12:47:06 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 12:47:06 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 12:47:06 INFO - building 'psutil._psutil_posix' extension 12:47:06 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 12:47:06 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 12:47:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:47:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:47:06 INFO - Successfully installed psutil 12:47:06 INFO - Cleaning up... 12:47:06 INFO - Return code: 0 12:47:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:06 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 0xbdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9b3b0>, '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 0xe9c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c740>, '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': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', '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 12:47:06 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 12:47:06 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 12:47:06 INFO - Using env: {'DISPLAY': ':0', 12:47:06 INFO - 'HOME': '/home/cltbld', 12:47:06 INFO - 'LANG': 'en_US.UTF-8', 12:47:06 INFO - 'LANGUAGE': 'en_US:en', 12:47:06 INFO - 'LOGNAME': 'cltbld', 12:47:06 INFO - 'MAIL': '/var/mail/cltbld', 12:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:06 INFO - 'MOZ_NO_REMOTE': '1', 12:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:06 INFO - 'NO_EM_RESTART': '1', 12:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:06 INFO - 'PWD': '/builds/slave/test', 12:47:06 INFO - 'SHELL': '/bin/bash', 12:47:06 INFO - 'SHLVL': '1', 12:47:06 INFO - 'TERM': 'linux', 12:47:06 INFO - 'TMOUT': '86400', 12:47:06 INFO - 'USER': 'cltbld', 12:47:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', 12:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:06 INFO - '_': '/tools/buildbot/bin/python'} 12:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47: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 12:47:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:47:09 INFO - Installing collected packages: mozsystemmonitor 12:47:09 INFO - Running setup.py install for mozsystemmonitor 12:47:09 INFO - Successfully installed mozsystemmonitor 12:47:09 INFO - Cleaning up... 12:47:09 INFO - Return code: 0 12:47:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:09 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 0xbdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9b3b0>, '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 0xe9c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c740>, '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': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', '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 12:47:09 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 12:47:09 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 12:47:09 INFO - Using env: {'DISPLAY': ':0', 12:47:09 INFO - 'HOME': '/home/cltbld', 12:47:09 INFO - 'LANG': 'en_US.UTF-8', 12:47:09 INFO - 'LANGUAGE': 'en_US:en', 12:47:09 INFO - 'LOGNAME': 'cltbld', 12:47:09 INFO - 'MAIL': '/var/mail/cltbld', 12:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:09 INFO - 'MOZ_NO_REMOTE': '1', 12:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:09 INFO - 'NO_EM_RESTART': '1', 12:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:09 INFO - 'PWD': '/builds/slave/test', 12:47:09 INFO - 'SHELL': '/bin/bash', 12:47:09 INFO - 'SHLVL': '1', 12:47:09 INFO - 'TERM': 'linux', 12:47:09 INFO - 'TMOUT': '86400', 12:47:09 INFO - 'USER': 'cltbld', 12:47:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', 12:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:09 INFO - '_': '/tools/buildbot/bin/python'} 12:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:09 INFO - Downloading/unpacking jsonschema==2.5.1 12:47:09 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 12:47:09 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 12:47:09 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 12:47:09 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 12:47:09 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 12:47:09 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 12:47:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:47:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:47:11 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 12:47:11 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 12:47:11 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 12:47:11 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 12:47:11 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 12:47:11 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 12:47:11 INFO - Downloading functools32-3.2.3-2.tar.gz 12:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:47:11 INFO - warning: no files found matching '*.txt' 12:47:11 INFO - no previously-included directories found matching 'build' 12:47:11 INFO - no previously-included directories found matching 'dist' 12:47:11 INFO - no previously-included directories found matching '.git*' 12:47:11 INFO - Installing collected packages: jsonschema, functools32 12:47:11 INFO - Running setup.py install for functools32 12:47:11 INFO - warning: no files found matching '*.txt' 12:47:11 INFO - no previously-included directories found matching 'build' 12:47:11 INFO - no previously-included directories found matching 'dist' 12:47:11 INFO - no previously-included directories found matching '.git*' 12:47:11 INFO - Successfully installed jsonschema functools32 12:47:11 INFO - Cleaning up... 12:47:11 INFO - Return code: 0 12:47:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:47: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')]} 12:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47: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')]} 12:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:11 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 0xbdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9b3b0>, '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 0xe9c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c740>, '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': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', '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 12:47:11 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 12:47:11 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 12:47:11 INFO - Using env: {'DISPLAY': ':0', 12:47:11 INFO - 'HOME': '/home/cltbld', 12:47:11 INFO - 'LANG': 'en_US.UTF-8', 12:47:11 INFO - 'LANGUAGE': 'en_US:en', 12:47:11 INFO - 'LOGNAME': 'cltbld', 12:47:11 INFO - 'MAIL': '/var/mail/cltbld', 12:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:11 INFO - 'MOZ_NO_REMOTE': '1', 12:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:11 INFO - 'NO_EM_RESTART': '1', 12:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:11 INFO - 'PWD': '/builds/slave/test', 12:47:11 INFO - 'SHELL': '/bin/bash', 12:47:11 INFO - 'SHLVL': '1', 12:47:11 INFO - 'TERM': 'linux', 12:47:11 INFO - 'TMOUT': '86400', 12:47:11 INFO - 'USER': 'cltbld', 12:47:11 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', 12:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:11 INFO - '_': '/tools/buildbot/bin/python'} 12:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:12 INFO - Downloading/unpacking blobuploader==1.2.4 12:47:12 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 12:47:12 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 12:47:12 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 12:47:12 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 12:47:12 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 12:47:12 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 12:47:14 INFO - Downloading blobuploader-1.2.4.tar.gz 12:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:47:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:47:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:14 INFO - Downloading docopt-0.6.1.tar.gz 12:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:47:14 INFO - Installing collected packages: blobuploader, requests, docopt 12:47:14 INFO - Running setup.py install for blobuploader 12:47:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:47:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:47:15 INFO - Running setup.py install for requests 12:47:15 INFO - Running setup.py install for docopt 12:47:15 INFO - Successfully installed blobuploader requests docopt 12:47:15 INFO - Cleaning up... 12:47:15 INFO - Return code: 0 12:47:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47: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')]} 12:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47: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')]} 12:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:15 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 0xbdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9b3b0>, '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 0xe9c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c740>, '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': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', '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 12:47:15 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 12:47:15 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 12:47:15 INFO - Using env: {'DISPLAY': ':0', 12:47:15 INFO - 'HOME': '/home/cltbld', 12:47:15 INFO - 'LANG': 'en_US.UTF-8', 12:47:15 INFO - 'LANGUAGE': 'en_US:en', 12:47:15 INFO - 'LOGNAME': 'cltbld', 12:47:15 INFO - 'MAIL': '/var/mail/cltbld', 12:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:15 INFO - 'MOZ_NO_REMOTE': '1', 12:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:15 INFO - 'NO_EM_RESTART': '1', 12:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:15 INFO - 'PWD': '/builds/slave/test', 12:47:15 INFO - 'SHELL': '/bin/bash', 12:47:15 INFO - 'SHLVL': '1', 12:47:15 INFO - 'TERM': 'linux', 12:47:15 INFO - 'TMOUT': '86400', 12:47:15 INFO - 'USER': 'cltbld', 12:47:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', 12:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:15 INFO - '_': '/tools/buildbot/bin/python'} 12:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:47:15 INFO - Running setup.py (path:/tmp/pip-0QPVOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:47:15 INFO - Running setup.py (path:/tmp/pip-Zs__3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:47:15 INFO - Running setup.py (path:/tmp/pip-uMCEYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:47:15 INFO - Running setup.py (path:/tmp/pip-aCCRf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:47:16 INFO - Running setup.py (path:/tmp/pip-Tr5LJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:47:16 INFO - Running setup.py (path:/tmp/pip-Sw87UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:47:16 INFO - Running setup.py (path:/tmp/pip-hKHeUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:47:16 INFO - Running setup.py (path:/tmp/pip-nr3oc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:47:16 INFO - Running setup.py (path:/tmp/pip-HSABIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:47:16 INFO - Running setup.py (path:/tmp/pip-9IcEjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:47:16 INFO - Running setup.py (path:/tmp/pip-WqC08H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:47:16 INFO - Running setup.py (path:/tmp/pip-G5RqA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:47:16 INFO - Running setup.py (path:/tmp/pip-MAUKNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:47:16 INFO - Running setup.py (path:/tmp/pip-6jcuJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:16 INFO - Running setup.py (path:/tmp/pip-_QEZnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:47:16 INFO - Running setup.py (path:/tmp/pip-RqoWVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:47:16 INFO - Running setup.py (path:/tmp/pip-wK6YEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:47:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:47:16 INFO - Running setup.py install for manifestparser 12:47:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:47:17 INFO - Running setup.py install for mozcrash 12:47:17 INFO - Running setup.py install for mozdebug 12:47:17 INFO - Running setup.py install for mozdevice 12:47:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:47:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:47:17 INFO - Running setup.py install for mozfile 12:47:17 INFO - Running setup.py install for mozhttpd 12:47:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:47:17 INFO - Running setup.py install for mozinfo 12:47:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:47:17 INFO - Running setup.py install for mozInstall 12:47:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:47:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:47:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:47:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:47:17 INFO - Running setup.py install for mozleak 12:47:17 INFO - Running setup.py install for mozlog 12:47:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:47:18 INFO - Running setup.py install for moznetwork 12:47:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:47:18 INFO - Running setup.py install for mozprocess 12:47:18 INFO - Running setup.py install for mozprofile 12:47:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:47:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:47:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:47:18 INFO - Running setup.py install for mozrunner 12:47:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:47:18 INFO - Running setup.py install for mozscreenshot 12:47:18 INFO - Running setup.py install for moztest 12:47:18 INFO - Running setup.py install for mozversion 12:47:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:47:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:47:18 INFO - Cleaning up... 12:47:18 INFO - Return code: 0 12:47:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:18 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 0xbdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9b3b0>, '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 0xe9c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c740>, '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': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', '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 12:47:18 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 12:47:18 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 12:47:18 INFO - Using env: {'DISPLAY': ':0', 12:47:18 INFO - 'HOME': '/home/cltbld', 12:47:18 INFO - 'LANG': 'en_US.UTF-8', 12:47:18 INFO - 'LANGUAGE': 'en_US:en', 12:47:18 INFO - 'LOGNAME': 'cltbld', 12:47:18 INFO - 'MAIL': '/var/mail/cltbld', 12:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:18 INFO - 'MOZ_NO_REMOTE': '1', 12:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:18 INFO - 'NO_EM_RESTART': '1', 12:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:18 INFO - 'PWD': '/builds/slave/test', 12:47:18 INFO - 'SHELL': '/bin/bash', 12:47:18 INFO - 'SHLVL': '1', 12:47:18 INFO - 'TERM': 'linux', 12:47:18 INFO - 'TMOUT': '86400', 12:47:18 INFO - 'USER': 'cltbld', 12:47:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', 12:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:18 INFO - '_': '/tools/buildbot/bin/python'} 12:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:47:18 INFO - Running setup.py (path:/tmp/pip-3ABc7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:47:19 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)) 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:47:19 INFO - Running setup.py (path:/tmp/pip-iL_PII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:47:19 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)) 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:47:19 INFO - Running setup.py (path:/tmp/pip-jRvjUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:47:19 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)) 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:47:19 INFO - Running setup.py (path:/tmp/pip-AULLYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:47:19 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)) 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:47:19 INFO - Running setup.py (path:/tmp/pip-DsMmd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:47:19 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)) 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:47:19 INFO - Running setup.py (path:/tmp/pip-6qUnTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:47:19 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)) 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:47:19 INFO - Running setup.py (path:/tmp/pip-kzCLI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:47:19 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)) 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:47:19 INFO - Running setup.py (path:/tmp/pip-2K76OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:47:19 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)) 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:47:19 INFO - Running setup.py (path:/tmp/pip-Q7hI3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:47:19 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)) 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:47:19 INFO - Running setup.py (path:/tmp/pip-wR3n7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:47:19 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)) 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:47:19 INFO - Running setup.py (path:/tmp/pip-FTG6jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:47:19 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)) 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:47:19 INFO - Running setup.py (path:/tmp/pip-9kwM81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:47:19 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)) 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:47:19 INFO - Running setup.py (path:/tmp/pip-d5pG2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:47:19 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)) 12:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:47:19 INFO - Running setup.py (path:/tmp/pip-ilrQiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:47:20 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)) 12:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:20 INFO - Running setup.py (path:/tmp/pip-GaDPKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:47:20 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)) 12:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:47:20 INFO - Running setup.py (path:/tmp/pip-KAG0Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:47:20 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)) 12:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:47:20 INFO - Running setup.py (path:/tmp/pip-AZLKQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:47:20 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)) 12:47:20 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)) 12:47:20 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)) 12:47:20 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)) 12:47:20 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)) 12:47:20 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)) 12:47:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:47:22 INFO - Downloading blessings-1.6.tar.gz 12:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:47:22 INFO - Installing collected packages: blessings 12:47:22 INFO - Running setup.py install for blessings 12:47:22 INFO - Successfully installed blessings 12:47:22 INFO - Cleaning up... 12:47:22 INFO - Return code: 0 12:47:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:47:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:47:22 INFO - Reading from file tmpfile_stdout 12:47:22 INFO - Current package versions: 12:47:22 INFO - argparse == 1.2.1 12:47:22 INFO - blessings == 1.6 12:47:22 INFO - blobuploader == 1.2.4 12:47:22 INFO - docopt == 0.6.1 12:47:22 INFO - functools32 == 3.2.3-2 12:47:22 INFO - jsonschema == 2.5.1 12:47:22 INFO - manifestparser == 1.1 12:47:22 INFO - mozInstall == 1.12 12:47:22 INFO - mozcrash == 0.17 12:47:22 INFO - mozdebug == 0.1 12:47:22 INFO - mozdevice == 0.48 12:47:22 INFO - mozfile == 1.2 12:47:22 INFO - mozhttpd == 0.7 12:47:22 INFO - mozinfo == 0.9 12:47:22 INFO - mozleak == 0.1 12:47:22 INFO - mozlog == 3.2 12:47:22 INFO - moznetwork == 0.27 12:47:22 INFO - mozprocess == 0.23 12:47:22 INFO - mozprofile == 0.28 12:47:22 INFO - mozrunner == 6.12 12:47:22 INFO - mozscreenshot == 0.1 12:47:22 INFO - mozsystemmonitor == 0.3 12:47:22 INFO - moztest == 0.7 12:47:22 INFO - mozversion == 1.4 12:47:22 INFO - psutil == 3.1.1 12:47:22 INFO - requests == 1.2.3 12:47:22 INFO - wsgiref == 0.1.2 12:47:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:22 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 0xbdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9b3b0>, '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 0xe9c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c740>, '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': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', '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 12:47:22 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 12:47:22 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 12:47:22 INFO - Using env: {'DISPLAY': ':0', 12:47:22 INFO - 'HOME': '/home/cltbld', 12:47:22 INFO - 'LANG': 'en_US.UTF-8', 12:47:22 INFO - 'LANGUAGE': 'en_US:en', 12:47:22 INFO - 'LOGNAME': 'cltbld', 12:47:22 INFO - 'MAIL': '/var/mail/cltbld', 12:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:22 INFO - 'MOZ_NO_REMOTE': '1', 12:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:22 INFO - 'NO_EM_RESTART': '1', 12:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:22 INFO - 'PWD': '/builds/slave/test', 12:47:22 INFO - 'SHELL': '/bin/bash', 12:47:22 INFO - 'SHLVL': '1', 12:47:22 INFO - 'TERM': 'linux', 12:47:22 INFO - 'TMOUT': '86400', 12:47:22 INFO - 'USER': 'cltbld', 12:47:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', 12:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:22 INFO - '_': '/tools/buildbot/bin/python'} 12:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:22 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)) 12:47:22 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)) 12:47:22 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)) 12:47:22 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)) 12:47:22 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)) 12:47:22 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)) 12:47:22 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)) 12:47:22 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)) 12:47:22 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)) 12:47:22 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)) 12:47:22 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)) 12:47:22 INFO - Cleaning up... 12:47:22 INFO - Return code: 0 12:47:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 12:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:47:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbdc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9b3b0>, '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 0xe9c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c740>, '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': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', '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 12:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:47:22 INFO - Using env: {'DISPLAY': ':0', 12:47:22 INFO - 'HOME': '/home/cltbld', 12:47:22 INFO - 'LANG': 'en_US.UTF-8', 12:47:22 INFO - 'LANGUAGE': 'en_US:en', 12:47:22 INFO - 'LOGNAME': 'cltbld', 12:47:22 INFO - 'MAIL': '/var/mail/cltbld', 12:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:22 INFO - 'MOZ_NO_REMOTE': '1', 12:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:22 INFO - 'NO_EM_RESTART': '1', 12:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:22 INFO - 'PWD': '/builds/slave/test', 12:47:22 INFO - 'SHELL': '/bin/bash', 12:47:22 INFO - 'SHLVL': '1', 12:47:22 INFO - 'TERM': 'linux', 12:47:22 INFO - 'TMOUT': '86400', 12:47:22 INFO - 'USER': 'cltbld', 12:47:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', 12:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:22 INFO - '_': '/tools/buildbot/bin/python'} 12:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:47:23 INFO - Cleaning up... 12:47:23 INFO - Return code: 0 12:47:23 INFO - Running post-action listener: _resource_record_post_action 12:47:23 INFO - Running post-action listener: _start_resource_monitoring 12:47:23 INFO - Starting resource monitoring. 12:47:23 INFO - ##### 12:47:23 INFO - ##### Finished create-virtualenv step (success) 12:47:23 INFO - ##### 12:47:23 INFO - ##### 12:47:23 INFO - ##### Running install step. 12:47:23 INFO - ##### 12:47:23 INFO - Running pre-action listener: _resource_record_pre_action 12:47:23 INFO - Running main action method: install 12:47:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:47:23 INFO - Reading from file tmpfile_stdout 12:47:23 INFO - Detecting whether we're running mozinstall >=1.0... 12:47:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:47:23 INFO - Reading from file tmpfile_stdout 12:47:23 INFO - Output received: 12:47:23 INFO - Usage: mozinstall [options] installer 12:47:23 INFO - Options: 12:47:23 INFO - -h, --help show this help message and exit 12:47:23 INFO - -d DEST, --destination=DEST 12:47:23 INFO - Directory to install application into. [default: 12:47:23 INFO - "/builds/slave/test"] 12:47:23 INFO - --app=APP Application being installed. [default: firefox] 12:47:23 INFO - mkdir: /builds/slave/test/build/application 12:47:23 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'] 12:47:23 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 12:47:39 INFO - Reading from file tmpfile_stdout 12:47:39 INFO - Output received: 12:47:39 INFO - /builds/slave/test/build/application/firefox/firefox 12:47:39 INFO - Running post-action listener: _resource_record_post_action 12:47:39 INFO - ##### 12:47:39 INFO - ##### Finished install step (success) 12:47:39 INFO - ##### 12:47:39 INFO - ##### 12:47:39 INFO - ##### Running run-tests step. 12:47:39 INFO - ##### 12:47:39 INFO - Running pre-action listener: _resource_record_pre_action 12:47:39 INFO - Running main action method: run_tests 12:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:47:39 INFO - Python 2.7.3 12:47:39 INFO - Return code: 0 12:47:39 INFO - grabbing minidump binary from tooltool 12:47:39 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')]} 12:47:39 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 0xe9b3b0>, '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 0xe9c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:47:39 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 12:47:39 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 12:47:39 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 12:47:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:47:39 INFO - Return code: 0 12:47:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:47:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:47:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:47:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:47:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 12:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 12:47:39 INFO - Using env: {'DISPLAY': ':0', 12:47:39 INFO - 'HOME': '/home/cltbld', 12:47:39 INFO - 'LANG': 'en_US.UTF-8', 12:47:39 INFO - 'LANGUAGE': 'en_US:en', 12:47:39 INFO - 'LOGNAME': 'cltbld', 12:47:39 INFO - 'MAIL': '/var/mail/cltbld', 12:47:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:47:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:39 INFO - 'MOZ_NO_REMOTE': '1', 12:47:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:39 INFO - 'NO_EM_RESTART': '1', 12:47:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:39 INFO - 'PWD': '/builds/slave/test', 12:47:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:47:39 INFO - 'SHELL': '/bin/bash', 12:47:39 INFO - 'SHLVL': '1', 12:47:39 INFO - 'TERM': 'linux', 12:47:39 INFO - 'TMOUT': '86400', 12:47:39 INFO - 'USER': 'cltbld', 12:47:39 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467920798.662274-898473575', 12:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:39 INFO - '_': '/tools/buildbot/bin/python'} 12:47:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 12:47:39 INFO - mozversion application_buildid: 20160707112723 12:47:39 INFO - mozversion application_changeset: 94cce4e79310565ff5b169f890842499ea713f8a 12:47:39 INFO - mozversion application_display_name: Nightly 12:47:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:47:39 INFO - mozversion application_name: Firefox 12:47:39 INFO - mozversion application_remotingname: firefox 12:47:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:47:39 INFO - mozversion application_vendor: Mozilla 12:47:39 INFO - mozversion application_version: 50.0a1 12:47:39 INFO - mozversion platform_buildid: 20160707112723 12:47:39 INFO - mozversion platform_changeset: 94cce4e79310565ff5b169f890842499ea713f8a 12:47:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:47:39 INFO - mozversion platform_version: 50.0a1 12:47:39 INFO - using testdate: 1467920859 12:47:39 INFO - actual date: 1467920859 12:47:39 INFO - starting webserver on 'localhost:33633' 12:47:39 INFO - SUITE-START | Running 2 tests 12:47:39 INFO - TEST-START | dromaeo_css 12:47:39 INFO - operating with platform_type : linux_ 12:47:39 INFO - Initialising browser for dromaeo_css test... 12:47:39 INFO - TEST-INFO | started process 9237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuxSncf/profile http://localhost:33633/getInfo.html) 12:47:44 INFO - PROCESS | 9237 | __metrics Screen width/height:1600/1200 12:47:44 INFO - PROCESS | 9237 | colorDepth:24 12:47:44 INFO - PROCESS | 9237 | Browser inner width/height: 1024/697 12:47:44 INFO - PROCESS | 9237 | __metrics 12:47:45 INFO - PROCESS | 9237 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:47:46 INFO - TEST-INFO | 9237: exit 0 12:47:46 INFO - Browser initialized. 12:47:46 INFO - Running cycle 1/1 for dromaeo_css test... 12:47:46 INFO - TEST-INFO | started process 9316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuxSncf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:47:58 INFO - PROCESS | 9316 | RSS: Main: 159129600 12:47:58 INFO - PROCESS | 9316 | 12:48:49 INFO - PROCESS | 9316 | 1467920929126 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] 12:51:01 INFO - PROCESS | 9316 | Cycle 1(1): loaded http://localhost:33633/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33633/tests/dromaeo/cssquery-ext.html) 12:51:03 INFO - PROCESS | 9316 | RSS: Main: 279617536 12:51:03 INFO - PROCESS | 9316 | 12:54:06 INFO - PROCESS | 9316 | Cycle 1(1): loaded http://localhost:33633/tests/dromaeo/cssquery-ext.html (next: http://localhost:33633/tests/dromaeo/cssquery-jquery.html) 12:54:06 INFO - PROCESS | 9316 | RSS: Main: 239939584 12:54:06 INFO - PROCESS | 9316 | 12:57:08 INFO - PROCESS | 9316 | Cycle 1(1): loaded http://localhost:33633/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33633/tests/dromaeo/cssquery-mootools.html) 12:57:09 INFO - PROCESS | 9316 | RSS: Main: 242204672 12:57:09 INFO - PROCESS | 9316 | 13:00:11 INFO - PROCESS | 9316 | Cycle 1(1): loaded http://localhost:33633/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33633/tests/dromaeo/cssquery-prototype.html) 13:00:12 INFO - PROCESS | 9316 | RSS: Main: 233390080 13:00:12 INFO - PROCESS | 9316 | 13:03:15 INFO - PROCESS | 9316 | Cycle 1(1): loaded http://localhost:33633/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33633/tests/dromaeo/cssquery-yui.html) 13:03:16 INFO - PROCESS | 9316 | RSS: Main: 227278848 13:03:16 INFO - PROCESS | 9316 | 13:06:18 INFO - PROCESS | 9316 | Cycle 1(1): loaded http://localhost:33633/tests/dromaeo/cssquery-yui.html (next: http://localhost:33633/tests/dromaeo/cssquery-dojo.html) 13:06:19 INFO - PROCESS | 9316 | RSS: Main: 286973952 13:06:19 INFO - PROCESS | 9316 | 13:06:19 INFO - PROCESS | 9316 | __start_tp_report 13:06:19 INFO - PROCESS | 9316 | _x_x_mozilla_page_load 13:06:19 INFO - PROCESS | 9316 | _x_x_mozilla_page_load_details 13:06:19 INFO - PROCESS | 9316 | |i|pagename|runs| 13:06:19 INFO - PROCESS | 9316 | |0;dojo.html;2592.4426248356604;2601.323655849481;2619.279698083027;2621.8689065546723;2624.6850377954647;4686.968866849288;4728.125296820086;4732.479427262998;4757.310190022445;4790.568848803607;4684.531546845314;4714.882127946803;4724.952750472494;4753.33453316536;4773.618110551156;4106.486689163855;4248.065425606369;4336.457942757155;4366.01764602965;4455.621272191867;4366.476022877259;4399.626031787302;4401.427814384126;4421.314696222091;4447.822087116511;4274.187904298189;4292.18448494785;4322.113966636832;4355.60799528044;4380.846670366554;4394.868153955386;4419.580139886705;4424.646028317727;4447.5552444755585;4447.933281000787;4378.824847006116;4392.978035109804;4410.933835992462;4411.316245981878;4450.977745111254;4610.861674149781;4707.835225767116;4749.335093086971;4763.952360476385;4860.125177468054;5116.923246151311;5162.845114646567;5182.222666600002;5186.170212765977;5189.403218629868;5199.584033277329;5208.9739551302;5211.557017653504;5212.6872387656485;5228.816991405282;4624.630029597624;4691.976540117345;4695.976520117378;4699.553542413465;4800.063987522434;5171.922421163686;5180.6891586504935;5187.247849061865;5250.343707036621;5254.211868219798;4988.201887697951;4999.850004499871;5062.7468626568525;5063;5068.619853511002;5009;5090.10923088458;5113.923291150636;5119.769610367543;5142.794288228504;5060.645754797129;5097.898042039138;5102.260172275;5102.311187989574;5154.098032844237;4943.752812359367;5045.924311135336;5046.84859454217;5058.114829904752;5067.087924173684;4186.5604111568455;4331.155424692155;4332.935005974913;4338.3709362142945;4415.337699345059;3770.2271034437877;3793.7534060285993;3795.3737633290198;3828.75113117652;3834.884953451401;4332.198543269442;4338.783060846945;4343.587359200871;4386.100849325944;4387.956120438818;4997.600191984632;5077.339945807022;5100.7959681613065;5128.871778205575;5143;4280.101178752435;4290.377895205178;4305.117450922553;4310.073334233155;4355.8475453359615;4465.7767111644935;4603.677742558056;4604.493505714368;4608.28571571407;4634.606058485067;4693.530646935347;4730.337752714554;4735.266033764772;4751.952480475151;4755.144074066701;5057.418396884405;5093.414257360303;5093.567046801063;5110.8466745997675;5137.5889928806355;4595.058013107238;4699.600533954652;4760.16697078003;4764.690295130806;4821.4696383397095;5008.048470790538;5045.646804723634;5063.87340316495;5067.797288108434;5109.20807274873;5128.820491282787;5142.76857541404;5146.356705411824;5147.40804807452;5195.220716892345;4851.369321988119;4888.95111048885;4894.9021019578695;4980.302757614009;4990.625703072356;4940.308356829974;4961.627877909244;4964.106460837084;4966.155753521838;4992.900141997213;4881.731504767272;4892.80428782859;4895.6083513318135;4916.606671466203;4934.185859333314;4848.733319667452;4907.779149938333;4943.703377797344;4965.652404331662;5052.9747351263;4783.928241076456;4814.277858321139;4828.734419606955;4830.903381932412;4879.682820616648 13:06:19 INFO - PROCESS | 9316 | |1;ext.html;537.001485130583;571.0919637775938;580.448573854838;583.3641330949265;593.1488314269023;27659.308517287052;28422.14733557994;30110.397792044147;30258.243543911387;40374.39438408419;36256.01183869772;41510.37734433978;42079.57920420795;42214.57785422145;42218.7889060555;7808.219178082189;7937.087234967966;7945.086315073754;7945.72189973351;7948.046234451874;7549.660265288047;7856.4893281936775;7953.403494737918;10264.640737574186;10518.579256829718;10132.240081993843;10471.057604815565;10524.736881577945;10539.789204215911;10548.683539493828;10367.429791361472;10463;10469;10472;10479.79040419195;10331.380117192992;10428.270021098526;10432.739181520446;10439.321444106185;10447.582096716122;40136.197276054605;40495.392569111485;40552.391714124315;40570.59429405727;40603.18793624111;2735.480258750831;2871.9856400717863;2922.7515661168827;2935.765138788892;3162.683731626842;30261.697383026327;30473.695263047528;30678.539821902465;31167.844160779277;31192;3533.1873669056263;3540.309639620275;3566.857325706969;3601.8559257629663;3640.5449318835144;261370;262593;262987;263707.68146159337;264379;57134.714326428104;57325.980772019175;57767.42232577704;57799.422005780245;57882.13176802267;61258.38741612616;61310.38689613136;61396.386036139964;61529.38470615326;61637.691811541554;12460;12488.50045998168;12635.747285054247;12648.494060237488;12735.23588584688;9792.21662267017;9908.603655853829;11544.134189935621;11927.1650984432;11934.28394296345;18444;18827.52931176704;18912.52718682044;19178.232870685017;19314.613707725766;6966.756163534252;7046.365827075588;7210.67551960163;7259.564426134449;7352.852942941111;803.6423791412765;885.9114088591218;908.7500937242311;954.3707086975338;963.1476143612813;28093.438131237668;28791.56812647812;28813.711862881104;28865.23938887928;29492.115236542937;961.9615215391445;973.6105557776946;991.5141580625442;1023.5701005577675;1069.4813015687384;15271.312790924436;15297.694046119015;15352.014833250843;15438.84561154374;15590.9220453897;345983;350369;351183;351657;352500;49649;50524;50554.241686374735;50559;50647.24029139566;1057.0856209378833;1086.7174534620897;1087.380193289833;1167.8131498960126;1168.2581560709011;19922.876622473254;31409.21476963094;32276.35447290994;32461.837690811393;32559.348813023134;40949.59050409458;41351.37972930469;41375.7931210342;41408.792956035024;41440;304201;305930;306443;306511;307655;32798.18004549905;32997.17507062342;33125.17187070246;33718.325633487686;33822.83088584541;46852.531474684816;47409.52590474051;47856.282155766996;48145;48190.27714584214;37396;37432.81283593565;37615.43576846295;38104.047398814146;38708.225835483696;37490.62509374871;38099.42850857295;38162.23675526418;38396;38494.80752596219;31432.37135257328;32059.358812823146;32599.511007334433;32645.673543264264;32649.836750816095;31952.84023579867;33630;33787.83106084552;33901;33994.490082648284;25318.240452786446;25801.741982579933;25996.970469577245;25999.480010400064;26204.475910482066 13:06:19 INFO - PROCESS | 9316 | |2;jquery.html;367.1225770408724;370.32231017238456;371.50218706932714;382.9846806127755;384.60770014585125;16464.094474803882;17001.489955301346;17612.295508179657;17617.735733964;17636.735448968277;16840.83159168408;17239.91380043098;17955.192016359262;17956.281748730034;17980.910095449537;4950.405951285842;5126.5642420394315;5156.071907056728;5164.767585458663;5165.328507294065;3729.160938788778;3922.1371298314325;5868.2371291732015;6178.25860896693;6188.381161883798;5987.191729116557;6168.167297414837;6176.629402235858;6196.504279657639;6201.782937597162;6184.412480814315;6194.287656919444;6203.596766210205;6215.098810672473;6222.9066564001805;3433.261848702541;5016.523430274118;5309.946900530984;5342.332208473941;5433.809816656398;21702.89148554263;21870.23454179096;22269.44326391837;22341.218057367914;22710.432239193986;1769.9469015929542;1913.8277555020115;1929.7973712760238;2011.4569066352149;2144.92610105712;9097.954510227406;10833;12669.303188324639;12949.54676586315;13366.599002029858;1705.2399261689488;1710.8802383833136;1731.471901070173;1756.6398888227882;1839.5375676337344;71971.28028719698;74703.62648186779;74817.25182748157;75564;75903.99999999945;10072.899271007343;10083.19334453242;10132.645357412603;10344.37933723979;10382.532786024647;14007.649808754659;14038.578842634737;14064.43742250319;14102.788458173136;14104.08323458972;6897.827554311082;6918.723251070001;6938.930610693929;6975.232724400312;7068.964655176691;6514.446272066927;6529.934700652932;6709.496787740939;6756;6756.2568117507035;4256.39575551023;4336.1978034063795;4366.930102124936;4413.426254586947;4417.403650507141;1610.2270909963283;1623.7564365345293;1704.3949397963793;1800.558863078528;1881.8494520438333;807.3662175192446;834.7370578267826;864.386285737121;912.224609082288;914.8444764390069;16751;17017.820933743173;17317.913410432866;17626.64746705059;17710.468685939442;860.6686425726016;862.166985530031;876.8469462656714;878.6441491196076;915.0712027292303;9784.853227201598;9933.50332483373;9973.601055957826;9987.201023918069;10011.048950349705;342989;347224;348873;351278;351419;76838.23161768311;77235.2276477228;78406;78745.60627196942;79290.60354698189;837.388706244445;875.2429148786254;880.6125304865839;886.5079880666163;894.0523045571715;16221.270042847864;16374.83625163733;16468;16691.332346705996;16741;39137.80431097826;39597.30872664307;40065.1986960265;40239.1952160961;41340.37989430221;55124.72437637786;56704.432955669916;56718.14922776244;56738.432615673315;57736;7112.893306600302;7368.115826100902;7475.738349157753;7511;7562.319391254813;10839.783204336027;11131.165162612675;11508.539658413905;11523.942380288045;11618.244814087057;4738.07607516531;5091.923621145612;9004.954975225082;9975.20198384113;10239.897601024193;9316.720498385059;9377.765555861159;9739.220862330854;9962.153216976349;10012.899871001197;9853.605855765689;9936.105750482491;10029.498525073863;10404.47977601132;10528.210384221062;7295.817604559928;7303.269673032654;7354.8896766549615;7435.851282974419;7567.659455324634;8858.335624828034;9633.229341652792;9685.370450920667;9780;10362.689119326433 13:06:19 INFO - PROCESS | 9316 | |3;mootools.html;1262.1921969939235;1379.1656048090904;1443.49477682811;1520.2930637253676;1739.2781995471887;6790.966045169774;7711.113221979467;7969.800754981128;7974.96012519938;8202.589870506466;7977.20227977202;8000.679972801081;8044.195580441953;8049.396295277848;8054.758357249292;1871.840893524052;2135.3380452059832;2214.568159208959;2244.427670943907;2246.7528571857083;2240.529488807352;2263.841531092816;2267.3424706835;2272.7954484096426;2276.6698828669832;2173.2393662218255;2195.4291884110166;2198.714167158267;2198.9340319790354;2203.316971738758;1814.8911065336122;2071.513194399315;2144.292383513437;2146.5063035501844;2153.3862849087936;2176.401489590375;2198.527316626933;2199.3182113544854;2199.417154454071;2200.482886521666;8002.479838810459;8037.839243215103;8048.074471435802;8051.557164355958;8053.4765240259785;4590.655700822452;4694.29585562165;4702.1771190041945;4704.247320428749;4708.058388322349;2849.957250641242;2952.8375939323328;2961.3781105967773;2967.866446009935;2974.078035808906;898.874157617934;919.0946917286467;930.5393830054098;950.064186776025;955.3217215776807;10872.293300935415;10877.83683244752;10878.857719939371;10913.23607347478;10940.835887461615;4080.3063479208604;4160.105577300835;4327.935080973788;4340.8480703175865;4342.696011279243;9360.251179905592;9361.063893610584;9388.577514011886;9408.106229908148;9408.43549387039;4697.389339385926;4710.764461776897;4715.552022557851;4724.126036683225;4741.644376671695;3570.767900086486;4198.097409057006;4305.784710764512;4346.043870348518;4346.195953748566;3651.087228192952;3687.631236876291;3773.056735816046;3810.5236845394325;3819.961800382016;1209.625016244967;1211.715246916974;1212.3332167308122;1215.6474622359417;1218.232513516479;500.98300450086384;558.1655425139361;651.563452486835;688.7435647697279;716.7133146741345;4931.334269873593;5046.091703493406;5109.259157422153;5120.769565369567;5189.040027594907;887.5695287785419;887.8978917424449;903.2954295649273;904.4889637354873;906.0531744327194;3248.3990461764647;3393.7794043387103;3426.880059197916;3454.687218856818;3508.5965114011706;9457.763555911157;9700;9726.221902247804;9777.511124443748;9796.26528010402;9706.70879873605;9709;9714.854277185848;9715.659951901649;9742.61029558824;7362.521436106743;7447.813804654927;7498.100227972678;7504.174540800507;7517.586532740643;5061.114304996685;5180.274761533464;5201.895962080813;5205.011047900886;5288.365396152486;8862.512561809162;9048.547572621474;9083.409578377385;9244.768880778034;9261;9143.862842057242;9197.540122993958;9279.304052195977;9365.969743328365;9480.099390557885;5916.970415148069;6530.575512591667;6743.089682892747;6786.558873673195;6863.828404289933;7257.165425976081;7284.089488813898;7321.816954575965;7370.115586129698;7380.926190738239;6448.580842245239;6682.3317668232785;6719.865602688016;6773.458123350219;6862.279460656759;6502.43941454057;6527.314631963765;6542.738290468328;6587.077809106825;6607.867842643216;5931.6441013539325;5990.400959903975;5995.46040856325;6000;6009.609375390585;4302.978485107555;4367.65058795302;4390.297552391602;4438.755868427267;4481.843135490242;4450.46594408673;4501.864944051684;4539.364488971612;4545.181867263925;4609.446866376056 13:06:19 INFO - PROCESS | 9316 | |4;prototype.html;285.64722567628985;288.82381747134247;292.8447922601021;298.26180203995114;304.80644790558;4942.1845395509745;4992.201247800353;5000.274960130783;5014.849554513361;5015.348004759376;4860.2709593560985;4890.119778439879;4948.851534453963;4960.925586116211;4962.70223786573;3634.636536346364;3774.2451509698035;3776.30138424391;3778.8299526521373;3779.489768881207;3741.6071312512204;3757.1734218471893;3883.533975922879;3886.2810380079636;3907.6873850091924;3806.3529200035923;3831.386978083507;3834.8082595870096;3839.9808000960097;3883.8446462141483;3770.009768645095;3805.124821291091;3824.330742120118;3845.750026248299;3871.7483363581277;3391.6947474727394;3399.3201359727905;3403.5915690117095;3413.8805141819917;3414.2830005698834;4748.905021899577;4754.833580824655;4793.058811181477;4793.089313030513;4800.879978000543;4176.477940257468;4347.174036932973;4347.630451411634;4363.6072753452345;4367.126574685076;5097.7196254206;5108.591312694975;5116.232565115225;5152.381714194321;5161.638685292031;3631.2374401375478;3642.25333806569;3661.2311414602964;3668.596454390015;3672.8347224374966;5224.399194092652;5332.280142180794;5370.3287089113865;5416.539594134503;5432.972835135839;3694.9815250923575;3703.9629603704157;3716.201016781405;3716.680578394685;3724.8696295629525;3781.6532368853764;3786.848526058927;3789.3936970084656;3790.6019867913474;3791.450239715226;4311.07311927937;4316.978415107905;4326.329418940069;4332.371806088099;4335.284678028153;4872.707637541759;5077.949220507748;5085.669431486942;5118.36212412032;5125.410577783603;1281.2568710148091;1305.6670549009941;1307.8038294255937;1317.3084130831198;1317.308413083139;798.2855344466669;808.8988876390451;828.6105530400702;843.7384410832661;844.4679851693394;4272.230998420252;4440.4005459263235;4449.310356894686;4460.3532487789735;4464.120642185772;5221;5221.034108689904;5221.511869117283;5251;5265.815696450606;4444.866654000385;4451.977740111279;4453.354263631755;4460.955390446119;4466.3523789050405;2646.642703235077;2809.789265805032;2813.268550176928;2817.492851286788;2821.7460428561526;4924.704517728876;4941.752912354368;4950.2822090796635;4952.504749525018;4956.207006878882;5273.444333921502;5412.269343638637;5437.700926449083;5444.455554444603;5475.534579560703;4958.082754690249;4965.975170124127;4968.552830245295;4976.377952755905;4981.206765564394;5295.947040529545;5296.682199068068;5320.334958130234;5324.201369794562;5341.893162136813;5030.496950304941;5144.6655967363495;5160.890408562177;5260.473952604709;5267.367915850123;4916.557509824133;4917.385326834145;4928.507149285187;4936.777844996912;4945.752712364296;3403.6936675699308;3468.358353704573;3473.496343030297;3475.704565111893;3485.9477107842895;4617.330487079422;4781.42622885256;4799.208130658542;4800.831970881002;4819.325294458708;4609.539046095364;4625.907481850277;4635.93046104302;4639.170106235261;4648.651890951586;4559.863204103882;4564.224081906017;4568.314752787109;4600.516945720651;4633.258678611406;4314.395984562101;4511.954880451285;4519.48597219935;4526.921693248622;4556.703814252063;4681.689127044433;4924.335214745964;5058.597166345956;5064.2403639452905;5064.5948324134715;4863.489333619919;4875.7074575525585;4914.8771280718265;4983.227599722049;5037.345145131109 13:06:19 INFO - PROCESS | 9316 | |5;yui.html;588.6106315940466;674.7840690978886;700.2997002997002;714.9499535032546;720.6792977125182;12623.179493332938;13351.732965340687;13513.986451016164;13530.594082177526;13548.932255338721;13523.661908452294;14160.504382346595;14230.288485575731;14268.928655356734;14271.286435678227;629.6379581740517;766.0921807657943;771.756896577579;783.3967844759532;797.5015615240475;796.55791035975;802.7832485228985;804.0994086622991;804.1074407407773;805.3597390074905;811.4563242627424;821.876718492228;822.1367564057715;822.4448497264323;823.1274848660439;584.5265335078558;599.5084031094505;650.9869802603921;818.2799136759643;818.4925346285281;436.415203627138;436.4457139432934;436.6397721879462;436.7772436057634;436.84492005337967;13237.205767653875;13317.467301307935;13330.73338533224;13348.399322030435;13353.599392018255;12273.140880138393;12659.177153484994;12882.80675789864;12900.612981610566;13139.247459489132;11914;11923.642290731292;12049.457774400173;12109.15235933485;12373.195742276723;4247.171801498709;4313.61177494027;4324.589164029412;4354;4467.218236808578;65379.34620653828;66396.6680166596;66596.66701666509;66611;66859.3314066858;10604.628837990633;10635.574577016987;10639.734006649896;10906.890931090746;11063.612773553048;19378.321758738377;20152.29466968649;20178;21195.576088478145;21211.46971325729;7362.079740032496;7365.410767138723;7379.446541509408;7451.552906825608;7506.399488040944;3672.3022625701033;3695.316366472211;3774.207416442523;3837.9232415351535;3868.1490072184074;2942.7940044196703;3053.6335639723375;3055.144559523337;3056.6026416565705;3059.495183294776;509.6381569085916;521.7182721330515;526.2238198656951;535.2319421629895;535.8713908661971;510.99233511497357;527.8759491519489;585.4906231578553;587.9147523609053;588.7615515716142;8130.959345203354;8250.752477425687;8362.498250105013;8773.649054037895;8884.244839188612;491.33424210195386;535.9115745901883;554.95945102932;581.7760162337446;640.3116649601697;3880.902977425587;3918.8236529356245;4068.7762173080764;4077.959220407817;4093.1199792044854;90280;92215;99747;99798;101038;71331.93002104973;83789.58105209435;84165;86747;89122;71377.2862271381;74437.62781186168;74744.62627686826;75491.86762198572;76459.61770191113;8079.128668710905;8100.149484304063;8126.878096828434;8337.3429431694;8367;42872.78563607162;43178;43297.13405731931;43367.78316108399;44701.776491117336;36657.816710917345;36945;37058.6294137066;45696;61716.69141654263;10396.48017599132;10769.784604308026;11151.219414640897;11490.88509114898;11619.302841829518;13466.93266533661;13860.306984650928;13880.444782208599;14278.928605356907;14730.337134828744;12644.55672579619;12887.420066097236;13006.544770932973;13459.798103028266;13468.326583670972;12631.431585578855;12871.678208044874;12895.806562901751;13128.721306927764;13364.933175334061;11236.719082023015;11594.130440216848;11718.88281117178;11899.881001189877;11966.880331196577;10688.412137332522;11237.55049797999;11247.268927519684;11371.61196148785;11617.535298587962;9575.726254484718;9976.950115249667;10092.34399764013;10437.791244175225;10500.894991050298 13:06:19 INFO - PROCESS | 9316 | __end_tp_report 13:06:19 INFO - PROCESS | 9316 | __start_cc_report 13:06:19 INFO - PROCESS | 9316 | _x_x_mozilla_cycle_collect,1125 13:06:19 INFO - PROCESS | 9316 | __end_cc_report 13:06:19 INFO - PROCESS | 9316 | __startTimestamp1467921979030__endTimestamp 13:06:19 INFO - PROCESS | 9316 | 13:06:19 INFO - PROCESS | 9316 | ------- Summary: start ------- 13:06:19 INFO - PROCESS | 9316 | Number of tests: 6 13:06:19 INFO - PROCESS | 9316 | 13:06:19 INFO - PROCESS | 9316 | [#0] dojo.html Cycles:165 Average:4698.37 Median:4790.57 stddev:505.18 (10.5%) stddev-sans-first:478.96 13:06:19 INFO - PROCESS | 9316 | Values: 2592.4 2601.3 2619.3 2621.9 2624.7 4687.0 4728.1 4732.5 4757.3 4790.6 4684.5 4714.9 4725.0 4753.3 4773.6 4106.5 4248.1 4336.5 4366.0 4455.6 4366.5 4399.6 4401.4 4421.3 4447.8 4274.2 4292.2 4322.1 4355.6 4380.8 4394.9 4419.6 4424.6 4447.6 4447.9 4378.8 4393.0 4410.9 4411.3 4451.0 4610.9 4707.8 4749.3 4764.0 4860.1 5116.9 5162.8 5182.2 5186.2 5189.4 5199.6 5209.0 5211.6 5212.7 5228.8 4624.6 4692.0 4696.0 4699.6 4800.1 5171.9 5180.7 5187.2 5250.3 5254.2 4988.2 4999.9 5062.7 5063.0 5068.6 5009.0 5090.1 5113.9 5119.8 5142.8 5060.6 5097.9 5102.3 5102.3 5154.1 4943.8 5045.9 5046.8 5058.1 5067.1 4186.6 4331.2 4332.9 4338.4 4415.3 3770.2 3793.8 3795.4 3828.8 3834.9 4332.2 4338.8 4343.6 4386.1 4388.0 4997.6 5077.3 5100.8 5128.9 5143.0 4280.1 4290.4 4305.1 4310.1 4355.8 4465.8 4603.7 4604.5 4608.3 4634.6 4693.5 4730.3 4735.3 4752.0 4755.1 5057.4 5093.4 5093.6 5110.8 5137.6 4595.1 4699.6 4760.2 4764.7 4821.5 5008.0 5045.6 5063.9 5067.8 5109.2 5128.8 5142.8 5146.4 5147.4 5195.2 4851.4 4889.0 4894.9 4980.3 4990.6 4940.3 4961.6 4964.1 4966.2 4992.9 4881.7 4892.8 4895.6 4916.6 4934.2 4848.7 4907.8 4943.7 4965.7 5053.0 4783.9 4814.3 4828.7 4830.9 4879.7 13:06:19 INFO - PROCESS | 9316 | 13:06:19 INFO - PROCESS | 9316 | [#1] ext.html Cycles:180 Average:47333.17 Median:33674.16 stddev:80821.02 (240.0%) stddev-sans-first:80971.37 13:06:19 INFO - PROCESS | 9316 | Values: 537.0 571.1 580.4 583.4 593.1 27659.3 28422.1 30110.4 30258.2 40374.4 36256.0 41510.4 42079.6 42214.6 42218.8 7808.2 7937.1 7945.1 7945.7 7948.0 7549.7 7856.5 7953.4 10264.6 10518.6 10132.2 10471.1 10524.7 10539.8 10548.7 10367.4 10463.0 10469.0 10472.0 10479.8 10331.4 10428.3 10432.7 10439.3 10447.6 40136.2 40495.4 40552.4 40570.6 40603.2 2735.5 2872.0 2922.8 2935.8 3162.7 30261.7 30473.7 30678.5 31167.8 31192.0 3533.2 3540.3 3566.9 3601.9 3640.5 261370.0 262593.0 262987.0 263707.7 264379.0 57134.7 57326.0 57767.4 57799.4 57882.1 61258.4 61310.4 61396.4 61529.4 61637.7 12460.0 12488.5 12635.7 12648.5 12735.2 9792.2 9908.6 11544.1 11927.2 11934.3 18444.0 18827.5 18912.5 19178.2 19314.6 6966.8 7046.4 7210.7 7259.6 7352.9 803.6 885.9 908.8 954.4 963.1 28093.4 28791.6 28813.7 28865.2 29492.1 962.0 973.6 991.5 1023.6 1069.5 15271.3 15297.7 15352.0 15438.8 15590.9 345983.0 350369.0 351183.0 351657.0 352500.0 49649.0 50524.0 50554.2 50559.0 50647.2 1057.1 1086.7 1087.4 1167.8 1168.3 19922.9 31409.2 32276.4 32461.8 32559.3 40949.6 41351.4 41375.8 41408.8 41440.0 304201.0 305930.0 306443.0 306511.0 307655.0 32798.2 32997.2 33125.2 33718.3 33822.8 46852.5 47409.5 47856.3 48145.0 48190.3 37396.0 37432.8 37615.4 38104.0 38708.2 37490.6 38099.4 38162.2 38396.0 38494.8 31432.4 32059.4 32599.5 32645.7 32649.8 31952.8 33630.0 33787.8 33901.0 33994.5 25318.2 25801.7 25997.0 25999.5 26204.5 13:06:19 INFO - PROCESS | 9316 | 13:06:19 INFO - PROCESS | 9316 | [#2] jquery.html Cycles:180 Average:23664.24 Median:4983.46 stddev:58081.05 (1165.5%) stddev-sans-first:58217.64 13:06:19 INFO - PROCESS | 9316 | Values: 367.1 370.3 371.5 383.0 384.6 16464.1 17001.5 17612.3 17617.7 17636.7 16840.8 17239.9 17955.2 17956.3 17980.9 4950.4 5126.6 5156.1 5164.8 5165.3 3729.2 3922.1 5868.2 6178.3 6188.4 5987.2 6168.2 6176.6 6196.5 6201.8 6184.4 6194.3 6203.6 6215.1 6222.9 3433.3 5016.5 5309.9 5342.3 5433.8 21702.9 21870.2 22269.4 22341.2 22710.4 1769.9 1913.8 1929.8 2011.5 2144.9 9098.0 10833.0 12669.3 12949.5 13366.6 1705.2 1710.9 1731.5 1756.6 1839.5 71971.3 74703.6 74817.3 75564.0 75904.0 10072.9 10083.2 10132.6 10344.4 10382.5 14007.6 14038.6 14064.4 14102.8 14104.1 6897.8 6918.7 6938.9 6975.2 7069.0 6514.4 6529.9 6709.5 6756.0 6756.3 4256.4 4336.2 4366.9 4413.4 4417.4 1610.2 1623.8 1704.4 1800.6 1881.8 807.4 834.7 864.4 912.2 914.8 16751.0 17017.8 17317.9 17626.6 17710.5 860.7 862.2 876.8 878.6 915.1 9784.9 9933.5 9973.6 9987.2 10011.0 342989.0 347224.0 348873.0 351278.0 351419.0 76838.2 77235.2 78406.0 78745.6 79290.6 837.4 875.2 880.6 886.5 894.1 16221.3 16374.8 16468.0 16691.3 16741.0 39137.8 39597.3 40065.2 40239.2 41340.4 55124.7 56704.4 56718.1 56738.4 57736.0 7112.9 7368.1 7475.7 7511.0 7562.3 10839.8 11131.2 11508.5 11523.9 11618.2 4738.1 5091.9 9005.0 9975.2 10239.9 9316.7 9377.8 9739.2 9962.2 10012.9 9853.6 9936.1 10029.5 10404.5 10528.2 7295.8 7303.3 7354.9 7435.9 7567.7 8858.3 9633.2 9685.4 9780.0 10362.7 13:06:19 INFO - PROCESS | 9316 | 13:06:19 INFO - PROCESS | 9316 | [#3] mootools.html Cycles:180 Average:5154.38 Median:5150.52 stddev:2938.49 (57.1%) stddev-sans-first:2932.17 13:06:19 INFO - PROCESS | 9316 | Values: 1262.2 1379.2 1443.5 1520.3 1739.3 6791.0 7711.1 7969.8 7975.0 8202.6 7977.2 8000.7 8044.2 8049.4 8054.8 1871.8 2135.3 2214.6 2244.4 2246.8 2240.5 2263.8 2267.3 2272.8 2276.7 2173.2 2195.4 2198.7 2198.9 2203.3 1814.9 2071.5 2144.3 2146.5 2153.4 2176.4 2198.5 2199.3 2199.4 2200.5 8002.5 8037.8 8048.1 8051.6 8053.5 4590.7 4694.3 4702.2 4704.2 4708.1 2850.0 2952.8 2961.4 2967.9 2974.1 898.9 919.1 930.5 950.1 955.3 10872.3 10877.8 10878.9 10913.2 10940.8 4080.3 4160.1 4327.9 4340.8 4342.7 9360.3 9361.1 9388.6 9408.1 9408.4 4697.4 4710.8 4715.6 4724.1 4741.6 3570.8 4198.1 4305.8 4346.0 4346.2 3651.1 3687.6 3773.1 3810.5 3820.0 1209.6 1211.7 1212.3 1215.6 1218.2 501.0 558.2 651.6 688.7 716.7 4931.3 5046.1 5109.3 5120.8 5189.0 887.6 887.9 903.3 904.5 906.1 3248.4 3393.8 3426.9 3454.7 3508.6 9457.8 9700.0 9726.2 9777.5 9796.3 9706.7 9709.0 9714.9 9715.7 9742.6 7362.5 7447.8 7498.1 7504.2 7517.6 5061.1 5180.3 5201.9 5205.0 5288.4 8862.5 9048.5 9083.4 9244.8 9261.0 9143.9 9197.5 9279.3 9366.0 9480.1 5917.0 6530.6 6743.1 6786.6 6863.8 7257.2 7284.1 7321.8 7370.1 7380.9 6448.6 6682.3 6719.9 6773.5 6862.3 6502.4 6527.3 6542.7 6587.1 6607.9 5931.6 5990.4 5995.5 6000.0 6009.6 4303.0 4367.7 4390.3 4438.8 4481.8 4450.5 4501.9 4539.4 4545.2 4609.4 13:06:19 INFO - PROCESS | 9316 | 13:06:19 INFO - PROCESS | 9316 | [#4] prototype.html Cycles:180 Average:4182.31 Median:4621.62 stddev:1210.16 (26.2%) stddev-sans-first:1177.68 13:06:19 INFO - PROCESS | 9316 | Values: 285.6 288.8 292.8 298.3 304.8 4942.2 4992.2 5000.3 5014.8 5015.3 4860.3 4890.1 4948.9 4960.9 4962.7 3634.6 3774.2 3776.3 3778.8 3779.5 3741.6 3757.2 3883.5 3886.3 3907.7 3806.4 3831.4 3834.8 3840.0 3883.8 3770.0 3805.1 3824.3 3845.8 3871.7 3391.7 3399.3 3403.6 3413.9 3414.3 4748.9 4754.8 4793.1 4793.1 4800.9 4176.5 4347.2 4347.6 4363.6 4367.1 5097.7 5108.6 5116.2 5152.4 5161.6 3631.2 3642.3 3661.2 3668.6 3672.8 5224.4 5332.3 5370.3 5416.5 5433.0 3695.0 3704.0 3716.2 3716.7 3724.9 3781.7 3786.8 3789.4 3790.6 3791.5 4311.1 4317.0 4326.3 4332.4 4335.3 4872.7 5077.9 5085.7 5118.4 5125.4 1281.3 1305.7 1307.8 1317.3 1317.3 798.3 808.9 828.6 843.7 844.5 4272.2 4440.4 4449.3 4460.4 4464.1 5221.0 5221.0 5221.5 5251.0 5265.8 4444.9 4452.0 4453.4 4461.0 4466.4 2646.6 2809.8 2813.3 2817.5 2821.7 4924.7 4941.8 4950.3 4952.5 4956.2 5273.4 5412.3 5437.7 5444.5 5475.5 4958.1 4966.0 4968.6 4976.4 4981.2 5295.9 5296.7 5320.3 5324.2 5341.9 5030.5 5144.7 5160.9 5260.5 5267.4 4916.6 4917.4 4928.5 4936.8 4945.8 3403.7 3468.4 3473.5 3475.7 3485.9 4617.3 4781.4 4799.2 4800.8 4819.3 4609.5 4625.9 4635.9 4639.2 4648.7 4559.9 4564.2 4568.3 4600.5 4633.3 4314.4 4512.0 4519.5 4526.9 4556.7 4681.7 4924.3 5058.6 5064.2 5064.6 4863.5 4875.7 4914.9 4983.2 5037.3 13:06:19 INFO - PROCESS | 9316 | 13:06:19 INFO - PROCESS | 9316 | [#5] yui.html Cycles:180 Average:17602.42 Median:23751.29 stddev:24595.04 (103.6%) stddev-sans-first:24630.85 13:06:19 INFO - PROCESS | 9316 | Values: 588.6 674.8 700.3 714.9 720.7 12623.2 13351.7 13514.0 13530.6 13548.9 13523.7 14160.5 14230.3 14268.9 14271.3 629.6 766.1 771.8 783.4 797.5 796.6 802.8 804.1 804.1 805.4 811.5 821.9 822.1 822.4 823.1 584.5 599.5 651.0 818.3 818.5 436.4 436.4 436.6 436.8 436.8 13237.2 13317.5 13330.7 13348.4 13353.6 12273.1 12659.2 12882.8 12900.6 13139.2 11914.0 11923.6 12049.5 12109.2 12373.2 4247.2 4313.6 4324.6 4354.0 4467.2 65379.3 66396.7 66596.7 66611.0 66859.3 10604.6 10635.6 10639.7 10906.9 11063.6 19378.3 20152.3 20178.0 21195.6 21211.5 7362.1 7365.4 7379.4 7451.6 7506.4 3672.3 3695.3 3774.2 3837.9 3868.1 2942.8 3053.6 3055.1 3056.6 3059.5 509.6 521.7 526.2 535.2 535.9 511.0 527.9 585.5 587.9 588.8 8131.0 8250.8 8362.5 8773.6 8884.2 491.3 535.9 555.0 581.8 640.3 3880.9 3918.8 4068.8 4078.0 4093.1 90280.0 92215.0 99747.0 99798.0 101038.0 71331.9 83789.6 84165.0 86747.0 89122.0 71377.3 74437.6 74744.6 75491.9 76459.6 8079.1 8100.1 8126.9 8337.3 8367.0 42872.8 43178.0 43297.1 43367.8 44701.8 36657.8 36945.0 37058.6 45696.0 61716.7 10396.5 10769.8 11151.2 11490.9 11619.3 13466.9 13860.3 13880.4 14278.9 14730.3 12644.6 12887.4 13006.5 13459.8 13468.3 12631.4 12871.7 12895.8 13128.7 13364.9 11236.7 11594.1 11718.9 11899.9 11966.9 10688.4 11237.6 11247.3 11371.6 11617.5 9575.7 9977.0 10092.3 10437.8 10500.9 13:06:19 INFO - PROCESS | 9316 | -------- Summary: end -------- 13:06:19 INFO - PROCESS | 9316 | 13:06:19 INFO - TEST-INFO | 9316: exit 0 13:06:19 INFO - TEST-OK | dromaeo_css | took 1119901ms 13:06:19 INFO - TEST-START | kraken 13:06:19 INFO - operating with platform_type : linux_ 13:06:19 INFO - Initialising browser for kraken test... 13:06:19 INFO - TEST-INFO | started process 9503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3klda9/profile http://localhost:33633/getInfo.html) 13:06:24 INFO - PROCESS | 9503 | __metrics Screen width/height:1600/1200 13:06:24 INFO - PROCESS | 9503 | colorDepth:24 13:06:24 INFO - PROCESS | 9503 | Browser inner width/height: 1024/697 13:06:24 INFO - PROCESS | 9503 | __metrics 13:06:25 INFO - PROCESS | 9503 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:06:26 INFO - TEST-INFO | 9503: exit 0 13:06:26 INFO - Browser initialized. 13:06:26 INFO - Running cycle 1/1 for kraken test... 13:06:26 INFO - TEST-INFO | started process 9581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3klda9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:06:38 INFO - PROCESS | 9581 | RSS: Main: 158638080 13:06:38 INFO - PROCESS | 9581 | 13:06:40 INFO - PROCESS | 9581 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33633/tests/kraken/driver.html?testName=audio-beat-detection) 13:06:41 INFO - PROCESS | 9581 | RSS: Main: 217047040 13:06:41 INFO - PROCESS | 9581 | 13:06:44 INFO - PROCESS | 9581 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33633/tests/kraken/driver.html?testName=audio-dft) 13:06:45 INFO - PROCESS | 9581 | RSS: Main: 203821056 13:06:45 INFO - PROCESS | 9581 | 13:06:48 INFO - PROCESS | 9581 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33633/tests/kraken/driver.html?testName=audio-fft) 13:06:49 INFO - PROCESS | 9581 | RSS: Main: 271503360 13:06:49 INFO - PROCESS | 9581 | 13:06:51 INFO - PROCESS | 9581 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33633/tests/kraken/driver.html?testName=audio-oscillator) 13:06:51 INFO - PROCESS | 9581 | RSS: Main: 182001664 13:06:51 INFO - PROCESS | 9581 | 13:06:54 INFO - PROCESS | 9581 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33633/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:06:54 INFO - PROCESS | 9581 | RSS: Main: 185360384 13:06:54 INFO - PROCESS | 9581 | 13:06:58 INFO - PROCESS | 9581 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33633/tests/kraken/driver.html?testName=imaging-darkroom) 13:06:58 INFO - PROCESS | 9581 | RSS: Main: 221970432 13:06:58 INFO - PROCESS | 9581 | 13:07:02 INFO - PROCESS | 9581 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33633/tests/kraken/driver.html?testName=imaging-desaturate) 13:07:02 INFO - PROCESS | 9581 | RSS: Main: 222343168 13:07:02 INFO - PROCESS | 9581 | 13:07:05 INFO - PROCESS | 9581 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33633/tests/kraken/driver.html?testName=json-parse-financial) 13:07:06 INFO - PROCESS | 9581 | RSS: Main: 222416896 13:07:06 INFO - PROCESS | 9581 | 13:07:07 INFO - PROCESS | 9581 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33633/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:07:08 INFO - PROCESS | 9581 | RSS: Main: 210280448 13:07:08 INFO - PROCESS | 9581 | 13:07:10 INFO - PROCESS | 9581 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:07:11 INFO - PROCESS | 9581 | RSS: Main: 213028864 13:07:11 INFO - PROCESS | 9581 | 13:07:13 INFO - PROCESS | 9581 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:07:13 INFO - PROCESS | 9581 | RSS: Main: 212340736 13:07:13 INFO - PROCESS | 9581 | 13:07:16 INFO - PROCESS | 9581 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:07:17 INFO - PROCESS | 9581 | RSS: Main: 224620544 13:07:17 INFO - PROCESS | 9581 | 13:07:20 INFO - PROCESS | 9581 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:07:20 INFO - PROCESS | 9581 | RSS: Main: 224747520 13:07:20 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33633/tests/kraken/driver.html?testName=ai-astar) 13:07:22 INFO - PROCESS | 9581 | RSS: Main: 266924032 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | __start_tp_report 13:07:22 INFO - PROCESS | 9581 | _x_x_mozilla_page_load 13:07:22 INFO - PROCESS | 9581 | _x_x_mozilla_page_load_details 13:07:22 INFO - PROCESS | 9581 | |i|pagename|runs| 13:07:22 INFO - PROCESS | 9581 | |0;ai-astar;105;114;114;115;114;113;114;114;115;112 13:07:22 INFO - PROCESS | 9581 | |1;audio-beat-detection;150;124;123;167;128;124;152;121;155;124 13:07:22 INFO - PROCESS | 9581 | |2;audio-dft;160;161;170;160;162;161;160;162;161;161 13:07:22 INFO - PROCESS | 9581 | |3;audio-fft;75;77;76;111;76;77;77;76;105;75 13:07:22 INFO - PROCESS | 9581 | |4;audio-oscillator;86;86;119;86;85;86;126;86;85;132 13:07:22 INFO - PROCESS | 9581 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 13:07:22 INFO - PROCESS | 9581 | |6;imaging-darkroom;147;147;146;145;152;145;146;146;146;146 13:07:22 INFO - PROCESS | 9581 | |7;imaging-desaturate;96;96;95;95;95;95;95;96;95;94 13:07:22 INFO - PROCESS | 9581 | |8;json-parse-financial;63;63;63;63;72;66;67;65;64;65 13:07:22 INFO - PROCESS | 9581 | |9;json-stringify-tinderbox;65;64;65;65;66;66;65;66;65;65 13:07:22 INFO - PROCESS | 9581 | |10;stanford-crypto-aes;82;84;78;78;87;77;76;78;78;88 13:07:22 INFO - PROCESS | 9581 | |11;stanford-crypto-ccm;130;131;128;127;129;130;133;131;165;136 13:07:22 INFO - PROCESS | 9581 | |12;stanford-crypto-pbkdf2;164;169;165;165;163;165;163;162;168;163 13:07:22 INFO - PROCESS | 9581 | |13;stanford-crypto-sha256-iterative;67;69;71;67;67;71;71;65;67;66 13:07:22 INFO - PROCESS | 9581 | __end_tp_report 13:07:22 INFO - PROCESS | 9581 | __start_cc_report 13:07:22 INFO - PROCESS | 9581 | _x_x_mozilla_cycle_collect,1922 13:07:22 INFO - PROCESS | 9581 | __end_cc_report 13:07:22 INFO - PROCESS | 9581 | __startTimestamp1467922042717__endTimestamp 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | ------- Summary: start ------- 13:07:22 INFO - PROCESS | 9581 | Number of tests: 14 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:2.94 (2.6%) stddev-sans-first:0.93 13:07:22 INFO - PROCESS | 9581 | Values: 105.0 114.0 114.0 115.0 114.0 113.0 114.0 114.0 115.0 112.0 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:139.00 stddev:17.18 (12.4%) stddev-sans-first:17.55 13:07:22 INFO - PROCESS | 9581 | Values: 150.0 124.0 123.0 167.0 128.0 124.0 152.0 121.0 155.0 124.0 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | [#2] audio-dft Cycles:10 Average:161.80 Median:161.00 stddev:2.97 (1.8%) stddev-sans-first:3.08 13:07:22 INFO - PROCESS | 9581 | Values: 160.0 161.0 170.0 160.0 162.0 161.0 160.0 162.0 161.0 161.0 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:13.53 (17.8%) stddev-sans-first:14.08 13:07:22 INFO - PROCESS | 9581 | Values: 75.0 77.0 76.0 111.0 76.0 77.0 77.0 76.0 105.0 75.0 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:86.00 stddev:19.55 (22.7%) stddev-sans-first:20.27 13:07:22 INFO - PROCESS | 9581 | Values: 86.0 86.0 119.0 86.0 85.0 86.0 126.0 86.0 85.0 132.0 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:07:22 INFO - PROCESS | 9581 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.00 stddev:2.01 (1.4%) stddev-sans-first:2.13 13:07:22 INFO - PROCESS | 9581 | Values: 147.0 147.0 146.0 145.0 152.0 145.0 146.0 146.0 146.0 146.0 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 13:07:22 INFO - PROCESS | 9581 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 94.0 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:2.81 (4.3%) stddev-sans-first:2.87 13:07:22 INFO - PROCESS | 9581 | Values: 63.0 63.0 63.0 63.0 72.0 66.0 67.0 65.0 64.0 65.0 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 13:07:22 INFO - PROCESS | 9581 | Values: 65.0 64.0 65.0 65.0 66.0 66.0 65.0 66.0 65.0 65.0 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:4.35 (5.4%) stddev-sans-first:4.59 13:07:22 INFO - PROCESS | 9581 | Values: 82.0 84.0 78.0 78.0 87.0 77.0 76.0 78.0 78.0 88.0 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:131.00 stddev:11.19 (8.5%) stddev-sans-first:11.77 13:07:22 INFO - PROCESS | 9581 | Values: 130.0 131.0 128.0 127.0 129.0 130.0 133.0 131.0 165.0 136.0 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.00 stddev:2.26 (1.4%) stddev-sans-first:2.39 13:07:22 INFO - PROCESS | 9581 | Values: 164.0 169.0 165.0 165.0 163.0 165.0 163.0 162.0 168.0 163.0 13:07:22 INFO - PROCESS | 9581 | 13:07:22 INFO - PROCESS | 9581 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:2.23 (3.3%) stddev-sans-first:2.33 13:07:22 INFO - PROCESS | 9581 | Values: 67.0 69.0 71.0 67.0 67.0 71.0 71.0 65.0 67.0 66.0 13:07:22 INFO - PROCESS | 9581 | -------- Summary: end -------- 13:07:22 INFO - PROCESS | 9581 | 13:07:23 INFO - TEST-INFO | 9581: exit 0 13:07:23 INFO - TEST-OK | kraken | took 63935ms 13:07:23 INFO - SUITE-END | took 1183s 13:07:23 INFO - Completed test suite (00:19:43) 13:07:23 INFO - javascript benchmark 13:07:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2592.4426248356604, 2601.323655849481, 2619.279698083027, 2621.8689065546723, 2624.6850377954647, 4686.968866849288, 4728.125296820086, 4732.479427262998, 4757.310190022445, 4790.568848803607, 4684.531546845314, 4714.882127946803, 4724.952750472494, 4753.33453316536, 4773.618110551156, 4106.486689163855, 4248.065425606369, 4336.457942757155, 4366.01764602965, 4455.621272191867, 4366.476022877259, 4399.626031787302, 4401.427814384126, 4421.314696222091, 4447.822087116511, 4274.187904298189, 4292.18448494785, 4322.113966636832, 4355.60799528044, 4380.846670366554, 4394.868153955386, 4419.580139886705, 4424.646028317727, 4447.5552444755585, 4447.933281000787, 4378.824847006116, 4392.978035109804, 4410.933835992462, 4411.316245981878, 4450.977745111254, 4610.861674149781, 4707.835225767116, 4749.335093086971, 4763.952360476385, 4860.125177468054, 5116.923246151311, 5162.845114646567, 5182.222666600002, 5186.170212765977, 5189.403218629868, 5199.584033277329, 5208.9739551302, 5211.557017653504, 5212.6872387656485, 5228.816991405282, 4624.630029597624, 4691.976540117345, 4695.976520117378, 4699.553542413465, 4800.063987522434, 5171.922421163686, 5180.6891586504935, 5187.247849061865, 5250.343707036621, 5254.211868219798, 4988.201887697951, 4999.850004499871, 5062.7468626568525, 5063.0, 5068.619853511002, 5009.0, 5090.10923088458, 5113.923291150636, 5119.769610367543, 5142.794288228504, 5060.645754797129, 5097.898042039138, 5102.260172275, 5102.311187989574, 5154.098032844237, 4943.752812359367, 5045.924311135336, 5046.84859454217, 5058.114829904752, 5067.087924173684, 4186.5604111568455, 4331.155424692155, 4332.935005974913, 4338.3709362142945, 4415.337699345059, 3770.2271034437877, 3793.7534060285993, 3795.3737633290198, 3828.75113117652, 3834.884953451401, 4332.198543269442, 4338.783060846945, 4343.587359200871, 4386.100849325944, 4387.956120438818, 4997.600191984632, 5077.339945807022, 5100.7959681613065, 5128.871778205575, 5143.0, 4280.101178752435, 4290.377895205178, 4305.117450922553, 4310.073334233155, 4355.8475453359615, 4465.7767111644935, 4603.677742558056, 4604.493505714368, 4608.28571571407, 4634.606058485067, 4693.530646935347, 4730.337752714554, 4735.266033764772, 4751.952480475151, 4755.144074066701, 5057.418396884405, 5093.414257360303, 5093.567046801063, 5110.8466745997675, 5137.5889928806355, 4595.058013107238, 4699.600533954652, 4760.16697078003, 4764.690295130806, 4821.4696383397095, 5008.048470790538, 5045.646804723634, 5063.87340316495, 5067.797288108434, 5109.20807274873, 5128.820491282787, 5142.76857541404, 5146.356705411824, 5147.40804807452, 5195.220716892345, 4851.369321988119, 4888.95111048885, 4894.9021019578695, 4980.302757614009, 4990.625703072356, 4940.308356829974, 4961.627877909244, 4964.106460837084, 4966.155753521838, 4992.900141997213, 4881.731504767272, 4892.80428782859, 4895.6083513318135, 4916.606671466203, 4934.185859333314, 4848.733319667452, 4907.779149938333, 4943.703377797344, 4965.652404331662, 5052.9747351263, 4783.928241076456, 4814.277858321139, 4828.734419606955, 4830.903381932412, 4879.682820616648], "value": 4665.233385898181, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.001485130583, 571.0919637775938, 580.448573854838, 583.3641330949265, 593.1488314269023, 27659.308517287052, 28422.14733557994, 30110.397792044147, 30258.243543911387, 40374.39438408419, 36256.01183869772, 41510.37734433978, 42079.57920420795, 42214.57785422145, 42218.7889060555, 7808.219178082189, 7937.087234967966, 7945.086315073754, 7945.72189973351, 7948.046234451874, 7549.660265288047, 7856.4893281936775, 7953.403494737918, 10264.640737574186, 10518.579256829718, 10132.240081993843, 10471.057604815565, 10524.736881577945, 10539.789204215911, 10548.683539493828, 10367.429791361472, 10463.0, 10469.0, 10472.0, 10479.79040419195, 10331.380117192992, 10428.270021098526, 10432.739181520446, 10439.321444106185, 10447.582096716122, 40136.197276054605, 40495.392569111485, 40552.391714124315, 40570.59429405727, 40603.18793624111, 2735.480258750831, 2871.9856400717863, 2922.7515661168827, 2935.765138788892, 3162.683731626842, 30261.697383026327, 30473.695263047528, 30678.539821902465, 31167.844160779277, 31192.0, 3533.1873669056263, 3540.309639620275, 3566.857325706969, 3601.8559257629663, 3640.5449318835144, 261370.0, 262593.0, 262987.0, 263707.68146159337, 264379.0, 57134.714326428104, 57325.980772019175, 57767.42232577704, 57799.422005780245, 57882.13176802267, 61258.38741612616, 61310.38689613136, 61396.386036139964, 61529.38470615326, 61637.691811541554, 12460.0, 12488.50045998168, 12635.747285054247, 12648.494060237488, 12735.23588584688, 9792.21662267017, 9908.603655853829, 11544.134189935621, 11927.1650984432, 11934.28394296345, 18444.0, 18827.52931176704, 18912.52718682044, 19178.232870685017, 19314.613707725766, 6966.756163534252, 7046.365827075588, 7210.67551960163, 7259.564426134449, 7352.852942941111, 803.6423791412765, 885.9114088591218, 908.7500937242311, 954.3707086975338, 963.1476143612813, 28093.438131237668, 28791.56812647812, 28813.711862881104, 28865.23938887928, 29492.115236542937, 961.9615215391445, 973.6105557776946, 991.5141580625442, 1023.5701005577675, 1069.4813015687384, 15271.312790924436, 15297.694046119015, 15352.014833250843, 15438.84561154374, 15590.9220453897, 345983.0, 350369.0, 351183.0, 351657.0, 352500.0, 49649.0, 50524.0, 50554.241686374735, 50559.0, 50647.24029139566, 1057.0856209378833, 1086.7174534620897, 1087.380193289833, 1167.8131498960126, 1168.2581560709011, 19922.876622473254, 31409.21476963094, 32276.35447290994, 32461.837690811393, 32559.348813023134, 40949.59050409458, 41351.37972930469, 41375.7931210342, 41408.792956035024, 41440.0, 304201.0, 305930.0, 306443.0, 306511.0, 307655.0, 32798.18004549905, 32997.17507062342, 33125.17187070246, 33718.325633487686, 33822.83088584541, 46852.531474684816, 47409.52590474051, 47856.282155766996, 48145.0, 48190.27714584214, 37396.0, 37432.81283593565, 37615.43576846295, 38104.047398814146, 38708.225835483696, 37490.62509374871, 38099.42850857295, 38162.23675526418, 38396.0, 38494.80752596219, 31432.37135257328, 32059.358812823146, 32599.511007334433, 32645.673543264264, 32649.836750816095, 31952.84023579867, 33630.0, 33787.83106084552, 33901.0, 33994.490082648284, 25318.240452786446, 25801.741982579933, 25996.970469577245, 25999.480010400064, 26204.475910482066], "value": 18249.97363809065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.1225770408724, 370.32231017238456, 371.50218706932714, 382.9846806127755, 384.60770014585125, 16464.094474803882, 17001.489955301346, 17612.295508179657, 17617.735733964, 17636.735448968277, 16840.83159168408, 17239.91380043098, 17955.192016359262, 17956.281748730034, 17980.910095449537, 4950.405951285842, 5126.5642420394315, 5156.071907056728, 5164.767585458663, 5165.328507294065, 3729.160938788778, 3922.1371298314325, 5868.2371291732015, 6178.25860896693, 6188.381161883798, 5987.191729116557, 6168.167297414837, 6176.629402235858, 6196.504279657639, 6201.782937597162, 6184.412480814315, 6194.287656919444, 6203.596766210205, 6215.098810672473, 6222.9066564001805, 3433.261848702541, 5016.523430274118, 5309.946900530984, 5342.332208473941, 5433.809816656398, 21702.89148554263, 21870.23454179096, 22269.44326391837, 22341.218057367914, 22710.432239193986, 1769.9469015929542, 1913.8277555020115, 1929.7973712760238, 2011.4569066352149, 2144.92610105712, 9097.954510227406, 10833.0, 12669.303188324639, 12949.54676586315, 13366.599002029858, 1705.2399261689488, 1710.8802383833136, 1731.471901070173, 1756.6398888227882, 1839.5375676337344, 71971.28028719698, 74703.62648186779, 74817.25182748157, 75564.0, 75903.99999999945, 10072.899271007343, 10083.19334453242, 10132.645357412603, 10344.37933723979, 10382.532786024647, 14007.649808754659, 14038.578842634737, 14064.43742250319, 14102.788458173136, 14104.08323458972, 6897.827554311082, 6918.723251070001, 6938.930610693929, 6975.232724400312, 7068.964655176691, 6514.446272066927, 6529.934700652932, 6709.496787740939, 6756.0, 6756.2568117507035, 4256.39575551023, 4336.1978034063795, 4366.930102124936, 4413.426254586947, 4417.403650507141, 1610.2270909963283, 1623.7564365345293, 1704.3949397963793, 1800.558863078528, 1881.8494520438333, 807.3662175192446, 834.7370578267826, 864.386285737121, 912.224609082288, 914.8444764390069, 16751.0, 17017.820933743173, 17317.913410432866, 17626.64746705059, 17710.468685939442, 860.6686425726016, 862.166985530031, 876.8469462656714, 878.6441491196076, 915.0712027292303, 9784.853227201598, 9933.50332483373, 9973.601055957826, 9987.201023918069, 10011.048950349705, 342989.0, 347224.0, 348873.0, 351278.0, 351419.0, 76838.23161768311, 77235.2276477228, 78406.0, 78745.60627196942, 79290.60354698189, 837.388706244445, 875.2429148786254, 880.6125304865839, 886.5079880666163, 894.0523045571715, 16221.270042847864, 16374.83625163733, 16468.0, 16691.332346705996, 16741.0, 39137.80431097826, 39597.30872664307, 40065.1986960265, 40239.1952160961, 41340.37989430221, 55124.72437637786, 56704.432955669916, 56718.14922776244, 56738.432615673315, 57736.0, 7112.893306600302, 7368.115826100902, 7475.738349157753, 7511.0, 7562.319391254813, 10839.783204336027, 11131.165162612675, 11508.539658413905, 11523.942380288045, 11618.244814087057, 4738.07607516531, 5091.923621145612, 9004.954975225082, 9975.20198384113, 10239.897601024193, 9316.720498385059, 9377.765555861159, 9739.220862330854, 9962.153216976349, 10012.899871001197, 9853.605855765689, 9936.105750482491, 10029.498525073863, 10404.47977601132, 10528.210384221062, 7295.817604559928, 7303.269673032654, 7354.8896766549615, 7435.851282974419, 7567.659455324634, 8858.335624828034, 9633.229341652792, 9685.370450920667, 9780.0, 10362.689119326433], "value": 8256.932437825213, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1262.1921969939235, 1379.1656048090904, 1443.49477682811, 1520.2930637253676, 1739.2781995471887, 6790.966045169774, 7711.113221979467, 7969.800754981128, 7974.96012519938, 8202.589870506466, 7977.20227977202, 8000.679972801081, 8044.195580441953, 8049.396295277848, 8054.758357249292, 1871.840893524052, 2135.3380452059832, 2214.568159208959, 2244.427670943907, 2246.7528571857083, 2240.529488807352, 2263.841531092816, 2267.3424706835, 2272.7954484096426, 2276.6698828669832, 2173.2393662218255, 2195.4291884110166, 2198.714167158267, 2198.9340319790354, 2203.316971738758, 1814.8911065336122, 2071.513194399315, 2144.292383513437, 2146.5063035501844, 2153.3862849087936, 2176.401489590375, 2198.527316626933, 2199.3182113544854, 2199.417154454071, 2200.482886521666, 8002.479838810459, 8037.839243215103, 8048.074471435802, 8051.557164355958, 8053.4765240259785, 4590.655700822452, 4694.29585562165, 4702.1771190041945, 4704.247320428749, 4708.058388322349, 2849.957250641242, 2952.8375939323328, 2961.3781105967773, 2967.866446009935, 2974.078035808906, 898.874157617934, 919.0946917286467, 930.5393830054098, 950.064186776025, 955.3217215776807, 10872.293300935415, 10877.83683244752, 10878.857719939371, 10913.23607347478, 10940.835887461615, 4080.3063479208604, 4160.105577300835, 4327.935080973788, 4340.8480703175865, 4342.696011279243, 9360.251179905592, 9361.063893610584, 9388.577514011886, 9408.106229908148, 9408.43549387039, 4697.389339385926, 4710.764461776897, 4715.552022557851, 4724.126036683225, 4741.644376671695, 3570.767900086486, 4198.097409057006, 4305.784710764512, 4346.043870348518, 4346.195953748566, 3651.087228192952, 3687.631236876291, 3773.056735816046, 3810.5236845394325, 3819.961800382016, 1209.625016244967, 1211.715246916974, 1212.3332167308122, 1215.6474622359417, 1218.232513516479, 500.98300450086384, 558.1655425139361, 651.563452486835, 688.7435647697279, 716.7133146741345, 4931.334269873593, 5046.091703493406, 5109.259157422153, 5120.769565369567, 5189.040027594907, 887.5695287785419, 887.8978917424449, 903.2954295649273, 904.4889637354873, 906.0531744327194, 3248.3990461764647, 3393.7794043387103, 3426.880059197916, 3454.687218856818, 3508.5965114011706, 9457.763555911157, 9700.0, 9726.221902247804, 9777.511124443748, 9796.26528010402, 9706.70879873605, 9709.0, 9714.854277185848, 9715.659951901649, 9742.61029558824, 7362.521436106743, 7447.813804654927, 7498.100227972678, 7504.174540800507, 7517.586532740643, 5061.114304996685, 5180.274761533464, 5201.895962080813, 5205.011047900886, 5288.365396152486, 8862.512561809162, 9048.547572621474, 9083.409578377385, 9244.768880778034, 9261.0, 9143.862842057242, 9197.540122993958, 9279.304052195977, 9365.969743328365, 9480.099390557885, 5916.970415148069, 6530.575512591667, 6743.089682892747, 6786.558873673195, 6863.828404289933, 7257.165425976081, 7284.089488813898, 7321.816954575965, 7370.115586129698, 7380.926190738239, 6448.580842245239, 6682.3317668232785, 6719.865602688016, 6773.458123350219, 6862.279460656759, 6502.43941454057, 6527.314631963765, 6542.738290468328, 6587.077809106825, 6607.867842643216, 5931.6441013539325, 5990.400959903975, 5995.46040856325, 6000.0, 6009.609375390585, 4302.978485107555, 4367.65058795302, 4390.297552391602, 4438.755868427267, 4481.843135490242, 4450.46594408673, 4501.864944051684, 4539.364488971612, 4545.181867263925, 4609.446866376056], "value": 4116.133478686263, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.64722567628985, 288.82381747134247, 292.8447922601021, 298.26180203995114, 304.80644790558, 4942.1845395509745, 4992.201247800353, 5000.274960130783, 5014.849554513361, 5015.348004759376, 4860.2709593560985, 4890.119778439879, 4948.851534453963, 4960.925586116211, 4962.70223786573, 3634.636536346364, 3774.2451509698035, 3776.30138424391, 3778.8299526521373, 3779.489768881207, 3741.6071312512204, 3757.1734218471893, 3883.533975922879, 3886.2810380079636, 3907.6873850091924, 3806.3529200035923, 3831.386978083507, 3834.8082595870096, 3839.9808000960097, 3883.8446462141483, 3770.009768645095, 3805.124821291091, 3824.330742120118, 3845.750026248299, 3871.7483363581277, 3391.6947474727394, 3399.3201359727905, 3403.5915690117095, 3413.8805141819917, 3414.2830005698834, 4748.905021899577, 4754.833580824655, 4793.058811181477, 4793.089313030513, 4800.879978000543, 4176.477940257468, 4347.174036932973, 4347.630451411634, 4363.6072753452345, 4367.126574685076, 5097.7196254206, 5108.591312694975, 5116.232565115225, 5152.381714194321, 5161.638685292031, 3631.2374401375478, 3642.25333806569, 3661.2311414602964, 3668.596454390015, 3672.8347224374966, 5224.399194092652, 5332.280142180794, 5370.3287089113865, 5416.539594134503, 5432.972835135839, 3694.9815250923575, 3703.9629603704157, 3716.201016781405, 3716.680578394685, 3724.8696295629525, 3781.6532368853764, 3786.848526058927, 3789.3936970084656, 3790.6019867913474, 3791.450239715226, 4311.07311927937, 4316.978415107905, 4326.329418940069, 4332.371806088099, 4335.284678028153, 4872.707637541759, 5077.949220507748, 5085.669431486942, 5118.36212412032, 5125.410577783603, 1281.2568710148091, 1305.6670549009941, 1307.8038294255937, 1317.3084130831198, 1317.308413083139, 798.2855344466669, 808.8988876390451, 828.6105530400702, 843.7384410832661, 844.4679851693394, 4272.230998420252, 4440.4005459263235, 4449.310356894686, 4460.3532487789735, 4464.120642185772, 5221.0, 5221.034108689904, 5221.511869117283, 5251.0, 5265.815696450606, 4444.866654000385, 4451.977740111279, 4453.354263631755, 4460.955390446119, 4466.3523789050405, 2646.642703235077, 2809.789265805032, 2813.268550176928, 2817.492851286788, 2821.7460428561526, 4924.704517728876, 4941.752912354368, 4950.2822090796635, 4952.504749525018, 4956.207006878882, 5273.444333921502, 5412.269343638637, 5437.700926449083, 5444.455554444603, 5475.534579560703, 4958.082754690249, 4965.975170124127, 4968.552830245295, 4976.377952755905, 4981.206765564394, 5295.947040529545, 5296.682199068068, 5320.334958130234, 5324.201369794562, 5341.893162136813, 5030.496950304941, 5144.6655967363495, 5160.890408562177, 5260.473952604709, 5267.367915850123, 4916.557509824133, 4917.385326834145, 4928.507149285187, 4936.777844996912, 4945.752712364296, 3403.6936675699308, 3468.358353704573, 3473.496343030297, 3475.704565111893, 3485.9477107842895, 4617.330487079422, 4781.42622885256, 4799.208130658542, 4800.831970881002, 4819.325294458708, 4609.539046095364, 4625.907481850277, 4635.93046104302, 4639.170106235261, 4648.651890951586, 4559.863204103882, 4564.224081906017, 4568.314752787109, 4600.516945720651, 4633.258678611406, 4314.395984562101, 4511.954880451285, 4519.48597219935, 4526.921693248622, 4556.703814252063, 4681.689127044433, 4924.335214745964, 5058.597166345956, 5064.2403639452905, 5064.5948324134715, 4863.489333619919, 4875.7074575525585, 4914.8771280718265, 4983.227599722049, 5037.345145131109], "value": 3794.9142957431936, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.6106315940466, 674.7840690978886, 700.2997002997002, 714.9499535032546, 720.6792977125182, 12623.179493332938, 13351.732965340687, 13513.986451016164, 13530.594082177526, 13548.932255338721, 13523.661908452294, 14160.504382346595, 14230.288485575731, 14268.928655356734, 14271.286435678227, 629.6379581740517, 766.0921807657943, 771.756896577579, 783.3967844759532, 797.5015615240475, 796.55791035975, 802.7832485228985, 804.0994086622991, 804.1074407407773, 805.3597390074905, 811.4563242627424, 821.876718492228, 822.1367564057715, 822.4448497264323, 823.1274848660439, 584.5265335078558, 599.5084031094505, 650.9869802603921, 818.2799136759643, 818.4925346285281, 436.415203627138, 436.4457139432934, 436.6397721879462, 436.7772436057634, 436.84492005337967, 13237.205767653875, 13317.467301307935, 13330.73338533224, 13348.399322030435, 13353.599392018255, 12273.140880138393, 12659.177153484994, 12882.80675789864, 12900.612981610566, 13139.247459489132, 11914.0, 11923.642290731292, 12049.457774400173, 12109.15235933485, 12373.195742276723, 4247.171801498709, 4313.61177494027, 4324.589164029412, 4354.0, 4467.218236808578, 65379.34620653828, 66396.6680166596, 66596.66701666509, 66611.0, 66859.3314066858, 10604.628837990633, 10635.574577016987, 10639.734006649896, 10906.890931090746, 11063.612773553048, 19378.321758738377, 20152.29466968649, 20178.0, 21195.576088478145, 21211.46971325729, 7362.079740032496, 7365.410767138723, 7379.446541509408, 7451.552906825608, 7506.399488040944, 3672.3022625701033, 3695.316366472211, 3774.207416442523, 3837.9232415351535, 3868.1490072184074, 2942.7940044196703, 3053.6335639723375, 3055.144559523337, 3056.6026416565705, 3059.495183294776, 509.6381569085916, 521.7182721330515, 526.2238198656951, 535.2319421629895, 535.8713908661971, 510.99233511497357, 527.8759491519489, 585.4906231578553, 587.9147523609053, 588.7615515716142, 8130.959345203354, 8250.752477425687, 8362.498250105013, 8773.649054037895, 8884.244839188612, 491.33424210195386, 535.9115745901883, 554.95945102932, 581.7760162337446, 640.3116649601697, 3880.902977425587, 3918.8236529356245, 4068.7762173080764, 4077.959220407817, 4093.1199792044854, 90280.0, 92215.0, 99747.0, 99798.0, 101038.0, 71331.93002104973, 83789.58105209435, 84165.0, 86747.0, 89122.0, 71377.2862271381, 74437.62781186168, 74744.62627686826, 75491.86762198572, 76459.61770191113, 8079.128668710905, 8100.149484304063, 8126.878096828434, 8337.3429431694, 8367.0, 42872.78563607162, 43178.0, 43297.13405731931, 43367.78316108399, 44701.776491117336, 36657.816710917345, 36945.0, 37058.6294137066, 45696.0, 61716.69141654263, 10396.48017599132, 10769.784604308026, 11151.219414640897, 11490.88509114898, 11619.302841829518, 13466.93266533661, 13860.306984650928, 13880.444782208599, 14278.928605356907, 14730.337134828744, 12644.55672579619, 12887.420066097236, 13006.544770932973, 13459.798103028266, 13468.326583670972, 12631.431585578855, 12871.678208044874, 12895.806562901751, 13128.721306927764, 13364.933175334061, 11236.719082023015, 11594.130440216848, 11718.88281117178, 11899.881001189877, 11966.880331196577, 10688.412137332522, 11237.55049797999, 11247.268927519684, 11371.61196148785, 11617.535298587962, 9575.726254484718, 9976.950115249667, 10092.34399764013, 10437.791244175225, 10500.894991050298], "value": 6637.263306755986, "unit": "score"}], "name": "dromaeo_css", "value": 6463.202308878065, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 115.0, 112.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 123.0, 167.0, 128.0, 124.0, 152.0, 121.0, 155.0, 124.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 170.0, 160.0, 162.0, 161.0, 160.0, 162.0, 161.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 111.0, 76.0, 77.0, 77.0, 76.0, 105.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 119.0, 86.0, 85.0, 86.0, 126.0, 86.0, 85.0, 132.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 145.0, 152.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 72.0, 66.0, 67.0, 65.0, 64.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 78.0, 78.0, 87.0, 77.0, 76.0, 78.0, 78.0, 88.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 131.0, 128.0, 127.0, 129.0, 130.0, 133.0, 131.0, 165.0, 136.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 165.0, 165.0, 163.0, 165.0, 163.0, 162.0, 168.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 71.0, 67.0, 67.0, 71.0, 71.0, 65.0, 67.0, 66.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1528.2, "alertThreshold": 2.0}]} 13:07:23 INFO - Return code: 0 13:07:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:07:24 INFO - # TBPL SUCCESS # 13:07:24 INFO - Running post-action listener: _resource_record_post_action 13:07:24 INFO - ##### 13:07:24 INFO - ##### Finished run-tests step (success) 13:07:24 INFO - ##### 13:07:24 INFO - Running post-run listener: _resource_record_post_run 13:07:24 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409702400; Read time: 12; Write time: 282720 13:07:24 INFO - TinderboxPrint: CPU usage
13.0% 13:07:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:07:24 INFO - TinderboxPrint: I/O write bytes / time
409,702,400 / 282,720 13:07:24 INFO - TinderboxPrint: CPU idle
8,331.6 (87.0%) 13:07:24 INFO - TinderboxPrint: CPU user
1,205.1 (12.6%) 13:07:24 INFO - TinderboxPrint: Swap in / out
0 / 0 13:07:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 125534208; Read time: 0; Write time: 92072 13:07:24 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284168192; Read time: 0; Write time: 190648 13:07:24 INFO - Running post-run listener: _upload_blobber_files 13:07:24 INFO - Blob upload gear active. 13:07:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:07:24 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 13:07:24 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:07:24 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:07:25 INFO - (blobuploader) - INFO - Open directory for files ... 13:07:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:07:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:07:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:07:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:07:25 INFO - (blobuploader) - INFO - Done attempting. 13:07:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:07:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:07:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:07:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:07:26 INFO - (blobuploader) - INFO - Done attempting. 13:07:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:07:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:07:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:07:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:07:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:07:29 INFO - (blobuploader) - INFO - Done attempting. 13:07:29 INFO - (blobuploader) - INFO - Iteration through files over. 13:07:29 INFO - Return code: 0 13:07:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:07:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:07:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e186127e9cf9b9a05054cc72ae6b5dca5a12131e315cbac1328910293a8b2cb605f9c7169c0f759989590bf04a8062f73834c7eecd74c70126a889725167aee0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e42abf48a46c248b862acd755c55534c7fbbe3a0eb29eb5813b219c5130b257ea1ca73f6e5369dd5580f7cf7240b674788ef348e4a78752500056e2473840aa6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93fcbf9d8179f817fb12668486b7bcb441e226a3a66a89ae8b7d8b4ab33ea9e296433c1d78ed46398740d3957105d56b7190a09f933c72177a83a5e1eda79486"} 13:07:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:07:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:07:29 INFO - Contents: 13:07:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e186127e9cf9b9a05054cc72ae6b5dca5a12131e315cbac1328910293a8b2cb605f9c7169c0f759989590bf04a8062f73834c7eecd74c70126a889725167aee0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e42abf48a46c248b862acd755c55534c7fbbe3a0eb29eb5813b219c5130b257ea1ca73f6e5369dd5580f7cf7240b674788ef348e4a78752500056e2473840aa6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93fcbf9d8179f817fb12668486b7bcb441e226a3a66a89ae8b7d8b4ab33ea9e296433c1d78ed46398740d3957105d56b7190a09f933c72177a83a5e1eda79486"} 13:07:29 INFO - Running post-run listener: copy_logs_to_upload_dir 13:07:29 INFO - Copying logs to upload dir... 13:07:29 INFO - mkdir: /builds/slave/test/build/upload/logs 13:07:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.818233 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-07 13:07:29.892234) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 13:07:29.895498) ========= 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=7de08804244eb36560b44971000001c3-1467920798.662274-898473575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e186127e9cf9b9a05054cc72ae6b5dca5a12131e315cbac1328910293a8b2cb605f9c7169c0f759989590bf04a8062f73834c7eecd74c70126a889725167aee0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e42abf48a46c248b862acd755c55534c7fbbe3a0eb29eb5813b219c5130b257ea1ca73f6e5369dd5580f7cf7240b674788ef348e4a78752500056e2473840aa6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93fcbf9d8179f817fb12668486b7bcb441e226a3a66a89ae8b7d8b4ab33ea9e296433c1d78ed46398740d3957105d56b7190a09f933c72177a83a5e1eda79486"} build_url:https://queue.taskcluster.net/v1/task/KHryqjOxRjutCCJXVZtgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011133 build_url: 'https://queue.taskcluster.net/v1/task/KHryqjOxRjutCCJXVZtgwg/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/Firefox-Non-PGO/sha512/e186127e9cf9b9a05054cc72ae6b5dca5a12131e315cbac1328910293a8b2cb605f9c7169c0f759989590bf04a8062f73834c7eecd74c70126a889725167aee0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e42abf48a46c248b862acd755c55534c7fbbe3a0eb29eb5813b219c5130b257ea1ca73f6e5369dd5580f7cf7240b674788ef348e4a78752500056e2473840aa6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93fcbf9d8179f817fb12668486b7bcb441e226a3a66a89ae8b7d8b4ab33ea9e296433c1d78ed46398740d3957105d56b7190a09f933c72177a83a5e1eda79486"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 13:07:29.921308) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 13:07:29.921649) ========= 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=7de08804244eb36560b44971000001c3-1467920798.662274-898473575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 13:07:30.003317) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 13:07:30.003702) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 13:07:30.004050) ========= ========= Total master_lag: 0.25 =========