builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1468441518.43 results: success (0) buildid: 20160713120145 builduid: 4136cd9c10af4aeb8477e41b53b2c57b revision: 9ce9896423df2ce58e0ec22486d6519d8221a362 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 13:25:18.425999) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 13:25:18.426860) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 13:25:18.427329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 13:25:18.474879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:25:18.475178) ========= 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=cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 13:25:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-07-13 13:25:19 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146604 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:25:18.636080) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:25:18.636423) ========= 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=cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015361 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:25:18.695786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:25:18.696477) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9ce9896423df2ce58e0ec22486d6519d8221a362 --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 9ce9896423df2ce58e0ec22486d6519d8221a362 --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=cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 13:25:19,169 truncating revision to first 12 chars 2016-07-13 13:25:19,169 Setting DEBUG logging. 2016-07-13 13:25:19,169 attempt 1/10 2016-07-13 13:25:19,169 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9ce9896423df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 13:25:19,473 unpacking tar archive at: mozilla-central-9ce9896423df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665426 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:25:19.378568) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 13:25:19.379125) ========= script_repo_revision: 9ce9896423df2ce58e0ec22486d6519d8221a362 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 13:25:19.379903) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 13:25:19.380516) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 13:25:19.391818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-13 13:25:19.392146) ========= /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=cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:25:19 INFO - MultiFileLogger online at 20160713 13:25:19 in /builds/slave/test 13:25:19 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 13:25:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:25:19 INFO - {'append_to_log': False, 13:25:19 INFO - 'base_work_dir': '/builds/slave/test', 13:25:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:25:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:25:19 INFO - 'branch': 'Firefox-Non-PGO', 13:25:19 INFO - 'buildbot_json_path': 'buildprops.json', 13:25:19 INFO - 'config_files': ('talos/linux_config.py',), 13:25:19 INFO - 'default_actions': ('clobber', 13:25:19 INFO - 'read-buildbot-config', 13:25:19 INFO - 'download-and-extract', 13:25:19 INFO - 'populate-webroot', 13:25:19 INFO - 'create-virtualenv', 13:25:19 INFO - 'install', 13:25:19 INFO - 'run-tests'), 13:25:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:25:19 INFO - 'download_minidump_stackwalk': True, 13:25:19 INFO - 'download_symbols': 'ondemand', 13:25:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:25:19 INFO - 'tooltool.py': '/tools/tooltool.py', 13:25:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:25:19 INFO - '/tools/misc-python/virtualenv.py')}, 13:25:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:25:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:25:19 INFO - 'installer_path': 'installer.exe', 13:25:19 INFO - 'log_level': 'info', 13:25:19 INFO - 'log_name': 'talos', 13:25:19 INFO - 'log_to_console': True, 13:25:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:25:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:25:19 INFO - 'opt_config_files': (), 13:25:19 INFO - 'pip_index': False, 13:25:19 INFO - 'sps_profile': False, 13:25:19 INFO - 'sps_profile_interval': 0, 13:25:19 INFO - 'suite': 'dromaeojs', 13:25:19 INFO - 'system_bits': '32', 13:25:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:25:19 INFO - 'title': 'talos-linux64-ix-054', 13:25:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:25:19 INFO - 'use_talos_json': True, 13:25:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:25:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:25:19 INFO - 'work_dir': 'build'} 13:25:19 INFO - ##### 13:25:19 INFO - ##### Running clobber step. 13:25:19 INFO - ##### 13:25:19 INFO - Running pre-action listener: _resource_record_pre_action 13:25:19 INFO - Running main action method: clobber 13:25:19 INFO - rmtree: /builds/slave/test/build 13:25:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:25:20 INFO - Running post-action listener: _resource_record_post_action 13:25:20 INFO - ##### 13:25:20 INFO - ##### Finished clobber step (success) 13:25:20 INFO - ##### 13:25:20 INFO - ##### 13:25:20 INFO - ##### Running read-buildbot-config step. 13:25:20 INFO - ##### 13:25:20 INFO - Running pre-action listener: _resource_record_pre_action 13:25:20 INFO - Running main action method: read_buildbot_config 13:25:20 INFO - Using buildbot properties: 13:25:20 INFO - { 13:25:20 INFO - "project": "", 13:25:20 INFO - "product": "firefox", 13:25:20 INFO - "script_repo_revision": "production", 13:25:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:25:20 INFO - "repository": "", 13:25:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 13:25:20 INFO - "buildid": "20160713120145", 13:25:20 INFO - "pgo_build": "False", 13:25:20 INFO - "basedir": "/builds/slave/test", 13:25:20 INFO - "buildnumber": 560, 13:25:20 INFO - "slavename": "talos-linux64-ix-054", 13:25:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:25:20 INFO - "platform": "ubuntu64_hw", 13:25:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 13:25:20 INFO - "branch": "mozilla-central", 13:25:20 INFO - "repo_path": "mozilla-central", 13:25:20 INFO - "revision": "9ce9896423df2ce58e0ec22486d6519d8221a362", 13:25:20 INFO - "stage_platform": "linux64", 13:25:20 INFO - "builduid": "4136cd9c10af4aeb8477e41b53b2c57b", 13:25:20 INFO - "slavebuilddir": "test" 13:25:20 INFO - } 13:25:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:25:20 INFO - Running post-action listener: _resource_record_post_action 13:25:20 INFO - ##### 13:25:20 INFO - ##### Finished read-buildbot-config step (success) 13:25:20 INFO - ##### 13:25:20 INFO - ##### 13:25:20 INFO - ##### Running download-and-extract step. 13:25:20 INFO - ##### 13:25:20 INFO - Running pre-action listener: _resource_record_pre_action 13:25:20 INFO - Running main action method: download_and_extract 13:25:20 INFO - mkdir: /builds/slave/test/build/tests 13:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:20 INFO - https://queue.taskcluster.net/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:25:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:25:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:25:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/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 13:25:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/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 13:25:29 INFO - Downloaded 1361 bytes. 13:25:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:25:29 INFO - Using the following test package requirements: 13:25:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:25:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:25:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:25:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:29 INFO - u'jsshell-linux-x86_64.zip'], 13:25:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:25:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:25:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:25:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:25:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:25:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:25:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:25:29 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')]} 13:25:29 INFO - https://queue.taskcluster.net/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:25:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:25:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:25:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/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 13:25:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/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 13:25:38 INFO - Downloaded 22755343 bytes. 13:25:38 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'] 13:25:38 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 13:25:39 INFO - Return code: 0 13:25:39 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 13:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:39 INFO - https://queue.taskcluster.net/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:25:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:25:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:25:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/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 13:25:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/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 13:25:40 INFO - Downloaded 22755343 bytes. 13:25:40 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'] 13:25:40 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 13:25:41 INFO - Return code: 0 13:25:41 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')]} 13:25:41 INFO - https://queue.taskcluster.net/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:25:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:25:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:25:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/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 13:25:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/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 13:25:42 INFO - Downloaded 14403317 bytes. 13:25:42 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'] 13:25:42 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 13:25:43 INFO - Return code: 0 13:25: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')]} 13:25:43 INFO - https://queue.taskcluster.net/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:25:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:25:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:25:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/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 13:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C9Q3hAERSO6fszxB-X7Ijg/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 13:25:44 INFO - Downloaded 57051372 bytes. 13:25:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:25:44 INFO - mkdir: /builds/slave/test/properties 13:25:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:25:44 INFO - Writing to file /builds/slave/test/properties/build_url 13:25:44 INFO - Contents: 13:25:44 INFO - build_url:https://queue.taskcluster.net/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:25:45 INFO - Running post-action listener: _resource_record_post_action 13:25:45 INFO - Running post-action listener: set_extra_try_arguments 13:25:45 INFO - ##### 13:25:45 INFO - ##### Finished download-and-extract step (success) 13:25:45 INFO - ##### 13:25:45 INFO - ##### 13:25:45 INFO - ##### Running populate-webroot step. 13:25:45 INFO - ##### 13:25:45 INFO - Running pre-action listener: _resource_record_pre_action 13:25:45 INFO - Running main action method: populate_webroot 13:25:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:25:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:25:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:25:45 INFO - '--tppagecycles', 13:25:45 INFO - '7'], 13:25:45 INFO - 'tests': ['tsvgm']}}, 13:25:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:25:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:25:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:25:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:25:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:25:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:25:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:45 INFO - 'talos_options': ['--disable-e10s'], 13:25:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:45 INFO - 'talos_options': ['--disable-e10s'], 13:25:45 INFO - 'tests': ['damp', 'tps']}, 13:25:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:45 INFO - 'tests': ['damp', 'tps']}, 13:25:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:25:45 INFO - 'tests': ['dromaeo_dom']}, 13:25:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:25:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:25:45 INFO - 'tests': ['basic_compositor_video']}, 13:25:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:25:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:25:45 INFO - 'tests': ['a11yr', 13:25:45 INFO - 'ts_paint', 13:25:45 INFO - 'tpaint', 13:25:45 INFO - 'sessionrestore', 13:25:45 INFO - 'sessionrestore_no_auto_restore', 13:25:45 INFO - 'tabpaint']}, 13:25:45 INFO - 'other-e10s': {'tests': ['a11yr', 13:25:45 INFO - 'ts_paint', 13:25:45 INFO - 'tpaint', 13:25:45 INFO - 'sessionrestore', 13:25:45 INFO - 'sessionrestore_no_auto_restore', 13:25:45 INFO - 'tabpaint']}, 13:25:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:25:45 INFO - 'ts_paint', 13:25:45 INFO - 'tpaint', 13:25:45 INFO - 'sessionrestore', 13:25:45 INFO - 'sessionrestore_no_auto_restore', 13:25:45 INFO - 'tabpaint']}, 13:25:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:25:45 INFO - 'ts_paint', 13:25:45 INFO - 'tpaint', 13:25:45 INFO - 'sessionrestore', 13:25:45 INFO - 'sessionrestore_no_auto_restore', 13:25:45 INFO - 'tabpaint']}, 13:25:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:25:45 INFO - 'tests': ['a11yr', 13:25:45 INFO - 'ts_paint', 13:25:45 INFO - 'tpaint', 13:25:45 INFO - 'sessionrestore', 13:25:45 INFO - 'sessionrestore_no_auto_restore', 13:25:45 INFO - 'tabpaint']}, 13:25:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:25:45 INFO - 'tests': ['a11yr', 13:25:45 INFO - 'ts_paint', 13:25:45 INFO - 'tpaint', 13:25:45 INFO - 'sessionrestore', 13:25:45 INFO - 'sessionrestore_no_auto_restore', 13:25:45 INFO - 'tabpaint']}, 13:25:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:25:45 INFO - 'tests': ['tsvgx', 13:25:45 INFO - 'tsvgr_opacity', 13:25:45 INFO - 'tart', 13:25:45 INFO - 'tscrollx', 13:25:45 INFO - 'cart']}, 13:25:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:25:45 INFO - 'tsvgr_opacity', 13:25:45 INFO - 'tart', 13:25:45 INFO - 'tscrollx', 13:25:45 INFO - 'cart']}, 13:25:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:45 INFO - 'talos_options': ['--disable-e10s'], 13:25:45 INFO - 'tests': ['tp5o']}, 13:25:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:45 INFO - 'tests': ['tp5o']}, 13:25:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:45 INFO - 'talos_options': ['--disable-e10s', 13:25:45 INFO - '--xperf_path', 13:25:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:45 INFO - 'tests': ['tp5n']}, 13:25:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:45 INFO - 'talos_options': ['--xperf_path', 13:25:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:45 INFO - 'tests': ['tp5n']}}, 13:25:45 INFO - 'talos.zip': {'path': '', 13:25:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:25:45 INFO - Running post-action listener: _resource_record_post_action 13:25:45 INFO - ##### 13:25:45 INFO - ##### Finished populate-webroot step (success) 13:25:45 INFO - ##### 13:25:45 INFO - ##### 13:25:45 INFO - ##### Running create-virtualenv step. 13:25:45 INFO - ##### 13:25:45 INFO - Running pre-action listener: _resource_record_pre_action 13:25:45 INFO - Running main action method: create_virtualenv 13:25:45 INFO - Creating virtualenv /builds/slave/test/build/venv 13:25:45 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 13:25:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:25:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:25:45 INFO - Using real prefix '/usr' 13:25:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:25:46 INFO - Installing distribute.............................................................................................................................................................................................done. 13:25:48 INFO - Installing pip.................done. 13:25:48 INFO - Return code: 0 13:25:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:25: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')]} 13:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25: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')]} 13:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b43b0>, '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 0x20b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', '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 13:25: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', 'pip>=1.5'] in /builds/slave/test/build 13:25: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 pip>=1.5 13:25:48 INFO - Using env: {'DISPLAY': ':0', 13:25:48 INFO - 'HOME': '/home/cltbld', 13:25:48 INFO - 'LANG': 'en_US.UTF-8', 13:25:48 INFO - 'LANGUAGE': 'en_US:en', 13:25:48 INFO - 'LOGNAME': 'cltbld', 13:25:48 INFO - 'MAIL': '/var/mail/cltbld', 13:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:48 INFO - 'MOZ_NO_REMOTE': '1', 13:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:48 INFO - 'NO_EM_RESTART': '1', 13:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:48 INFO - 'PWD': '/builds/slave/test', 13:25:48 INFO - 'SHELL': '/bin/bash', 13:25:48 INFO - 'SHLVL': '1', 13:25:48 INFO - 'TERM': 'linux', 13:25:48 INFO - 'TMOUT': '86400', 13:25:48 INFO - 'USER': 'cltbld', 13:25:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', 13:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:48 INFO - '_': '/tools/buildbot/bin/python'} 13:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:48 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 13:25:48 INFO - Cleaning up... 13:25:48 INFO - Return code: 0 13:25:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:25: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')]} 13:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25: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')]} 13:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25: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', '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 0x1df5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b43b0>, '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 0x20b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', '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 13:25: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:25: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 psutil>=3.1.1 13:25:48 INFO - Using env: {'DISPLAY': ':0', 13:25:48 INFO - 'HOME': '/home/cltbld', 13:25:48 INFO - 'LANG': 'en_US.UTF-8', 13:25:48 INFO - 'LANGUAGE': 'en_US:en', 13:25:48 INFO - 'LOGNAME': 'cltbld', 13:25:48 INFO - 'MAIL': '/var/mail/cltbld', 13:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:48 INFO - 'MOZ_NO_REMOTE': '1', 13:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:48 INFO - 'NO_EM_RESTART': '1', 13:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:48 INFO - 'PWD': '/builds/slave/test', 13:25:48 INFO - 'SHELL': '/bin/bash', 13:25:48 INFO - 'SHLVL': '1', 13:25:48 INFO - 'TERM': 'linux', 13:25:48 INFO - 'TMOUT': '86400', 13:25:48 INFO - 'USER': 'cltbld', 13:25:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', 13:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:48 INFO - '_': '/tools/buildbot/bin/python'} 13:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:48 INFO - Downloading/unpacking psutil>=3.1.1 13:25: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 13:25: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 13:25: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 13:25: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 13:25: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 13:25: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 13:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:25:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:50 INFO - Installing collected packages: psutil 13:25:50 INFO - Running setup.py install for psutil 13:25:50 INFO - building 'psutil._psutil_linux' extension 13:25:50 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 13:25:50 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 13:25:50 INFO - building 'psutil._psutil_posix' extension 13:25:50 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 13:25:51 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 13:25:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:51 INFO - Successfully installed psutil 13:25:51 INFO - Cleaning up... 13:25:51 INFO - Return code: 0 13:25:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:25: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')]} 13:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25: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')]} 13:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:51 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 0x1df5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b43b0>, '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 0x20b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', '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 13:25:51 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 13:25:51 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 13:25:51 INFO - Using env: {'DISPLAY': ':0', 13:25:51 INFO - 'HOME': '/home/cltbld', 13:25:51 INFO - 'LANG': 'en_US.UTF-8', 13:25:51 INFO - 'LANGUAGE': 'en_US:en', 13:25:51 INFO - 'LOGNAME': 'cltbld', 13:25:51 INFO - 'MAIL': '/var/mail/cltbld', 13:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:51 INFO - 'MOZ_NO_REMOTE': '1', 13:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:51 INFO - 'NO_EM_RESTART': '1', 13:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:51 INFO - 'PWD': '/builds/slave/test', 13:25:51 INFO - 'SHELL': '/bin/bash', 13:25:51 INFO - 'SHLVL': '1', 13:25:51 INFO - 'TERM': 'linux', 13:25:51 INFO - 'TMOUT': '86400', 13:25:51 INFO - 'USER': 'cltbld', 13:25:51 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', 13:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:51 INFO - '_': '/tools/buildbot/bin/python'} 13:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:25:51 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 13:25:51 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 13:25:51 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 13:25:51 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 13:25:51 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 13:25:51 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 13:25:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:25:53 INFO - Installing collected packages: mozsystemmonitor 13:25:53 INFO - Running setup.py install for mozsystemmonitor 13:25:53 INFO - Successfully installed mozsystemmonitor 13:25:53 INFO - Cleaning up... 13:25:53 INFO - Return code: 0 13:25:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:53 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 0x1df5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b43b0>, '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 0x20b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', '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 13:25:53 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 13:25:53 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 13:25:53 INFO - Using env: {'DISPLAY': ':0', 13:25:53 INFO - 'HOME': '/home/cltbld', 13:25:53 INFO - 'LANG': 'en_US.UTF-8', 13:25:53 INFO - 'LANGUAGE': 'en_US:en', 13:25:53 INFO - 'LOGNAME': 'cltbld', 13:25:53 INFO - 'MAIL': '/var/mail/cltbld', 13:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:53 INFO - 'MOZ_NO_REMOTE': '1', 13:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:53 INFO - 'NO_EM_RESTART': '1', 13:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:53 INFO - 'PWD': '/builds/slave/test', 13:25:53 INFO - 'SHELL': '/bin/bash', 13:25:53 INFO - 'SHLVL': '1', 13:25:53 INFO - 'TERM': 'linux', 13:25:53 INFO - 'TMOUT': '86400', 13:25:53 INFO - 'USER': 'cltbld', 13:25:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', 13:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:53 INFO - '_': '/tools/buildbot/bin/python'} 13:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:53 INFO - Downloading/unpacking jsonschema==2.5.1 13:25:53 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 13:25:53 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 13:25:53 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 13:25:53 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 13:25:53 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 13:25:53 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 13:25:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:25:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:25:55 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 13:25:55 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 13:25:55 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 13:25:55 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 13:25:55 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 13:25:55 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 13:25:55 INFO - Downloading functools32-3.2.3-2.tar.gz 13:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:25:55 INFO - warning: no files found matching '*.txt' 13:25:55 INFO - no previously-included directories found matching 'build' 13:25:55 INFO - no previously-included directories found matching 'dist' 13:25:55 INFO - no previously-included directories found matching '.git*' 13:25:55 INFO - Installing collected packages: jsonschema, functools32 13:25:55 INFO - Running setup.py install for functools32 13:25:55 INFO - warning: no files found matching '*.txt' 13:25:55 INFO - no previously-included directories found matching 'build' 13:25:55 INFO - no previously-included directories found matching 'dist' 13:25:55 INFO - no previously-included directories found matching '.git*' 13:25:56 INFO - Successfully installed jsonschema functools32 13:25:56 INFO - Cleaning up... 13:25:56 INFO - Return code: 0 13:25:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1df5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b43b0>, '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 0x20b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', '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 13:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:25:56 INFO - Using env: {'DISPLAY': ':0', 13:25:56 INFO - 'HOME': '/home/cltbld', 13:25:56 INFO - 'LANG': 'en_US.UTF-8', 13:25:56 INFO - 'LANGUAGE': 'en_US:en', 13:25:56 INFO - 'LOGNAME': 'cltbld', 13:25:56 INFO - 'MAIL': '/var/mail/cltbld', 13:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:56 INFO - 'MOZ_NO_REMOTE': '1', 13:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:56 INFO - 'NO_EM_RESTART': '1', 13:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:56 INFO - 'PWD': '/builds/slave/test', 13:25:56 INFO - 'SHELL': '/bin/bash', 13:25:56 INFO - 'SHLVL': '1', 13:25:56 INFO - 'TERM': 'linux', 13:25:56 INFO - 'TMOUT': '86400', 13:25:56 INFO - 'USER': 'cltbld', 13:25:56 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', 13:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:56 INFO - '_': '/tools/buildbot/bin/python'} 13:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:56 INFO - Downloading/unpacking blobuploader==1.2.4 13:25: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 13:25: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 13:25: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 13:25: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 13:25: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 13:25: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 13:25:58 INFO - Downloading blobuploader-1.2.4.tar.gz 13:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:25:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:25:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:25:58 INFO - Downloading docopt-0.6.1.tar.gz 13:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:25:59 INFO - Installing collected packages: blobuploader, requests, docopt 13:25:59 INFO - Running setup.py install for blobuploader 13:25:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:25:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:25:59 INFO - Running setup.py install for requests 13:25:59 INFO - Running setup.py install for docopt 13:25:59 INFO - Successfully installed blobuploader requests docopt 13:25:59 INFO - Cleaning up... 13:25:59 INFO - Return code: 0 13:25:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:25: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')]} 13:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25: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')]} 13:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:59 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 0x1df5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b43b0>, '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 0x20b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', '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 13:25:59 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 13:25:59 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 13:25:59 INFO - Using env: {'DISPLAY': ':0', 13:25:59 INFO - 'HOME': '/home/cltbld', 13:25:59 INFO - 'LANG': 'en_US.UTF-8', 13:25:59 INFO - 'LANGUAGE': 'en_US:en', 13:25:59 INFO - 'LOGNAME': 'cltbld', 13:25:59 INFO - 'MAIL': '/var/mail/cltbld', 13:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:59 INFO - 'MOZ_NO_REMOTE': '1', 13:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:59 INFO - 'NO_EM_RESTART': '1', 13:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:59 INFO - 'PWD': '/builds/slave/test', 13:25:59 INFO - 'SHELL': '/bin/bash', 13:25:59 INFO - 'SHLVL': '1', 13:25:59 INFO - 'TERM': 'linux', 13:25:59 INFO - 'TMOUT': '86400', 13:25:59 INFO - 'USER': 'cltbld', 13:25:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', 13:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:59 INFO - '_': '/tools/buildbot/bin/python'} 13:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:25:59 INFO - Running setup.py (path:/tmp/pip-7uFR7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:25:59 INFO - Running setup.py (path:/tmp/pip-5scveF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:00 INFO - Running setup.py (path:/tmp/pip-BgBrRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:00 INFO - Running setup.py (path:/tmp/pip-7d33Gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:00 INFO - Running setup.py (path:/tmp/pip-No7uRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:00 INFO - Running setup.py (path:/tmp/pip-2lUi92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:00 INFO - Running setup.py (path:/tmp/pip-UT9S6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:00 INFO - Running setup.py (path:/tmp/pip-f397fV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:00 INFO - Running setup.py (path:/tmp/pip-KAl_YT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:00 INFO - Running setup.py (path:/tmp/pip-EFYUCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:00 INFO - Running setup.py (path:/tmp/pip-MnScak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:00 INFO - Running setup.py (path:/tmp/pip-eHim9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:00 INFO - Running setup.py (path:/tmp/pip-JYtyUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:00 INFO - Running setup.py (path:/tmp/pip-pC2KFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:00 INFO - Running setup.py (path:/tmp/pip-jeywd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:00 INFO - Running setup.py (path:/tmp/pip-KT497C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:01 INFO - Running setup.py (path:/tmp/pip-dztVoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:26:01 INFO - Running setup.py install for manifestparser 13:26:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:26:01 INFO - Running setup.py install for mozcrash 13:26:01 INFO - Running setup.py install for mozdebug 13:26:01 INFO - Running setup.py install for mozdevice 13:26:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:26:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:26:01 INFO - Running setup.py install for mozfile 13:26:01 INFO - Running setup.py install for mozhttpd 13:26:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:26:01 INFO - Running setup.py install for mozinfo 13:26:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:26:01 INFO - Running setup.py install for mozInstall 13:26:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:26:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:26:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:26:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:26:01 INFO - Running setup.py install for mozleak 13:26:01 INFO - Running setup.py install for mozlog 13:26:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:26:02 INFO - Running setup.py install for moznetwork 13:26:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:26:02 INFO - Running setup.py install for mozprocess 13:26:02 INFO - Running setup.py install for mozprofile 13:26:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:26:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:26:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:26:02 INFO - Running setup.py install for mozrunner 13:26:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:26:02 INFO - Running setup.py install for mozscreenshot 13:26:02 INFO - Running setup.py install for moztest 13:26:02 INFO - Running setup.py install for mozversion 13:26:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:26:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:26:02 INFO - Cleaning up... 13:26:02 INFO - Return code: 0 13:26:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:02 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 0x1df5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b43b0>, '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 0x20b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', '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 13:26:02 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 13:26:02 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 13:26:02 INFO - Using env: {'DISPLAY': ':0', 13:26:02 INFO - 'HOME': '/home/cltbld', 13:26:02 INFO - 'LANG': 'en_US.UTF-8', 13:26:02 INFO - 'LANGUAGE': 'en_US:en', 13:26:02 INFO - 'LOGNAME': 'cltbld', 13:26:02 INFO - 'MAIL': '/var/mail/cltbld', 13:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:02 INFO - 'MOZ_NO_REMOTE': '1', 13:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:02 INFO - 'NO_EM_RESTART': '1', 13:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:02 INFO - 'PWD': '/builds/slave/test', 13:26:02 INFO - 'SHELL': '/bin/bash', 13:26:02 INFO - 'SHLVL': '1', 13:26:02 INFO - 'TERM': 'linux', 13:26:02 INFO - 'TMOUT': '86400', 13:26:02 INFO - 'USER': 'cltbld', 13:26:02 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', 13:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:02 INFO - '_': '/tools/buildbot/bin/python'} 13:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:03 INFO - Running setup.py (path:/tmp/pip-RWa8FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:03 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)) 13:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:03 INFO - Running setup.py (path:/tmp/pip-6p6JuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:03 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)) 13:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:03 INFO - Running setup.py (path:/tmp/pip-QUFVcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:03 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)) 13:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:03 INFO - Running setup.py (path:/tmp/pip-Cnyior-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:03 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)) 13:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:03 INFO - Running setup.py (path:/tmp/pip-154PZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:03 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)) 13:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:03 INFO - Running setup.py (path:/tmp/pip-WbQP3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:03 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)) 13:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:03 INFO - Running setup.py (path:/tmp/pip-BcjO5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:03 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)) 13:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:03 INFO - Running setup.py (path:/tmp/pip-ag1Iyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:03 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)) 13:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:03 INFO - Running setup.py (path:/tmp/pip-isjpZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:03 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)) 13:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:03 INFO - Running setup.py (path:/tmp/pip-kw9x1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:03 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)) 13:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:03 INFO - Running setup.py (path:/tmp/pip-wltaT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:03 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)) 13:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:03 INFO - Running setup.py (path:/tmp/pip-PYpTQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:03 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)) 13:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:03 INFO - Running setup.py (path:/tmp/pip-VtHLnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:04 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)) 13:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:04 INFO - Running setup.py (path:/tmp/pip-RIJgD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:04 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)) 13:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:04 INFO - Running setup.py (path:/tmp/pip-4D3Pzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:04 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)) 13:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:04 INFO - Running setup.py (path:/tmp/pip-4lAetV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:04 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)) 13:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:04 INFO - Running setup.py (path:/tmp/pip-XSMi8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:04 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)) 13:26:04 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)) 13:26:04 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)) 13:26:04 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)) 13:26:04 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)) 13:26:04 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)) 13:26:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:06 INFO - Downloading blessings-1.6.tar.gz 13:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:26:06 INFO - Installing collected packages: blessings 13:26:06 INFO - Running setup.py install for blessings 13:26:06 INFO - Successfully installed blessings 13:26:06 INFO - Cleaning up... 13:26:06 INFO - Return code: 0 13:26:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:06 INFO - Reading from file tmpfile_stdout 13:26:06 INFO - Current package versions: 13:26:06 INFO - argparse == 1.2.1 13:26:06 INFO - blessings == 1.6 13:26:06 INFO - blobuploader == 1.2.4 13:26:06 INFO - docopt == 0.6.1 13:26:06 INFO - functools32 == 3.2.3-2 13:26:06 INFO - jsonschema == 2.5.1 13:26:06 INFO - manifestparser == 1.1 13:26:06 INFO - mozInstall == 1.12 13:26:06 INFO - mozcrash == 0.17 13:26:06 INFO - mozdebug == 0.1 13:26:06 INFO - mozdevice == 0.48 13:26:06 INFO - mozfile == 1.2 13:26:06 INFO - mozhttpd == 0.7 13:26:06 INFO - mozinfo == 0.9 13:26:06 INFO - mozleak == 0.1 13:26:06 INFO - mozlog == 3.2 13:26:06 INFO - moznetwork == 0.27 13:26:06 INFO - mozprocess == 0.23 13:26:06 INFO - mozprofile == 0.28 13:26:06 INFO - mozrunner == 6.12 13:26:06 INFO - mozscreenshot == 0.1 13:26:06 INFO - mozsystemmonitor == 0.3 13:26:06 INFO - moztest == 0.7 13:26:06 INFO - mozversion == 1.4 13:26:06 INFO - psutil == 3.1.1 13:26:06 INFO - requests == 1.2.3 13:26:06 INFO - wsgiref == 0.1.2 13:26:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:06 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 0x1df5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b43b0>, '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 0x20b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', '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 13:26:06 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 13:26:06 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 13:26:06 INFO - Using env: {'DISPLAY': ':0', 13:26:06 INFO - 'HOME': '/home/cltbld', 13:26:06 INFO - 'LANG': 'en_US.UTF-8', 13:26:06 INFO - 'LANGUAGE': 'en_US:en', 13:26:06 INFO - 'LOGNAME': 'cltbld', 13:26:06 INFO - 'MAIL': '/var/mail/cltbld', 13:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:06 INFO - 'MOZ_NO_REMOTE': '1', 13:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:06 INFO - 'NO_EM_RESTART': '1', 13:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:06 INFO - 'PWD': '/builds/slave/test', 13:26:06 INFO - 'SHELL': '/bin/bash', 13:26:06 INFO - 'SHLVL': '1', 13:26:06 INFO - 'TERM': 'linux', 13:26:06 INFO - 'TMOUT': '86400', 13:26:06 INFO - 'USER': 'cltbld', 13:26:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', 13:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:06 INFO - '_': '/tools/buildbot/bin/python'} 13:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:06 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)) 13:26:06 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)) 13:26:06 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)) 13:26:06 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)) 13:26:06 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)) 13:26:06 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)) 13:26:06 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)) 13:26:06 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)) 13:26:06 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)) 13:26:06 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)) 13:26:06 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)) 13:26:06 INFO - Cleaning up... 13:26:06 INFO - Return code: 0 13:26:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b43b0>, '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 0x20b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5740>, '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': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', '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 13:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:26:06 INFO - Using env: {'DISPLAY': ':0', 13:26:06 INFO - 'HOME': '/home/cltbld', 13:26:06 INFO - 'LANG': 'en_US.UTF-8', 13:26:06 INFO - 'LANGUAGE': 'en_US:en', 13:26:06 INFO - 'LOGNAME': 'cltbld', 13:26:06 INFO - 'MAIL': '/var/mail/cltbld', 13:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:06 INFO - 'MOZ_NO_REMOTE': '1', 13:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:06 INFO - 'NO_EM_RESTART': '1', 13:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:06 INFO - 'PWD': '/builds/slave/test', 13:26:06 INFO - 'SHELL': '/bin/bash', 13:26:06 INFO - 'SHLVL': '1', 13:26:06 INFO - 'TERM': 'linux', 13:26:06 INFO - 'TMOUT': '86400', 13:26:06 INFO - 'USER': 'cltbld', 13:26:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', 13:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:06 INFO - '_': '/tools/buildbot/bin/python'} 13:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:26:07 INFO - Cleaning up... 13:26:07 INFO - Return code: 0 13:26:07 INFO - Running post-action listener: _resource_record_post_action 13:26:07 INFO - Running post-action listener: _start_resource_monitoring 13:26:07 INFO - Starting resource monitoring. 13:26:07 INFO - ##### 13:26:07 INFO - ##### Finished create-virtualenv step (success) 13:26:07 INFO - ##### 13:26:07 INFO - ##### 13:26:07 INFO - ##### Running install step. 13:26:07 INFO - ##### 13:26:07 INFO - Running pre-action listener: _resource_record_pre_action 13:26:07 INFO - Running main action method: install 13:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:07 INFO - Reading from file tmpfile_stdout 13:26:07 INFO - Detecting whether we're running mozinstall >=1.0... 13:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:26:07 INFO - Reading from file tmpfile_stdout 13:26:07 INFO - Output received: 13:26:07 INFO - Usage: mozinstall [options] installer 13:26:07 INFO - Options: 13:26:07 INFO - -h, --help show this help message and exit 13:26:07 INFO - -d DEST, --destination=DEST 13:26:07 INFO - Directory to install application into. [default: 13:26:07 INFO - "/builds/slave/test"] 13:26:07 INFO - --app=APP Application being installed. [default: firefox] 13:26:07 INFO - mkdir: /builds/slave/test/build/application 13:26:07 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'] 13:26:07 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 13:26:23 INFO - Reading from file tmpfile_stdout 13:26:23 INFO - Output received: 13:26:23 INFO - /builds/slave/test/build/application/firefox/firefox 13:26:23 INFO - Running post-action listener: _resource_record_post_action 13:26:23 INFO - ##### 13:26:23 INFO - ##### Finished install step (success) 13:26:23 INFO - ##### 13:26:23 INFO - ##### 13:26:23 INFO - ##### Running run-tests step. 13:26:23 INFO - ##### 13:26:23 INFO - Running pre-action listener: _resource_record_pre_action 13:26:23 INFO - Running main action method: run_tests 13:26:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:26:23 INFO - Python 2.7.3 13:26:23 INFO - Return code: 0 13:26:23 INFO - grabbing minidump binary from tooltool 13:26: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')]} 13:26:23 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 0x20b43b0>, '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 0x20b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:26:23 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 13:26:23 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 13:26:23 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 13:26:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:26:23 INFO - Return code: 0 13:26:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:26:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:26:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:26:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:26:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:26:23 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/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 13:26:23 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/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 13:26:23 INFO - Using env: {'DISPLAY': ':0', 13:26:23 INFO - 'HOME': '/home/cltbld', 13:26:23 INFO - 'LANG': 'en_US.UTF-8', 13:26:23 INFO - 'LANGUAGE': 'en_US:en', 13:26:23 INFO - 'LOGNAME': 'cltbld', 13:26:23 INFO - 'MAIL': '/var/mail/cltbld', 13:26:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:26:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:23 INFO - 'MOZ_NO_REMOTE': '1', 13:26:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:23 INFO - 'NO_EM_RESTART': '1', 13:26:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:23 INFO - 'PWD': '/builds/slave/test', 13:26:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:26:23 INFO - 'SHELL': '/bin/bash', 13:26:23 INFO - 'SHLVL': '1', 13:26:23 INFO - 'TERM': 'linux', 13:26:23 INFO - 'TMOUT': '86400', 13:26:23 INFO - 'USER': 'cltbld', 13:26:23 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824', 13:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:23 INFO - '_': '/tools/buildbot/bin/python'} 13:26:23 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/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 13:26:24 INFO - mozversion application_buildid: 20160713120145 13:26:24 INFO - mozversion application_changeset: 9ce9896423df2ce58e0ec22486d6519d8221a362 13:26:24 INFO - mozversion application_display_name: Nightly 13:26:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:26:24 INFO - mozversion application_name: Firefox 13:26:24 INFO - mozversion application_remotingname: firefox 13:26:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:26:24 INFO - mozversion application_vendor: Mozilla 13:26:24 INFO - mozversion application_version: 50.0a1 13:26:24 INFO - mozversion platform_buildid: 20160713120145 13:26:24 INFO - mozversion platform_changeset: 9ce9896423df2ce58e0ec22486d6519d8221a362 13:26:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:26:24 INFO - mozversion platform_version: 50.0a1 13:26:24 INFO - using testdate: 1468441584 13:26:24 INFO - actual date: 1468441584 13:26:24 INFO - starting webserver on 'localhost:50805' 13:26:24 INFO - SUITE-START | Running 2 tests 13:26:24 INFO - TEST-START | dromaeo_css 13:26:24 INFO - operating with platform_type : linux_ 13:26:24 INFO - Initialising browser for dromaeo_css test... 13:26:24 INFO - TEST-INFO | started process 4083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpskfwZI/profile http://localhost:50805/getInfo.html) 13:26:28 INFO - PROCESS | 4083 | __metrics Screen width/height:1600/1200 13:26:28 INFO - PROCESS | 4083 | colorDepth:24 13:26:28 INFO - PROCESS | 4083 | Browser inner width/height: 1024/697 13:26:28 INFO - PROCESS | 4083 | __metrics 13:26:29 INFO - PROCESS | 4083 | 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" 13:26:29 INFO - PROCESS | 4083 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:26:30 INFO - TEST-INFO | 4083: exit 0 13:26:30 INFO - Browser initialized. 13:26:30 INFO - Running cycle 1/1 for dromaeo_css test... 13:26:30 INFO - TEST-INFO | started process 4165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpskfwZI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:26:42 INFO - PROCESS | 4165 | RSS: Main: 159031296 13:26:42 INFO - PROCESS | 4165 | 13:27:33 INFO - PROCESS | 4165 | 1468441653729 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] 13:29:46 INFO - PROCESS | 4165 | Cycle 1(1): loaded http://localhost:50805/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50805/tests/dromaeo/cssquery-ext.html) 13:29:47 INFO - PROCESS | 4165 | RSS: Main: 245080064 13:29:47 INFO - PROCESS | 4165 | 13:32:49 INFO - PROCESS | 4165 | Cycle 1(1): loaded http://localhost:50805/tests/dromaeo/cssquery-ext.html (next: http://localhost:50805/tests/dromaeo/cssquery-jquery.html) 13:32:50 INFO - PROCESS | 4165 | RSS: Main: 243683328 13:32:50 INFO - PROCESS | 4165 | 13:35:52 INFO - PROCESS | 4165 | Cycle 1(1): loaded http://localhost:50805/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50805/tests/dromaeo/cssquery-mootools.html) 13:35:53 INFO - PROCESS | 4165 | RSS: Main: 242102272 13:35:53 INFO - PROCESS | 4165 | 13:38:55 INFO - PROCESS | 4165 | Cycle 1(1): loaded http://localhost:50805/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50805/tests/dromaeo/cssquery-prototype.html) 13:38:56 INFO - PROCESS | 4165 | RSS: Main: 239534080 13:38:56 INFO - PROCESS | 4165 | 13:41:59 INFO - PROCESS | 4165 | Cycle 1(1): loaded http://localhost:50805/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50805/tests/dromaeo/cssquery-yui.html) 13:41:59 INFO - PROCESS | 4165 | RSS: Main: 228347904 13:41:59 INFO - PROCESS | 4165 | 13:45:02 INFO - PROCESS | 4165 | Cycle 1(1): loaded http://localhost:50805/tests/dromaeo/cssquery-yui.html (next: http://localhost:50805/tests/dromaeo/cssquery-dojo.html) 13:45:02 INFO - PROCESS | 4165 | RSS: Main: 288649216 13:45:02 INFO - PROCESS | 4165 | 13:45:02 INFO - PROCESS | 4165 | __start_tp_report 13:45:02 INFO - PROCESS | 4165 | _x_x_mozilla_page_load 13:45:02 INFO - PROCESS | 4165 | _x_x_mozilla_page_load_details 13:45:02 INFO - PROCESS | 4165 | |i|pagename|runs| 13:45:02 INFO - PROCESS | 4165 | |0;dojo.html;2599.441120159166;2608.647832542606;2637.7098519162896;2645.6296118543396;2649.046343316406;4500.212462819002;4568.040711450591;4641.860744177676;4676.859694209171;4692.624590032798;4553.931691024637;4593.609543188833;4606.562376574228;4614.169449499097;4620.953790462095;4202.978985105078;4246.723962942398;4286.39990401344;4325.82696692132;4342.283523218665;4265.061686428996;4294.355846623016;4336.04606986464;4337.934930976038;4342.196693611676;4145.2952997990415;4179.958200417987;4188.895277618053;4324.308110702273;4361.367601697736;4219.07180420307;4238.851640192578;4242.066745316026;4246.4691913510815;4247.97876010618;4218.620324170839;4228.217779710763;4228.238916994939;4234.280172370704;4243.851465198703;4619.422572178478;4689.437267527885;4699.365585645963;4719.716816990992;4740.691855029447;4688.062387522509;4994.750262486861;5033.949660503421;5041.647084704072;5046.671966322214;4888.755562221874;4914.606831453475;4949.4060712714345;5006.148954677714;5010.3737032870895;4629.375034370317;4667.673262871566;4668.929966050512;4669.112868555032;4674.626029917598;4896.828610998598;5022.522860328263;5090.592752579785;5094.77073531692;5096.872578185501;4842.975785121052;4852.2479015752615;4924.113659541245;4924.162892308316;4928.359313289249;4957.628177886673;4961.627877909171;5002.574781143643;5009.423916249605;5012.473690262543;4651.488336283006;4870.439899411542;4886.486918873467;4888.462269150391;4900.387451568554;4887.218045112836;4904.803807847647;4910.094409579273;4913.410390753061;4926.778294976734;4123.8969025774595;4128.050548373831;4133.194027164674;4167.437395951508;4173.061061261192;3541.8229088545986;3548.6806187443253;3586.4261718124976;3595.676389124939;3681.4109742441615;4215.957840421556;4227.471566054243;4252.851150209728;4285.7000009999;4298.989737411705;4933.186024306021;4935.457099719028;4935.654504184673;4941.03649788295;4978.65149439543;4088.2845502037026;4173.91652166961;4252.638525725348;4256.127493863751;4293.484781826201;4422.09347083847;4424;4451.221036318631;4484.8430304939175;4497.123061003073;4712.552307530779;4724.220503616864;4743.5019322971975;4744.217204161344;4777.856664300077;4812.278158276146;4885.2427873679635;4904.92642610354;5000.64995450315;5003.34956455673;4677.929831052469;4682.976585117052;4702.553257440538;4712.552307530779;4758.833440829554;4920.48334924842;4928.778204980713;4941.530554597308;4941.950580494149;4985.52637499437;4654.557817007379;4770.689905156154;4879.585235254901;4993.275974983534;5038.84883453497;4801.351817504592;4817.205161148371;4837.879053023703;4839.201531747222;4878.63410244226;4818.10864989978;4823.975880120577;4824.324594556835;4834.3231947528075;4854.1747902857305;4597.057603191404;4641.071785642953;4701.435827700698;4771.379720636295;4816.397950256218;4837.685550439211;4858.416989961227;4876.951230487792;4882.975585122052;4932.4327702314695;4742.264948932783;4746.145693775015;4751;4751.477337492804;4781.402324709411 13:45:02 INFO - PROCESS | 4165 | |1;ext.html;519.903817793708;559.5887023038067;559.9076152434849;568.442925932586;590.5216774412726;28268.858655706717;31317.21706957327;38890.222195556074;39577.20845583086;39799.40300895489;39747.80126099373;40176.799116004455;40191.19617607646;40211;40292.39561406581;7642.885356719626;7680.308772210486;7820.374370050382;7824.178461261571;7829.138794732575;7630.656620452065;7696.114946781136;7705.113911900147;9852.310338276287;10126.088652021317;10184.847227291597;10190.184785217201;10235.641752538662;10297.330673506236;10307.278490505667;10110.241731870103;10154.441505717183;10168.084872361524;10170.694879153638;10171.135453486462;7540.622968851536;9729.659461918798;10053.949730251303;10107.49462526878;10111.39331640104;38299.808500957595;38652.613473865465;38660.613393865984;38677.80661096676;38691.61308386908;2905.7094290570985;2961.4044837887;3053.92365190872;3386.271951530433;3440.8107554084513;29610;30191.69808301911;30292.54561181562;30319.24201894948;30505.542416863766;2634.486275176341;2669.2659518632336;2688.086050742757;2695.299222202222;2697.4335389568214;239044;239105;239566;239906;240373.99999999825;52417;53539;53548.196777048375;53577.732111339195;53683;56017.439825602036;56041.31876043725;56056.719716401974;56189.438105619236;56228.71885640546;13462.730745385037;13769.449222031006;13779.173249605055;13805.309734513234;13810.516631917835;11249.381284029294;11255.04332131778;11298.54805807775;11313.094952403788;11318.717032074264;13895.58313250604;14276.714465710627;14284.000119991708;14635.853641463662;15271.694566108838;5278.340207474066;5486.835394938158;5533.170024496358;5534.75093620788;5616.522595579421;756.7918822323795;878.1481962496368;880.4057261348564;898.3935843305873;919.595378033663;26571.202863914114;27090.458190836074;27521.17436476909;27578.724212758018;27583.31041723973;949.1362859797551;975.7755716185317;1015.3704703084135;1031.8194315994672;1076.7846430713732;14017.439302427993;14557.708845823025;14703.926480367743;14862.479813206486;14890.776638350433;369463;371671;371814;373840;374289;43571.78214108909;48081.27878081831;48177.277340839915;48725;49301.50698492969;1159.6984783956232;1194.331174542259;1209.1777591238042;1220.4690959432676;1224.969375765613;27127.1861844145;28651;28696.282592935342;28964;29482.852585736935;42770.78614606907;42949.78525107355;43242;43280.567194327654;43322.78338608287;548386;554279;563936;565810;566021;35912.51093613298;36493;36514.8174259127;36634.8168259157;36645.816770917045;42128.3680744783;42287.1542569153;42695.786521067195;42896;42978.78510607427;35850.28299434049;36052.27895442024;36064.81967590145;36116;36247.63752362443;35446.113847154025;36193.63806361903;37052.62947370492;37526.249475010896;37807.05482362963;35363;35883.641163589076;36026.49668791401;36290.63709362873;36510.4523432154;31786.331877292985;31810.522842156923;32106.67893321037;32149.517757234127;32410.513842292858;24458.61387315822;24492.387690307885;24553.263402097964;24660.14953420489;24702.629460558466 13:45:02 INFO - PROCESS | 4165 | |2;jquery.html;347.96520347965225;370.63492459926965;380.3666894620456;383.8560539797574;395.312156847086;13039.804402933953;13189.604311870635;16217.918910405431;17433.651326973453;17481.388151414703;16566.337346506127;17172.742408863876;17291.913540432313;17566.736498952527;17578.472645820646;5053.671511351759;5244.370675518943;5246.344206974129;5249.1601343785005;5251.369835619731;3740.36413809653;5886.587938844283;6154.630722156662;6158.384161583828;6303.621782693031;6012.068129439944;6054.186921397478;6202.875942481148;6214.782482613109;6255.562110652256;5979;6007.549433792483;6009.459148676597;6028.306744724369;6053.455189032986;4537.841175558872;4849.248366503198;4868.05073010763;5303.257543943851;5307.310049693515;12844.48622055126;12980;13102.541411050663;13237.470501179941;20045.298414555422;1750.824917508239;1804.440623406748;1851.0652120679106;1867.785204701463;2281.9201327953606;8939.86590201141;9835.754106147331;9852;11676.708082297926;13335;1619.1175809184024;1627.5992910457098;1647.9423220187236;1657.991710041442;1667.616448216917;62269.688651556906;74021;75517.24482755156;76451.6177419115;76609.61695191488;8414;9072.27421806254;9124.726258212264;9307.348485605942;9412.858807117898;12121.818172727417;12182.269063856196;12190.81713774294;12210.877891220975;12260.26438413698;6928.237893831674;7182;7208.92791072093;7248.4563657725885;7249.130104387507;6981.5461994970165;7093.538919970186;7111.4666400020205;7252.854942901113;7460.850782984418;3405.11467018572;3543.8936831895085;3561.94657080144;3829.9808500957874;3966.2860685076384;1751.5008222656481;1771.1941066814568;1826.8355847973746;1834.7889992651017;1883.6326916251198;805.7179987004502;836.7155167243045;841.3563623827777;869.9739007829776;913.3743385780762;16633.085180314956;16634.916825416036;16997.06516141624;17025.148742562822;17366.47900562985;824.431142511665;824.8968878890139;825.4675734151439;854.0434713121344;892.6250974590688;5700.47587014482;6019.759209631653;6107.694615269219;6135.417135372132;6341.746330146835;354627;355077;355738;364310;374507;77996;81618;83389.58305208557;83560;84830;413.64839886096576;424.0628211652283;425.6892468498014;425.987220383389;426.74608607878264;10667.786644267226;10716.892831071902;10737.677869663923;10829.458527073772;11023.669289921316;37907.43138852864;38434;39515.604843951194;39842.60157398389;40472.79763601163;53266;54410;54626.453735462135;54953;56040.43959560352;7124.536905101152;7275.835866261373;7353.264673532818;7419.295166959346;7485.7754267372065;9641.951790241284;11190.888091118984;11220.607278745205;11232.045276151619;11362.602308919148;9740.951295243478;9787.706368808947;10082.747931301776;10086.798264034825;10263.794724105626;9542.236621070158;9675.467849268358;9801.705948821547;9897.752556186153;9970.252231082843;9533.952330238304;9667.516624168904;9974.152197063331;9997.559384167864;10417.739556511147;7392.667329970272;7436.367908727602;7476.775696729107;7554.848903021799;7672.654730537028;9303.76740581491;9870.654527091518;10046.447445390282;10070.44612546317;10123.392596444237 13:45:02 INFO - PROCESS | 4165 | |3;mootools.html;1212.9636110916665;1370.7669696151654;1428.89997700161;1489.9180545070024;1724.6205834716366;6662.433693136083;7813.1405545390035;8057.395695322845;8065.959670201648;8223.506589604627;7982.840343193147;8141.389395795324;8150.959245203766;8153.225443582865;8162.632681529345;2199.3401979406194;2217.168561789329;2235.6087684655204;2236.2508559632543;2237.5860465813876;2166.1876796201423;2208.9116435342567;2211.3365990202956;2214.678871563622;2215.545813108317;2178.2811672148155;2203.063697928382;2210.403191138392;2212.8008479236864;2215.423989762657;2125.691774692669;2130.4886827161527;2137.9786202137934;2138.486763176842;2140.6253905566464;2103.0536258683655;2135.231316725977;2139.155033761671;2139.732533433321;2140.047678782942;8031.799205019863;8074.919250807534;8166.305864001567;8167;8203.630836612367;4719.126961512097;4850.902981940341;4851.223804191348;4852.951470485285;4857.587105096071;2686.2881336445857;2752.160591019738;2797.818141820775;2803.5794630805544;2807.0771521507627;853.6542700206427;857.459800325797;865.2299453486402;866.7789713623049;875.912408759119;11100.944495277552;11191.66425007251;11198.944005279922;11228;11229.438528073564;3928.8232029558167;4098.569650186688;4171.249175148441;4174.373843923436;4179.393987871802;8689.826203476021;8753.387262891663;8755.518446485505;8764.430312029697;8775.912240877637;4631.490536041033;4652.464966528825;4699.224627936353;4700.318453824177;4700.741459219707;3634.7819130852236;4110.876673699794;4314.654827613784;4338.76136812472;4350.6736994725525;3710.07248187953;3760.0975765816006;3853.2100919311474;3892.805359732002;3894.571597124314;1202.1284568687631;1202.723373624054;1203.9819402708965;1205.0841360566033;1217.4886547650008;732.4909188114316;787.6770524085098;797.310326567515;810.1857633078719;830.5265998380986;5363.141897296492;5488.204210389471;5501.092319767274;5566.777328906879;5753.741081651336;879.5294517433142;884.6063501741792;888.9155530224618;910.2899738204211;917.7701879481526;3887.941680874789;3922.2547715933883;3993.820278087493;3999.3601023836045;4025.798710064485;9675.129238368581;10078.798424031478;10105.090541851268;10115.443650599287;10123.088921997056;9813.705588832203;10131.08820206185;10147;10148.644797432054;10164.949175254224;7191.676374563262;7420.7773766786;7623.923760762433;7654.502457340255;7660.119086305146;5520.337559492887;5686.402927692533;5730.71346432685;5782.826515204551;5918.970405147947;9271.02654221324;9282.535873206178;9284.071592840663;9432.056794320788;9525.1903588193;9537.666181683608;9565.139137477661;9623.085806848338;9681.70954871355;9688.467134307399;6152.938470615237;6351.745930162741;6354.777582784581;6405.135306733718;6490.902636460362;7028.824279392851;7074.540154889915;7275.236100209613;7493.288137626917;7502.662380192795;6830.45356371499;7026.859462810818;7044.894326585003;7076.823079423056;7230.9638451807405;6776.6950487227205;6860.725570977105;6941.548799328028;7028.683709232994;7051.330123638246;6488.156539650005;6529.347065293433;6577.375149360803;6582.341765823379;6587.901181482186;4784.40194975628;4795.321637427012;4807.134715751198;4830.1305764961235;4860.659753817199;4666.9533304667875;4674.836380726658;4690.061987602425;4727.432708074915;4767.356406885165 13:45:02 INFO - PROCESS | 4165 | |4;prototype.html;293.93974235281763;299.53721500282063;302.90609910927606;303.578026543105;304.3578050313836;4844.103840789457;4874.147024270756;4881.560659540641;4886.828960986366;4888;4793.32893394925;4809.302651115586;4815.3258543803895;4846.697818536193;4858;3631.2011357501306;3714.9814250928707;3720.3258533659828;3791.905202369949;3831.8275677594434;3774.2640185163905;3832.501774769276;3832.693384529245;3838.9845331201204;3847.769133851978;3786.6024067472795;3791.8055812419;3797.8670746523876;3802.543694756633;3809.9619003809885;3588.6411358864166;3682.521272234619;3790.943135852937;3814.275287695329;3837;3358.56338675973;3370.747193960463;3376.4091284025444;3376.915577110592;3384.5430866832908;4705.458872229703;4716.976415117937;4718.9292160617615;4724.6928949618505;4755.524447555252;4217.514985776645;4340.500842403132;4344.261475549164;4355.346697995295;4359.171757366122;5000.274960130797;5043.142665746832;5046.7224302663335;5055.216441451544;5073.670211436245;3675.3016926783826;3679.6872265857432;3689.7786132832116;3695.1685870679153;3697.4453831925157;5060.7722652480725;5244.344456942882;5275.498827611371;5294.7617357219015;5302.693328402157;3722.5532936047307;3753.530808648919;3755.2114056048536;3760.6427389397963;3768.340540405418;3802.543694756647;3810.2189051244427;3821.216650586623;3827.75119617224;3828.9087610031006;4308.547602501692;4314.913701725948;4327.112941846914;4328.437303150633;4328.7402755834755;4836.153673107263;5028.5977121830165;5062.392512898402;5065.6200784941275;5076.923846142311;1310.3186343101725;1317.466426097432;1318.1959005006938;1321.378951892609;1322.1736414740787;827.6358402302967;853.2380633990913;862.4437237981467;868.9044205137429;869.2484643443466;4328.848490302824;4466.419365482467;4502.144592527409;4522.118186953512;4527.637788976874;5214.869628259324;5225.843224703265;5227.215917612389;5249.632525723239;5290.338707661543;4470.8435204767675;4474.776261186993;4480.484744254387;4484.775761211927;4486.394336764561;2656.123479251842;2794.720527947189;2800.8319500830016;2806.652806652818;2812.367217376115;4971.527704868032;4989.725565093955;4999.650024498323;5001.949980500149;5016.2224855147515;5229.320188375486;5369.48989845964;5406.459354064562;5407.161889907071;5411.540019098342;4972.453030166606;4994.500549945049;5002.249662550574;5010.89978200434;5017.122003649347;5249.320217530354;5255;5256.948610277883;5262.421133675216;5274.657147285414;4993.400791904849;5144.356955380577;5169.405518365436;5181.81863634771;5185.481451854785;4971.98074394741;4999.325091112799;5001.549860512571;5001.774920128676;5002.849914502571;3789.5452545694693;3817.370133927871;3817.732758706864;3820.789856557916;3837.3860182370686;4979.975100124476;5260.316158899319;5262.210668399771;5264.52619264268;5300.443453437333;5098.566621837185;5102.770375333044;5109.923351149661;5131.204663277198;5131.897362052813;5113.744312784272;5150.175971844487;5151.768170432265;5155.9742201288755;5168.431472538093;4837.879053023562;4959.20652695567;5002.649814512949;5007.7245751484015;5023.547880690755;4863.586595139453;5019.573336266459;5029.371328583927;5036.640107171116;5138.537531622172;4866.637341544373;4926.965337279212;5003.574696150722;5028.974855125701;5030.245463180552 13:45:02 INFO - PROCESS | 4165 | |5;yui.html;606.1574411567922;636.4717284653738;656.3043174235311;680.591645012992;717.905194578268;12462.314572698499;13254.734905301912;13279.203247805126;13282.136661117032;13320.13419127756;12928.13885557607;13353;13540.864591354084;13541.458341666346;13668.453261869514;781.9687212511493;802.0015081223885;805.5207151744703;808.0222930254399;808.3452403553111;617.8702472480785;765.3838659878795;789.9249571290746;798.7603718884341;801.5791709352578;838.6980686952722;841.5918279634373;841.7643059943226;841.9452735572169;842.1115722912325;646.3084499585445;832.6253186066234;832.7959649885756;832.8417600655886;835.4319063037133;581.549299293047;596.9224000879858;598.1715324275866;598.4015984015984;601.1253625974197;12561;12591.307478088702;12591.93704031474;12596.937015314865;12654.367281635881;12282.877171228263;12784.872151278461;12813.10308278421;12962.157459765085;12978.545750898767;11556.422178891022;11559.248648837798;11601.205449428391;11905.16663833532;11992.460339284753;4062.410950412174;4099.200655872106;4139.958600414017;4155.252054630166;4168.333066709312;57926;58838.41161588372;58970.11544826831;60997.69501152466;62379.6881015592;9235.861462078074;9531.046895310414;9823.795570970218;9914.504274786232;10709.410982395888;18475.353362632242;18734.437966861016;18772.24911003572;18785.530361741065;18793;6288.339724328879;6388.456981156561;6399.360063993563;6432.035194720829;6520.532880102034;3628.3106209820576;3637.217998130415;3663.7069034477177;3673.2286219893585;3690.114372550622;2778.1804367711575;2855.1434569629027;2867.4121805029918;2868.0822136915986;2879.9136025919256;501.2831650739405;523.254362533396;526.0846127737709;530.0485628297216;537.258583155251;388.8658412847563;402.83685107531494;414.86309517859036;421.3910898751336;459.11161901720277;7427.888581671279;7440.85118297631;7529.962350188323;7626.9618651906385;7896.052473703192;406.12682732126166;456.915470637933;465.3299249081312;515.2734644151803;525.1030922737601;3540.168060505779;3630.5098811660087;3717.1078941054493;3833.5208098987628;3870.41943708446;93814;100298.498507507;101892.49053754832;104039.47980260201;104118;88722;91645.54177229072;91775.54112229396;91855;92091.0790892096;79339.60330198312;81018;81986.18013819905;82491.98818100529;83241.58379208065;6931.549449285781;7263.309985551364;7323.7436689715605;7362.889556656762;7372.705091796268;39249.43002279877;43753;45866.541334586225;47464.7626761864;48918.51081489139;39979.60020399875;40057.39913901352;47227;58087.12869306879;59613.80772384441;10739.677809665722;10763.569457221936;10937.671869843918;11093.833592495957;11477.368744718786;12547.749045018865;12595.685107872376;12758.234505929673;12893.161944473579;13193.934030329787;11202.15983801202;11877.465514051715;11983.820242696542;12243.265404075784;12528.12303138808;11020.338779673246;11150.665480035612;11488.080953523866;11489.08087352993;11501.48243329069;10539.736506587396;11076.501557429774;11474.368909710047;11487.138464615355;11496.94251528737;9077;9248.861267080865;9411;9781.168600668738;9810.362326448758;9036.23192028685;9129.360944733804;9611.855822162814;9655.420674759536;9662.97594668694 13:45:02 INFO - PROCESS | 4165 | __end_tp_report 13:45:02 INFO - PROCESS | 4165 | __start_cc_report 13:45:02 INFO - PROCESS | 4165 | _x_x_mozilla_cycle_collect,903 13:45:02 INFO - PROCESS | 4165 | __end_cc_report 13:45:02 INFO - PROCESS | 4165 | __startTimestamp1468442702822__endTimestamp 13:45:02 INFO - PROCESS | 4165 | 13:45:02 INFO - PROCESS | 4165 | ------- Summary: start ------- 13:45:02 INFO - PROCESS | 4165 | Number of tests: 6 13:45:02 INFO - PROCESS | 4165 | 13:45:02 INFO - PROCESS | 4165 | [#0] dojo.html Cycles:165 Average:4572.06 Median:4712.55 stddev:480.61 (10.2%) stddev-sans-first:456.49 13:45:02 INFO - PROCESS | 4165 | Values: 2599.4 2608.6 2637.7 2645.6 2649.0 4500.2 4568.0 4641.9 4676.9 4692.6 4553.9 4593.6 4606.6 4614.2 4621.0 4203.0 4246.7 4286.4 4325.8 4342.3 4265.1 4294.4 4336.0 4337.9 4342.2 4145.3 4180.0 4188.9 4324.3 4361.4 4219.1 4238.9 4242.1 4246.5 4248.0 4218.6 4228.2 4228.2 4234.3 4243.9 4619.4 4689.4 4699.4 4719.7 4740.7 4688.1 4994.8 5033.9 5041.6 5046.7 4888.8 4914.6 4949.4 5006.1 5010.4 4629.4 4667.7 4668.9 4669.1 4674.6 4896.8 5022.5 5090.6 5094.8 5096.9 4843.0 4852.2 4924.1 4924.2 4928.4 4957.6 4961.6 5002.6 5009.4 5012.5 4651.5 4870.4 4886.5 4888.5 4900.4 4887.2 4904.8 4910.1 4913.4 4926.8 4123.9 4128.1 4133.2 4167.4 4173.1 3541.8 3548.7 3586.4 3595.7 3681.4 4216.0 4227.5 4252.9 4285.7 4299.0 4933.2 4935.5 4935.7 4941.0 4978.7 4088.3 4173.9 4252.6 4256.1 4293.5 4422.1 4424.0 4451.2 4484.8 4497.1 4712.6 4724.2 4743.5 4744.2 4777.9 4812.3 4885.2 4904.9 5000.6 5003.3 4677.9 4683.0 4702.6 4712.6 4758.8 4920.5 4928.8 4941.5 4942.0 4985.5 4654.6 4770.7 4879.6 4993.3 5038.8 4801.4 4817.2 4837.9 4839.2 4878.6 4818.1 4824.0 4824.3 4834.3 4854.2 4597.1 4641.1 4701.4 4771.4 4816.4 4837.7 4858.4 4877.0 4883.0 4932.4 4742.3 4746.1 4751.0 4751.5 4781.4 13:45:02 INFO - PROCESS | 4165 | 13:45:02 INFO - PROCESS | 4165 | [#1] ext.html Cycles:180 Average:53662.13 Median:36058.55 stddev:109916.38 (304.8%) stddev-sans-first:110152.31 13:45:02 INFO - PROCESS | 4165 | Values: 519.9 559.6 559.9 568.4 590.5 28268.9 31317.2 38890.2 39577.2 39799.4 39747.8 40176.8 40191.2 40211.0 40292.4 7642.9 7680.3 7820.4 7824.2 7829.1 7630.7 7696.1 7705.1 9852.3 10126.1 10184.8 10190.2 10235.6 10297.3 10307.3 10110.2 10154.4 10168.1 10170.7 10171.1 7540.6 9729.7 10053.9 10107.5 10111.4 38299.8 38652.6 38660.6 38677.8 38691.6 2905.7 2961.4 3053.9 3386.3 3440.8 29610.0 30191.7 30292.5 30319.2 30505.5 2634.5 2669.3 2688.1 2695.3 2697.4 239044.0 239105.0 239566.0 239906.0 240374.0 52417.0 53539.0 53548.2 53577.7 53683.0 56017.4 56041.3 56056.7 56189.4 56228.7 13462.7 13769.4 13779.2 13805.3 13810.5 11249.4 11255.0 11298.5 11313.1 11318.7 13895.6 14276.7 14284.0 14635.9 15271.7 5278.3 5486.8 5533.2 5534.8 5616.5 756.8 878.1 880.4 898.4 919.6 26571.2 27090.5 27521.2 27578.7 27583.3 949.1 975.8 1015.4 1031.8 1076.8 14017.4 14557.7 14703.9 14862.5 14890.8 369463.0 371671.0 371814.0 373840.0 374289.0 43571.8 48081.3 48177.3 48725.0 49301.5 1159.7 1194.3 1209.2 1220.5 1225.0 27127.2 28651.0 28696.3 28964.0 29482.9 42770.8 42949.8 43242.0 43280.6 43322.8 548386.0 554279.0 563936.0 565810.0 566021.0 35912.5 36493.0 36514.8 36634.8 36645.8 42128.4 42287.2 42695.8 42896.0 42978.8 35850.3 36052.3 36064.8 36116.0 36247.6 35446.1 36193.6 37052.6 37526.2 37807.1 35363.0 35883.6 36026.5 36290.6 36510.5 31786.3 31810.5 32106.7 32149.5 32410.5 24458.6 24492.4 24553.3 24660.1 24702.6 13:45:02 INFO - PROCESS | 4165 | 13:45:02 INFO - PROCESS | 4165 | [#2] jquery.html Cycles:180 Average:23392.39 Median:5250.26 stddev:60187.48 (1146.4%) stddev-sans-first:60331.45 13:45:02 INFO - PROCESS | 4165 | Values: 348.0 370.6 380.4 383.9 395.3 13039.8 13189.6 16217.9 17433.7 17481.4 16566.3 17172.7 17291.9 17566.7 17578.5 5053.7 5244.4 5246.3 5249.2 5251.4 3740.4 5886.6 6154.6 6158.4 6303.6 6012.1 6054.2 6202.9 6214.8 6255.6 5979.0 6007.5 6009.5 6028.3 6053.5 4537.8 4849.2 4868.1 5303.3 5307.3 12844.5 12980.0 13102.5 13237.5 20045.3 1750.8 1804.4 1851.1 1867.8 2281.9 8939.9 9835.8 9852.0 11676.7 13335.0 1619.1 1627.6 1647.9 1658.0 1667.6 62269.7 74021.0 75517.2 76451.6 76609.6 8414.0 9072.3 9124.7 9307.3 9412.9 12121.8 12182.3 12190.8 12210.9 12260.3 6928.2 7182.0 7208.9 7248.5 7249.1 6981.5 7093.5 7111.5 7252.9 7460.9 3405.1 3543.9 3561.9 3830.0 3966.3 1751.5 1771.2 1826.8 1834.8 1883.6 805.7 836.7 841.4 870.0 913.4 16633.1 16634.9 16997.1 17025.1 17366.5 824.4 824.9 825.5 854.0 892.6 5700.5 6019.8 6107.7 6135.4 6341.7 354627.0 355077.0 355738.0 364310.0 374507.0 77996.0 81618.0 83389.6 83560.0 84830.0 413.6 424.1 425.7 426.0 426.7 10667.8 10716.9 10737.7 10829.5 11023.7 37907.4 38434.0 39515.6 39842.6 40472.8 53266.0 54410.0 54626.5 54953.0 56040.4 7124.5 7275.8 7353.3 7419.3 7485.8 9642.0 11190.9 11220.6 11232.0 11362.6 9741.0 9787.7 10082.7 10086.8 10263.8 9542.2 9675.5 9801.7 9897.8 9970.3 9534.0 9667.5 9974.2 9997.6 10417.7 7392.7 7436.4 7476.8 7554.8 7672.7 9303.8 9870.7 10046.4 10070.4 10123.4 13:45:02 INFO - PROCESS | 4165 | 13:45:02 INFO - PROCESS | 4165 | [#3] mootools.html Cycles:180 Average:5274.92 Median:4855.27 stddev:2994.00 (61.7%) stddev-sans-first:2986.83 13:45:02 INFO - PROCESS | 4165 | Values: 1213.0 1370.8 1428.9 1489.9 1724.6 6662.4 7813.1 8057.4 8066.0 8223.5 7982.8 8141.4 8151.0 8153.2 8162.6 2199.3 2217.2 2235.6 2236.3 2237.6 2166.2 2208.9 2211.3 2214.7 2215.5 2178.3 2203.1 2210.4 2212.8 2215.4 2125.7 2130.5 2138.0 2138.5 2140.6 2103.1 2135.2 2139.2 2139.7 2140.0 8031.8 8074.9 8166.3 8167.0 8203.6 4719.1 4850.9 4851.2 4853.0 4857.6 2686.3 2752.2 2797.8 2803.6 2807.1 853.7 857.5 865.2 866.8 875.9 11100.9 11191.7 11198.9 11228.0 11229.4 3928.8 4098.6 4171.2 4174.4 4179.4 8689.8 8753.4 8755.5 8764.4 8775.9 4631.5 4652.5 4699.2 4700.3 4700.7 3634.8 4110.9 4314.7 4338.8 4350.7 3710.1 3760.1 3853.2 3892.8 3894.6 1202.1 1202.7 1204.0 1205.1 1217.5 732.5 787.7 797.3 810.2 830.5 5363.1 5488.2 5501.1 5566.8 5753.7 879.5 884.6 888.9 910.3 917.8 3887.9 3922.3 3993.8 3999.4 4025.8 9675.1 10078.8 10105.1 10115.4 10123.1 9813.7 10131.1 10147.0 10148.6 10164.9 7191.7 7420.8 7623.9 7654.5 7660.1 5520.3 5686.4 5730.7 5782.8 5919.0 9271.0 9282.5 9284.1 9432.1 9525.2 9537.7 9565.1 9623.1 9681.7 9688.5 6152.9 6351.7 6354.8 6405.1 6490.9 7028.8 7074.5 7275.2 7493.3 7502.7 6830.5 7026.9 7044.9 7076.8 7231.0 6776.7 6860.7 6941.5 7028.7 7051.3 6488.2 6529.3 6577.4 6582.3 6587.9 4784.4 4795.3 4807.1 4830.1 4860.7 4667.0 4674.8 4690.1 4727.4 4767.4 13:45:02 INFO - PROCESS | 4165 | 13:45:02 INFO - PROCESS | 4165 | [#4] prototype.html Cycles:180 Average:4237.07 Median:4845.40 stddev:1223.95 (25.3%) stddev-sans-first:1191.06 13:45:02 INFO - PROCESS | 4165 | Values: 293.9 299.5 302.9 303.6 304.4 4844.1 4874.1 4881.6 4886.8 4888.0 4793.3 4809.3 4815.3 4846.7 4858.0 3631.2 3715.0 3720.3 3791.9 3831.8 3774.3 3832.5 3832.7 3839.0 3847.8 3786.6 3791.8 3797.9 3802.5 3810.0 3588.6 3682.5 3790.9 3814.3 3837.0 3358.6 3370.7 3376.4 3376.9 3384.5 4705.5 4717.0 4718.9 4724.7 4755.5 4217.5 4340.5 4344.3 4355.3 4359.2 5000.3 5043.1 5046.7 5055.2 5073.7 3675.3 3679.7 3689.8 3695.2 3697.4 5060.8 5244.3 5275.5 5294.8 5302.7 3722.6 3753.5 3755.2 3760.6 3768.3 3802.5 3810.2 3821.2 3827.8 3828.9 4308.5 4314.9 4327.1 4328.4 4328.7 4836.2 5028.6 5062.4 5065.6 5076.9 1310.3 1317.5 1318.2 1321.4 1322.2 827.6 853.2 862.4 868.9 869.2 4328.8 4466.4 4502.1 4522.1 4527.6 5214.9 5225.8 5227.2 5249.6 5290.3 4470.8 4474.8 4480.5 4484.8 4486.4 2656.1 2794.7 2800.8 2806.7 2812.4 4971.5 4989.7 4999.7 5001.9 5016.2 5229.3 5369.5 5406.5 5407.2 5411.5 4972.5 4994.5 5002.2 5010.9 5017.1 5249.3 5255.0 5256.9 5262.4 5274.7 4993.4 5144.4 5169.4 5181.8 5185.5 4972.0 4999.3 5001.5 5001.8 5002.8 3789.5 3817.4 3817.7 3820.8 3837.4 4980.0 5260.3 5262.2 5264.5 5300.4 5098.6 5102.8 5109.9 5131.2 5131.9 5113.7 5150.2 5151.8 5156.0 5168.4 4837.9 4959.2 5002.6 5007.7 5023.5 4863.6 5019.6 5029.4 5036.6 5138.5 4866.6 4927.0 5003.6 5029.0 5030.2 13:45:02 INFO - PROCESS | 4165 | 13:45:02 INFO - PROCESS | 4165 | [#5] yui.html Cycles:180 Average:17731.97 Median:23162.83 stddev:26036.76 (112.4%) stddev-sans-first:26078.04 13:45:02 INFO - PROCESS | 4165 | Values: 606.2 636.5 656.3 680.6 717.9 12462.3 13254.7 13279.2 13282.1 13320.1 12928.1 13353.0 13540.9 13541.5 13668.5 782.0 802.0 805.5 808.0 808.3 617.9 765.4 789.9 798.8 801.6 838.7 841.6 841.8 841.9 842.1 646.3 832.6 832.8 832.8 835.4 581.5 596.9 598.2 598.4 601.1 12561.0 12591.3 12591.9 12596.9 12654.4 12282.9 12784.9 12813.1 12962.2 12978.5 11556.4 11559.2 11601.2 11905.2 11992.5 4062.4 4099.2 4140.0 4155.3 4168.3 57926.0 58838.4 58970.1 60997.7 62379.7 9235.9 9531.0 9823.8 9914.5 10709.4 18475.4 18734.4 18772.2 18785.5 18793.0 6288.3 6388.5 6399.4 6432.0 6520.5 3628.3 3637.2 3663.7 3673.2 3690.1 2778.2 2855.1 2867.4 2868.1 2879.9 501.3 523.3 526.1 530.0 537.3 388.9 402.8 414.9 421.4 459.1 7427.9 7440.9 7530.0 7627.0 7896.1 406.1 456.9 465.3 515.3 525.1 3540.2 3630.5 3717.1 3833.5 3870.4 93814.0 100298.5 101892.5 104039.5 104118.0 88722.0 91645.5 91775.5 91855.0 92091.1 79339.6 81018.0 81986.2 82492.0 83241.6 6931.5 7263.3 7323.7 7362.9 7372.7 39249.4 43753.0 45866.5 47464.8 48918.5 39979.6 40057.4 47227.0 58087.1 59613.8 10739.7 10763.6 10937.7 11093.8 11477.4 12547.7 12595.7 12758.2 12893.2 13193.9 11202.2 11877.5 11983.8 12243.3 12528.1 11020.3 11150.7 11488.1 11489.1 11501.5 10539.7 11076.5 11474.4 11487.1 11496.9 9077.0 9248.9 9411.0 9781.2 9810.4 9036.2 9129.4 9611.9 9655.4 9663.0 13:45:02 INFO - PROCESS | 4165 | -------- Summary: end -------- 13:45:02 INFO - PROCESS | 4165 | 13:45:03 INFO - TEST-INFO | 4165: exit 0 13:45:03 INFO - TEST-OK | dromaeo_css | took 1119510ms 13:45:03 INFO - TEST-START | kraken 13:45:03 INFO - operating with platform_type : linux_ 13:45:03 INFO - Initialising browser for kraken test... 13:45:03 INFO - TEST-INFO | started process 4351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9ACfMw/profile http://localhost:50805/getInfo.html) 13:45:07 INFO - PROCESS | 4351 | __metrics Screen width/height:1600/1200 13:45:07 INFO - PROCESS | 4351 | colorDepth:24 13:45:07 INFO - PROCESS | 4351 | Browser inner width/height: 1024/697 13:45:07 INFO - PROCESS | 4351 | __metrics 13:45:08 INFO - PROCESS | 4351 | 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" 13:45:08 INFO - PROCESS | 4351 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:45:09 INFO - TEST-INFO | 4351: exit 0 13:45:09 INFO - Browser initialized. 13:45:09 INFO - Running cycle 1/1 for kraken test... 13:45:09 INFO - TEST-INFO | started process 4430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9ACfMw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:21 INFO - PROCESS | 4430 | RSS: Main: 159240192 13:45:21 INFO - PROCESS | 4430 | 13:45:24 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:50805/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50805/tests/kraken/driver.html?testName=audio-beat-detection) 13:45:25 INFO - PROCESS | 4430 | RSS: Main: 217632768 13:45:25 INFO - PROCESS | 4430 | 13:45:28 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:50805/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50805/tests/kraken/driver.html?testName=audio-dft) 13:45:28 INFO - PROCESS | 4430 | RSS: Main: 204845056 13:45:28 INFO - PROCESS | 4430 | 13:45:31 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:50805/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50805/tests/kraken/driver.html?testName=audio-fft) 13:45:32 INFO - PROCESS | 4430 | RSS: Main: 270491648 13:45:32 INFO - PROCESS | 4430 | 13:45:34 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:50805/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50805/tests/kraken/driver.html?testName=audio-oscillator) 13:45:35 INFO - PROCESS | 4430 | RSS: Main: 182165504 13:45:35 INFO - PROCESS | 4430 | 13:45:37 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:50805/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50805/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:45:38 INFO - PROCESS | 4430 | RSS: Main: 186183680 13:45:38 INFO - PROCESS | 4430 | 13:45:41 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:50805/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50805/tests/kraken/driver.html?testName=imaging-darkroom) 13:45:41 INFO - PROCESS | 4430 | RSS: Main: 222081024 13:45:41 INFO - PROCESS | 4430 | 13:45:45 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:50805/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50805/tests/kraken/driver.html?testName=imaging-desaturate) 13:45:46 INFO - PROCESS | 4430 | RSS: Main: 222515200 13:45:46 INFO - PROCESS | 4430 | 13:45:48 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:50805/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50805/tests/kraken/driver.html?testName=json-parse-financial) 13:45:49 INFO - PROCESS | 4430 | RSS: Main: 222560256 13:45:49 INFO - PROCESS | 4430 | 13:45:51 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:50805/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50805/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:45:51 INFO - PROCESS | 4430 | RSS: Main: 209567744 13:45:51 INFO - PROCESS | 4430 | 13:45:53 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:50805/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50805/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:45:54 INFO - PROCESS | 4430 | RSS: Main: 211546112 13:45:54 INFO - PROCESS | 4430 | 13:45:56 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:50805/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50805/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:45:57 INFO - PROCESS | 4430 | RSS: Main: 213962752 13:45:57 INFO - PROCESS | 4430 | 13:45:59 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:50805/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50805/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:46:00 INFO - PROCESS | 4430 | RSS: Main: 230744064 13:46:00 INFO - PROCESS | 4430 | 13:46:03 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:50805/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50805/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:46:04 INFO - PROCESS | 4430 | RSS: Main: 226332672 13:46:04 INFO - PROCESS | 4430 | 13:46:05 INFO - PROCESS | 4430 | Cycle 1(1): loaded http://localhost:50805/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50805/tests/kraken/driver.html?testName=ai-astar) 13:46:06 INFO - PROCESS | 4430 | RSS: Main: 269881344 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | __start_tp_report 13:46:06 INFO - PROCESS | 4430 | _x_x_mozilla_page_load 13:46:06 INFO - PROCESS | 4430 | _x_x_mozilla_page_load_details 13:46:06 INFO - PROCESS | 4430 | |i|pagename|runs| 13:46:06 INFO - PROCESS | 4430 | |0;ai-astar;104;114;115;114;113;113;112;113;115;115 13:46:06 INFO - PROCESS | 4430 | |1;audio-beat-detection;157;122;125;186;121;124;151;121;195;125 13:46:06 INFO - PROCESS | 4430 | |2;audio-dft;161;160;161;161;163;162;163;162;162;161 13:46:06 INFO - PROCESS | 4430 | |3;audio-fft;76;76;77;131;76;77;76;76;98;75 13:46:06 INFO - PROCESS | 4430 | |4;audio-oscillator;85;91;118;85;84;86;131;85;89;128 13:46:06 INFO - PROCESS | 4430 | |5;imaging-gaussian-blur;118;117;117;117;117;117;116;117;117;117 13:46:06 INFO - PROCESS | 4430 | |6;imaging-darkroom;146;146;147;147;146;146;147;146;146;145 13:46:06 INFO - PROCESS | 4430 | |7;imaging-desaturate;95;94;94;94;94;95;94;95;94;94 13:46:06 INFO - PROCESS | 4430 | |8;json-parse-financial;71;63;64;65;64;66;64;65;64;64 13:46:06 INFO - PROCESS | 4430 | |9;json-stringify-tinderbox;66;66;66;65;66;66;65;65;66;69 13:46:06 INFO - PROCESS | 4430 | |10;stanford-crypto-aes;81;85;79;78;87;83;78;78;82;83 13:46:06 INFO - PROCESS | 4430 | |11;stanford-crypto-ccm;131;127;132;127;125;128;135;133;172;127 13:46:06 INFO - PROCESS | 4430 | |12;stanford-crypto-pbkdf2;166;166;169;166;164;168;168;169;163;165 13:46:06 INFO - PROCESS | 4430 | |13;stanford-crypto-sha256-iterative;67;66;68;66;67;65;65;66;65;68 13:46:06 INFO - PROCESS | 4430 | __end_tp_report 13:46:06 INFO - PROCESS | 4430 | __start_cc_report 13:46:06 INFO - PROCESS | 4430 | _x_x_mozilla_cycle_collect,1913 13:46:06 INFO - PROCESS | 4430 | __end_cc_report 13:46:06 INFO - PROCESS | 4430 | __startTimestamp1468442766044__endTimestamp 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | ------- Summary: start ------- 13:46:06 INFO - PROCESS | 4430 | Number of tests: 14 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.26 (2.9%) stddev-sans-first:1.09 13:46:06 INFO - PROCESS | 4430 | Values: 104.0 114.0 115.0 114.0 113.0 113.0 112.0 113.0 115.0 115.0 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:138.00 stddev:28.34 (20.5%) stddev-sans-first:29.59 13:46:06 INFO - PROCESS | 4430 | Values: 157.0 122.0 125.0 186.0 121.0 124.0 151.0 121.0 195.0 125.0 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 13:46:06 INFO - PROCESS | 4430 | Values: 161.0 160.0 161.0 161.0 163.0 162.0 163.0 162.0 162.0 161.0 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | [#3] audio-fft Cycles:10 Average:83.80 Median:76.00 stddev:17.96 (23.6%) stddev-sans-first:18.83 13:46:06 INFO - PROCESS | 4430 | Values: 76.0 76.0 77.0 131.0 76.0 77.0 76.0 76.0 98.0 75.0 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:85.00 stddev:19.34 (22.8%) stddev-sans-first:19.91 13:46:06 INFO - PROCESS | 4430 | Values: 85.0 91.0 118.0 85.0 84.0 86.0 131.0 85.0 89.0 128.0 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 13:46:06 INFO - PROCESS | 4430 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:46:06 INFO - PROCESS | 4430 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 145.0 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 13:46:06 INFO - PROCESS | 4430 | Values: 95.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 94.0 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:64.50 stddev:2.26 (3.5%) stddev-sans-first:0.87 13:46:06 INFO - PROCESS | 4430 | Values: 71.0 63.0 64.0 65.0 64.0 66.0 64.0 65.0 64.0 64.0 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:1.15 (1.7%) stddev-sans-first:1.22 13:46:06 INFO - PROCESS | 4430 | Values: 66.0 66.0 66.0 65.0 66.0 66.0 65.0 65.0 66.0 69.0 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:82.50 stddev:3.17 (3.8%) stddev-sans-first:3.36 13:46:06 INFO - PROCESS | 4430 | Values: 81.0 85.0 79.0 78.0 87.0 83.0 78.0 78.0 82.0 83.0 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:131.50 stddev:13.83 (10.5%) stddev-sans-first:14.64 13:46:06 INFO - PROCESS | 4430 | Values: 131.0 127.0 132.0 127.0 125.0 128.0 135.0 133.0 172.0 127.0 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:167.00 stddev:2.07 (1.2%) stddev-sans-first:2.19 13:46:06 INFO - PROCESS | 4430 | Values: 166.0 166.0 169.0 166.0 164.0 168.0 168.0 169.0 163.0 165.0 13:46:06 INFO - PROCESS | 4430 | 13:46:06 INFO - PROCESS | 4430 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.16 (1.7%) stddev-sans-first:1.20 13:46:06 INFO - PROCESS | 4430 | Values: 67.0 66.0 68.0 66.0 67.0 65.0 65.0 66.0 65.0 68.0 13:46:06 INFO - PROCESS | 4430 | -------- Summary: end -------- 13:46:06 INFO - PROCESS | 4430 | 13:46:07 INFO - TEST-INFO | 4430: exit 0 13:46:07 INFO - TEST-OK | kraken | took 63499ms 13:46:07 INFO - SUITE-END | took 1183s 13:46:07 INFO - Completed test suite (00:19:43) 13:46:07 INFO - javascript benchmark 13:46:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2599.441120159166, 2608.647832542606, 2637.7098519162896, 2645.6296118543396, 2649.046343316406, 4500.212462819002, 4568.040711450591, 4641.860744177676, 4676.859694209171, 4692.624590032798, 4553.931691024637, 4593.609543188833, 4606.562376574228, 4614.169449499097, 4620.953790462095, 4202.978985105078, 4246.723962942398, 4286.39990401344, 4325.82696692132, 4342.283523218665, 4265.061686428996, 4294.355846623016, 4336.04606986464, 4337.934930976038, 4342.196693611676, 4145.2952997990415, 4179.958200417987, 4188.895277618053, 4324.308110702273, 4361.367601697736, 4219.07180420307, 4238.851640192578, 4242.066745316026, 4246.4691913510815, 4247.97876010618, 4218.620324170839, 4228.217779710763, 4228.238916994939, 4234.280172370704, 4243.851465198703, 4619.422572178478, 4689.437267527885, 4699.365585645963, 4719.716816990992, 4740.691855029447, 4688.062387522509, 4994.750262486861, 5033.949660503421, 5041.647084704072, 5046.671966322214, 4888.755562221874, 4914.606831453475, 4949.4060712714345, 5006.148954677714, 5010.3737032870895, 4629.375034370317, 4667.673262871566, 4668.929966050512, 4669.112868555032, 4674.626029917598, 4896.828610998598, 5022.522860328263, 5090.592752579785, 5094.77073531692, 5096.872578185501, 4842.975785121052, 4852.2479015752615, 4924.113659541245, 4924.162892308316, 4928.359313289249, 4957.628177886673, 4961.627877909171, 5002.574781143643, 5009.423916249605, 5012.473690262543, 4651.488336283006, 4870.439899411542, 4886.486918873467, 4888.462269150391, 4900.387451568554, 4887.218045112836, 4904.803807847647, 4910.094409579273, 4913.410390753061, 4926.778294976734, 4123.8969025774595, 4128.050548373831, 4133.194027164674, 4167.437395951508, 4173.061061261192, 3541.8229088545986, 3548.6806187443253, 3586.4261718124976, 3595.676389124939, 3681.4109742441615, 4215.957840421556, 4227.471566054243, 4252.851150209728, 4285.7000009999, 4298.989737411705, 4933.186024306021, 4935.457099719028, 4935.654504184673, 4941.03649788295, 4978.65149439543, 4088.2845502037026, 4173.91652166961, 4252.638525725348, 4256.127493863751, 4293.484781826201, 4422.09347083847, 4424.0, 4451.221036318631, 4484.8430304939175, 4497.123061003073, 4712.552307530779, 4724.220503616864, 4743.5019322971975, 4744.217204161344, 4777.856664300077, 4812.278158276146, 4885.2427873679635, 4904.92642610354, 5000.64995450315, 5003.34956455673, 4677.929831052469, 4682.976585117052, 4702.553257440538, 4712.552307530779, 4758.833440829554, 4920.48334924842, 4928.778204980713, 4941.530554597308, 4941.950580494149, 4985.52637499437, 4654.557817007379, 4770.689905156154, 4879.585235254901, 4993.275974983534, 5038.84883453497, 4801.351817504592, 4817.205161148371, 4837.879053023703, 4839.201531747222, 4878.63410244226, 4818.10864989978, 4823.975880120577, 4824.324594556835, 4834.3231947528075, 4854.1747902857305, 4597.057603191404, 4641.071785642953, 4701.435827700698, 4771.379720636295, 4816.397950256218, 4837.685550439211, 4858.416989961227, 4876.951230487792, 4882.975585122052, 4932.4327702314695, 4742.264948932783, 4746.145693775015, 4751.0, 4751.477337492804, 4781.402324709411], "value": 4541.711033810366, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.903817793708, 559.5887023038067, 559.9076152434849, 568.442925932586, 590.5216774412726, 28268.858655706717, 31317.21706957327, 38890.222195556074, 39577.20845583086, 39799.40300895489, 39747.80126099373, 40176.799116004455, 40191.19617607646, 40211.0, 40292.39561406581, 7642.885356719626, 7680.308772210486, 7820.374370050382, 7824.178461261571, 7829.138794732575, 7630.656620452065, 7696.114946781136, 7705.113911900147, 9852.310338276287, 10126.088652021317, 10184.847227291597, 10190.184785217201, 10235.641752538662, 10297.330673506236, 10307.278490505667, 10110.241731870103, 10154.441505717183, 10168.084872361524, 10170.694879153638, 10171.135453486462, 7540.622968851536, 9729.659461918798, 10053.949730251303, 10107.49462526878, 10111.39331640104, 38299.808500957595, 38652.613473865465, 38660.613393865984, 38677.80661096676, 38691.61308386908, 2905.7094290570985, 2961.4044837887, 3053.92365190872, 3386.271951530433, 3440.8107554084513, 29610.0, 30191.69808301911, 30292.54561181562, 30319.24201894948, 30505.542416863766, 2634.486275176341, 2669.2659518632336, 2688.086050742757, 2695.299222202222, 2697.4335389568214, 239044.0, 239105.0, 239566.0, 239906.0, 240373.99999999825, 52417.0, 53539.0, 53548.196777048375, 53577.732111339195, 53683.0, 56017.439825602036, 56041.31876043725, 56056.719716401974, 56189.438105619236, 56228.71885640546, 13462.730745385037, 13769.449222031006, 13779.173249605055, 13805.309734513234, 13810.516631917835, 11249.381284029294, 11255.04332131778, 11298.54805807775, 11313.094952403788, 11318.717032074264, 13895.58313250604, 14276.714465710627, 14284.000119991708, 14635.853641463662, 15271.694566108838, 5278.340207474066, 5486.835394938158, 5533.170024496358, 5534.75093620788, 5616.522595579421, 756.7918822323795, 878.1481962496368, 880.4057261348564, 898.3935843305873, 919.595378033663, 26571.202863914114, 27090.458190836074, 27521.17436476909, 27578.724212758018, 27583.31041723973, 949.1362859797551, 975.7755716185317, 1015.3704703084135, 1031.8194315994672, 1076.7846430713732, 14017.439302427993, 14557.708845823025, 14703.926480367743, 14862.479813206486, 14890.776638350433, 369463.0, 371671.0, 371814.0, 373840.0, 374289.0, 43571.78214108909, 48081.27878081831, 48177.277340839915, 48725.0, 49301.50698492969, 1159.6984783956232, 1194.331174542259, 1209.1777591238042, 1220.4690959432676, 1224.969375765613, 27127.1861844145, 28651.0, 28696.282592935342, 28964.0, 29482.852585736935, 42770.78614606907, 42949.78525107355, 43242.0, 43280.567194327654, 43322.78338608287, 548386.0, 554279.0, 563936.0, 565810.0, 566021.0, 35912.51093613298, 36493.0, 36514.8174259127, 36634.8168259157, 36645.816770917045, 42128.3680744783, 42287.1542569153, 42695.786521067195, 42896.0, 42978.78510607427, 35850.28299434049, 36052.27895442024, 36064.81967590145, 36116.0, 36247.63752362443, 35446.113847154025, 36193.63806361903, 37052.62947370492, 37526.249475010896, 37807.05482362963, 35363.0, 35883.641163589076, 36026.49668791401, 36290.63709362873, 36510.4523432154, 31786.331877292985, 31810.522842156923, 32106.67893321037, 32149.517757234127, 32410.513842292858, 24458.61387315822, 24492.387690307885, 24553.263402097964, 24660.14953420489, 24702.629460558466], "value": 17940.48222126202, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.96520347965225, 370.63492459926965, 380.3666894620456, 383.8560539797574, 395.312156847086, 13039.804402933953, 13189.604311870635, 16217.918910405431, 17433.651326973453, 17481.388151414703, 16566.337346506127, 17172.742408863876, 17291.913540432313, 17566.736498952527, 17578.472645820646, 5053.671511351759, 5244.370675518943, 5246.344206974129, 5249.1601343785005, 5251.369835619731, 3740.36413809653, 5886.587938844283, 6154.630722156662, 6158.384161583828, 6303.621782693031, 6012.068129439944, 6054.186921397478, 6202.875942481148, 6214.782482613109, 6255.562110652256, 5979.0, 6007.549433792483, 6009.459148676597, 6028.306744724369, 6053.455189032986, 4537.841175558872, 4849.248366503198, 4868.05073010763, 5303.257543943851, 5307.310049693515, 12844.48622055126, 12980.0, 13102.541411050663, 13237.470501179941, 20045.298414555422, 1750.824917508239, 1804.440623406748, 1851.0652120679106, 1867.785204701463, 2281.9201327953606, 8939.86590201141, 9835.754106147331, 9852.0, 11676.708082297926, 13335.0, 1619.1175809184024, 1627.5992910457098, 1647.9423220187236, 1657.991710041442, 1667.616448216917, 62269.688651556906, 74021.0, 75517.24482755156, 76451.6177419115, 76609.61695191488, 8414.0, 9072.27421806254, 9124.726258212264, 9307.348485605942, 9412.858807117898, 12121.818172727417, 12182.269063856196, 12190.81713774294, 12210.877891220975, 12260.26438413698, 6928.237893831674, 7182.0, 7208.92791072093, 7248.4563657725885, 7249.130104387507, 6981.5461994970165, 7093.538919970186, 7111.4666400020205, 7252.854942901113, 7460.850782984418, 3405.11467018572, 3543.8936831895085, 3561.94657080144, 3829.9808500957874, 3966.2860685076384, 1751.5008222656481, 1771.1941066814568, 1826.8355847973746, 1834.7889992651017, 1883.6326916251198, 805.7179987004502, 836.7155167243045, 841.3563623827777, 869.9739007829776, 913.3743385780762, 16633.085180314956, 16634.916825416036, 16997.06516141624, 17025.148742562822, 17366.47900562985, 824.431142511665, 824.8968878890139, 825.4675734151439, 854.0434713121344, 892.6250974590688, 5700.47587014482, 6019.759209631653, 6107.694615269219, 6135.417135372132, 6341.746330146835, 354627.0, 355077.0, 355738.0, 364310.0, 374507.0, 77996.0, 81618.0, 83389.58305208557, 83560.0, 84830.0, 413.64839886096576, 424.0628211652283, 425.6892468498014, 425.987220383389, 426.74608607878264, 10667.786644267226, 10716.892831071902, 10737.677869663923, 10829.458527073772, 11023.669289921316, 37907.43138852864, 38434.0, 39515.604843951194, 39842.60157398389, 40472.79763601163, 53266.0, 54410.0, 54626.453735462135, 54953.0, 56040.43959560352, 7124.536905101152, 7275.835866261373, 7353.264673532818, 7419.295166959346, 7485.7754267372065, 9641.951790241284, 11190.888091118984, 11220.607278745205, 11232.045276151619, 11362.602308919148, 9740.951295243478, 9787.706368808947, 10082.747931301776, 10086.798264034825, 10263.794724105626, 9542.236621070158, 9675.467849268358, 9801.705948821547, 9897.752556186153, 9970.252231082843, 9533.952330238304, 9667.516624168904, 9974.152197063331, 9997.559384167864, 10417.739556511147, 7392.667329970272, 7436.367908727602, 7476.775696729107, 7554.848903021799, 7672.654730537028, 9303.76740581491, 9870.654527091518, 10046.447445390282, 10070.44612546317, 10123.392596444237], "value": 7721.8386595299835, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1212.9636110916665, 1370.7669696151654, 1428.89997700161, 1489.9180545070024, 1724.6205834716366, 6662.433693136083, 7813.1405545390035, 8057.395695322845, 8065.959670201648, 8223.506589604627, 7982.840343193147, 8141.389395795324, 8150.959245203766, 8153.225443582865, 8162.632681529345, 2199.3401979406194, 2217.168561789329, 2235.6087684655204, 2236.2508559632543, 2237.5860465813876, 2166.1876796201423, 2208.9116435342567, 2211.3365990202956, 2214.678871563622, 2215.545813108317, 2178.2811672148155, 2203.063697928382, 2210.403191138392, 2212.8008479236864, 2215.423989762657, 2125.691774692669, 2130.4886827161527, 2137.9786202137934, 2138.486763176842, 2140.6253905566464, 2103.0536258683655, 2135.231316725977, 2139.155033761671, 2139.732533433321, 2140.047678782942, 8031.799205019863, 8074.919250807534, 8166.305864001567, 8167.0, 8203.630836612367, 4719.126961512097, 4850.902981940341, 4851.223804191348, 4852.951470485285, 4857.587105096071, 2686.2881336445857, 2752.160591019738, 2797.818141820775, 2803.5794630805544, 2807.0771521507627, 853.6542700206427, 857.459800325797, 865.2299453486402, 866.7789713623049, 875.912408759119, 11100.944495277552, 11191.66425007251, 11198.944005279922, 11228.0, 11229.438528073564, 3928.8232029558167, 4098.569650186688, 4171.249175148441, 4174.373843923436, 4179.393987871802, 8689.826203476021, 8753.387262891663, 8755.518446485505, 8764.430312029697, 8775.912240877637, 4631.490536041033, 4652.464966528825, 4699.224627936353, 4700.318453824177, 4700.741459219707, 3634.7819130852236, 4110.876673699794, 4314.654827613784, 4338.76136812472, 4350.6736994725525, 3710.07248187953, 3760.0975765816006, 3853.2100919311474, 3892.805359732002, 3894.571597124314, 1202.1284568687631, 1202.723373624054, 1203.9819402708965, 1205.0841360566033, 1217.4886547650008, 732.4909188114316, 787.6770524085098, 797.310326567515, 810.1857633078719, 830.5265998380986, 5363.141897296492, 5488.204210389471, 5501.092319767274, 5566.777328906879, 5753.741081651336, 879.5294517433142, 884.6063501741792, 888.9155530224618, 910.2899738204211, 917.7701879481526, 3887.941680874789, 3922.2547715933883, 3993.820278087493, 3999.3601023836045, 4025.798710064485, 9675.129238368581, 10078.798424031478, 10105.090541851268, 10115.443650599287, 10123.088921997056, 9813.705588832203, 10131.08820206185, 10147.0, 10148.644797432054, 10164.949175254224, 7191.676374563262, 7420.7773766786, 7623.923760762433, 7654.502457340255, 7660.119086305146, 5520.337559492887, 5686.402927692533, 5730.71346432685, 5782.826515204551, 5918.970405147947, 9271.02654221324, 9282.535873206178, 9284.071592840663, 9432.056794320788, 9525.1903588193, 9537.666181683608, 9565.139137477661, 9623.085806848338, 9681.70954871355, 9688.467134307399, 6152.938470615237, 6351.745930162741, 6354.777582784581, 6405.135306733718, 6490.902636460362, 7028.824279392851, 7074.540154889915, 7275.236100209613, 7493.288137626917, 7502.662380192795, 6830.45356371499, 7026.859462810818, 7044.894326585003, 7076.823079423056, 7230.9638451807405, 6776.6950487227205, 6860.725570977105, 6941.548799328028, 7028.683709232994, 7051.330123638246, 6488.156539650005, 6529.347065293433, 6577.375149360803, 6582.341765823379, 6587.901181482186, 4784.40194975628, 4795.321637427012, 4807.134715751198, 4830.1305764961235, 4860.659753817199, 4666.9533304667875, 4674.836380726658, 4690.061987602425, 4727.432708074915, 4767.356406885165], "value": 4214.554199612751, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.93974235281763, 299.53721500282063, 302.90609910927606, 303.578026543105, 304.3578050313836, 4844.103840789457, 4874.147024270756, 4881.560659540641, 4886.828960986366, 4888.0, 4793.32893394925, 4809.302651115586, 4815.3258543803895, 4846.697818536193, 4858.0, 3631.2011357501306, 3714.9814250928707, 3720.3258533659828, 3791.905202369949, 3831.8275677594434, 3774.2640185163905, 3832.501774769276, 3832.693384529245, 3838.9845331201204, 3847.769133851978, 3786.6024067472795, 3791.8055812419, 3797.8670746523876, 3802.543694756633, 3809.9619003809885, 3588.6411358864166, 3682.521272234619, 3790.943135852937, 3814.275287695329, 3837.0, 3358.56338675973, 3370.747193960463, 3376.4091284025444, 3376.915577110592, 3384.5430866832908, 4705.458872229703, 4716.976415117937, 4718.9292160617615, 4724.6928949618505, 4755.524447555252, 4217.514985776645, 4340.500842403132, 4344.261475549164, 4355.346697995295, 4359.171757366122, 5000.274960130797, 5043.142665746832, 5046.7224302663335, 5055.216441451544, 5073.670211436245, 3675.3016926783826, 3679.6872265857432, 3689.7786132832116, 3695.1685870679153, 3697.4453831925157, 5060.7722652480725, 5244.344456942882, 5275.498827611371, 5294.7617357219015, 5302.693328402157, 3722.5532936047307, 3753.530808648919, 3755.2114056048536, 3760.6427389397963, 3768.340540405418, 3802.543694756647, 3810.2189051244427, 3821.216650586623, 3827.75119617224, 3828.9087610031006, 4308.547602501692, 4314.913701725948, 4327.112941846914, 4328.437303150633, 4328.7402755834755, 4836.153673107263, 5028.5977121830165, 5062.392512898402, 5065.6200784941275, 5076.923846142311, 1310.3186343101725, 1317.466426097432, 1318.1959005006938, 1321.378951892609, 1322.1736414740787, 827.6358402302967, 853.2380633990913, 862.4437237981467, 868.9044205137429, 869.2484643443466, 4328.848490302824, 4466.419365482467, 4502.144592527409, 4522.118186953512, 4527.637788976874, 5214.869628259324, 5225.843224703265, 5227.215917612389, 5249.632525723239, 5290.338707661543, 4470.8435204767675, 4474.776261186993, 4480.484744254387, 4484.775761211927, 4486.394336764561, 2656.123479251842, 2794.720527947189, 2800.8319500830016, 2806.652806652818, 2812.367217376115, 4971.527704868032, 4989.725565093955, 4999.650024498323, 5001.949980500149, 5016.2224855147515, 5229.320188375486, 5369.48989845964, 5406.459354064562, 5407.161889907071, 5411.540019098342, 4972.453030166606, 4994.500549945049, 5002.249662550574, 5010.89978200434, 5017.122003649347, 5249.320217530354, 5255.0, 5256.948610277883, 5262.421133675216, 5274.657147285414, 4993.400791904849, 5144.356955380577, 5169.405518365436, 5181.81863634771, 5185.481451854785, 4971.98074394741, 4999.325091112799, 5001.549860512571, 5001.774920128676, 5002.849914502571, 3789.5452545694693, 3817.370133927871, 3817.732758706864, 3820.789856557916, 3837.3860182370686, 4979.975100124476, 5260.316158899319, 5262.210668399771, 5264.52619264268, 5300.443453437333, 5098.566621837185, 5102.770375333044, 5109.923351149661, 5131.204663277198, 5131.897362052813, 5113.744312784272, 5150.175971844487, 5151.768170432265, 5155.9742201288755, 5168.431472538093, 4837.879053023562, 4959.20652695567, 5002.649814512949, 5007.7245751484015, 5023.547880690755, 4863.586595139453, 5019.573336266459, 5029.371328583927, 5036.640107171116, 5138.537531622172, 4866.637341544373, 4926.965337279212, 5003.574696150722, 5028.974855125701, 5030.245463180552], "value": 3846.868728171362, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.1574411567922, 636.4717284653738, 656.3043174235311, 680.591645012992, 717.905194578268, 12462.314572698499, 13254.734905301912, 13279.203247805126, 13282.136661117032, 13320.13419127756, 12928.13885557607, 13353.0, 13540.864591354084, 13541.458341666346, 13668.453261869514, 781.9687212511493, 802.0015081223885, 805.5207151744703, 808.0222930254399, 808.3452403553111, 617.8702472480785, 765.3838659878795, 789.9249571290746, 798.7603718884341, 801.5791709352578, 838.6980686952722, 841.5918279634373, 841.7643059943226, 841.9452735572169, 842.1115722912325, 646.3084499585445, 832.6253186066234, 832.7959649885756, 832.8417600655886, 835.4319063037133, 581.549299293047, 596.9224000879858, 598.1715324275866, 598.4015984015984, 601.1253625974197, 12561.0, 12591.307478088702, 12591.93704031474, 12596.937015314865, 12654.367281635881, 12282.877171228263, 12784.872151278461, 12813.10308278421, 12962.157459765085, 12978.545750898767, 11556.422178891022, 11559.248648837798, 11601.205449428391, 11905.16663833532, 11992.460339284753, 4062.410950412174, 4099.200655872106, 4139.958600414017, 4155.252054630166, 4168.333066709312, 57926.0, 58838.41161588372, 58970.11544826831, 60997.69501152466, 62379.6881015592, 9235.861462078074, 9531.046895310414, 9823.795570970218, 9914.504274786232, 10709.410982395888, 18475.353362632242, 18734.437966861016, 18772.24911003572, 18785.530361741065, 18793.0, 6288.339724328879, 6388.456981156561, 6399.360063993563, 6432.035194720829, 6520.532880102034, 3628.3106209820576, 3637.217998130415, 3663.7069034477177, 3673.2286219893585, 3690.114372550622, 2778.1804367711575, 2855.1434569629027, 2867.4121805029918, 2868.0822136915986, 2879.9136025919256, 501.2831650739405, 523.254362533396, 526.0846127737709, 530.0485628297216, 537.258583155251, 388.8658412847563, 402.83685107531494, 414.86309517859036, 421.3910898751336, 459.11161901720277, 7427.888581671279, 7440.85118297631, 7529.962350188323, 7626.9618651906385, 7896.052473703192, 406.12682732126166, 456.915470637933, 465.3299249081312, 515.2734644151803, 525.1030922737601, 3540.168060505779, 3630.5098811660087, 3717.1078941054493, 3833.5208098987628, 3870.41943708446, 93814.0, 100298.498507507, 101892.49053754832, 104039.47980260201, 104118.0, 88722.0, 91645.54177229072, 91775.54112229396, 91855.0, 92091.0790892096, 79339.60330198312, 81018.0, 81986.18013819905, 82491.98818100529, 83241.58379208065, 6931.549449285781, 7263.309985551364, 7323.7436689715605, 7362.889556656762, 7372.705091796268, 39249.43002279877, 43753.0, 45866.541334586225, 47464.7626761864, 48918.51081489139, 39979.60020399875, 40057.39913901352, 47227.0, 58087.12869306879, 59613.80772384441, 10739.677809665722, 10763.569457221936, 10937.671869843918, 11093.833592495957, 11477.368744718786, 12547.749045018865, 12595.685107872376, 12758.234505929673, 12893.161944473579, 13193.934030329787, 11202.15983801202, 11877.465514051715, 11983.820242696542, 12243.265404075784, 12528.12303138808, 11020.338779673246, 11150.665480035612, 11488.080953523866, 11489.08087352993, 11501.48243329069, 10539.736506587396, 11076.501557429774, 11474.368909710047, 11487.138464615355, 11496.94251528737, 9077.0, 9248.861267080865, 9411.0, 9781.168600668738, 9810.362326448758, 9036.23192028685, 9129.360944733804, 9611.855822162814, 9655.420674759536, 9662.97594668694], "value": 6405.139586850264, "unit": "score"}], "name": "dromaeo_css", "value": 6346.513295254784, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 115.0, 114.0, 113.0, 113.0, 112.0, 113.0, 115.0, 115.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 122.0, 125.0, 186.0, 121.0, 124.0, 151.0, 121.0, 195.0, 125.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 163.0, 162.0, 163.0, 162.0, 162.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 131.0, 76.0, 77.0, 76.0, 76.0, 98.0, 75.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 91.0, 118.0, 85.0, 84.0, 86.0, 131.0, 85.0, 89.0, 128.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 63.0, 64.0, 65.0, 64.0, 66.0, 64.0, 65.0, 64.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 69.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 79.0, 78.0, 87.0, 83.0, 78.0, 78.0, 82.0, 83.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 127.0, 132.0, 127.0, 125.0, 128.0, 135.0, 133.0, 172.0, 127.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 169.0, 166.0, 164.0, 168.0, 168.0, 169.0, 163.0, 165.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 66.0, 67.0, 65.0, 65.0, 66.0, 65.0, 68.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1535.4, "alertThreshold": 2.0}]} 13:46:07 INFO - Return code: 0 13:46:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:46:07 INFO - # TBPL SUCCESS # 13:46:07 INFO - Running post-action listener: _resource_record_post_action 13:46:07 INFO - ##### 13:46:07 INFO - ##### Finished run-tests step (success) 13:46:07 INFO - ##### 13:46:07 INFO - Running post-run listener: _resource_record_post_run 13:46:07 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535703552; Read time: 16; Write time: 482480 13:46:07 INFO - TinderboxPrint: CPU usage
13.0% 13:46:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:46:07 INFO - TinderboxPrint: I/O write bytes / time
535,703,552 / 482,480 13:46:07 INFO - TinderboxPrint: CPU idle
8,335.5 (87.0%) 13:46:07 INFO - TinderboxPrint: CPU user
1,199.5 (12.5%) 13:46:07 INFO - TinderboxPrint: Swap in / out
0 / 0 13:46:07 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246247424; Read time: 0; Write time: 276944 13:46:07 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 289148928; Read time: 0; Write time: 205500 13:46:07 INFO - Running post-run listener: _upload_blobber_files 13:46:07 INFO - Blob upload gear active. 13:46:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:46:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:46:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:46:08 INFO - (blobuploader) - INFO - Open directory for files ... 13:46:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:46:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:46:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:09 INFO - (blobuploader) - INFO - Done attempting. 13:46:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:46:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:46:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:12 INFO - (blobuploader) - INFO - Done attempting. 13:46:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:46:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:46:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:13 INFO - (blobuploader) - INFO - Done attempting. 13:46:13 INFO - (blobuploader) - INFO - Iteration through files over. 13:46:13 INFO - Return code: 0 13:46:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:46:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:46:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8315d324ef0cac886fdc5ed6a0d8eefad4d7523511359017a62b4932e0166411fbc9cf47b243b40d75a5f8e24e3677af2c2aa43fee34f75f9a67a13ad989f02c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aeb1ee71dd8fe7bac5e03a0f4be6c4ce5f28dce113e03d53b01ae1aec573886a110516c07bb32d34ca0fcca4878d00ed85b263e8bff6ee9eb4c6dc6ff34a6f4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01c967c796c158ad793083ed95e73386c15978510e91d80f804d3f87545c4d44ecb95af83e124861b89817ad3c67a85487bdadd2e5c16eb12b4e59ff72d3d664"} 13:46:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:46:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:46:13 INFO - Contents: 13:46:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8315d324ef0cac886fdc5ed6a0d8eefad4d7523511359017a62b4932e0166411fbc9cf47b243b40d75a5f8e24e3677af2c2aa43fee34f75f9a67a13ad989f02c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aeb1ee71dd8fe7bac5e03a0f4be6c4ce5f28dce113e03d53b01ae1aec573886a110516c07bb32d34ca0fcca4878d00ed85b263e8bff6ee9eb4c6dc6ff34a6f4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01c967c796c158ad793083ed95e73386c15978510e91d80f804d3f87545c4d44ecb95af83e124861b89817ad3c67a85487bdadd2e5c16eb12b4e59ff72d3d664"} 13:46:13 INFO - Running post-run listener: copy_logs_to_upload_dir 13:46:13 INFO - Copying logs to upload dir... 13:46:13 INFO - mkdir: /builds/slave/test/build/upload/logs 13:46:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.395876 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-13 13:46:12.809386) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 13:46:12.812707) ========= 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=cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824 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/8315d324ef0cac886fdc5ed6a0d8eefad4d7523511359017a62b4932e0166411fbc9cf47b243b40d75a5f8e24e3677af2c2aa43fee34f75f9a67a13ad989f02c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aeb1ee71dd8fe7bac5e03a0f4be6c4ce5f28dce113e03d53b01ae1aec573886a110516c07bb32d34ca0fcca4878d00ed85b263e8bff6ee9eb4c6dc6ff34a6f4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01c967c796c158ad793083ed95e73386c15978510e91d80f804d3f87545c4d44ecb95af83e124861b89817ad3c67a85487bdadd2e5c16eb12b4e59ff72d3d664"} build_url:https://queue.taskcluster.net/v1/task/C9Q3hAERSO6fszxB-X7Ijg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/C9Q3hAERSO6fszxB-X7Ijg/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/8315d324ef0cac886fdc5ed6a0d8eefad4d7523511359017a62b4932e0166411fbc9cf47b243b40d75a5f8e24e3677af2c2aa43fee34f75f9a67a13ad989f02c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aeb1ee71dd8fe7bac5e03a0f4be6c4ce5f28dce113e03d53b01ae1aec573886a110516c07bb32d34ca0fcca4878d00ed85b263e8bff6ee9eb4c6dc6ff34a6f4a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01c967c796c158ad793083ed95e73386c15978510e91d80f804d3f87545c4d44ecb95af83e124861b89817ad3c67a85487bdadd2e5c16eb12b4e59ff72d3d664"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 13:46:12.843300) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:46:12.843738) ========= 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=cbe409c6de289db6ac707de3000001d4-1468439585.745324-1010506824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 13:46:12.926097) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 13:46:12.926815) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 13:46:12.927520) ========= ========= Total master_lag: 0.19 =========