builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1468600394.85 results: success (0) buildid: 20160715071456 builduid: 2def54cf46424ce78440e660d78fc895 revision: 683bf5d3c1cdd76799d7da01d3a0cd2dbb42e8f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 09:33:14.847145) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 09:33:14.847654) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 09:33:14.847997) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 09:33:14.885860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:33:14.886167) ========= 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=523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 09:33:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-07-15 09:33:15 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.301946 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:33:15.202092) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:33:15.202407) ========= 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=523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017879 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:33:15.251974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:33:15.252358) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 683bf5d3c1cdd76799d7da01d3a0cd2dbb42e8f9 --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 683bf5d3c1cdd76799d7da01d3a0cd2dbb42e8f9 --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=523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 09:33:15,446 truncating revision to first 12 chars 2016-07-15 09:33:15,446 Setting DEBUG logging. 2016-07-15 09:33:15,446 attempt 1/10 2016-07-15 09:33:15,446 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/683bf5d3c1cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 09:33:15,756 unpacking tar archive at: mozilla-central-683bf5d3c1cd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609412 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:33:15.875757) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 09:33:15.876118) ========= script_repo_revision: 683bf5d3c1cdd76799d7da01d3a0cd2dbb42e8f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 09:33:15.876542) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 09:33:15.876830) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 09:33:15.887413) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-15 09:33:15.887753) ========= /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=523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:33:16 INFO - MultiFileLogger online at 20160715 09:33:16 in /builds/slave/test 09:33:16 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 09:33:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:33:16 INFO - {'append_to_log': False, 09:33:16 INFO - 'base_work_dir': '/builds/slave/test', 09:33:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:33:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:33:16 INFO - 'branch': 'Firefox-Non-PGO', 09:33:16 INFO - 'buildbot_json_path': 'buildprops.json', 09:33:16 INFO - 'config_files': ('talos/linux_config.py',), 09:33:16 INFO - 'default_actions': ('clobber', 09:33:16 INFO - 'read-buildbot-config', 09:33:16 INFO - 'download-and-extract', 09:33:16 INFO - 'populate-webroot', 09:33:16 INFO - 'create-virtualenv', 09:33:16 INFO - 'install', 09:33:16 INFO - 'run-tests'), 09:33:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:33:16 INFO - 'download_minidump_stackwalk': True, 09:33:16 INFO - 'download_symbols': 'ondemand', 09:33:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:33:16 INFO - 'tooltool.py': '/tools/tooltool.py', 09:33:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:33:16 INFO - '/tools/misc-python/virtualenv.py')}, 09:33:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:33:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:33:16 INFO - 'installer_path': 'installer.exe', 09:33:16 INFO - 'log_level': 'info', 09:33:16 INFO - 'log_name': 'talos', 09:33:16 INFO - 'log_to_console': True, 09:33:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:33:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:33:16 INFO - 'opt_config_files': (), 09:33:16 INFO - 'pip_index': False, 09:33:16 INFO - 'sps_profile': False, 09:33:16 INFO - 'sps_profile_interval': 0, 09:33:16 INFO - 'suite': 'dromaeojs', 09:33:16 INFO - 'system_bits': '32', 09:33:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:33:16 INFO - 'title': 'talos-linux64-ix-065', 09:33:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:33:16 INFO - 'use_talos_json': True, 09:33:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:33:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:33:16 INFO - 'work_dir': 'build'} 09:33:16 INFO - ##### 09:33:16 INFO - ##### Running clobber step. 09:33:16 INFO - ##### 09:33:16 INFO - Running pre-action listener: _resource_record_pre_action 09:33:16 INFO - Running main action method: clobber 09:33:16 INFO - rmtree: /builds/slave/test/build 09:33:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:33:16 INFO - Running post-action listener: _resource_record_post_action 09:33:16 INFO - ##### 09:33:16 INFO - ##### Finished clobber step (success) 09:33:16 INFO - ##### 09:33:16 INFO - ##### 09:33:16 INFO - ##### Running read-buildbot-config step. 09:33:16 INFO - ##### 09:33:16 INFO - Running pre-action listener: _resource_record_pre_action 09:33:16 INFO - Running main action method: read_buildbot_config 09:33:16 INFO - Using buildbot properties: 09:33:16 INFO - { 09:33:16 INFO - "project": "", 09:33:16 INFO - "product": "firefox", 09:33:16 INFO - "script_repo_revision": "production", 09:33:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:33:16 INFO - "repository": "", 09:33:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:33:16 INFO - "buildid": "20160715071456", 09:33:16 INFO - "pgo_build": "False", 09:33:16 INFO - "basedir": "/builds/slave/test", 09:33:16 INFO - "buildnumber": 562, 09:33:16 INFO - "slavename": "talos-linux64-ix-065", 09:33:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:33:16 INFO - "platform": "ubuntu64_hw", 09:33:16 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:33:16 INFO - "branch": "mozilla-central", 09:33:16 INFO - "repo_path": "mozilla-central", 09:33:16 INFO - "revision": "683bf5d3c1cdd76799d7da01d3a0cd2dbb42e8f9", 09:33:16 INFO - "stage_platform": "linux64", 09:33:16 INFO - "builduid": "2def54cf46424ce78440e660d78fc895", 09:33:16 INFO - "slavebuilddir": "test" 09:33:16 INFO - } 09:33:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:33:16 INFO - Running post-action listener: _resource_record_post_action 09:33:16 INFO - ##### 09:33:16 INFO - ##### Finished read-buildbot-config step (success) 09:33:16 INFO - ##### 09:33:16 INFO - ##### 09:33:16 INFO - ##### Running download-and-extract step. 09:33:16 INFO - ##### 09:33:16 INFO - Running pre-action listener: _resource_record_pre_action 09:33:16 INFO - Running main action method: download_and_extract 09:33:16 INFO - mkdir: /builds/slave/test/build/tests 09:33:16 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')]} 09:33:16 INFO - https://queue.taskcluster.net/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:33:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:33:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:33:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/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 09:33:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/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 09:33:23 INFO - Downloaded 1361 bytes. 09:33:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:33:23 INFO - Using the following test package requirements: 09:33:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:33:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:33:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:33:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:23 INFO - u'jsshell-linux-x86_64.zip'], 09:33:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:33:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:33:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:33:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:33:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:33:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:33:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:33:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:23 INFO - https://queue.taskcluster.net/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:33:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:33:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:33:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/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 09:33:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/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 09:33:26 INFO - Downloaded 22756641 bytes. 09:33:26 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'] 09:33:26 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 09:33:27 INFO - Return code: 0 09:33:27 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 09:33:27 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')]} 09:33:27 INFO - https://queue.taskcluster.net/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:33:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:33:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:33:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/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 09:33:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/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 09:33:32 INFO - Downloaded 22756641 bytes. 09:33:32 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'] 09:33:32 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 09:33:34 INFO - Return code: 0 09:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:34 INFO - https://queue.taskcluster.net/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:33:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:33:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:33:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/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 09:33:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/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 09:33:35 INFO - Downloaded 14403317 bytes. 09:33:35 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'] 09:33:35 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 09:33:35 INFO - Return code: 0 09:33:35 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')]} 09:33:35 INFO - https://queue.taskcluster.net/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:33:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:33:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:33:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/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 09:33:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/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 09:33:36 INFO - Downloaded 57045991 bytes. 09:33:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:33:36 INFO - mkdir: /builds/slave/test/properties 09:33:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:33:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:33:36 INFO - Contents: 09:33:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:33:37 INFO - Running post-action listener: _resource_record_post_action 09:33:37 INFO - Running post-action listener: set_extra_try_arguments 09:33:37 INFO - ##### 09:33:37 INFO - ##### Finished download-and-extract step (success) 09:33:37 INFO - ##### 09:33:37 INFO - ##### 09:33:37 INFO - ##### Running populate-webroot step. 09:33:37 INFO - ##### 09:33:37 INFO - Running pre-action listener: _resource_record_pre_action 09:33:37 INFO - Running main action method: populate_webroot 09:33:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:33:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:33:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:33:37 INFO - '--tppagecycles', 09:33:37 INFO - '7'], 09:33:37 INFO - 'tests': ['tsvgm']}}, 09:33:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:33:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:33:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:33:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:33:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:33:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:33:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:37 INFO - 'talos_options': ['--disable-e10s'], 09:33:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:37 INFO - 'talos_options': ['--disable-e10s'], 09:33:37 INFO - 'tests': ['damp', 'tps']}, 09:33:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:37 INFO - 'tests': ['damp', 'tps']}, 09:33:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:33:37 INFO - 'tests': ['dromaeo_dom']}, 09:33:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:33:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:33:37 INFO - 'tests': ['basic_compositor_video']}, 09:33:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:33:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:33:37 INFO - 'tests': ['a11yr', 09:33:37 INFO - 'ts_paint', 09:33:37 INFO - 'tpaint', 09:33:37 INFO - 'sessionrestore', 09:33:37 INFO - 'sessionrestore_no_auto_restore', 09:33:37 INFO - 'tabpaint']}, 09:33:37 INFO - 'other-e10s': {'tests': ['a11yr', 09:33:37 INFO - 'ts_paint', 09:33:37 INFO - 'tpaint', 09:33:37 INFO - 'sessionrestore', 09:33:37 INFO - 'sessionrestore_no_auto_restore', 09:33:37 INFO - 'tabpaint']}, 09:33:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:33:37 INFO - 'ts_paint', 09:33:37 INFO - 'tpaint', 09:33:37 INFO - 'sessionrestore', 09:33:37 INFO - 'sessionrestore_no_auto_restore', 09:33:37 INFO - 'tabpaint']}, 09:33:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:33:37 INFO - 'ts_paint', 09:33:37 INFO - 'tpaint', 09:33:37 INFO - 'sessionrestore', 09:33:37 INFO - 'sessionrestore_no_auto_restore', 09:33:37 INFO - 'tabpaint']}, 09:33:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:33:37 INFO - 'tests': ['a11yr', 09:33:37 INFO - 'ts_paint', 09:33:37 INFO - 'tpaint', 09:33:37 INFO - 'sessionrestore', 09:33:37 INFO - 'sessionrestore_no_auto_restore', 09:33:37 INFO - 'tabpaint']}, 09:33:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:33:37 INFO - 'tests': ['a11yr', 09:33:37 INFO - 'ts_paint', 09:33:37 INFO - 'tpaint', 09:33:37 INFO - 'sessionrestore', 09:33:37 INFO - 'sessionrestore_no_auto_restore', 09:33:37 INFO - 'tabpaint']}, 09:33:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:33:37 INFO - 'tests': ['tsvgx', 09:33:37 INFO - 'tsvgr_opacity', 09:33:37 INFO - 'tart', 09:33:37 INFO - 'tscrollx', 09:33:37 INFO - 'cart']}, 09:33:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:33:37 INFO - 'tsvgr_opacity', 09:33:37 INFO - 'tart', 09:33:37 INFO - 'tscrollx', 09:33:37 INFO - 'cart']}, 09:33:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:37 INFO - 'talos_options': ['--disable-e10s'], 09:33:37 INFO - 'tests': ['tp5o']}, 09:33:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:37 INFO - 'tests': ['tp5o']}, 09:33:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:37 INFO - 'talos_options': ['--disable-e10s', 09:33:37 INFO - '--xperf_path', 09:33:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:37 INFO - 'tests': ['tp5n']}, 09:33:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:37 INFO - 'talos_options': ['--xperf_path', 09:33:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:37 INFO - 'tests': ['tp5n']}}, 09:33:37 INFO - 'talos.zip': {'path': '', 09:33:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:33:37 INFO - Running post-action listener: _resource_record_post_action 09:33:37 INFO - ##### 09:33:37 INFO - ##### Finished populate-webroot step (success) 09:33:37 INFO - ##### 09:33:37 INFO - ##### 09:33:37 INFO - ##### Running create-virtualenv step. 09:33:37 INFO - ##### 09:33:37 INFO - Running pre-action listener: _resource_record_pre_action 09:33:37 INFO - Running main action method: create_virtualenv 09:33:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:33:37 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 09:33:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:33:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:33:37 INFO - Using real prefix '/usr' 09:33:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:33:38 INFO - Installing distribute.............................................................................................................................................................................................done. 09:33:40 INFO - Installing pip.................done. 09:33:40 INFO - Return code: 0 09:33:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:33:40 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')]} 09:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:40 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')]} 09:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:40 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 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', '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 09:33:40 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 09:33:40 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 09:33:40 INFO - Using env: {'DISPLAY': ':0', 09:33:40 INFO - 'HOME': '/home/cltbld', 09:33:40 INFO - 'LANG': 'en_US.UTF-8', 09:33:40 INFO - 'LANGUAGE': 'en_US:en', 09:33:40 INFO - 'LOGNAME': 'cltbld', 09:33:40 INFO - 'MAIL': '/var/mail/cltbld', 09:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:40 INFO - 'MOZ_NO_REMOTE': '1', 09:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:40 INFO - 'NO_EM_RESTART': '1', 09:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:40 INFO - 'PWD': '/builds/slave/test', 09:33:40 INFO - 'SHELL': '/bin/bash', 09:33:40 INFO - 'SHLVL': '1', 09:33:40 INFO - 'TERM': 'linux', 09:33:40 INFO - 'TMOUT': '86400', 09:33:40 INFO - 'USER': 'cltbld', 09:33:40 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', 09:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:40 INFO - '_': '/tools/buildbot/bin/python'} 09:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:40 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 09:33:40 INFO - Cleaning up... 09:33:40 INFO - Return code: 0 09:33:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:33:40 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')]} 09:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:40 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')]} 09:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:40 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 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', '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 09:33:40 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 09:33:40 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 09:33:40 INFO - Using env: {'DISPLAY': ':0', 09:33:40 INFO - 'HOME': '/home/cltbld', 09:33:40 INFO - 'LANG': 'en_US.UTF-8', 09:33:40 INFO - 'LANGUAGE': 'en_US:en', 09:33:40 INFO - 'LOGNAME': 'cltbld', 09:33:40 INFO - 'MAIL': '/var/mail/cltbld', 09:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:40 INFO - 'MOZ_NO_REMOTE': '1', 09:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:40 INFO - 'NO_EM_RESTART': '1', 09:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:40 INFO - 'PWD': '/builds/slave/test', 09:33:40 INFO - 'SHELL': '/bin/bash', 09:33:40 INFO - 'SHLVL': '1', 09:33:40 INFO - 'TERM': 'linux', 09:33:40 INFO - 'TMOUT': '86400', 09:33:40 INFO - 'USER': 'cltbld', 09:33:40 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', 09:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:40 INFO - '_': '/tools/buildbot/bin/python'} 09:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:40 INFO - Downloading/unpacking psutil>=3.1.1 09:33:40 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 09:33:40 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 09:33:40 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 09:33:40 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 09:33:40 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 09:33:40 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 09:33:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:33:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:42 INFO - Installing collected packages: psutil 09:33:42 INFO - Running setup.py install for psutil 09:33:42 INFO - building 'psutil._psutil_linux' extension 09:33:42 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 09:33:43 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 09:33:43 INFO - building 'psutil._psutil_posix' extension 09:33:43 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 09:33:43 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 09:33:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:43 INFO - Successfully installed psutil 09:33:43 INFO - Cleaning up... 09:33:43 INFO - Return code: 0 09:33:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:33:43 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')]} 09:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:43 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')]} 09:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:43 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 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', '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 09:33:43 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 09:33:43 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 09:33:43 INFO - Using env: {'DISPLAY': ':0', 09:33:43 INFO - 'HOME': '/home/cltbld', 09:33:43 INFO - 'LANG': 'en_US.UTF-8', 09:33:43 INFO - 'LANGUAGE': 'en_US:en', 09:33:43 INFO - 'LOGNAME': 'cltbld', 09:33:43 INFO - 'MAIL': '/var/mail/cltbld', 09:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:43 INFO - 'MOZ_NO_REMOTE': '1', 09:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:43 INFO - 'NO_EM_RESTART': '1', 09:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:43 INFO - 'PWD': '/builds/slave/test', 09:33:43 INFO - 'SHELL': '/bin/bash', 09:33:43 INFO - 'SHLVL': '1', 09:33:43 INFO - 'TERM': 'linux', 09:33:43 INFO - 'TMOUT': '86400', 09:33:43 INFO - 'USER': 'cltbld', 09:33:43 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', 09:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:43 INFO - '_': '/tools/buildbot/bin/python'} 09:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:33:43 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 09:33:43 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 09:33:43 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 09:33:43 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 09:33:43 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 09:33:43 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 09:33:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:33:45 INFO - Installing collected packages: mozsystemmonitor 09:33:45 INFO - Running setup.py install for mozsystemmonitor 09:33:45 INFO - Successfully installed mozsystemmonitor 09:33:45 INFO - Cleaning up... 09:33:45 INFO - Return code: 0 09:33:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:33: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')]} 09:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:45 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 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', '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 09:33:45 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 09:33:45 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 09:33:45 INFO - Using env: {'DISPLAY': ':0', 09:33:45 INFO - 'HOME': '/home/cltbld', 09:33:45 INFO - 'LANG': 'en_US.UTF-8', 09:33:45 INFO - 'LANGUAGE': 'en_US:en', 09:33:45 INFO - 'LOGNAME': 'cltbld', 09:33:45 INFO - 'MAIL': '/var/mail/cltbld', 09:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:45 INFO - 'MOZ_NO_REMOTE': '1', 09:33:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:45 INFO - 'NO_EM_RESTART': '1', 09:33:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:45 INFO - 'PWD': '/builds/slave/test', 09:33:45 INFO - 'SHELL': '/bin/bash', 09:33:45 INFO - 'SHLVL': '1', 09:33:45 INFO - 'TERM': 'linux', 09:33:45 INFO - 'TMOUT': '86400', 09:33:45 INFO - 'USER': 'cltbld', 09:33:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', 09:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:45 INFO - '_': '/tools/buildbot/bin/python'} 09:33:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:45 INFO - Downloading/unpacking jsonschema==2.5.1 09:33:45 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 09:33:45 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 09:33:45 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 09:33:45 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 09:33:45 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 09:33:45 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 09:33:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:33:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:33:47 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 09:33:47 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 09:33:47 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 09:33:47 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 09:33:47 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 09:33:47 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 09:33:48 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:48 INFO - warning: no files found matching '*.txt' 09:33:48 INFO - no previously-included directories found matching 'build' 09:33:48 INFO - no previously-included directories found matching 'dist' 09:33:48 INFO - no previously-included directories found matching '.git*' 09:33:48 INFO - Installing collected packages: jsonschema, functools32 09:33:48 INFO - Running setup.py install for functools32 09:33:48 INFO - warning: no files found matching '*.txt' 09:33:48 INFO - no previously-included directories found matching 'build' 09:33:48 INFO - no previously-included directories found matching 'dist' 09:33:48 INFO - no previously-included directories found matching '.git*' 09:33:48 INFO - Successfully installed jsonschema functools32 09:33:48 INFO - Cleaning up... 09:33:48 INFO - Return code: 0 09:33:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33:48 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')]} 09:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:48 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')]} 09:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:48 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 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', '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 09:33:48 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 09:33:48 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 09:33:48 INFO - Using env: {'DISPLAY': ':0', 09:33:48 INFO - 'HOME': '/home/cltbld', 09:33:48 INFO - 'LANG': 'en_US.UTF-8', 09:33:48 INFO - 'LANGUAGE': 'en_US:en', 09:33:48 INFO - 'LOGNAME': 'cltbld', 09:33:48 INFO - 'MAIL': '/var/mail/cltbld', 09:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:48 INFO - 'MOZ_NO_REMOTE': '1', 09:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:48 INFO - 'NO_EM_RESTART': '1', 09:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:48 INFO - 'PWD': '/builds/slave/test', 09:33:48 INFO - 'SHELL': '/bin/bash', 09:33:48 INFO - 'SHLVL': '1', 09:33:48 INFO - 'TERM': 'linux', 09:33:48 INFO - 'TMOUT': '86400', 09:33:48 INFO - 'USER': 'cltbld', 09:33:48 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', 09:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:48 INFO - '_': '/tools/buildbot/bin/python'} 09:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:48 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:48 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 09:33:48 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 09:33:48 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 09:33:48 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 09:33:48 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 09:33:48 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 09:33:50 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33:50 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 09:33:50 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 09:33:50 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 09:33:50 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 09:33:50 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 09:33:50 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 09:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:50 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 09:33:50 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 09:33:50 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 09:33:50 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 09:33:50 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 09:33:50 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 09:33:51 INFO - Downloading docopt-0.6.1.tar.gz 09:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:51 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:51 INFO - Running setup.py install for blobuploader 09:33:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:51 INFO - Running setup.py install for requests 09:33:51 INFO - Running setup.py install for docopt 09:33:51 INFO - Successfully installed blobuploader requests docopt 09:33:51 INFO - Cleaning up... 09:33:51 INFO - Return code: 0 09:33:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:51 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 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', '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 09:33:51 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 09:33:51 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 09:33:51 INFO - Using env: {'DISPLAY': ':0', 09:33:51 INFO - 'HOME': '/home/cltbld', 09:33:51 INFO - 'LANG': 'en_US.UTF-8', 09:33:51 INFO - 'LANGUAGE': 'en_US:en', 09:33:51 INFO - 'LOGNAME': 'cltbld', 09:33:51 INFO - 'MAIL': '/var/mail/cltbld', 09:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:51 INFO - 'MOZ_NO_REMOTE': '1', 09:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:51 INFO - 'NO_EM_RESTART': '1', 09:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:51 INFO - 'PWD': '/builds/slave/test', 09:33:51 INFO - 'SHELL': '/bin/bash', 09:33:51 INFO - 'SHLVL': '1', 09:33:51 INFO - 'TERM': 'linux', 09:33:51 INFO - 'TMOUT': '86400', 09:33:51 INFO - 'USER': 'cltbld', 09:33:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', 09:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:51 INFO - '_': '/tools/buildbot/bin/python'} 09:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:51 INFO - Running setup.py (path:/tmp/pip-BHYC83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:52 INFO - Running setup.py (path:/tmp/pip-WkqnMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:52 INFO - Running setup.py (path:/tmp/pip-lAa0Li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:52 INFO - Running setup.py (path:/tmp/pip-t_D0In-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:52 INFO - Running setup.py (path:/tmp/pip-rkKpvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:52 INFO - Running setup.py (path:/tmp/pip-LFfgdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:52 INFO - Running setup.py (path:/tmp/pip-gnHjNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:52 INFO - Running setup.py (path:/tmp/pip-1Dw4lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:52 INFO - Running setup.py (path:/tmp/pip-_CX7bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:52 INFO - Running setup.py (path:/tmp/pip-2q7Tv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:52 INFO - Running setup.py (path:/tmp/pip-DPGjLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:52 INFO - Running setup.py (path:/tmp/pip-lOWsZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:52 INFO - Running setup.py (path:/tmp/pip-_8FmFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:52 INFO - Running setup.py (path:/tmp/pip-1zNYiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:53 INFO - Running setup.py (path:/tmp/pip-5LXXK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:53 INFO - Running setup.py (path:/tmp/pip-smzeoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:53 INFO - Running setup.py (path:/tmp/pip-L93u6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:53 INFO - Running setup.py install for manifestparser 09:33:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:53 INFO - Running setup.py install for mozcrash 09:33:53 INFO - Running setup.py install for mozdebug 09:33:53 INFO - Running setup.py install for mozdevice 09:33:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:33:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:53 INFO - Running setup.py install for mozfile 09:33:53 INFO - Running setup.py install for mozhttpd 09:33:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:53 INFO - Running setup.py install for mozinfo 09:33:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:53 INFO - Running setup.py install for mozInstall 09:33:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:54 INFO - Running setup.py install for mozleak 09:33:54 INFO - Running setup.py install for mozlog 09:33:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:54 INFO - Running setup.py install for moznetwork 09:33:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:54 INFO - Running setup.py install for mozprocess 09:33:54 INFO - Running setup.py install for mozprofile 09:33:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:54 INFO - Running setup.py install for mozrunner 09:33:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:54 INFO - Running setup.py install for mozscreenshot 09:33:54 INFO - Running setup.py install for moztest 09:33:54 INFO - Running setup.py install for mozversion 09:33:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:55 INFO - Cleaning up... 09:33:55 INFO - Return code: 0 09:33:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:55 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')]} 09:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:55 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')]} 09:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:55 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 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', '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 09:33:55 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 09:33:55 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 09:33:55 INFO - Using env: {'DISPLAY': ':0', 09:33:55 INFO - 'HOME': '/home/cltbld', 09:33:55 INFO - 'LANG': 'en_US.UTF-8', 09:33:55 INFO - 'LANGUAGE': 'en_US:en', 09:33:55 INFO - 'LOGNAME': 'cltbld', 09:33:55 INFO - 'MAIL': '/var/mail/cltbld', 09:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:55 INFO - 'MOZ_NO_REMOTE': '1', 09:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:55 INFO - 'NO_EM_RESTART': '1', 09:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:55 INFO - 'PWD': '/builds/slave/test', 09:33:55 INFO - 'SHELL': '/bin/bash', 09:33:55 INFO - 'SHLVL': '1', 09:33:55 INFO - 'TERM': 'linux', 09:33:55 INFO - 'TMOUT': '86400', 09:33:55 INFO - 'USER': 'cltbld', 09:33:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', 09:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:55 INFO - '_': '/tools/buildbot/bin/python'} 09:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:55 INFO - Running setup.py (path:/tmp/pip-WveC81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:55 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)) 09:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:55 INFO - Running setup.py (path:/tmp/pip-6Dbw1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:55 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)) 09:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:55 INFO - Running setup.py (path:/tmp/pip-7Es9S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:55 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)) 09:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:55 INFO - Running setup.py (path:/tmp/pip-NInzUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:55 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)) 09:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:55 INFO - Running setup.py (path:/tmp/pip-fGMast-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:55 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)) 09:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:55 INFO - Running setup.py (path:/tmp/pip-9pGoKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:55 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)) 09:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:55 INFO - Running setup.py (path:/tmp/pip-kNUF24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:55 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)) 09:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:55 INFO - Running setup.py (path:/tmp/pip-fdBNMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:55 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)) 09:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:55 INFO - Running setup.py (path:/tmp/pip-1duS8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:55 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)) 09:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:55 INFO - Running setup.py (path:/tmp/pip-1UoqWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:55 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)) 09:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:55 INFO - Running setup.py (path:/tmp/pip-36auPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:56 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)) 09:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:56 INFO - Running setup.py (path:/tmp/pip-oGXEON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:56 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)) 09:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:56 INFO - Running setup.py (path:/tmp/pip-tzAlaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:56 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)) 09:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:56 INFO - Running setup.py (path:/tmp/pip-6Evznz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:56 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)) 09:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:56 INFO - Running setup.py (path:/tmp/pip-b6o9YY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:56 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)) 09:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:56 INFO - Running setup.py (path:/tmp/pip-7xo5Zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:56 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)) 09:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:56 INFO - Running setup.py (path:/tmp/pip-zHfwHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:56 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)) 09:33:56 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)) 09:33:56 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)) 09:33:56 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)) 09:33:56 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)) 09:33:56 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)) 09:33:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:56 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 09:33:56 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 09:33:56 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 09:33:56 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 09:33:56 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 09:33:56 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 09:33:58 INFO - Downloading blessings-1.6.tar.gz 09:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:58 INFO - Installing collected packages: blessings 09:33:58 INFO - Running setup.py install for blessings 09:33:58 INFO - Successfully installed blessings 09:33:58 INFO - Cleaning up... 09:33:58 INFO - Return code: 0 09:33:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:58 INFO - Reading from file tmpfile_stdout 09:33:58 INFO - Current package versions: 09:33:58 INFO - argparse == 1.2.1 09:33:58 INFO - blessings == 1.6 09:33:58 INFO - blobuploader == 1.2.4 09:33:58 INFO - docopt == 0.6.1 09:33:58 INFO - functools32 == 3.2.3-2 09:33:58 INFO - jsonschema == 2.5.1 09:33:58 INFO - manifestparser == 1.1 09:33:58 INFO - mozInstall == 1.12 09:33:58 INFO - mozcrash == 0.17 09:33:58 INFO - mozdebug == 0.1 09:33:58 INFO - mozdevice == 0.48 09:33:58 INFO - mozfile == 1.2 09:33:58 INFO - mozhttpd == 0.7 09:33:58 INFO - mozinfo == 0.9 09:33:58 INFO - mozleak == 0.1 09:33:58 INFO - mozlog == 3.2 09:33:58 INFO - moznetwork == 0.27 09:33:58 INFO - mozprocess == 0.23 09:33:58 INFO - mozprofile == 0.28 09:33:58 INFO - mozrunner == 6.12 09:33:58 INFO - mozscreenshot == 0.1 09:33:58 INFO - mozsystemmonitor == 0.3 09:33:58 INFO - moztest == 0.7 09:33:58 INFO - mozversion == 1.4 09:33:58 INFO - psutil == 3.1.1 09:33:58 INFO - requests == 1.2.3 09:33:58 INFO - wsgiref == 0.1.2 09:33:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:58 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 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', '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 09:33:58 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 09:33:58 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 09:33:58 INFO - Using env: {'DISPLAY': ':0', 09:33:58 INFO - 'HOME': '/home/cltbld', 09:33:58 INFO - 'LANG': 'en_US.UTF-8', 09:33:58 INFO - 'LANGUAGE': 'en_US:en', 09:33:58 INFO - 'LOGNAME': 'cltbld', 09:33:58 INFO - 'MAIL': '/var/mail/cltbld', 09:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:58 INFO - 'MOZ_NO_REMOTE': '1', 09:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:58 INFO - 'NO_EM_RESTART': '1', 09:33:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:58 INFO - 'PWD': '/builds/slave/test', 09:33:58 INFO - 'SHELL': '/bin/bash', 09:33:58 INFO - 'SHLVL': '1', 09:33:58 INFO - 'TERM': 'linux', 09:33:58 INFO - 'TMOUT': '86400', 09:33:58 INFO - 'USER': 'cltbld', 09:33:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', 09:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:58 INFO - '_': '/tools/buildbot/bin/python'} 09:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:59 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)) 09:33:59 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)) 09:33:59 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)) 09:33:59 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)) 09:33:59 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)) 09:33:59 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)) 09:33:59 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)) 09:33:59 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)) 09:33:59 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)) 09:33:59 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)) 09:33:59 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)) 09:33:59 INFO - Cleaning up... 09:33:59 INFO - Return code: 0 09:33:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, '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': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', '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 09:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:33:59 INFO - Using env: {'DISPLAY': ':0', 09:33:59 INFO - 'HOME': '/home/cltbld', 09:33:59 INFO - 'LANG': 'en_US.UTF-8', 09:33:59 INFO - 'LANGUAGE': 'en_US:en', 09:33:59 INFO - 'LOGNAME': 'cltbld', 09:33:59 INFO - 'MAIL': '/var/mail/cltbld', 09:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:59 INFO - 'MOZ_NO_REMOTE': '1', 09:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:59 INFO - 'NO_EM_RESTART': '1', 09:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:59 INFO - 'PWD': '/builds/slave/test', 09:33:59 INFO - 'SHELL': '/bin/bash', 09:33:59 INFO - 'SHLVL': '1', 09:33:59 INFO - 'TERM': 'linux', 09:33:59 INFO - 'TMOUT': '86400', 09:33:59 INFO - 'USER': 'cltbld', 09:33:59 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', 09:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:59 INFO - '_': '/tools/buildbot/bin/python'} 09:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:33:59 INFO - Cleaning up... 09:33:59 INFO - Return code: 0 09:33:59 INFO - Running post-action listener: _resource_record_post_action 09:33:59 INFO - Running post-action listener: _start_resource_monitoring 09:33:59 INFO - Starting resource monitoring. 09:33:59 INFO - ##### 09:33:59 INFO - ##### Finished create-virtualenv step (success) 09:33:59 INFO - ##### 09:33:59 INFO - ##### 09:33:59 INFO - ##### Running install step. 09:33:59 INFO - ##### 09:33:59 INFO - Running pre-action listener: _resource_record_pre_action 09:33:59 INFO - Running main action method: install 09:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:59 INFO - Reading from file tmpfile_stdout 09:33:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:59 INFO - Reading from file tmpfile_stdout 09:33:59 INFO - Output received: 09:33:59 INFO - Usage: mozinstall [options] installer 09:33:59 INFO - Options: 09:33:59 INFO - -h, --help show this help message and exit 09:33:59 INFO - -d DEST, --destination=DEST 09:33:59 INFO - Directory to install application into. [default: 09:33:59 INFO - "/builds/slave/test"] 09:33:59 INFO - --app=APP Application being installed. [default: firefox] 09:33:59 INFO - mkdir: /builds/slave/test/build/application 09:33:59 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'] 09:33:59 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 09:34:15 INFO - Reading from file tmpfile_stdout 09:34:15 INFO - Output received: 09:34:15 INFO - /builds/slave/test/build/application/firefox/firefox 09:34:15 INFO - Running post-action listener: _resource_record_post_action 09:34:15 INFO - ##### 09:34:15 INFO - ##### Finished install step (success) 09:34:15 INFO - ##### 09:34:15 INFO - ##### 09:34:15 INFO - ##### Running run-tests step. 09:34:15 INFO - ##### 09:34:15 INFO - Running pre-action listener: _resource_record_pre_action 09:34:15 INFO - Running main action method: run_tests 09:34:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:34:16 INFO - Python 2.7.3 09:34:16 INFO - Return code: 0 09:34:16 INFO - grabbing minidump binary from tooltool 09:34:16 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')]} 09:34:16 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 0x2d2e3b0>, '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 0x2d2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:34:16 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 09:34:16 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 09:34:16 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 09:34:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:34:16 INFO - Return code: 0 09:34:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:34:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:34:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:34:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:34:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:34:16 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/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 09:34:16 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/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 09:34:16 INFO - Using env: {'DISPLAY': ':0', 09:34:16 INFO - 'HOME': '/home/cltbld', 09:34:16 INFO - 'LANG': 'en_US.UTF-8', 09:34:16 INFO - 'LANGUAGE': 'en_US:en', 09:34:16 INFO - 'LOGNAME': 'cltbld', 09:34:16 INFO - 'MAIL': '/var/mail/cltbld', 09:34:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:34:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:16 INFO - 'MOZ_NO_REMOTE': '1', 09:34:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:34:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:16 INFO - 'NO_EM_RESTART': '1', 09:34:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:16 INFO - 'PWD': '/builds/slave/test', 09:34:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:34:16 INFO - 'SHELL': '/bin/bash', 09:34:16 INFO - 'SHLVL': '1', 09:34:16 INFO - 'TERM': 'linux', 09:34:16 INFO - 'TMOUT': '86400', 09:34:16 INFO - 'USER': 'cltbld', 09:34:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256', 09:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:16 INFO - '_': '/tools/buildbot/bin/python'} 09:34:16 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/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 09:34:16 INFO - mozversion application_buildid: 20160715071456 09:34:16 INFO - mozversion application_changeset: 683bf5d3c1cdd76799d7da01d3a0cd2dbb42e8f9 09:34:16 INFO - mozversion application_display_name: Nightly 09:34:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:34:16 INFO - mozversion application_name: Firefox 09:34:16 INFO - mozversion application_remotingname: firefox 09:34:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:34:16 INFO - mozversion application_vendor: Mozilla 09:34:16 INFO - mozversion application_version: 50.0a1 09:34:16 INFO - mozversion platform_buildid: 20160715071456 09:34:16 INFO - mozversion platform_changeset: 683bf5d3c1cdd76799d7da01d3a0cd2dbb42e8f9 09:34:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:34:16 INFO - mozversion platform_version: 50.0a1 09:34:16 INFO - using testdate: 1468600456 09:34:16 INFO - actual date: 1468600456 09:34:16 INFO - starting webserver on 'localhost:58647' 09:34:16 INFO - SUITE-START | Running 2 tests 09:34:16 INFO - TEST-START | dromaeo_css 09:34:16 INFO - operating with platform_type : linux_ 09:34:16 INFO - Initialising browser for dromaeo_css test... 09:34:16 INFO - TEST-INFO | started process 26162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1xA5zc/profile http://localhost:58647/getInfo.html) 09:34:20 INFO - PROCESS | 26162 | __metrics Screen width/height:1600/1200 09:34:20 INFO - PROCESS | 26162 | colorDepth:24 09:34:20 INFO - PROCESS | 26162 | Browser inner width/height: 1024/697 09:34:20 INFO - PROCESS | 26162 | __metrics 09:34:21 INFO - PROCESS | 26162 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:34:21 INFO - PROCESS | 26162 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:34:22 INFO - TEST-INFO | 26162: exit 0 09:34:22 INFO - Browser initialized. 09:34:22 INFO - Running cycle 1/1 for dromaeo_css test... 09:34:22 INFO - TEST-INFO | started process 26244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1xA5zc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:34 INFO - PROCESS | 26244 | RSS: Main: 159645696 09:34:34 INFO - PROCESS | 26244 | 09:35:25 INFO - PROCESS | 26244 | 1468600525911 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] 09:37:37 INFO - PROCESS | 26244 | Cycle 1(1): loaded http://localhost:58647/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58647/tests/dromaeo/cssquery-ext.html) 09:37:38 INFO - PROCESS | 26244 | RSS: Main: 246685696 09:37:38 INFO - PROCESS | 26244 | 09:40:41 INFO - PROCESS | 26244 | Cycle 1(1): loaded http://localhost:58647/tests/dromaeo/cssquery-ext.html (next: http://localhost:58647/tests/dromaeo/cssquery-jquery.html) 09:40:41 INFO - PROCESS | 26244 | RSS: Main: 235937792 09:40:41 INFO - PROCESS | 26244 | 09:43:43 INFO - PROCESS | 26244 | Cycle 1(1): loaded http://localhost:58647/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58647/tests/dromaeo/cssquery-mootools.html) 09:43:44 INFO - PROCESS | 26244 | RSS: Main: 238301184 09:43:44 INFO - PROCESS | 26244 | 09:46:46 INFO - PROCESS | 26244 | Cycle 1(1): loaded http://localhost:58647/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58647/tests/dromaeo/cssquery-prototype.html) 09:46:47 INFO - PROCESS | 26244 | RSS: Main: 237297664 09:46:47 INFO - PROCESS | 26244 | 09:49:50 INFO - PROCESS | 26244 | Cycle 1(1): loaded http://localhost:58647/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58647/tests/dromaeo/cssquery-yui.html) 09:49:50 INFO - PROCESS | 26244 | RSS: Main: 212238336 09:49:50 INFO - PROCESS | 26244 | 09:52:53 INFO - PROCESS | 26244 | Cycle 1(1): loaded http://localhost:58647/tests/dromaeo/cssquery-yui.html (next: http://localhost:58647/tests/dromaeo/cssquery-dojo.html) 09:52:53 INFO - PROCESS | 26244 | RSS: Main: 292139008 09:52:53 INFO - PROCESS | 26244 | 09:52:53 INFO - PROCESS | 26244 | __start_tp_report 09:52:53 INFO - PROCESS | 26244 | _x_x_mozilla_page_load 09:52:53 INFO - PROCESS | 26244 | _x_x_mozilla_page_load_details 09:52:53 INFO - PROCESS | 26244 | |i|pagename|runs| 09:52:53 INFO - PROCESS | 26244 | |0;dojo.html;2582.3931376126607;2596.1822026061777;2630.368711509238;2640.168346970704;2641.7358264173586;4503.144402563511;4574.4968053514085;4667.136579732747;4715.834945776898;4721.881952951174;4655.860324190271;4663.090697314025;4688.6249100072;4708.458527269365;4713.882152946178;4094.97952510237;4314.050908800059;4344.087741574257;4371.14762621289;4437.090396468732;4353.825846966118;4393.692441529094;4414.470263568376;4417.42573465449;4444.488883778358;4187.43469631602;4233.978830105861;4238.152369526077;4239.830406783756;4244.0663054128045;4217.219814334358;4224.704270701052;4271.743695378256;4279.251131052053;4291.35629655551;4267.445232119836;4270.850520231777;4284.871453856389;4299.462567179103;4314.072474418015;4523.886902827423;4622.121796858586;4691.601213896823;4695.60087392572;4744.786484608167;5076.213186955991;5081.466446023152;5086.872828179326;5098.158803797406;5099.898002039976;4808.855734327975;5108.489151084899;5115.309433226504;5124.769385377667;5130.3074084998425;4581.74800385982;4627.282771170474;4629.745364004944;4693.366395536627;4694.929576056362;5082.491750824962;5122.769475373617;5123.077845987684;5124.30821839047;5133.998870220271;4909.116359055333;4928.162212423897;4955.306257124005;4960.851174464772;4962.5533701967;4850.1997170466475;4886.95113048865;4985.326980857611;5050.217216331474;5051.747412629354;5001.599872010231;5008.774605142778;5020.071286811952;5024.723640199824;5087.23691446286;4995.650304478651;5005.199168133154;5007.8247261346405;5020.347354843847;5059.56993655536;4058.939115913264;4087.3868919661695;4091.6931230157857;4133.152703695735;4140.627343539096;3640.3265395901844;3641.1625326175126;3683.797391143459;3686.4101743720876;3687;4216.2832318505925;4269.893252668646;4271.060366719316;4281.01536646573;4316.028893499;4893.168161412568;4899.559039686445;4903.068417000758;4903.509649035139;4953.083679519301;4266.1254442839145;4269.615734583902;4271.402003719481;4271.893202669896;4314.525402205755;3952.9722272208855;4329.480462344539;4366.694331396771;4431.446069241345;4440.622547083534;4715;4715.528447155257;4718.079974404958;4728.71627702339;4766.76166191689;4749.715017098985;4960.23116416956;4964.304997300309;4968.22992436173;5004.524570165829;4604.976975115103;4675.485696573306;4737.597304229179;4742.1227072991605;4743.549362810528;4867.80528778859;4874.463808981081;4892.241702536113;4897.90204195907;4943.456219815889;4755.2153894607;4962.801487940442;4968.3292755479;4980.103581355246;5031.698098114125;4832.613390928787;4878.048780487913;4895.632827537877;4904.534069263557;4952.232403977389;4905.166121759238;4905.435874874435;4907.386576677915;4910.165271903857;4945.901081978268;4667.463241727245;4738.218193997952;4761.500042495488;4824.927626085541;4860.805567777391;4797.40032495938;4807.18277892766;4822.734749588806;4854.126257273725;4908.067467181224;4720.645951553716;4723.858284251478;4723.976380118077;4737;4797.64017698667 09:52:53 INFO - PROCESS | 26244 | |1;ext.html;551.7710150287634;570.1647087017518;574.6724367110746;588.1471865794596;590.5423296944869;28475.43049139016;31653.68346316539;31684.366312673734;39839.20321593573;41059.794701026454;40531.18937621246;40938;40940.38589421161;41011.79494102533;41033.17933641325;7821.256980586835;7973.880391794128;7979.441439099265;7982.720604778805;7984.520928744294;7873.25204105609;7959.1244963054305;7971.9601401993195;7980.401469889753;7981.880271795928;7949.046114466272;7988.680452781882;7995.600219989006;7996.800079997988;7998.12020677725;7941.960290198541;7969.242921922408;7981.20187981206;7983.481073730247;7990.280874721245;7862.331701805353;7886.250806173462;7892.092409372881;7893.05283365994;7894.052713674396;38525;38898.22203555941;38901.80549097265;38904.41643375352;38919;2863.541833306682;3006.684298148685;3047.283888286251;3096.2723759916403;3154.936901261962;29746.553801692993;29789.553156702666;29916.850415747784;30282.69717302821;30314.84842575773;3005.9248518786985;3094.2883136878418;3118.5634011238444;3132.37352529495;3220.6296275928335;261895;262711;264863;266111;267400;31286.530702039487;32489.51265731016;51560.74219628953;52097.21854172191;52262.738686307086;33998.66001340005;34018.31963360719;34129.14677133092;34147.4877876832;34158.82920585431;13611.86388136106;13790.448382064806;13811.51659691926;13816.585502434944;13843;11389.658310250707;11564.479598418091;11594.362310073027;11620.418979051014;11628;7924.445288829726;7932.524048557105;7950.165232650604;7999.280064794197;8017.559034253055;3104.5343198520404;3109.9067027989195;3113.906582802474;3160.7313378363096;3184.7611429142908;813.3818298093373;862.6247582301719;886.570013543431;897.3673560140086;927.8608208768603;26782.732172678025;26971.865140674563;27327;27543.724562754116;27868.442631147263;771.3898952900367;895.1540793949655;970.0541971577796;978.9559469823876;1028.285341687535;13841;14500.492482763053;14525.709485810225;14605.853941460662;14799.18604476764;369264;369700;380067;381055;382335;47498;48173;48224.27663585049;48332.27501587479;48418.5158148421;1087.396494945313;1177.5937301630925;1197;1213.4114954247184;1215.604928398274;28183.71816281893;29333.85333073321;29489.26276843096;29652.555211672272;30298;41301.38047929223;41462.37806432966;41614.58385416107;41785.1642967145;41905.37141942812;306337;306978;307015;307643;368675;25106.62340064937;25517.61723574185;25567.360815979748;26848.463030739666;26914.192574222805;41961.31282701779;42581.12830753869;43007.354889677306;43173.3523997134;43283.783581081894;36834.447483288306;36981.81509092437;37008.444873326385;37420.62579374172;37620.247595048495;37286.62713372832;37415.81292093631;37441.81279093696;37644.2471150581;37787.43318850164;35679.82160089183;36236.63763362333;36566.817165914;36964.26071478609;37039.25921481609;32670;33037.50443743394;33463;33792;33811.3237735239;24623.50752984966;25155.371115721522;25459.236222913343;25487.36281592975;25903.481930361664 09:52:53 INFO - PROCESS | 26244 | |2;jquery.html;378.8995916082239;383.113093189267;384.55199692358406;391.8550136449514;399.6083837838918;16525.17374131293;18044.097795110225;18920.24319027239;18982.71525927112;19062.428127156207;16995.15024248789;17004.574885627866;17963.91018044911;18310.542236444096;18313.81686183138;5091.43994160643;5252.028374750684;5271.973640131794;5278.762455689484;5293.179557168645;3754.6620804127624;3771.830267637949;6072.392760723937;6073.66594837286;6170.19787427636;6071.696415179245;6108.786192483264;6118.204633397652;6123.234595675541;6135.6625385603775;5208;5489.725513724317;5491;5578.2748242728185;5585.245991791137;3485.494603282535;5183.948160518385;5521.668699878021;5529.778808847641;5619.072852979253;13055.673608159777;13085.149465284821;13151.21092734439;13214.537491187859;13283.402246898913;1838.9816101839078;1858.628274345123;1887.1507821480388;2154.084514081525;2174.412908514708;9046.954765226197;9467.52662366879;9482.478463684494;9972.90027099727;9995.550200241007;1699.7280435130444;1866.4214093630883;1924.8652594318403;1979.782433803215;2002.1590931808676;71809.6409517949;72227;72344;73454.26545734527;74625;10175.592976281014;10347.27569070158;10349.327293725884;10626.840597391045;10824.350538967687;14375.856241437452;14504.927475362556;14506.274686265644;14513.274336283355;14544.49094281695;7570.9242907570215;7607.961960190164;7614.657340419694;7688.615569221628;7708.730194443167;7576.5832879191075;7591.848163036709;7684.654190561439;7709.344705699966;7714.421418393643;4512.9774351128035;4527.139843429738;4588.9541104588525;4591.127685739765;4610.354550362952;1818.2181661885252;1840.4662647832247;1874.322481379158;1909.847212223019;1947.1043320072924;762.1045271805606;827.4125370986546;829.8381815545911;889.5552223888056;911.2482202183226;17201.569960750832;17278.65442691139;17826.5543361417;17855;18200.1809918554;805.2350267246139;809.9554524501209;825.2449009156554;848.4781859156698;867.9392442529089;9222.584983675752;9908.504574771378;9972.900270997343;9985.700428987142;9993.10062094415;402451;407155;407193;409671;409949;48607.5139248603;58668.413315866295;76672;80006;83823.58088209642;933.9813203735887;944.6457578408097;949.8907625623142;959.1032384720309;979.5689896445399;15083.4720784772;15720.21398930026;15841.920790395974;15968.680626387639;16173.59566010859;37792.055198620255;38288.80855595704;38629.613703862604;38653.420198697604;39254;53704.73147634237;55157.448425515235;56169.43830561642;56320.15519767125;56675.71662141663;7386.113666360071;7925.962257794452;8030.43786934909;8261.504309741435;8266.421350505407;9962.900370996198;10414.739631509274;10552.683419497427;10795.406252655865;10979.28634638746;8994.415363001384;9367.110124538158;9406.811863762823;9899.703008909744;10310.43292618913;9276.768080798034;9697.224222062077;9705.708828735149;9893.802123957625;10019.148372388428;9660.32377733552;9935.751606209613;10174.084332410119;10183.287169898036;10480.371177729055;7438.73964411243;7692.307692307719;7895.447318687637;7930.405219608668;7952;8145.551994640352;10184.745381365228;10379.273450858367;10734.355938643706;10851.782964340828 09:52:53 INFO - PROCESS | 26244 | |3;mootools.html;1271.45327509171;1364.563339731286;1415.030703967782;1492.5149326468893;1725.3271224222556;6814.318568143183;7652.57910814905;7850;7870.173631768667;8053.637586308616;7830.8042298942555;7937.20627937206;7937.40469464791;7939.126696063443;7957.403194760402;2219.4895174109965;2243.1588154442084;2256.4133325335447;2257.1084421653436;2263.875486848223;2212.944676383095;2233.3858188997992;2258.7515373308925;2259.085070546423;2260.9434764130947;2173.467500462389;2188.7154669892893;2199.3841724317135;2199.670049492573;2202.4603972026875;2156.9568608627737;2172.880491572963;2178.5751778403137;2178.59695956247;2185.846990710651;2178.880161591112;2191.112599397247;2197.373748481691;2197.923072692448;2200.7689192634703;7695.230476952316;7944.324732397753;7975.282224599756;7981.72063977758;8040.155783642692;4721.457032441279;4803.759812009385;4821.493743156953;4836.056968891067;4843.007183527368;2791.8743656535303;2818;2895.753860921824;2902.651681798198;2906.3024874030293;869.3132425383939;875.5403413208053;876.3865294293956;899.0784445942895;905.678484138128;10871.83692244617;10929.289596176222;10946.288491248044;10949.288296260718;10954.287971281921;3964.1675248198203;4087.816048277835;4228.725132866354;4231.217224813419;4233.618974292329;8624;8627.568621568897;8630.827383452295;8641.567921603895;8658.264047556027;4716.740579268105;4717.787699553528;4719.5752382285755;4720.268358404453;4727.054589082129;3764.378877485184;4121.175764847043;4246.745195288293;4366.716163449366;4366.8908277292685;3525.823708814549;3539.1329124364697;3609.7112231021456;3641.053326135171;3655.6344365563764;1028.9022542858415;1107.058999850121;1108.2242430298822;1111.244353839381;1123.4326665034105;738.2912404092132;840.1850205300848;852.9721685369116;857.9313654907593;860.4536119564121;5159.484051594885;5178.508041736029;5314.92027619586;5353;5362.839114826562;401.60441964664784;408.1795590862388;413.64839886096576;419.4065397462617;419.77961570175904;3484.564429446319;3607.85568577254;3618.095476130967;3650.9817450913106;3697.0387699198404;9462.243020558339;9842.11420972116;9907.653232136841;9943.950280248697;9949.204063674888;9817.165540928958;9823.656172033945;9829.262805289633;9851.704448866545;9853.901460985442;7290.5625662460425;7370.410367170613;7468.290512401313;7481;7489.737859174903;5284.180951952453;5370.462953704755;5389.407165211902;5528.391876893619;5631.774729010794;9100.590473428843;9114.40756350835;9123.315751318545;9182.632694692138;9209.585568649562;8739.38824282294;9034.728958131267;9056.637734490547;9253.491057991874;9386.48374339418;6220.502359811114;6414.390632889868;6417.26201486835;6844.2129155147795;6994.650267486707;7051.541649792747;7094.361507464353;7367.079115110611;7544.660490277841;7596.734114305973;6682.732690692318;6933.514653974174;6976.267491913276;7014.68433920485;7227.421806255592;6837.658117094026;6860.211075726155;6897.620630865351;6967.094277744063;7045.401140902875;6500.349965003462;6503.512236582181;6514.218293804584;6571;6625.4037136657935;4635.768211589474;4733.644976626698;4771.95228047729;4791.616670666269;4872.6832755870755;4854.2233242681;4934.18585933317;4944.901101977868;4951.653384263067;5007.7496125192865 09:52:53 INFO - PROCESS | 26244 | |4;prototype.html;304.4702218140435;309.50942755732166;315.60706919884746;316.1353697636964;318.33468051771797;4837.443693975194;4865.61075113991;4869.878253043676;4882.6093912487;4896.510348965102;4743.928841067387;4750.477447480775;4792.329073929653;4805.375301210846;4805.471398146201;3565.23347480291;3689.114612492996;3704.944425833615;3802.391617341226;3825.5791862895057;3755.9624403756025;3791.4312853071983;3793.943090853639;3811.6760075393486;3833.0609000794843;3765.7363984521094;3774.2074164425503;3784.243151369737;3787.1182038410575;3809.542854857421;3609.3322735294055;3644.817759112047;3787.8106094695154;3804.524434445694;3806.90482737931;3316.8507417166284;3367.6295607483157;3368.292658541685;3370.174307294704;3374.2622549387083;4688.882777930545;4690.906181876343;4693.88265293367;4704.952950470486;4705.458872229703;4204.264253755611;4300.505441874193;4318.956810431887;4334.479862416499;4341.3053911374345;4901.142300097505;4937.728424936627;4943.1102401567705;4955.38949841303;4956.727379994099;3662.963370366289;3671.430928206132;3683.834227459771;3690.7970061646597;3729.1050147964565;5093.668911520776;5226.137687281632;5229.744861233315;5231.738413079331;5255.710935898524;3802;3838.9040273993373;3847.076701591598;3855.5951625079524;3861.8373710721526;3908.413737939275;3913.8043097844993;3917.236138952877;3919.333713268751;3919.530176183931;4272.786360681954;4351.825007248089;4375.518692943837;4383.3863259143745;4409.11817636474;5001.7499125043605;5037.974810125926;5043.5712964398435;5044.772985215674;5049.722265275445;1333.8932885369147;1346.1250187378282;1352.154903185509;1354.593621913422;1355.0650051464654;846.7756044648173;877.1842186766369;899.2042042792176;901.7159594727771;909.1999040844015;4365.214261432972;4447.199504089295;4466.129104824593;4475.060237350128;4482.982657804001;5093.719845408538;5119.180931051014;5135.3324067870935;5140.280360749498;5166.689998600096;4340.180043740548;4455.2426087564545;4461.821527138943;4468.486124095705;4474.619657329164;2662.7736642385225;2726.2230264374557;2727.7316048037756;2735.466584016098;2736.7947403944386;4903.509649035068;4915.680480768739;4920.704757714549;4925.581325587294;4926.187179115406;4928.310036594879;5250;5273.6572122811895;5275.4460781618145;5281.788728450896;4912.361393018885;4921.163402221559;4921.409430868319;4943.604511639061;4948.505149485023;5130.563902068366;5158.871028224325;5160.200168973815;5162.354705661793;5178.792848286026;4899.167141585867;5072.619553533426;5077.7461126944245;5091.66904151229;5120.948790512047;4880.6085018340045;4915.852524424273;4927.359443272495;4930.556249937523;4935.889424879373;3688.2992231475932;3711.3319602471815;3757.8308976095595;3761.266553022244;3765.7175711821174;4919.237518184687;5259.973700131475;5268.604854635994;5274.340707411574;5276.841694749163;5016.87457813543;5029.1953287473825;5034.622403319692;5036.219385995177;5045.192769156917;5036.370453693288;5048.8990220194655;5051.217061355495;5063.291139240583;5066.4680208577565;4809.855704328876;4945.950540494549;4961.5286547777905;4989.775460104232;4990.50094990498;4856.295837103671;4939.975300123477;5002.974985125051;5051.595872330131;5061.139606267017;4926.753662316942;4931.13705101613;4940.802367905244;4954.306397104337;4965.205567109245 09:52:53 INFO - PROCESS | 26244 | |5;yui.html;629.2071989293489;631.1763149090436;661.5402295404695;666.6533402630632;732.103173612325;12417.627471175869;13362.13146145501;13383;13410.66473338167;13417.463301467942;13034.934825325883;13063.281519516422;13113.868861311385;13220.735585288312;13254.337283135828;627.0406278394064;761.9961900190491;762.5958242131679;782.2529484342439;787.6534324897056;769.4959801330137;772.6445834915945;775.0892701076241;775.9224077592224;776.2935728487078;824.6907409721355;826.4380221449412;826.5412695953743;826.5412695953743;826.7561069484486;646.7962591783597;660.7059858363031;661.5137873662854;663.8838203314449;821.6138414944996;596.9492593129589;601.2034054877305;601.7532811547288;602.8824379246049;602.9427204415573;13284.070115091947;13323.600291991255;13330.666733331647;13339.066265361429;13361.13152645075;12421.813672794826;12837.486500539968;12896.935515322457;12918.741625167539;13026.674333141653;11496;11810.114241431842;11817.409129543488;12028.578999734968;12442.751144977141;4054.776987265699;4066.654334381581;4077.673786097105;4125.23683118624;4204.894877628053;60615.393846061415;60618.393816062155;60626.39373606251;60631.69684151551;60815.08777368343;9229.077092290718;9350.392224505385;9621.90378096224;9827.606895724091;10074.44590547527;19194.424167275003;19215.32746353899;19219.32732354389;19236.134373953206;19248.61502769965;6394.648294343856;6431.935680643227;6501.869962600722;6512.837179070466;6809.897851532132;3414.6585341466152;3543.875964341236;3756.5145088567256;3765.058735316171;3858.5369755628944;2801.6918139004692;2913.950977648045;2919.8978035768646;2920.66412362581;2930.6922773108945;510.9296024827979;536.919462080691;539.0539602996794;552.850730302824;560.3136158206165;512.8846009647874;516.8811173430132;535.2078923193695;535.3976776126857;542.4196110162168;7652;7665.731699390494;7742.264484873928;7860.882086768703;8160.224778646019;470.2922102236113;483.71460838105685;538.4050624060435;553.4907884746043;567.6225310168774;3679.1721862580707;3793.258961537112;3880.049387899983;3928.46965659638;3994.6404823565435;83637;89663;90635.54682226546;91626.54186729157;91698;78553;80184;80276.59861700654;80282;80525;44015.339769902836;45861.99999999933;66584.33415665878;70859.2914070863;71820.28179718241;7161.104861892263;7224.494285400182;7277.454190935595;7326.96336518314;7417.332440080419;44286.55713442824;45121.77439112915;45178.322325165806;45673.54326456693;46258.537414625425;58066.4193358061;64436;64810.35189648043;65140.67429662821;65187;10612.522436490532;10810.67567972962;10861.131109511378;11033.007029367396;11621.418929053345;12811.103222774316;12894.290814004944;13114.213147211198;13749.656258593615;13792.517261895786;7589.892302501415;11057.612983545538;11356.54573817038;12357.25856448616;12543.56097536582;11272.549098035986;12275.508979641072;12518.12373133872;12678.683032924251;12982.480700772241;11324.689319371035;11539.36533490666;12014.75970480603;12033.819492707442;12237.449314780679;9844.163246124159;10191.133753631024;10233.84649230277;10460.581576736846;10562.683119506428;10275.588976440858;10441.947790261;10521.421321827067;10554.683359499228;10598.099161571045 09:52:53 INFO - PROCESS | 26244 | __end_tp_report 09:52:53 INFO - PROCESS | 26244 | __start_cc_report 09:52:53 INFO - PROCESS | 26244 | _x_x_mozilla_cycle_collect,908 09:52:53 INFO - PROCESS | 26244 | __end_cc_report 09:52:53 INFO - PROCESS | 26244 | __startTimestamp1468601573860__endTimestamp 09:52:53 INFO - PROCESS | 26244 | 09:52:53 INFO - PROCESS | 26244 | ------- Summary: start ------- 09:52:53 INFO - PROCESS | 26244 | Number of tests: 6 09:52:53 INFO - PROCESS | 26244 | 09:52:53 INFO - PROCESS | 26244 | [#0] dojo.html Cycles:165 Average:4601.03 Median:4723.98 stddev:493.97 (10.5%) stddev-sans-first:469.41 09:52:53 INFO - PROCESS | 26244 | Values: 2582.4 2596.2 2630.4 2640.2 2641.7 4503.1 4574.5 4667.1 4715.8 4721.9 4655.9 4663.1 4688.6 4708.5 4713.9 4095.0 4314.1 4344.1 4371.1 4437.1 4353.8 4393.7 4414.5 4417.4 4444.5 4187.4 4234.0 4238.2 4239.8 4244.1 4217.2 4224.7 4271.7 4279.3 4291.4 4267.4 4270.9 4284.9 4299.5 4314.1 4523.9 4622.1 4691.6 4695.6 4744.8 5076.2 5081.5 5086.9 5098.2 5099.9 4808.9 5108.5 5115.3 5124.8 5130.3 4581.7 4627.3 4629.7 4693.4 4694.9 5082.5 5122.8 5123.1 5124.3 5134.0 4909.1 4928.2 4955.3 4960.9 4962.6 4850.2 4887.0 4985.3 5050.2 5051.7 5001.6 5008.8 5020.1 5024.7 5087.2 4995.7 5005.2 5007.8 5020.3 5059.6 4058.9 4087.4 4091.7 4133.2 4140.6 3640.3 3641.2 3683.8 3686.4 3687.0 4216.3 4269.9 4271.1 4281.0 4316.0 4893.2 4899.6 4903.1 4903.5 4953.1 4266.1 4269.6 4271.4 4271.9 4314.5 3953.0 4329.5 4366.7 4431.4 4440.6 4715.0 4715.5 4718.1 4728.7 4766.8 4749.7 4960.2 4964.3 4968.2 5004.5 4605.0 4675.5 4737.6 4742.1 4743.5 4867.8 4874.5 4892.2 4897.9 4943.5 4755.2 4962.8 4968.3 4980.1 5031.7 4832.6 4878.0 4895.6 4904.5 4952.2 4905.2 4905.4 4907.4 4910.2 4945.9 4667.5 4738.2 4761.5 4824.9 4860.8 4797.4 4807.2 4822.7 4854.1 4908.1 4720.6 4723.9 4724.0 4737.0 4797.6 09:52:53 INFO - PROCESS | 26244 | 09:52:53 INFO - PROCESS | 26244 | [#1] ext.html Cycles:180 Average:46337.40 Median:203114.13 stddev:85310.16 (42.0%) stddev-sans-first:85480.21 09:52:53 INFO - PROCESS | 26244 | Values: 551.8 570.2 574.7 588.1 590.5 28475.4 31653.7 31684.4 39839.2 41059.8 40531.2 40938.0 40940.4 41011.8 41033.2 7821.3 7973.9 7979.4 7982.7 7984.5 7873.3 7959.1 7972.0 7980.4 7981.9 7949.0 7988.7 7995.6 7996.8 7998.1 7942.0 7969.2 7981.2 7983.5 7990.3 7862.3 7886.3 7892.1 7893.1 7894.1 38525.0 38898.2 38901.8 38904.4 38919.0 2863.5 3006.7 3047.3 3096.3 3154.9 29746.6 29789.6 29916.9 30282.7 30314.8 3005.9 3094.3 3118.6 3132.4 3220.6 261895.0 262711.0 264863.0 266111.0 267400.0 31286.5 32489.5 51560.7 52097.2 52262.7 33998.7 34018.3 34129.1 34147.5 34158.8 13611.9 13790.4 13811.5 13816.6 13843.0 11389.7 11564.5 11594.4 11620.4 11628.0 7924.4 7932.5 7950.2 7999.3 8017.6 3104.5 3109.9 3113.9 3160.7 3184.8 813.4 862.6 886.6 897.4 927.9 26782.7 26971.9 27327.0 27543.7 27868.4 771.4 895.2 970.1 979.0 1028.3 13841.0 14500.5 14525.7 14605.9 14799.2 369264.0 369700.0 380067.0 381055.0 382335.0 47498.0 48173.0 48224.3 48332.3 48418.5 1087.4 1177.6 1197.0 1213.4 1215.6 28183.7 29333.9 29489.3 29652.6 30298.0 41301.4 41462.4 41614.6 41785.2 41905.4 306337.0 306978.0 307015.0 307643.0 368675.0 25106.6 25517.6 25567.4 26848.5 26914.2 41961.3 42581.1 43007.4 43173.4 43283.8 36834.4 36981.8 37008.4 37420.6 37620.2 37286.6 37415.8 37441.8 37644.2 37787.4 35679.8 36236.6 36566.8 36964.3 37039.3 32670.0 33037.5 33463.0 33792.0 33811.3 24623.5 25155.4 25459.2 25487.4 25903.5 09:52:53 INFO - PROCESS | 26244 | 09:52:53 INFO - PROCESS | 26244 | [#2] jquery.html Cycles:180 Average:24785.57 Median:5262.00 stddev:67166.25 (1276.4%) stddev-sans-first:67329.67 09:52:53 INFO - PROCESS | 26244 | Values: 378.9 383.1 384.6 391.9 399.6 16525.2 18044.1 18920.2 18982.7 19062.4 16995.2 17004.6 17963.9 18310.5 18313.8 5091.4 5252.0 5272.0 5278.8 5293.2 3754.7 3771.8 6072.4 6073.7 6170.2 6071.7 6108.8 6118.2 6123.2 6135.7 5208.0 5489.7 5491.0 5578.3 5585.2 3485.5 5183.9 5521.7 5529.8 5619.1 13055.7 13085.1 13151.2 13214.5 13283.4 1839.0 1858.6 1887.2 2154.1 2174.4 9047.0 9467.5 9482.5 9972.9 9995.6 1699.7 1866.4 1924.9 1979.8 2002.2 71809.6 72227.0 72344.0 73454.3 74625.0 10175.6 10347.3 10349.3 10626.8 10824.4 14375.9 14504.9 14506.3 14513.3 14544.5 7570.9 7608.0 7614.7 7688.6 7708.7 7576.6 7591.8 7684.7 7709.3 7714.4 4513.0 4527.1 4589.0 4591.1 4610.4 1818.2 1840.5 1874.3 1909.8 1947.1 762.1 827.4 829.8 889.6 911.2 17201.6 17278.7 17826.6 17855.0 18200.2 805.2 810.0 825.2 848.5 867.9 9222.6 9908.5 9972.9 9985.7 9993.1 402451.0 407155.0 407193.0 409671.0 409949.0 48607.5 58668.4 76672.0 80006.0 83823.6 934.0 944.6 949.9 959.1 979.6 15083.5 15720.2 15841.9 15968.7 16173.6 37792.1 38288.8 38629.6 38653.4 39254.0 53704.7 55157.4 56169.4 56320.2 56675.7 7386.1 7926.0 8030.4 8261.5 8266.4 9962.9 10414.7 10552.7 10795.4 10979.3 8994.4 9367.1 9406.8 9899.7 10310.4 9276.8 9697.2 9705.7 9893.8 10019.1 9660.3 9935.8 10174.1 10183.3 10480.4 7438.7 7692.3 7895.4 7930.4 7952.0 8145.6 10184.7 10379.3 10734.4 10851.8 09:52:53 INFO - PROCESS | 26244 | 09:52:53 INFO - PROCESS | 26244 | [#3] mootools.html Cycles:180 Average:5188.36 Median:5169.00 stddev:2935.71 (56.8%) stddev-sans-first:2929.18 09:52:53 INFO - PROCESS | 26244 | Values: 1271.5 1364.6 1415.0 1492.5 1725.3 6814.3 7652.6 7850.0 7870.2 8053.6 7830.8 7937.2 7937.4 7939.1 7957.4 2219.5 2243.2 2256.4 2257.1 2263.9 2212.9 2233.4 2258.8 2259.1 2260.9 2173.5 2188.7 2199.4 2199.7 2202.5 2157.0 2172.9 2178.6 2178.6 2185.8 2178.9 2191.1 2197.4 2197.9 2200.8 7695.2 7944.3 7975.3 7981.7 8040.2 4721.5 4803.8 4821.5 4836.1 4843.0 2791.9 2818.0 2895.8 2902.7 2906.3 869.3 875.5 876.4 899.1 905.7 10871.8 10929.3 10946.3 10949.3 10954.3 3964.2 4087.8 4228.7 4231.2 4233.6 8624.0 8627.6 8630.8 8641.6 8658.3 4716.7 4717.8 4719.6 4720.3 4727.1 3764.4 4121.2 4246.7 4366.7 4366.9 3525.8 3539.1 3609.7 3641.1 3655.6 1028.9 1107.1 1108.2 1111.2 1123.4 738.3 840.2 853.0 857.9 860.5 5159.5 5178.5 5314.9 5353.0 5362.8 401.6 408.2 413.6 419.4 419.8 3484.6 3607.9 3618.1 3651.0 3697.0 9462.2 9842.1 9907.7 9944.0 9949.2 9817.2 9823.7 9829.3 9851.7 9853.9 7290.6 7370.4 7468.3 7481.0 7489.7 5284.2 5370.5 5389.4 5528.4 5631.8 9100.6 9114.4 9123.3 9182.6 9209.6 8739.4 9034.7 9056.6 9253.5 9386.5 6220.5 6414.4 6417.3 6844.2 6994.7 7051.5 7094.4 7367.1 7544.7 7596.7 6682.7 6933.5 6976.3 7014.7 7227.4 6837.7 6860.2 6897.6 6967.1 7045.4 6500.3 6503.5 6514.2 6571.0 6625.4 4635.8 4733.6 4772.0 4791.6 4872.7 4854.2 4934.2 4944.9 4951.7 5007.7 09:52:53 INFO - PROCESS | 26244 | 09:52:53 INFO - PROCESS | 26244 | [#4] prototype.html Cycles:180 Average:4204.74 Median:4823.65 stddev:1197.59 (24.8%) stddev-sans-first:1164.62 09:52:53 INFO - PROCESS | 26244 | Values: 304.5 309.5 315.6 316.1 318.3 4837.4 4865.6 4869.9 4882.6 4896.5 4743.9 4750.5 4792.3 4805.4 4805.5 3565.2 3689.1 3704.9 3802.4 3825.6 3756.0 3791.4 3793.9 3811.7 3833.1 3765.7 3774.2 3784.2 3787.1 3809.5 3609.3 3644.8 3787.8 3804.5 3806.9 3316.9 3367.6 3368.3 3370.2 3374.3 4688.9 4690.9 4693.9 4705.0 4705.5 4204.3 4300.5 4319.0 4334.5 4341.3 4901.1 4937.7 4943.1 4955.4 4956.7 3663.0 3671.4 3683.8 3690.8 3729.1 5093.7 5226.1 5229.7 5231.7 5255.7 3802.0 3838.9 3847.1 3855.6 3861.8 3908.4 3913.8 3917.2 3919.3 3919.5 4272.8 4351.8 4375.5 4383.4 4409.1 5001.7 5038.0 5043.6 5044.8 5049.7 1333.9 1346.1 1352.2 1354.6 1355.1 846.8 877.2 899.2 901.7 909.2 4365.2 4447.2 4466.1 4475.1 4483.0 5093.7 5119.2 5135.3 5140.3 5166.7 4340.2 4455.2 4461.8 4468.5 4474.6 2662.8 2726.2 2727.7 2735.5 2736.8 4903.5 4915.7 4920.7 4925.6 4926.2 4928.3 5250.0 5273.7 5275.4 5281.8 4912.4 4921.2 4921.4 4943.6 4948.5 5130.6 5158.9 5160.2 5162.4 5178.8 4899.2 5072.6 5077.7 5091.7 5120.9 4880.6 4915.9 4927.4 4930.6 4935.9 3688.3 3711.3 3757.8 3761.3 3765.7 4919.2 5260.0 5268.6 5274.3 5276.8 5016.9 5029.2 5034.6 5036.2 5045.2 5036.4 5048.9 5051.2 5063.3 5066.5 4809.9 4946.0 4961.5 4989.8 4990.5 4856.3 4940.0 5003.0 5051.6 5061.1 4926.8 4931.1 4940.8 4954.3 4965.2 09:52:53 INFO - PROCESS | 26244 | 09:52:53 INFO - PROCESS | 26244 | [#5] yui.html Cycles:180 Average:17060.64 Median:23364.41 stddev:23559.24 (100.8%) stddev-sans-first:23593.03 09:52:53 INFO - PROCESS | 26244 | Values: 629.2 631.2 661.5 666.7 732.1 12417.6 13362.1 13383.0 13410.7 13417.5 13034.9 13063.3 13113.9 13220.7 13254.3 627.0 762.0 762.6 782.3 787.7 769.5 772.6 775.1 775.9 776.3 824.7 826.4 826.5 826.5 826.8 646.8 660.7 661.5 663.9 821.6 596.9 601.2 601.8 602.9 602.9 13284.1 13323.6 13330.7 13339.1 13361.1 12421.8 12837.5 12896.9 12918.7 13026.7 11496.0 11810.1 11817.4 12028.6 12442.8 4054.8 4066.7 4077.7 4125.2 4204.9 60615.4 60618.4 60626.4 60631.7 60815.1 9229.1 9350.4 9621.9 9827.6 10074.4 19194.4 19215.3 19219.3 19236.1 19248.6 6394.6 6431.9 6501.9 6512.8 6809.9 3414.7 3543.9 3756.5 3765.1 3858.5 2801.7 2914.0 2919.9 2920.7 2930.7 510.9 536.9 539.1 552.9 560.3 512.9 516.9 535.2 535.4 542.4 7652.0 7665.7 7742.3 7860.9 8160.2 470.3 483.7 538.4 553.5 567.6 3679.2 3793.3 3880.0 3928.5 3994.6 83637.0 89663.0 90635.5 91626.5 91698.0 78553.0 80184.0 80276.6 80282.0 80525.0 44015.3 45862.0 66584.3 70859.3 71820.3 7161.1 7224.5 7277.5 7327.0 7417.3 44286.6 45121.8 45178.3 45673.5 46258.5 58066.4 64436.0 64810.4 65140.7 65187.0 10612.5 10810.7 10861.1 11033.0 11621.4 12811.1 12894.3 13114.2 13749.7 13792.5 7589.9 11057.6 11356.5 12357.3 12543.6 11272.5 12275.5 12518.1 12678.7 12982.5 11324.7 11539.4 12014.8 12033.8 12237.4 9844.2 10191.1 10233.8 10460.6 10562.7 10275.6 10441.9 10521.4 10554.7 10598.1 09:52:53 INFO - PROCESS | 26244 | -------- Summary: end -------- 09:52:53 INFO - PROCESS | 26244 | 09:52:54 INFO - TEST-INFO | 26244: exit 0 09:52:54 INFO - TEST-OK | dromaeo_css | took 1118424ms 09:52:54 INFO - TEST-START | kraken 09:52:54 INFO - operating with platform_type : linux_ 09:52:54 INFO - Initialising browser for kraken test... 09:52:54 INFO - TEST-INFO | started process 26437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3sC0vU/profile http://localhost:58647/getInfo.html) 09:52:58 INFO - PROCESS | 26437 | __metrics Screen width/height:1600/1200 09:52:58 INFO - PROCESS | 26437 | colorDepth:24 09:52:58 INFO - PROCESS | 26437 | Browser inner width/height: 1024/697 09:52:58 INFO - PROCESS | 26437 | __metrics 09:52:59 INFO - PROCESS | 26437 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:52:59 INFO - PROCESS | 26437 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:53:00 INFO - TEST-INFO | 26437: exit 0 09:53:00 INFO - Browser initialized. 09:53:00 INFO - Running cycle 1/1 for kraken test... 09:53:00 INFO - TEST-INFO | started process 26518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3sC0vU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:12 INFO - PROCESS | 26518 | RSS: Main: 159084544 09:53:12 INFO - PROCESS | 26518 | 09:53:15 INFO - PROCESS | 26518 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58647/tests/kraken/driver.html?testName=audio-beat-detection) 09:53:16 INFO - PROCESS | 26518 | RSS: Main: 217829376 09:53:16 INFO - PROCESS | 26518 | 09:53:18 INFO - PROCESS | 26518 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58647/tests/kraken/driver.html?testName=audio-dft) 09:53:19 INFO - PROCESS | 26518 | RSS: Main: 204808192 09:53:19 INFO - PROCESS | 26518 | 09:53:22 INFO - PROCESS | 26518 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58647/tests/kraken/driver.html?testName=audio-fft) 09:53:23 INFO - PROCESS | 26518 | RSS: Main: 272457728 09:53:23 INFO - PROCESS | 26518 | 09:53:25 INFO - PROCESS | 26518 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58647/tests/kraken/driver.html?testName=audio-oscillator) 09:53:26 INFO - PROCESS | 26518 | RSS: Main: 182005760 09:53:26 INFO - PROCESS | 26518 | 09:53:28 INFO - PROCESS | 26518 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58647/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:53:29 INFO - PROCESS | 26518 | RSS: Main: 186724352 09:53:29 INFO - PROCESS | 26518 | 09:53:32 INFO - PROCESS | 26518 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58647/tests/kraken/driver.html?testName=imaging-darkroom) 09:53:32 INFO - PROCESS | 26518 | RSS: Main: 222781440 09:53:32 INFO - PROCESS | 26518 | 09:53:36 INFO - PROCESS | 26518 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58647/tests/kraken/driver.html?testName=imaging-desaturate) 09:53:36 INFO - PROCESS | 26518 | RSS: Main: 218320896 09:53:36 INFO - PROCESS | 26518 | 09:53:39 INFO - PROCESS | 26518 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58647/tests/kraken/driver.html?testName=json-parse-financial) 09:53:40 INFO - PROCESS | 26518 | RSS: Main: 221483008 09:53:40 INFO - PROCESS | 26518 | 09:53:42 INFO - PROCESS | 26518 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58647/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:53:42 INFO - PROCESS | 26518 | RSS: Main: 208314368 09:53:42 INFO - PROCESS | 26518 | 09:53:44 INFO - PROCESS | 26518 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:53:45 INFO - PROCESS | 26518 | RSS: Main: 213143552 09:53:45 INFO - PROCESS | 26518 | 09:53:47 INFO - PROCESS | 26518 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:53:48 INFO - PROCESS | 26518 | RSS: Main: 210419712 09:53:48 INFO - PROCESS | 26518 | 09:53:50 INFO - PROCESS | 26518 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:53:51 INFO - PROCESS | 26518 | RSS: Main: 225460224 09:53:51 INFO - PROCESS | 26518 | 09:53:54 INFO - PROCESS | 26518 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:54 INFO - PROCESS | 26518 | RSS: Main: 226287616 09:53:54 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | Cycle 1(1): loaded http://localhost:58647/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58647/tests/kraken/driver.html?testName=ai-astar) 09:53:56 INFO - PROCESS | 26518 | RSS: Main: 269369344 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | __start_tp_report 09:53:56 INFO - PROCESS | 26518 | _x_x_mozilla_page_load 09:53:56 INFO - PROCESS | 26518 | _x_x_mozilla_page_load_details 09:53:56 INFO - PROCESS | 26518 | |i|pagename|runs| 09:53:56 INFO - PROCESS | 26518 | |0;ai-astar;104;114;113;114;116;112;113;114;116;113 09:53:56 INFO - PROCESS | 26518 | |1;audio-beat-detection;152;132;130;178;123;129;152;123;182;126 09:53:56 INFO - PROCESS | 26518 | |2;audio-dft;161;161;160;162;159;161;160;161;161;160 09:53:56 INFO - PROCESS | 26518 | |3;audio-fft;77;75;76;108;76;77;75;75;106;75 09:53:56 INFO - PROCESS | 26518 | |4;audio-oscillator;86;86;110;85;85;86;123;86;85;130 09:53:56 INFO - PROCESS | 26518 | |5;imaging-gaussian-blur;117;117;117;116;118;118;118;117;117;116 09:53:56 INFO - PROCESS | 26518 | |6;imaging-darkroom;146;146;146;146;148;145;146;147;146;146 09:53:56 INFO - PROCESS | 26518 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 09:53:56 INFO - PROCESS | 26518 | |8;json-parse-financial;66;66;66;65;65;66;67;67;67;66 09:53:56 INFO - PROCESS | 26518 | |9;json-stringify-tinderbox;65;66;66;66;65;65;66;65;65;65 09:53:56 INFO - PROCESS | 26518 | |10;stanford-crypto-aes;78;79;79;79;78;82;82;84;78;79 09:53:56 INFO - PROCESS | 26518 | |11;stanford-crypto-ccm;137;128;127;126;127;140;128;140;172;132 09:53:56 INFO - PROCESS | 26518 | |12;stanford-crypto-pbkdf2;165;164;162;163;163;164;163;162;166;162 09:53:56 INFO - PROCESS | 26518 | |13;stanford-crypto-sha256-iterative;67;65;66;65;65;65;70;70;64;65 09:53:56 INFO - PROCESS | 26518 | __end_tp_report 09:53:56 INFO - PROCESS | 26518 | __start_cc_report 09:53:56 INFO - PROCESS | 26518 | _x_x_mozilla_cycle_collect,1956 09:53:56 INFO - PROCESS | 26518 | __end_cc_report 09:53:56 INFO - PROCESS | 26518 | __startTimestamp1468601636932__endTimestamp 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | ------- Summary: start ------- 09:53:56 INFO - PROCESS | 26518 | Number of tests: 14 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.38 (3.0%) stddev-sans-first:1.36 09:53:56 INFO - PROCESS | 26518 | Values: 104.0 114.0 113.0 114.0 116.0 112.0 113.0 114.0 116.0 113.0 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:142.00 stddev:22.32 (15.7%) stddev-sans-first:23.41 09:53:56 INFO - PROCESS | 26518 | Values: 152.0 132.0 130.0 178.0 123.0 129.0 152.0 123.0 182.0 126.0 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 09:53:56 INFO - PROCESS | 26518 | Values: 161.0 161.0 160.0 162.0 159.0 161.0 160.0 161.0 161.0 160.0 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.50 stddev:13.21 (17.5%) stddev-sans-first:13.88 09:53:56 INFO - PROCESS | 26518 | Values: 77.0 75.0 76.0 108.0 76.0 77.0 75.0 75.0 106.0 75.0 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.50 stddev:17.78 (20.8%) stddev-sans-first:18.47 09:53:56 INFO - PROCESS | 26518 | Values: 86.0 86.0 110.0 85.0 85.0 86.0 123.0 86.0 85.0 130.0 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 09:53:56 INFO - PROCESS | 26518 | Values: 117.0 117.0 117.0 116.0 118.0 118.0 118.0 117.0 117.0 116.0 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 09:53:56 INFO - PROCESS | 26518 | Values: 146.0 146.0 146.0 146.0 148.0 145.0 146.0 147.0 146.0 146.0 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:53:56 INFO - PROCESS | 26518 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 09:53:56 INFO - PROCESS | 26518 | Values: 66.0 66.0 66.0 65.0 65.0 66.0 67.0 67.0 67.0 66.0 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 09:53:56 INFO - PROCESS | 26518 | Values: 65.0 66.0 66.0 66.0 65.0 65.0 66.0 65.0 65.0 65.0 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.00 stddev:2.10 (2.7%) stddev-sans-first:2.12 09:53:56 INFO - PROCESS | 26518 | Values: 78.0 79.0 79.0 79.0 78.0 82.0 82.0 84.0 78.0 79.0 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:134.50 stddev:13.88 (10.3%) stddev-sans-first:14.71 09:53:56 INFO - PROCESS | 26518 | Values: 137.0 128.0 127.0 126.0 127.0 140.0 128.0 140.0 172.0 132.0 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:163.50 stddev:1.35 (0.8%) stddev-sans-first:1.30 09:53:56 INFO - PROCESS | 26518 | Values: 165.0 164.0 162.0 163.0 163.0 164.0 163.0 162.0 166.0 162.0 09:53:56 INFO - PROCESS | 26518 | 09:53:56 INFO - PROCESS | 26518 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:65.50 stddev:2.15 (3.3%) stddev-sans-first:2.26 09:53:56 INFO - PROCESS | 26518 | Values: 67.0 65.0 66.0 65.0 65.0 65.0 70.0 70.0 64.0 65.0 09:53:56 INFO - PROCESS | 26518 | -------- Summary: end -------- 09:53:56 INFO - PROCESS | 26518 | 09:53:57 INFO - TEST-INFO | 26518: exit 0 09:53:57 INFO - TEST-OK | kraken | took 63281ms 09:53:57 INFO - SUITE-END | took 1181s 09:53:58 INFO - Completed test suite (00:19:41) 09:53:58 INFO - javascript benchmark 09:53:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2582.3931376126607, 2596.1822026061777, 2630.368711509238, 2640.168346970704, 2641.7358264173586, 4503.144402563511, 4574.4968053514085, 4667.136579732747, 4715.834945776898, 4721.881952951174, 4655.860324190271, 4663.090697314025, 4688.6249100072, 4708.458527269365, 4713.882152946178, 4094.97952510237, 4314.050908800059, 4344.087741574257, 4371.14762621289, 4437.090396468732, 4353.825846966118, 4393.692441529094, 4414.470263568376, 4417.42573465449, 4444.488883778358, 4187.43469631602, 4233.978830105861, 4238.152369526077, 4239.830406783756, 4244.0663054128045, 4217.219814334358, 4224.704270701052, 4271.743695378256, 4279.251131052053, 4291.35629655551, 4267.445232119836, 4270.850520231777, 4284.871453856389, 4299.462567179103, 4314.072474418015, 4523.886902827423, 4622.121796858586, 4691.601213896823, 4695.60087392572, 4744.786484608167, 5076.213186955991, 5081.466446023152, 5086.872828179326, 5098.158803797406, 5099.898002039976, 4808.855734327975, 5108.489151084899, 5115.309433226504, 5124.769385377667, 5130.3074084998425, 4581.74800385982, 4627.282771170474, 4629.745364004944, 4693.366395536627, 4694.929576056362, 5082.491750824962, 5122.769475373617, 5123.077845987684, 5124.30821839047, 5133.998870220271, 4909.116359055333, 4928.162212423897, 4955.306257124005, 4960.851174464772, 4962.5533701967, 4850.1997170466475, 4886.95113048865, 4985.326980857611, 5050.217216331474, 5051.747412629354, 5001.599872010231, 5008.774605142778, 5020.071286811952, 5024.723640199824, 5087.23691446286, 4995.650304478651, 5005.199168133154, 5007.8247261346405, 5020.347354843847, 5059.56993655536, 4058.939115913264, 4087.3868919661695, 4091.6931230157857, 4133.152703695735, 4140.627343539096, 3640.3265395901844, 3641.1625326175126, 3683.797391143459, 3686.4101743720876, 3687.0, 4216.2832318505925, 4269.893252668646, 4271.060366719316, 4281.01536646573, 4316.028893499, 4893.168161412568, 4899.559039686445, 4903.068417000758, 4903.509649035139, 4953.083679519301, 4266.1254442839145, 4269.615734583902, 4271.402003719481, 4271.893202669896, 4314.525402205755, 3952.9722272208855, 4329.480462344539, 4366.694331396771, 4431.446069241345, 4440.622547083534, 4715.0, 4715.528447155257, 4718.079974404958, 4728.71627702339, 4766.76166191689, 4749.715017098985, 4960.23116416956, 4964.304997300309, 4968.22992436173, 5004.524570165829, 4604.976975115103, 4675.485696573306, 4737.597304229179, 4742.1227072991605, 4743.549362810528, 4867.80528778859, 4874.463808981081, 4892.241702536113, 4897.90204195907, 4943.456219815889, 4755.2153894607, 4962.801487940442, 4968.3292755479, 4980.103581355246, 5031.698098114125, 4832.613390928787, 4878.048780487913, 4895.632827537877, 4904.534069263557, 4952.232403977389, 4905.166121759238, 4905.435874874435, 4907.386576677915, 4910.165271903857, 4945.901081978268, 4667.463241727245, 4738.218193997952, 4761.500042495488, 4824.927626085541, 4860.805567777391, 4797.40032495938, 4807.18277892766, 4822.734749588806, 4854.126257273725, 4908.067467181224, 4720.645951553716, 4723.858284251478, 4723.976380118077, 4737.0, 4797.64017698667], "value": 4569.330064163442, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.7710150287634, 570.1647087017518, 574.6724367110746, 588.1471865794596, 590.5423296944869, 28475.43049139016, 31653.68346316539, 31684.366312673734, 39839.20321593573, 41059.794701026454, 40531.18937621246, 40938.0, 40940.38589421161, 41011.79494102533, 41033.17933641325, 7821.256980586835, 7973.880391794128, 7979.441439099265, 7982.720604778805, 7984.520928744294, 7873.25204105609, 7959.1244963054305, 7971.9601401993195, 7980.401469889753, 7981.880271795928, 7949.046114466272, 7988.680452781882, 7995.600219989006, 7996.800079997988, 7998.12020677725, 7941.960290198541, 7969.242921922408, 7981.20187981206, 7983.481073730247, 7990.280874721245, 7862.331701805353, 7886.250806173462, 7892.092409372881, 7893.05283365994, 7894.052713674396, 38525.0, 38898.22203555941, 38901.80549097265, 38904.41643375352, 38919.0, 2863.541833306682, 3006.684298148685, 3047.283888286251, 3096.2723759916403, 3154.936901261962, 29746.553801692993, 29789.553156702666, 29916.850415747784, 30282.69717302821, 30314.84842575773, 3005.9248518786985, 3094.2883136878418, 3118.5634011238444, 3132.37352529495, 3220.6296275928335, 261895.0, 262711.0, 264863.0, 266111.0, 267400.0, 31286.530702039487, 32489.51265731016, 51560.74219628953, 52097.21854172191, 52262.738686307086, 33998.66001340005, 34018.31963360719, 34129.14677133092, 34147.4877876832, 34158.82920585431, 13611.86388136106, 13790.448382064806, 13811.51659691926, 13816.585502434944, 13843.0, 11389.658310250707, 11564.479598418091, 11594.362310073027, 11620.418979051014, 11628.0, 7924.445288829726, 7932.524048557105, 7950.165232650604, 7999.280064794197, 8017.559034253055, 3104.5343198520404, 3109.9067027989195, 3113.906582802474, 3160.7313378363096, 3184.7611429142908, 813.3818298093373, 862.6247582301719, 886.570013543431, 897.3673560140086, 927.8608208768603, 26782.732172678025, 26971.865140674563, 27327.0, 27543.724562754116, 27868.442631147263, 771.3898952900367, 895.1540793949655, 970.0541971577796, 978.9559469823876, 1028.285341687535, 13841.0, 14500.492482763053, 14525.709485810225, 14605.853941460662, 14799.18604476764, 369264.0, 369700.0, 380067.0, 381055.0, 382335.0, 47498.0, 48173.0, 48224.27663585049, 48332.27501587479, 48418.5158148421, 1087.396494945313, 1177.5937301630925, 1197.0, 1213.4114954247184, 1215.604928398274, 28183.71816281893, 29333.85333073321, 29489.26276843096, 29652.555211672272, 30298.0, 41301.38047929223, 41462.37806432966, 41614.58385416107, 41785.1642967145, 41905.37141942812, 306337.0, 306978.0, 307015.0, 307643.0, 368675.0, 25106.62340064937, 25517.61723574185, 25567.360815979748, 26848.463030739666, 26914.192574222805, 41961.31282701779, 42581.12830753869, 43007.354889677306, 43173.3523997134, 43283.783581081894, 36834.447483288306, 36981.81509092437, 37008.444873326385, 37420.62579374172, 37620.247595048495, 37286.62713372832, 37415.81292093631, 37441.81279093696, 37644.2471150581, 37787.43318850164, 35679.82160089183, 36236.63763362333, 36566.817165914, 36964.26071478609, 37039.25921481609, 32670.0, 33037.50443743394, 33463.0, 33792.0, 33811.3237735239, 24623.50752984966, 25155.371115721522, 25459.236222913343, 25487.36281592975, 25903.481930361664], "value": 16427.77952608612, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.8995916082239, 383.113093189267, 384.55199692358406, 391.8550136449514, 399.6083837838918, 16525.17374131293, 18044.097795110225, 18920.24319027239, 18982.71525927112, 19062.428127156207, 16995.15024248789, 17004.574885627866, 17963.91018044911, 18310.542236444096, 18313.81686183138, 5091.43994160643, 5252.028374750684, 5271.973640131794, 5278.762455689484, 5293.179557168645, 3754.6620804127624, 3771.830267637949, 6072.392760723937, 6073.66594837286, 6170.19787427636, 6071.696415179245, 6108.786192483264, 6118.204633397652, 6123.234595675541, 6135.6625385603775, 5208.0, 5489.725513724317, 5491.0, 5578.2748242728185, 5585.245991791137, 3485.494603282535, 5183.948160518385, 5521.668699878021, 5529.778808847641, 5619.072852979253, 13055.673608159777, 13085.149465284821, 13151.21092734439, 13214.537491187859, 13283.402246898913, 1838.9816101839078, 1858.628274345123, 1887.1507821480388, 2154.084514081525, 2174.412908514708, 9046.954765226197, 9467.52662366879, 9482.478463684494, 9972.90027099727, 9995.550200241007, 1699.7280435130444, 1866.4214093630883, 1924.8652594318403, 1979.782433803215, 2002.1590931808676, 71809.6409517949, 72227.0, 72344.0, 73454.26545734527, 74625.0, 10175.592976281014, 10347.27569070158, 10349.327293725884, 10626.840597391045, 10824.350538967687, 14375.856241437452, 14504.927475362556, 14506.274686265644, 14513.274336283355, 14544.49094281695, 7570.9242907570215, 7607.961960190164, 7614.657340419694, 7688.615569221628, 7708.730194443167, 7576.5832879191075, 7591.848163036709, 7684.654190561439, 7709.344705699966, 7714.421418393643, 4512.9774351128035, 4527.139843429738, 4588.9541104588525, 4591.127685739765, 4610.354550362952, 1818.2181661885252, 1840.4662647832247, 1874.322481379158, 1909.847212223019, 1947.1043320072924, 762.1045271805606, 827.4125370986546, 829.8381815545911, 889.5552223888056, 911.2482202183226, 17201.569960750832, 17278.65442691139, 17826.5543361417, 17855.0, 18200.1809918554, 805.2350267246139, 809.9554524501209, 825.2449009156554, 848.4781859156698, 867.9392442529089, 9222.584983675752, 9908.504574771378, 9972.900270997343, 9985.700428987142, 9993.10062094415, 402451.0, 407155.0, 407193.0, 409671.0, 409949.0, 48607.5139248603, 58668.413315866295, 76672.0, 80006.0, 83823.58088209642, 933.9813203735887, 944.6457578408097, 949.8907625623142, 959.1032384720309, 979.5689896445399, 15083.4720784772, 15720.21398930026, 15841.920790395974, 15968.680626387639, 16173.59566010859, 37792.055198620255, 38288.80855595704, 38629.613703862604, 38653.420198697604, 39254.0, 53704.73147634237, 55157.448425515235, 56169.43830561642, 56320.15519767125, 56675.71662141663, 7386.113666360071, 7925.962257794452, 8030.43786934909, 8261.504309741435, 8266.421350505407, 9962.900370996198, 10414.739631509274, 10552.683419497427, 10795.406252655865, 10979.28634638746, 8994.415363001384, 9367.110124538158, 9406.811863762823, 9899.703008909744, 10310.43292618913, 9276.768080798034, 9697.224222062077, 9705.708828735149, 9893.802123957625, 10019.148372388428, 9660.32377733552, 9935.751606209613, 10174.084332410119, 10183.287169898036, 10480.371177729055, 7438.73964411243, 7692.307692307719, 7895.447318687637, 7930.405219608668, 7952.0, 8145.551994640352, 10184.745381365228, 10379.273450858367, 10734.355938643706, 10851.782964340828], "value": 8264.616328308366, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1271.45327509171, 1364.563339731286, 1415.030703967782, 1492.5149326468893, 1725.3271224222556, 6814.318568143183, 7652.57910814905, 7850.0, 7870.173631768667, 8053.637586308616, 7830.8042298942555, 7937.20627937206, 7937.40469464791, 7939.126696063443, 7957.403194760402, 2219.4895174109965, 2243.1588154442084, 2256.4133325335447, 2257.1084421653436, 2263.875486848223, 2212.944676383095, 2233.3858188997992, 2258.7515373308925, 2259.085070546423, 2260.9434764130947, 2173.467500462389, 2188.7154669892893, 2199.3841724317135, 2199.670049492573, 2202.4603972026875, 2156.9568608627737, 2172.880491572963, 2178.5751778403137, 2178.59695956247, 2185.846990710651, 2178.880161591112, 2191.112599397247, 2197.373748481691, 2197.923072692448, 2200.7689192634703, 7695.230476952316, 7944.324732397753, 7975.282224599756, 7981.72063977758, 8040.155783642692, 4721.457032441279, 4803.759812009385, 4821.493743156953, 4836.056968891067, 4843.007183527368, 2791.8743656535303, 2818.0, 2895.753860921824, 2902.651681798198, 2906.3024874030293, 869.3132425383939, 875.5403413208053, 876.3865294293956, 899.0784445942895, 905.678484138128, 10871.83692244617, 10929.289596176222, 10946.288491248044, 10949.288296260718, 10954.287971281921, 3964.1675248198203, 4087.816048277835, 4228.725132866354, 4231.217224813419, 4233.618974292329, 8624.0, 8627.568621568897, 8630.827383452295, 8641.567921603895, 8658.264047556027, 4716.740579268105, 4717.787699553528, 4719.5752382285755, 4720.268358404453, 4727.054589082129, 3764.378877485184, 4121.175764847043, 4246.745195288293, 4366.716163449366, 4366.8908277292685, 3525.823708814549, 3539.1329124364697, 3609.7112231021456, 3641.053326135171, 3655.6344365563764, 1028.9022542858415, 1107.058999850121, 1108.2242430298822, 1111.244353839381, 1123.4326665034105, 738.2912404092132, 840.1850205300848, 852.9721685369116, 857.9313654907593, 860.4536119564121, 5159.484051594885, 5178.508041736029, 5314.92027619586, 5353.0, 5362.839114826562, 401.60441964664784, 408.1795590862388, 413.64839886096576, 419.4065397462617, 419.77961570175904, 3484.564429446319, 3607.85568577254, 3618.095476130967, 3650.9817450913106, 3697.0387699198404, 9462.243020558339, 9842.11420972116, 9907.653232136841, 9943.950280248697, 9949.204063674888, 9817.165540928958, 9823.656172033945, 9829.262805289633, 9851.704448866545, 9853.901460985442, 7290.5625662460425, 7370.410367170613, 7468.290512401313, 7481.0, 7489.737859174903, 5284.180951952453, 5370.462953704755, 5389.407165211902, 5528.391876893619, 5631.774729010794, 9100.590473428843, 9114.40756350835, 9123.315751318545, 9182.632694692138, 9209.585568649562, 8739.38824282294, 9034.728958131267, 9056.637734490547, 9253.491057991874, 9386.48374339418, 6220.502359811114, 6414.390632889868, 6417.26201486835, 6844.2129155147795, 6994.650267486707, 7051.541649792747, 7094.361507464353, 7367.079115110611, 7544.660490277841, 7596.734114305973, 6682.732690692318, 6933.514653974174, 6976.267491913276, 7014.68433920485, 7227.421806255592, 6837.658117094026, 6860.211075726155, 6897.620630865351, 6967.094277744063, 7045.401140902875, 6500.349965003462, 6503.512236582181, 6514.218293804584, 6571.0, 6625.4037136657935, 4635.768211589474, 4733.644976626698, 4771.95228047729, 4791.616670666269, 4872.6832755870755, 4854.2233242681, 4934.18585933317, 4944.901101977868, 4951.653384263067, 5007.7496125192865], "value": 4088.270291055357, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.4702218140435, 309.50942755732166, 315.60706919884746, 316.1353697636964, 318.33468051771797, 4837.443693975194, 4865.61075113991, 4869.878253043676, 4882.6093912487, 4896.510348965102, 4743.928841067387, 4750.477447480775, 4792.329073929653, 4805.375301210846, 4805.471398146201, 3565.23347480291, 3689.114612492996, 3704.944425833615, 3802.391617341226, 3825.5791862895057, 3755.9624403756025, 3791.4312853071983, 3793.943090853639, 3811.6760075393486, 3833.0609000794843, 3765.7363984521094, 3774.2074164425503, 3784.243151369737, 3787.1182038410575, 3809.542854857421, 3609.3322735294055, 3644.817759112047, 3787.8106094695154, 3804.524434445694, 3806.90482737931, 3316.8507417166284, 3367.6295607483157, 3368.292658541685, 3370.174307294704, 3374.2622549387083, 4688.882777930545, 4690.906181876343, 4693.88265293367, 4704.952950470486, 4705.458872229703, 4204.264253755611, 4300.505441874193, 4318.956810431887, 4334.479862416499, 4341.3053911374345, 4901.142300097505, 4937.728424936627, 4943.1102401567705, 4955.38949841303, 4956.727379994099, 3662.963370366289, 3671.430928206132, 3683.834227459771, 3690.7970061646597, 3729.1050147964565, 5093.668911520776, 5226.137687281632, 5229.744861233315, 5231.738413079331, 5255.710935898524, 3802.0, 3838.9040273993373, 3847.076701591598, 3855.5951625079524, 3861.8373710721526, 3908.413737939275, 3913.8043097844993, 3917.236138952877, 3919.333713268751, 3919.530176183931, 4272.786360681954, 4351.825007248089, 4375.518692943837, 4383.3863259143745, 4409.11817636474, 5001.7499125043605, 5037.974810125926, 5043.5712964398435, 5044.772985215674, 5049.722265275445, 1333.8932885369147, 1346.1250187378282, 1352.154903185509, 1354.593621913422, 1355.0650051464654, 846.7756044648173, 877.1842186766369, 899.2042042792176, 901.7159594727771, 909.1999040844015, 4365.214261432972, 4447.199504089295, 4466.129104824593, 4475.060237350128, 4482.982657804001, 5093.719845408538, 5119.180931051014, 5135.3324067870935, 5140.280360749498, 5166.689998600096, 4340.180043740548, 4455.2426087564545, 4461.821527138943, 4468.486124095705, 4474.619657329164, 2662.7736642385225, 2726.2230264374557, 2727.7316048037756, 2735.466584016098, 2736.7947403944386, 4903.509649035068, 4915.680480768739, 4920.704757714549, 4925.581325587294, 4926.187179115406, 4928.310036594879, 5250.0, 5273.6572122811895, 5275.4460781618145, 5281.788728450896, 4912.361393018885, 4921.163402221559, 4921.409430868319, 4943.604511639061, 4948.505149485023, 5130.563902068366, 5158.871028224325, 5160.200168973815, 5162.354705661793, 5178.792848286026, 4899.167141585867, 5072.619553533426, 5077.7461126944245, 5091.66904151229, 5120.948790512047, 4880.6085018340045, 4915.852524424273, 4927.359443272495, 4930.556249937523, 4935.889424879373, 3688.2992231475932, 3711.3319602471815, 3757.8308976095595, 3761.266553022244, 3765.7175711821174, 4919.237518184687, 5259.973700131475, 5268.604854635994, 5274.340707411574, 5276.841694749163, 5016.87457813543, 5029.1953287473825, 5034.622403319692, 5036.219385995177, 5045.192769156917, 5036.370453693288, 5048.8990220194655, 5051.217061355495, 5063.291139240583, 5066.4680208577565, 4809.855704328876, 4945.950540494549, 4961.5286547777905, 4989.775460104232, 4990.50094990498, 4856.295837103671, 4939.975300123477, 5002.974985125051, 5051.595872330131, 5061.139606267017, 4926.753662316942, 4931.13705101613, 4940.802367905244, 4954.306397104337, 4965.205567109245], "value": 3830.0512488955733, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.2071989293489, 631.1763149090436, 661.5402295404695, 666.6533402630632, 732.103173612325, 12417.627471175869, 13362.13146145501, 13383.0, 13410.66473338167, 13417.463301467942, 13034.934825325883, 13063.281519516422, 13113.868861311385, 13220.735585288312, 13254.337283135828, 627.0406278394064, 761.9961900190491, 762.5958242131679, 782.2529484342439, 787.6534324897056, 769.4959801330137, 772.6445834915945, 775.0892701076241, 775.9224077592224, 776.2935728487078, 824.6907409721355, 826.4380221449412, 826.5412695953743, 826.5412695953743, 826.7561069484486, 646.7962591783597, 660.7059858363031, 661.5137873662854, 663.8838203314449, 821.6138414944996, 596.9492593129589, 601.2034054877305, 601.7532811547288, 602.8824379246049, 602.9427204415573, 13284.070115091947, 13323.600291991255, 13330.666733331647, 13339.066265361429, 13361.13152645075, 12421.813672794826, 12837.486500539968, 12896.935515322457, 12918.741625167539, 13026.674333141653, 11496.0, 11810.114241431842, 11817.409129543488, 12028.578999734968, 12442.751144977141, 4054.776987265699, 4066.654334381581, 4077.673786097105, 4125.23683118624, 4204.894877628053, 60615.393846061415, 60618.393816062155, 60626.39373606251, 60631.69684151551, 60815.08777368343, 9229.077092290718, 9350.392224505385, 9621.90378096224, 9827.606895724091, 10074.44590547527, 19194.424167275003, 19215.32746353899, 19219.32732354389, 19236.134373953206, 19248.61502769965, 6394.648294343856, 6431.935680643227, 6501.869962600722, 6512.837179070466, 6809.897851532132, 3414.6585341466152, 3543.875964341236, 3756.5145088567256, 3765.058735316171, 3858.5369755628944, 2801.6918139004692, 2913.950977648045, 2919.8978035768646, 2920.66412362581, 2930.6922773108945, 510.9296024827979, 536.919462080691, 539.0539602996794, 552.850730302824, 560.3136158206165, 512.8846009647874, 516.8811173430132, 535.2078923193695, 535.3976776126857, 542.4196110162168, 7652.0, 7665.731699390494, 7742.264484873928, 7860.882086768703, 8160.224778646019, 470.2922102236113, 483.71460838105685, 538.4050624060435, 553.4907884746043, 567.6225310168774, 3679.1721862580707, 3793.258961537112, 3880.049387899983, 3928.46965659638, 3994.6404823565435, 83637.0, 89663.0, 90635.54682226546, 91626.54186729157, 91698.0, 78553.0, 80184.0, 80276.59861700654, 80282.0, 80525.0, 44015.339769902836, 45861.99999999933, 66584.33415665878, 70859.2914070863, 71820.28179718241, 7161.104861892263, 7224.494285400182, 7277.454190935595, 7326.96336518314, 7417.332440080419, 44286.55713442824, 45121.77439112915, 45178.322325165806, 45673.54326456693, 46258.537414625425, 58066.4193358061, 64436.0, 64810.35189648043, 65140.67429662821, 65187.0, 10612.522436490532, 10810.67567972962, 10861.131109511378, 11033.007029367396, 11621.418929053345, 12811.103222774316, 12894.290814004944, 13114.213147211198, 13749.656258593615, 13792.517261895786, 7589.892302501415, 11057.612983545538, 11356.54573817038, 12357.25856448616, 12543.56097536582, 11272.549098035986, 12275.508979641072, 12518.12373133872, 12678.683032924251, 12982.480700772241, 11324.689319371035, 11539.36533490666, 12014.75970480603, 12033.819492707442, 12237.449314780679, 9844.163246124159, 10191.133753631024, 10233.84649230277, 10460.581576736846, 10562.683119506428, 10275.588976440858, 10441.947790261, 10521.421321827067, 10554.683359499228, 10598.099161571045], "value": 6465.444527027223, "unit": "score"}], "name": "dromaeo_css", "value": 6304.839424623006, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 114.0, 116.0, 112.0, 113.0, 114.0, 116.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 132.0, 130.0, 178.0, 123.0, 129.0, 152.0, 123.0, 182.0, 126.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 159.0, 161.0, 160.0, 161.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 108.0, 76.0, 77.0, 75.0, 75.0, 106.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 110.0, 85.0, 85.0, 86.0, 123.0, 86.0, 85.0, 130.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 118.0, 118.0, 118.0, 117.0, 117.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 148.0, 145.0, 146.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 67.0, 67.0, 67.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 79.0, 78.0, 82.0, 82.0, 84.0, 78.0, 79.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 128.0, 127.0, 126.0, 127.0, 140.0, 128.0, 140.0, 172.0, 132.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 162.0, 163.0, 163.0, 164.0, 163.0, 162.0, 166.0, 162.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 65.0, 65.0, 65.0, 70.0, 70.0, 64.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1529.4000000000003, "alertThreshold": 2.0}]} 09:53:58 INFO - Return code: 0 09:53:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:53:58 INFO - # TBPL SUCCESS # 09:53:58 INFO - Running post-action listener: _resource_record_post_action 09:53:58 INFO - ##### 09:53:58 INFO - ##### Finished run-tests step (success) 09:53:58 INFO - ##### 09:53:58 INFO - Running post-run listener: _resource_record_post_run 09:53:58 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 535744512; Read time: 0; Write time: 406136 09:53:58 INFO - TinderboxPrint: CPU usage
13.0% 09:53:58 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:53:58 INFO - TinderboxPrint: I/O write bytes / time
535,744,512 / 406,136 09:53:58 INFO - TinderboxPrint: CPU idle
8,323.6 (87.0%) 09:53:58 INFO - TinderboxPrint: CPU user
1,199.3 (12.5%) 09:53:58 INFO - TinderboxPrint: Swap in / out
0 / 0 09:53:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246525952; Read time: 0; Write time: 216948 09:53:58 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288604160; Read time: 0; Write time: 189188 09:53:58 INFO - Running post-run listener: _upload_blobber_files 09:53:58 INFO - Blob upload gear active. 09:53:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:53:58 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 09:53:58 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'] 09:53:58 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 09:53:59 INFO - (blobuploader) - INFO - Open directory for files ... 09:53:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:53:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:54:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:03 INFO - (blobuploader) - INFO - Done attempting. 09:54:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:54:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:54:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:04 INFO - (blobuploader) - INFO - Done attempting. 09:54:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:54:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:54:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:04 INFO - (blobuploader) - INFO - Done attempting. 09:54:04 INFO - (blobuploader) - INFO - Iteration through files over. 09:54:04 INFO - Return code: 0 09:54:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:54:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:54:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7f91238dc370802c0cc565d2b4e810cce20983d432595941e8c79f98b40b200be8c810987ef59bb687b20f314c608fc083cd32434971d6d7ae1a523c056e064", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab0ea8a574a71a1c5e8886c11854f7f0bc4febc1f7b2827312a08d13196a46c7d1f538a205de77fd515462ad93c00ee31544f4bf2ccf1a9578f7af7a64369993", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9625c8f0bed8860792a875d8ee9d52089bd646357f352b568286409db1ecd0152c86293225a5a25f46fda6c5f7b1789d56d1c3fee63ad1d6ec1e9cc64a98f380"} 09:54:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:54:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:54:04 INFO - Contents: 09:54:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7f91238dc370802c0cc565d2b4e810cce20983d432595941e8c79f98b40b200be8c810987ef59bb687b20f314c608fc083cd32434971d6d7ae1a523c056e064", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab0ea8a574a71a1c5e8886c11854f7f0bc4febc1f7b2827312a08d13196a46c7d1f538a205de77fd515462ad93c00ee31544f4bf2ccf1a9578f7af7a64369993", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9625c8f0bed8860792a875d8ee9d52089bd646357f352b568286409db1ecd0152c86293225a5a25f46fda6c5f7b1789d56d1c3fee63ad1d6ec1e9cc64a98f380"} 09:54:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:54:04 INFO - Copying logs to upload dir... 09:54:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:54:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.985889 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-15 09:54:04.892758) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 09:54:04.900333) ========= 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=523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256 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/c7f91238dc370802c0cc565d2b4e810cce20983d432595941e8c79f98b40b200be8c810987ef59bb687b20f314c608fc083cd32434971d6d7ae1a523c056e064", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab0ea8a574a71a1c5e8886c11854f7f0bc4febc1f7b2827312a08d13196a46c7d1f538a205de77fd515462ad93c00ee31544f4bf2ccf1a9578f7af7a64369993", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9625c8f0bed8860792a875d8ee9d52089bd646357f352b568286409db1ecd0152c86293225a5a25f46fda6c5f7b1789d56d1c3fee63ad1d6ec1e9cc64a98f380"} build_url:https://queue.taskcluster.net/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/Z1ZNFN1gSAe3-F6yWjLJ-A/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/c7f91238dc370802c0cc565d2b4e810cce20983d432595941e8c79f98b40b200be8c810987ef59bb687b20f314c608fc083cd32434971d6d7ae1a523c056e064", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab0ea8a574a71a1c5e8886c11854f7f0bc4febc1f7b2827312a08d13196a46c7d1f538a205de77fd515462ad93c00ee31544f4bf2ccf1a9578f7af7a64369993", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9625c8f0bed8860792a875d8ee9d52089bd646357f352b568286409db1ecd0152c86293225a5a25f46fda6c5f7b1789d56d1c3fee63ad1d6ec1e9cc64a98f380"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 09:54:04.928365) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:54:04.928693) ========= 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=523ca41ca1e0623de333ad52000001bf-1468595210.940479-1773463256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 09:54:05.012521) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 09:54:05.012927) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 09:54:05.013275) ========= ========= Total master_lag: 0.17 =========