builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1470612471.09 results: success (0) buildid: 20160807150052 builduid: 6fc9bd8f35e4477f90b33128110ce38e revision: 2c1f6bf57d21f2bb3dda621bfc21db36e6539fb0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 16:27:51.087214) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 16:27:51.087556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 16:27:51.087814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 16:27:51.108946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:27:51.109217) ========= 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=03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-07 16:27:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.3M=0s 2016-08-07 16:27:51 (70.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146430 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:27:51.275381) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:27:51.275643) ========= 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=03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020066 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:27:51.324870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:27:51.325191) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2c1f6bf57d21f2bb3dda621bfc21db36e6539fb0 --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 2c1f6bf57d21f2bb3dda621bfc21db36e6539fb0 --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=03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-07 16:27:52,056 truncating revision to first 12 chars 2016-08-07 16:27:52,056 Setting DEBUG logging. 2016-08-07 16:27:52,056 attempt 1/10 2016-08-07 16:27:52,056 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2c1f6bf57d21?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 16:27:52,530 unpacking tar archive at: mozilla-central-2c1f6bf57d21/testing/mozharness/ program finished with exit code 0 elapsedTime=0.812161 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:27:52.151257) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 16:27:52.151520) ========= script_repo_revision: 2c1f6bf57d21f2bb3dda621bfc21db36e6539fb0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 16:27:52.151857) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 16:27:52.152107) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 16:27:52.176064) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-07 16:27:52.176327) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:27:52 INFO - MultiFileLogger online at 20160807 16:27:52 in /builds/slave/test 16:27:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 16:27:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:27:52 INFO - {'append_to_log': False, 16:27:52 INFO - 'base_work_dir': '/builds/slave/test', 16:27:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:27:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:27:52 INFO - 'branch': 'Firefox-Non-PGO', 16:27:52 INFO - 'buildbot_json_path': 'buildprops.json', 16:27:52 INFO - 'config_files': ('talos/linux_config.py',), 16:27:52 INFO - 'default_actions': ('clobber', 16:27:52 INFO - 'read-buildbot-config', 16:27:52 INFO - 'download-and-extract', 16:27:52 INFO - 'populate-webroot', 16:27:52 INFO - 'create-virtualenv', 16:27:52 INFO - 'install', 16:27:52 INFO - 'run-tests'), 16:27:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:27:52 INFO - 'download_minidump_stackwalk': True, 16:27:52 INFO - 'download_symbols': 'ondemand', 16:27:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:27:52 INFO - 'tooltool.py': '/tools/tooltool.py', 16:27:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:27:52 INFO - '/tools/misc-python/virtualenv.py')}, 16:27:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:27:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:27:52 INFO - 'installer_path': 'installer.exe', 16:27:52 INFO - 'log_level': 'info', 16:27:52 INFO - 'log_name': 'talos', 16:27:52 INFO - 'log_to_console': True, 16:27:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:27:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:27:52 INFO - 'opt_config_files': (), 16:27:52 INFO - 'pip_index': False, 16:27:52 INFO - 'sps_profile': False, 16:27:52 INFO - 'sps_profile_interval': 0, 16:27:52 INFO - 'suite': 'dromaeojs-e10s', 16:27:52 INFO - 'system_bits': '32', 16:27:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:27:52 INFO - 'title': 'talos-linux64-ix-047', 16:27:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:27:52 INFO - 'use_talos_json': True, 16:27:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:27:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:27:52 INFO - 'work_dir': 'build'} 16:27:52 INFO - [mozharness: 2016-08-07 23:27:52.997381Z] Running clobber step. 16:27:52 INFO - Running pre-action listener: _resource_record_pre_action 16:27:52 INFO - Running main action method: clobber 16:27:52 INFO - rmtree: /builds/slave/test/build 16:27:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:27:53 INFO - Running post-action listener: _resource_record_post_action 16:27:53 INFO - [mozharness: 2016-08-07 23:27:53.454918Z] Finished clobber step (success) 16:27:53 INFO - [mozharness: 2016-08-07 23:27:53.455019Z] Running read-buildbot-config step. 16:27:53 INFO - Running pre-action listener: _resource_record_pre_action 16:27:53 INFO - Running main action method: read_buildbot_config 16:27:53 INFO - Using buildbot properties: 16:27:53 INFO - { 16:27:53 INFO - "project": "", 16:27:53 INFO - "product": "firefox", 16:27:53 INFO - "script_repo_revision": "production", 16:27:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:27:53 INFO - "repository": "", 16:27:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:27:53 INFO - "buildid": "20160807150052", 16:27:53 INFO - "pgo_build": "False", 16:27:53 INFO - "basedir": "/builds/slave/test", 16:27:53 INFO - "buildnumber": 154, 16:27:53 INFO - "slavename": "talos-linux64-ix-047", 16:27:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:27:53 INFO - "platform": "ubuntu64_hw", 16:27:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:27:53 INFO - "branch": "mozilla-central", 16:27:53 INFO - "repo_path": "mozilla-central", 16:27:53 INFO - "revision": "2c1f6bf57d21f2bb3dda621bfc21db36e6539fb0", 16:27:53 INFO - "stage_platform": "linux64", 16:27:53 INFO - "builduid": "6fc9bd8f35e4477f90b33128110ce38e", 16:27:53 INFO - "slavebuilddir": "test" 16:27:53 INFO - } 16:27:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:27:53 INFO - Running post-action listener: _resource_record_post_action 16:27:53 INFO - [mozharness: 2016-08-07 23:27:53.457464Z] Finished read-buildbot-config step (success) 16:27:53 INFO - [mozharness: 2016-08-07 23:27:53.457552Z] Running download-and-extract step. 16:27:53 INFO - Running pre-action listener: _resource_record_pre_action 16:27:53 INFO - Running main action method: download_and_extract 16:27:53 INFO - mkdir: /builds/slave/test/build/tests 16:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:53 INFO - trying https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:27:53 INFO - Downloading https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:27:54 INFO - Downloaded 1361 bytes. 16:27:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:27:54 INFO - Using the following test package requirements: 16:27:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:27:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:27:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:27:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:54 INFO - u'jsshell-linux-x86_64.zip'], 16:27:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:27:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:27:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:27:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:27:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:27:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:27:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:27:54 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:54 INFO - trying https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:27:54 INFO - Downloading https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:27:54 INFO - Downloaded 20257838 bytes. 16:27:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:27:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:27:56 INFO - Return code: 0 16:27:56 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:27: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:56 INFO - trying https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:27:56 INFO - Downloading https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:27:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:27:56 INFO - Downloaded 20257838 bytes. 16:27:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:27:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:27:58 INFO - Return code: 0 16:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:58 INFO - trying https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:27:58 INFO - Downloading https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:27:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:28:00 INFO - Downloaded 14413723 bytes. 16:28:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:28:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:28:00 INFO - Return code: 0 16:28:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:00 INFO - trying https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:28:00 INFO - Downloading https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:28:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:28:02 INFO - Downloaded 56122595 bytes. 16:28:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:28:02 INFO - mkdir: /builds/slave/test/properties 16:28:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:28:02 INFO - Writing to file /builds/slave/test/properties/build_url 16:28:02 INFO - Contents: 16:28:02 INFO - build_url:https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:28:03 INFO - Running post-action listener: _resource_record_post_action 16:28:03 INFO - Running post-action listener: set_extra_try_arguments 16:28:03 INFO - [mozharness: 2016-08-07 23:28:03.682214Z] Finished download-and-extract step (success) 16:28:03 INFO - [mozharness: 2016-08-07 23:28:03.682447Z] Running populate-webroot step. 16:28:03 INFO - Running pre-action listener: _resource_record_pre_action 16:28:03 INFO - Running main action method: populate_webroot 16:28:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:28:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:28:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:28:03 INFO - '--tppagecycles', 16:28:03 INFO - '7'], 16:28:03 INFO - 'tests': ['tsvgm']}}, 16:28:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:28:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:28:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:28:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:28:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:28:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:28:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:03 INFO - 'talos_options': ['--disable-e10s'], 16:28:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:03 INFO - 'talos_options': ['--disable-e10s'], 16:28:03 INFO - 'tests': ['damp', 'tps']}, 16:28:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:03 INFO - 'tests': ['damp', 'tps']}, 16:28:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:28:03 INFO - 'tests': ['dromaeo_dom']}, 16:28:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:28:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:28:03 INFO - 'tests': ['basic_compositor_video']}, 16:28:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:28:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:28:03 INFO - 'tests': ['a11yr', 16:28:03 INFO - 'ts_paint', 16:28:03 INFO - 'tpaint', 16:28:03 INFO - 'sessionrestore', 16:28:03 INFO - 'sessionrestore_no_auto_restore', 16:28:03 INFO - 'tabpaint']}, 16:28:03 INFO - 'other-e10s': {'tests': ['a11yr', 16:28:03 INFO - 'ts_paint', 16:28:03 INFO - 'tpaint', 16:28:03 INFO - 'sessionrestore', 16:28:03 INFO - 'sessionrestore_no_auto_restore', 16:28:03 INFO - 'tabpaint']}, 16:28:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:28:03 INFO - 'ts_paint', 16:28:03 INFO - 'tpaint', 16:28:03 INFO - 'sessionrestore', 16:28:03 INFO - 'sessionrestore_no_auto_restore', 16:28:03 INFO - 'tabpaint']}, 16:28:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:28:03 INFO - 'ts_paint', 16:28:03 INFO - 'tpaint', 16:28:03 INFO - 'sessionrestore', 16:28:03 INFO - 'sessionrestore_no_auto_restore', 16:28:03 INFO - 'tabpaint']}, 16:28:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:28:03 INFO - 'tests': ['a11yr', 16:28:03 INFO - 'ts_paint', 16:28:03 INFO - 'tpaint', 16:28:03 INFO - 'sessionrestore', 16:28:03 INFO - 'sessionrestore_no_auto_restore', 16:28:03 INFO - 'tabpaint']}, 16:28:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:28:03 INFO - 'tests': ['a11yr', 16:28:03 INFO - 'ts_paint', 16:28:03 INFO - 'tpaint', 16:28:03 INFO - 'sessionrestore', 16:28:03 INFO - 'sessionrestore_no_auto_restore', 16:28:03 INFO - 'tabpaint']}, 16:28:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:28:03 INFO - 'tests': ['tsvgx', 16:28:03 INFO - 'tsvgr_opacity', 16:28:03 INFO - 'tart', 16:28:03 INFO - 'tscrollx', 16:28:03 INFO - 'cart']}, 16:28:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:28:03 INFO - 'tsvgr_opacity', 16:28:03 INFO - 'tart', 16:28:03 INFO - 'tscrollx', 16:28:03 INFO - 'cart']}, 16:28:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:03 INFO - 'talos_options': ['--disable-e10s'], 16:28:03 INFO - 'tests': ['tp5o']}, 16:28:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:03 INFO - 'tests': ['tp5o']}, 16:28:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:03 INFO - 'talos_options': ['--disable-e10s', 16:28:03 INFO - '--xperf_path', 16:28:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:03 INFO - 'tests': ['tp5n']}, 16:28:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:03 INFO - 'talos_options': ['--xperf_path', 16:28:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:03 INFO - 'tests': ['tp5n']}}, 16:28:03 INFO - 'talos.zip': {'path': '', 16:28:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:28:03 INFO - Running post-action listener: _resource_record_post_action 16:28:03 INFO - [mozharness: 2016-08-07 23:28:03.705032Z] Finished populate-webroot step (success) 16:28:03 INFO - [mozharness: 2016-08-07 23:28:03.705123Z] Running create-virtualenv step. 16:28:03 INFO - Running pre-action listener: _resource_record_pre_action 16:28:03 INFO - Running main action method: create_virtualenv 16:28:03 INFO - Creating virtualenv /builds/slave/test/build/venv 16:28:03 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 16:28:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:28:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:28:03 INFO - Using real prefix '/usr' 16:28:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:28:04 INFO - Installing distribute.............................................................................................................................................................................................done. 16:28:06 INFO - Installing pip.................done. 16:28:06 INFO - Return code: 0 16:28:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:28: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088570>, '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 0x1089470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, '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': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', '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 16:28: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', 'pip>=1.5'] in /builds/slave/test/build 16:28: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 pip>=1.5 16:28:06 INFO - Using env: {'DISPLAY': ':0', 16:28:06 INFO - 'HOME': '/home/cltbld', 16:28:06 INFO - 'LANG': 'en_US.UTF-8', 16:28:06 INFO - 'LANGUAGE': 'en_US:en', 16:28:06 INFO - 'LOGNAME': 'cltbld', 16:28:06 INFO - 'MAIL': '/var/mail/cltbld', 16:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:06 INFO - 'MOZ_NO_REMOTE': '1', 16:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:06 INFO - 'NO_EM_RESTART': '1', 16:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:06 INFO - 'PWD': '/builds/slave/test', 16:28:06 INFO - 'SHELL': '/bin/bash', 16:28:06 INFO - 'SHLVL': '1', 16:28:06 INFO - 'TERM': 'linux', 16:28:06 INFO - 'TMOUT': '86400', 16:28:06 INFO - 'USER': 'cltbld', 16:28:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', 16:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:06 INFO - '_': '/tools/buildbot/bin/python'} 16:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:06 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 16:28:06 INFO - Cleaning up... 16:28:06 INFO - Return code: 0 16:28:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:28: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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', '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 0xdca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088570>, '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 0x1089470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, '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': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', '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 16:28: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:28: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 psutil>=3.1.1 16:28:06 INFO - Using env: {'DISPLAY': ':0', 16:28:06 INFO - 'HOME': '/home/cltbld', 16:28:06 INFO - 'LANG': 'en_US.UTF-8', 16:28:06 INFO - 'LANGUAGE': 'en_US:en', 16:28:06 INFO - 'LOGNAME': 'cltbld', 16:28:06 INFO - 'MAIL': '/var/mail/cltbld', 16:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:06 INFO - 'MOZ_NO_REMOTE': '1', 16:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:06 INFO - 'NO_EM_RESTART': '1', 16:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:06 INFO - 'PWD': '/builds/slave/test', 16:28:06 INFO - 'SHELL': '/bin/bash', 16:28:06 INFO - 'SHLVL': '1', 16:28:06 INFO - 'TERM': 'linux', 16:28:06 INFO - 'TMOUT': '86400', 16:28:06 INFO - 'USER': 'cltbld', 16:28:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', 16:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:06 INFO - '_': '/tools/buildbot/bin/python'} 16:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:06 INFO - Downloading/unpacking psutil>=3.1.1 16:28:06 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 16:28:06 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 16:28:06 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 16:28:06 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 16:28:06 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 16:28:06 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 16:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:28:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:08 INFO - Installing collected packages: psutil 16:28:08 INFO - Running setup.py install for psutil 16:28:08 INFO - building 'psutil._psutil_linux' extension 16:28:08 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 16:28:08 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 16:28:08 INFO - building 'psutil._psutil_posix' extension 16:28:08 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 16:28:09 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 16:28:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:09 INFO - Successfully installed psutil 16:28:09 INFO - Cleaning up... 16:28:09 INFO - Return code: 0 16:28:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088570>, '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 0x1089470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, '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': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', '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 16:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:28:09 INFO - Using env: {'DISPLAY': ':0', 16:28:09 INFO - 'HOME': '/home/cltbld', 16:28:09 INFO - 'LANG': 'en_US.UTF-8', 16:28:09 INFO - 'LANGUAGE': 'en_US:en', 16:28:09 INFO - 'LOGNAME': 'cltbld', 16:28:09 INFO - 'MAIL': '/var/mail/cltbld', 16:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:09 INFO - 'MOZ_NO_REMOTE': '1', 16:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:09 INFO - 'NO_EM_RESTART': '1', 16:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:09 INFO - 'PWD': '/builds/slave/test', 16:28:09 INFO - 'SHELL': '/bin/bash', 16:28:09 INFO - 'SHLVL': '1', 16:28:09 INFO - 'TERM': 'linux', 16:28:09 INFO - 'TMOUT': '86400', 16:28:09 INFO - 'USER': 'cltbld', 16:28:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', 16:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:09 INFO - '_': '/tools/buildbot/bin/python'} 16:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:28:11 INFO - Installing collected packages: mozsystemmonitor 16:28:11 INFO - Running setup.py install for mozsystemmonitor 16:28:11 INFO - Successfully installed mozsystemmonitor 16:28:11 INFO - Cleaning up... 16:28:11 INFO - Return code: 0 16:28:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088570>, '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 0x1089470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, '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': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', '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 16:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:28:11 INFO - Using env: {'DISPLAY': ':0', 16:28:11 INFO - 'HOME': '/home/cltbld', 16:28:11 INFO - 'LANG': 'en_US.UTF-8', 16:28:11 INFO - 'LANGUAGE': 'en_US:en', 16:28:11 INFO - 'LOGNAME': 'cltbld', 16:28:11 INFO - 'MAIL': '/var/mail/cltbld', 16:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:11 INFO - 'MOZ_NO_REMOTE': '1', 16:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:11 INFO - 'NO_EM_RESTART': '1', 16:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:11 INFO - 'PWD': '/builds/slave/test', 16:28:11 INFO - 'SHELL': '/bin/bash', 16:28:11 INFO - 'SHLVL': '1', 16:28:11 INFO - 'TERM': 'linux', 16:28:11 INFO - 'TMOUT': '86400', 16:28:11 INFO - 'USER': 'cltbld', 16:28:11 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', 16:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:11 INFO - '_': '/tools/buildbot/bin/python'} 16:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:11 INFO - Downloading/unpacking jsonschema==2.5.1 16:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:28:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:13 INFO - Downloading functools32-3.2.3-2.tar.gz 16:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:28:13 INFO - warning: no files found matching '*.txt' 16:28:13 INFO - no previously-included directories found matching 'build' 16:28:13 INFO - no previously-included directories found matching 'dist' 16:28:13 INFO - no previously-included directories found matching '.git*' 16:28:13 INFO - Installing collected packages: jsonschema, functools32 16:28:13 INFO - Running setup.py install for functools32 16:28:13 INFO - warning: no files found matching '*.txt' 16:28:13 INFO - no previously-included directories found matching 'build' 16:28:13 INFO - no previously-included directories found matching 'dist' 16:28:13 INFO - no previously-included directories found matching '.git*' 16:28:14 INFO - Successfully installed jsonschema functools32 16:28:14 INFO - Cleaning up... 16:28:14 INFO - Return code: 0 16:28:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:14 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088570>, '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 0x1089470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, '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': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', '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 16:28:14 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:28:14 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 functools32==3.2.3-2 16:28:14 INFO - Using env: {'DISPLAY': ':0', 16:28:14 INFO - 'HOME': '/home/cltbld', 16:28:14 INFO - 'LANG': 'en_US.UTF-8', 16:28:14 INFO - 'LANGUAGE': 'en_US:en', 16:28:14 INFO - 'LOGNAME': 'cltbld', 16:28:14 INFO - 'MAIL': '/var/mail/cltbld', 16:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:14 INFO - 'MOZ_NO_REMOTE': '1', 16:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:14 INFO - 'NO_EM_RESTART': '1', 16:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:14 INFO - 'PWD': '/builds/slave/test', 16:28:14 INFO - 'SHELL': '/bin/bash', 16:28:14 INFO - 'SHLVL': '1', 16:28:14 INFO - 'TERM': 'linux', 16:28:14 INFO - 'TMOUT': '86400', 16:28:14 INFO - 'USER': 'cltbld', 16:28:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', 16:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:14 INFO - '_': '/tools/buildbot/bin/python'} 16:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:28:14 INFO - Cleaning up... 16:28:14 INFO - Return code: 0 16:28:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:14 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 0xdca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088570>, '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 0x1089470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, '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': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', '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 16:28:14 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 16:28:14 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 16:28:14 INFO - Using env: {'DISPLAY': ':0', 16:28:14 INFO - 'HOME': '/home/cltbld', 16:28:14 INFO - 'LANG': 'en_US.UTF-8', 16:28:14 INFO - 'LANGUAGE': 'en_US:en', 16:28:14 INFO - 'LOGNAME': 'cltbld', 16:28:14 INFO - 'MAIL': '/var/mail/cltbld', 16:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:14 INFO - 'MOZ_NO_REMOTE': '1', 16:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:14 INFO - 'NO_EM_RESTART': '1', 16:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:14 INFO - 'PWD': '/builds/slave/test', 16:28:14 INFO - 'SHELL': '/bin/bash', 16:28:14 INFO - 'SHLVL': '1', 16:28:14 INFO - 'TERM': 'linux', 16:28:14 INFO - 'TMOUT': '86400', 16:28:14 INFO - 'USER': 'cltbld', 16:28:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', 16:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:14 INFO - '_': '/tools/buildbot/bin/python'} 16:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:14 INFO - Downloading/unpacking blobuploader==1.2.4 16:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:16 INFO - Downloading blobuploader-1.2.4.tar.gz 16:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:28:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:28:16 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 16:28:16 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 16:28:16 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 16:28:16 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 16:28:16 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 16:28:16 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 16:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:28:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:28:16 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 16:28:16 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 16:28:16 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 16:28:16 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 16:28:16 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 16:28:16 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 16:28:17 INFO - Downloading docopt-0.6.1.tar.gz 16:28:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:28:17 INFO - Installing collected packages: blobuploader, requests, docopt 16:28:17 INFO - Running setup.py install for blobuploader 16:28:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:28:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:28:17 INFO - Running setup.py install for requests 16:28:17 INFO - Running setup.py install for docopt 16:28:17 INFO - Successfully installed blobuploader requests docopt 16:28:17 INFO - Cleaning up... 16:28:17 INFO - Return code: 0 16:28:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:17 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 0xdca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088570>, '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 0x1089470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, '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': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', '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 16:28:17 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 16:28:17 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 16:28:17 INFO - Using env: {'DISPLAY': ':0', 16:28:17 INFO - 'HOME': '/home/cltbld', 16:28:17 INFO - 'LANG': 'en_US.UTF-8', 16:28:17 INFO - 'LANGUAGE': 'en_US:en', 16:28:17 INFO - 'LOGNAME': 'cltbld', 16:28:17 INFO - 'MAIL': '/var/mail/cltbld', 16:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:17 INFO - 'MOZ_NO_REMOTE': '1', 16:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:17 INFO - 'NO_EM_RESTART': '1', 16:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:17 INFO - 'PWD': '/builds/slave/test', 16:28:17 INFO - 'SHELL': '/bin/bash', 16:28:17 INFO - 'SHLVL': '1', 16:28:17 INFO - 'TERM': 'linux', 16:28:17 INFO - 'TMOUT': '86400', 16:28:17 INFO - 'USER': 'cltbld', 16:28:17 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', 16:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:17 INFO - '_': '/tools/buildbot/bin/python'} 16:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:28:17 INFO - Running setup.py (path:/tmp/pip-krrchY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:28:18 INFO - Running setup.py (path:/tmp/pip-Op3xuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:28:18 INFO - Running setup.py (path:/tmp/pip-LilaXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:28:18 INFO - Running setup.py (path:/tmp/pip-4QJvPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:28:18 INFO - Running setup.py (path:/tmp/pip-rZxb7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:28:18 INFO - Running setup.py (path:/tmp/pip-OuqXai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:28:18 INFO - Running setup.py (path:/tmp/pip-2kNuCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:28:18 INFO - Running setup.py (path:/tmp/pip-nUc3cM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:28:18 INFO - Running setup.py (path:/tmp/pip-cZT6m_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:28:18 INFO - Running setup.py (path:/tmp/pip-Inn4Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:28:18 INFO - Running setup.py (path:/tmp/pip-57e11p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:28:18 INFO - Running setup.py (path:/tmp/pip-gAvK0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:28:18 INFO - Running setup.py (path:/tmp/pip-Y5iqYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:28:18 INFO - Running setup.py (path:/tmp/pip-m1tKSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:18 INFO - Running setup.py (path:/tmp/pip-zYAfu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:28:19 INFO - Running setup.py (path:/tmp/pip-1VUJU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:28:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:28:19 INFO - Running setup.py (path:/tmp/pip-MfutwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:28:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:28:19 INFO - Running setup.py install for manifestparser 16:28:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:28:19 INFO - Running setup.py install for mozcrash 16:28:19 INFO - Running setup.py install for mozdebug 16:28:19 INFO - Running setup.py install for mozdevice 16:28:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:28:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:28:19 INFO - Running setup.py install for mozfile 16:28:19 INFO - Running setup.py install for mozhttpd 16:28:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:28:19 INFO - Running setup.py install for mozinfo 16:28:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:28:19 INFO - Running setup.py install for mozInstall 16:28:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:28:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:28:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:28:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:28:19 INFO - Running setup.py install for mozleak 16:28:20 INFO - Running setup.py install for mozlog 16:28:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:28:20 INFO - Running setup.py install for moznetwork 16:28:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:28:20 INFO - Running setup.py install for mozprocess 16:28:20 INFO - Running setup.py install for mozprofile 16:28:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:28:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:28:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:28:20 INFO - Running setup.py install for mozrunner 16:28:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:28:20 INFO - Running setup.py install for mozscreenshot 16:28:20 INFO - Running setup.py install for moztest 16:28:20 INFO - Running setup.py install for mozversion 16:28:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:28:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:28:20 INFO - Cleaning up... 16:28:20 INFO - Return code: 0 16:28:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:20 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 0xdca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088570>, '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 0x1089470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, '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': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', '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 16:28:20 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 16:28:20 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 16:28:20 INFO - Using env: {'DISPLAY': ':0', 16:28:20 INFO - 'HOME': '/home/cltbld', 16:28:20 INFO - 'LANG': 'en_US.UTF-8', 16:28:20 INFO - 'LANGUAGE': 'en_US:en', 16:28:20 INFO - 'LOGNAME': 'cltbld', 16:28:20 INFO - 'MAIL': '/var/mail/cltbld', 16:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:20 INFO - 'MOZ_NO_REMOTE': '1', 16:28:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:20 INFO - 'NO_EM_RESTART': '1', 16:28:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:20 INFO - 'PWD': '/builds/slave/test', 16:28:20 INFO - 'SHELL': '/bin/bash', 16:28:20 INFO - 'SHLVL': '1', 16:28:20 INFO - 'TERM': 'linux', 16:28:20 INFO - 'TMOUT': '86400', 16:28:20 INFO - 'USER': 'cltbld', 16:28:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', 16:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:20 INFO - '_': '/tools/buildbot/bin/python'} 16:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:28:21 INFO - Running setup.py (path:/tmp/pip-InHRTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:28:21 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)) 16:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:28:21 INFO - Running setup.py (path:/tmp/pip-9NqNy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:28:21 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)) 16:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:28:21 INFO - Running setup.py (path:/tmp/pip-JW4ZNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:28:21 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)) 16:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:28:21 INFO - Running setup.py (path:/tmp/pip-c8fOQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:28:21 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)) 16:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:28:21 INFO - Running setup.py (path:/tmp/pip-TJosNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:28:21 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)) 16:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:28:21 INFO - Running setup.py (path:/tmp/pip-9EpTBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:28:21 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)) 16:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:28:21 INFO - Running setup.py (path:/tmp/pip-9_6O_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:28:21 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)) 16:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:28:21 INFO - Running setup.py (path:/tmp/pip-13T2SE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:28:21 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)) 16:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:28:21 INFO - Running setup.py (path:/tmp/pip-Xm_LIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:28:21 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)) 16:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:28:21 INFO - Running setup.py (path:/tmp/pip-6Txqyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 16:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:28:21 INFO - Running setup.py (path:/tmp/pip-bWBdxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:28:21 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)) 16:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:28:22 INFO - Running setup.py (path:/tmp/pip-OgTRQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:28:22 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)) 16:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:28:22 INFO - Running setup.py (path:/tmp/pip-odf3LH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:28:22 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)) 16:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:28:22 INFO - Running setup.py (path:/tmp/pip-SRYYlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:28:22 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)) 16:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:22 INFO - Running setup.py (path:/tmp/pip-0szFRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:22 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)) 16:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:28:22 INFO - Running setup.py (path:/tmp/pip-CTCNR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:28:22 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)) 16:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:28:22 INFO - Running setup.py (path:/tmp/pip-EIP4ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:28:22 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)) 16:28:22 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)) 16:28:22 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)) 16:28:22 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)) 16:28:22 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)) 16:28:22 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)) 16:28:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:28:22 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 16:28:22 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 16:28:22 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 16:28:22 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 16:28:22 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 16:28:22 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 16:28:24 INFO - Downloading blessings-1.6.tar.gz 16:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:28:24 INFO - Installing collected packages: blessings 16:28:24 INFO - Running setup.py install for blessings 16:28:24 INFO - Successfully installed blessings 16:28:24 INFO - Cleaning up... 16:28:24 INFO - Return code: 0 16:28:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:28:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:28:24 INFO - Reading from file tmpfile_stdout 16:28:24 INFO - Current package versions: 16:28:24 INFO - argparse == 1.2.1 16:28:24 INFO - blessings == 1.6 16:28:24 INFO - blobuploader == 1.2.4 16:28:24 INFO - docopt == 0.6.1 16:28:24 INFO - functools32 == 3.2.3-2 16:28:24 INFO - jsonschema == 2.5.1 16:28:24 INFO - manifestparser == 1.1 16:28:24 INFO - mozInstall == 1.12 16:28:24 INFO - mozcrash == 0.17 16:28:24 INFO - mozdebug == 0.1 16:28:24 INFO - mozdevice == 0.48 16:28:24 INFO - mozfile == 1.2 16:28:24 INFO - mozhttpd == 0.7 16:28:24 INFO - mozinfo == 0.9 16:28:24 INFO - mozleak == 0.1 16:28:24 INFO - mozlog == 3.3 16:28:24 INFO - moznetwork == 0.27 16:28:24 INFO - mozprocess == 0.23 16:28:24 INFO - mozprofile == 0.28 16:28:24 INFO - mozrunner == 6.12 16:28:24 INFO - mozscreenshot == 0.1 16:28:24 INFO - mozsystemmonitor == 0.3 16:28:24 INFO - moztest == 0.7 16:28:24 INFO - mozversion == 1.4 16:28:24 INFO - psutil == 3.1.1 16:28:24 INFO - requests == 1.2.3 16:28:24 INFO - wsgiref == 0.1.2 16:28:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:24 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 0xdca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088570>, '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 0x1089470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, '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': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', '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 16:28:24 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 16:28:24 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 16:28:24 INFO - Using env: {'DISPLAY': ':0', 16:28:24 INFO - 'HOME': '/home/cltbld', 16:28:24 INFO - 'LANG': 'en_US.UTF-8', 16:28:24 INFO - 'LANGUAGE': 'en_US:en', 16:28:24 INFO - 'LOGNAME': 'cltbld', 16:28:24 INFO - 'MAIL': '/var/mail/cltbld', 16:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:24 INFO - 'MOZ_NO_REMOTE': '1', 16:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:24 INFO - 'NO_EM_RESTART': '1', 16:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:24 INFO - 'PWD': '/builds/slave/test', 16:28:24 INFO - 'SHELL': '/bin/bash', 16:28:24 INFO - 'SHLVL': '1', 16:28:24 INFO - 'TERM': 'linux', 16:28:24 INFO - 'TMOUT': '86400', 16:28:24 INFO - 'USER': 'cltbld', 16:28:24 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', 16:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:24 INFO - '_': '/tools/buildbot/bin/python'} 16:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:24 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)) 16:28:24 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)) 16:28:24 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)) 16:28:24 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)) 16:28:24 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)) 16:28:24 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)) 16:28:24 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)) 16:28:24 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)) 16:28:24 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)) 16:28:24 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)) 16:28:24 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)) 16:28:24 INFO - Cleaning up... 16:28:24 INFO - Return code: 0 16:28:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdca030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff9400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088570>, '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 0x1089470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, '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': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', '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 16:28:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:28:25 INFO - Using env: {'DISPLAY': ':0', 16:28:25 INFO - 'HOME': '/home/cltbld', 16:28:25 INFO - 'LANG': 'en_US.UTF-8', 16:28:25 INFO - 'LANGUAGE': 'en_US:en', 16:28:25 INFO - 'LOGNAME': 'cltbld', 16:28:25 INFO - 'MAIL': '/var/mail/cltbld', 16:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:25 INFO - 'MOZ_NO_REMOTE': '1', 16:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:25 INFO - 'NO_EM_RESTART': '1', 16:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:25 INFO - 'PWD': '/builds/slave/test', 16:28:25 INFO - 'SHELL': '/bin/bash', 16:28:25 INFO - 'SHLVL': '1', 16:28:25 INFO - 'TERM': 'linux', 16:28:25 INFO - 'TMOUT': '86400', 16:28:25 INFO - 'USER': 'cltbld', 16:28:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', 16:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:25 INFO - '_': '/tools/buildbot/bin/python'} 16:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:28:25 INFO - Cleaning up... 16:28:25 INFO - Return code: 0 16:28:25 INFO - Running post-action listener: _resource_record_post_action 16:28:25 INFO - Running post-action listener: _start_resource_monitoring 16:28:25 INFO - Starting resource monitoring. 16:28:25 INFO - [mozharness: 2016-08-07 23:28:25.254345Z] Finished create-virtualenv step (success) 16:28:25 INFO - [mozharness: 2016-08-07 23:28:25.254775Z] Running install step. 16:28:25 INFO - Running pre-action listener: _resource_record_pre_action 16:28:25 INFO - Running main action method: install 16:28:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:28:25 INFO - Reading from file tmpfile_stdout 16:28:25 INFO - Detecting whether we're running mozinstall >=1.0... 16:28:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:28:25 INFO - Reading from file tmpfile_stdout 16:28:25 INFO - Output received: 16:28:25 INFO - Usage: mozinstall [options] installer 16:28:25 INFO - Options: 16:28:25 INFO - -h, --help show this help message and exit 16:28:25 INFO - -d DEST, --destination=DEST 16:28:25 INFO - Directory to install application into. [default: 16:28:25 INFO - "/builds/slave/test"] 16:28:25 INFO - --app=APP Application being installed. [default: firefox] 16:28:25 INFO - mkdir: /builds/slave/test/build/application 16:28:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:28:42 INFO - Reading from file tmpfile_stdout 16:28:42 INFO - Output received: 16:28:42 INFO - /builds/slave/test/build/application/firefox/firefox 16:28:42 INFO - Running post-action listener: _resource_record_post_action 16:28:42 INFO - [mozharness: 2016-08-07 23:28:42.122243Z] Finished install step (success) 16:28:42 INFO - [mozharness: 2016-08-07 23:28:42.122491Z] Running run-tests step. 16:28:42 INFO - Running pre-action listener: _resource_record_pre_action 16:28:42 INFO - Running main action method: run_tests 16:28:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:28:42 INFO - Python 2.7.3 16:28:42 INFO - Return code: 0 16:28:42 INFO - grabbing minidump binary from tooltool 16:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:42 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 0x1088570>, '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 0x1089470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:28:42 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 16:28:42 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 16:28:42 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 16:28:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:28:42 INFO - Return code: 0 16:28:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:28:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:28:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:28:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:28:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:28:42 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:28:42 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:28:42 INFO - Using env: {'DISPLAY': ':0', 16:28:42 INFO - 'HOME': '/home/cltbld', 16:28:42 INFO - 'LANG': 'en_US.UTF-8', 16:28:42 INFO - 'LANGUAGE': 'en_US:en', 16:28:42 INFO - 'LOGNAME': 'cltbld', 16:28:42 INFO - 'MAIL': '/var/mail/cltbld', 16:28:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:28:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:42 INFO - 'MOZ_NO_REMOTE': '1', 16:28:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:42 INFO - 'NO_EM_RESTART': '1', 16:28:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:42 INFO - 'PWD': '/builds/slave/test', 16:28:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:28:42 INFO - 'SHELL': '/bin/bash', 16:28:42 INFO - 'SHLVL': '1', 16:28:42 INFO - 'TERM': 'linux', 16:28:42 INFO - 'TMOUT': '86400', 16:28:42 INFO - 'USER': 'cltbld', 16:28:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252', 16:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:42 INFO - '_': '/tools/buildbot/bin/python'} 16:28:42 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:28:42 INFO - mozversion application_buildid: 20160807150052 16:28:42 INFO - mozversion application_changeset: 2c1f6bf57d21f2bb3dda621bfc21db36e6539fb0 16:28:42 INFO - mozversion application_display_name: Nightly 16:28:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:28:42 INFO - mozversion application_name: Firefox 16:28:42 INFO - mozversion application_remotingname: firefox 16:28:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:28:42 INFO - mozversion application_vendor: Mozilla 16:28:42 INFO - mozversion application_version: 51.0a1 16:28:42 INFO - mozversion platform_buildid: 20160807150052 16:28:42 INFO - mozversion platform_changeset: 2c1f6bf57d21f2bb3dda621bfc21db36e6539fb0 16:28:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:28:42 INFO - mozversion platform_version: 51.0a1 16:28:42 INFO - using testdate: 1470612522 16:28:42 INFO - actual date: 1470612522 16:28:42 INFO - starting webserver on 'localhost:38483' 16:28:42 INFO - SUITE-START | Running 2 tests 16:28:42 INFO - TEST-START | dromaeo_css 16:28:42 INFO - operating with platform_type : linux_ 16:28:42 INFO - Initialising browser for dromaeo_css test... 16:28:42 INFO - TEST-INFO | started process 19603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY7KU39/profile http://localhost:38483/getInfo.html) 16:28:47 INFO - PROCESS | 19603 | __metrics Screen width/height:1600/1200 16:28:47 INFO - PROCESS | 19603 | colorDepth:24 16:28:47 INFO - PROCESS | 19603 | Browser inner width/height: 1024/697 16:28:47 INFO - PROCESS | 19603 | __metrics 16:28:47 ERROR - PROCESS | 19603 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:28:48 INFO - TEST-INFO | 19603: exit 0 16:28:48 INFO - Browser initialized. 16:28:48 INFO - Running cycle 1/1 for dromaeo_css test... 16:28:48 INFO - TEST-INFO | started process 19720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY7KU39/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:29:00 INFO - PROCESS | 19720 | RSS: Main: 164683776 16:29:00 INFO - PROCESS | 19720 | 16:29:50 INFO - PROCESS | 19720 | 1470612590297 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] 16:32:02 INFO - PROCESS | 19720 | Cycle 1(1): loaded http://localhost:38483/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38483/tests/dromaeo/cssquery-ext.html) 16:32:04 INFO - PROCESS | 19720 | RSS: Main: 166879232 16:32:04 INFO - PROCESS | 19720 | 16:35:06 INFO - PROCESS | 19720 | Cycle 1(1): loaded http://localhost:38483/tests/dromaeo/cssquery-ext.html (next: http://localhost:38483/tests/dromaeo/cssquery-jquery.html) 16:35:07 INFO - PROCESS | 19720 | RSS: Main: 166580224 16:35:07 INFO - PROCESS | 19720 | 16:38:09 INFO - PROCESS | 19720 | Cycle 1(1): loaded http://localhost:38483/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38483/tests/dromaeo/cssquery-mootools.html) 16:38:09 INFO - PROCESS | 19720 | RSS: Main: 169902080 16:38:09 INFO - PROCESS | 19720 | 16:41:11 INFO - PROCESS | 19720 | Cycle 1(1): loaded http://localhost:38483/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38483/tests/dromaeo/cssquery-prototype.html) 16:41:12 INFO - PROCESS | 19720 | RSS: Main: 164528128 16:41:12 INFO - PROCESS | 19720 | 16:44:15 INFO - PROCESS | 19720 | Cycle 1(1): loaded http://localhost:38483/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38483/tests/dromaeo/cssquery-yui.html) 16:44:15 INFO - PROCESS | 19720 | RSS: Main: 166338560 16:44:15 INFO - PROCESS | 19720 | 16:47:18 INFO - PROCESS | 19720 | Cycle 1(1): loaded http://localhost:38483/tests/dromaeo/cssquery-yui.html (next: http://localhost:38483/tests/dromaeo/cssquery-dojo.html) 16:47:18 INFO - PROCESS | 19720 | RSS: Main: 170106880 16:47:18 INFO - PROCESS | 19720 | 16:47:18 INFO - PROCESS | 19720 | __start_tp_report 16:47:18 INFO - PROCESS | 19720 | _x_x_mozilla_page_load 16:47:18 INFO - PROCESS | 19720 | _x_x_mozilla_page_load_details 16:47:18 INFO - PROCESS | 19720 | |i|pagename|runs| 16:47:18 INFO - PROCESS | 19720 | |0;dojo.html;2648.0864101884845;2656.588228824532;2681.209043332217;2686.9328266793327;2699.770519505843;4595.2417851054615;4812.42250929888;4843.273508973656;4851.708897466155;4866.829660961867;4770.928436073462;4804.83183088592;4818.108649899771;4839.7338146401935;4870.123377791996;4379.956200438002;4383.978080109603;4430.069685366061;4521.909561808762;4544.97727511362;4474.328850672393;4527.275635898257;4566.1780879441685;4567.2920697291975;4568.56598623132;4248.702590818644;4368.628666563346;4374.431323927869;4482.238019536687;4524.796384162688;4455.509893911667;4462.866114016585;4488.192125417456;4493.955060449386;4512.323151527265;4402.8679139625865;4414.095110502371;4418.5581441855875;4419.9337009944875;4463.4866990296205;4635.072985402933;4749.4063242094735;4775.021120670254;4801.975990120062;4835.468098509161;5213.4525874782985;5217.060929032773;5224.190250511177;5227.111391063529;5246.108161612497;5259.053370393328;5259.894802103937;5261.921071183935;5267.104592219293;5298.602604804655;4621.19129152397;4833.854984350475;4866.635002374801;4876.683015603974;4877.95122048775;5330.733463326818;5336.626436149432;5345.679259244458;5380.838574842761;5391.676499410048;5112.9744351278005;5114.079465696136;5115.232715092691;5120.769565369567;5164.483551644806;4966.453690094159;5153.2270159476375;5216.765245563959;5229.843104706865;5232;5200.167973124282;5201.167813149954;5205.479452054764;5217.504337088047;5249.632525723239;5150.381954165524;5193.532582067556;5205.817796377109;5212.192110222845;5266.3943646480375;4197.412362269285;4358.389825424443;4368.868933931987;4377.671674624416;4427.180971520279;3828.425736139601;3841.692664586826;3842.212346468967;3856.305864944337;3878.049877779962;4434.822607095744;4450.6439484841785;4451.955480445219;4490.820367185342;4508.797104130322;4944.480829512921;4958.553730164231;5092.490750924952;5118.513741194581;5232.450592687713;4414.492333381638;4423.380726698265;4445.59989600931;4461.843835465743;4462.843800466968;4620.53794620542;4626.745528995937;4630.21286381316;4641.767911604406;4694.906101877943;4639.025804581076;4826.806927722922;4829.517048295143;4849.4908034657265;4890.095332363524;5268.841934741964;5277.261183434399;5279.52484276417;5300.814471493479;5321.866953326198;4914.852554423373;4920.384951881015;4929.211326187793;4930.235813448921;4973.825916092919;4902.289168070539;4978.60171186297;5024.874378140429;5036.118679231193;5179.274901513866;5112.795488180431;5137.152369858932;5140.074786538459;5145.125328694206;5192.27308176848;4970.105381031449;4994.925076123788;5002.574781143498;5002.574781143643;5036.521530454601;4833.758312084452;4908.509149085063;4948.282499037691;4962.5533701967;4969.676970996874;4861.440934292602;4876.512348765095;4911.8280860169725;4945.530174633404;4973.030259099441;5004.499550044967;5011.924821127759;5016.3227964225825;5030.044291584587;5031.52200540948;4757.738324392053;4761.40482439695;4797.520247975174;4851.490593487633;4933.802647894044 16:47:18 INFO - PROCESS | 19720 | |1;ext.html;510.80078769279976;516.6073783924217;517.1905967161392;560.8990381731287;595.6009473652653;34353.14117147073;38548.42177367335;38608;38651.420228696596;38699.03252418684;39042.80478597603;39386.8030659847;39414.8029259854;39434.80282598583;39668.80165599168;7642.3121919027135;7789.571573563452;7795.14253432122;7818.14000459949;7843.68625254992;7732.845343093135;7820.100688420819;7824.178461261543;7840;7840.490368126082;7824.5305281682995;7849.764507064797;7871.5277083374895;7875.133735289113;7881.527108373487;7790.766277011699;7793.376529877596;7844.333231675286;7848.489848159851;7853.371730261565;7727.922720772776;7771.844563108706;7818;7823.8435231295625;7841.803954901116;37016.444753328724;37071.62928370709;37244;37244.81377593095;37324;2670.6127611496418;2895.1893469828483;3013.291876409064;3103.1311232854837;3211.887583934551;26136.34659133518;27403;27738.722612773814;28214.717852821414;28555.57166642502;3072.9692703072906;3126.6716994715453;3222.7099561039618;3254.137653521795;3277.721393681516;213001;213922;214780;215157;216714;31036;31742.523862141625;31886;31927.52108718371;31962.680373196436;32232.677673223436;33774.662253377646;33959.4906076409;34005.489917651255;34010.31979360399;12137.271763694207;12346.567870124503;12353.32056736888;12359.443825027894;12367.196132251374;9525.5713492893;9533;9554.331196816294;9556.283278754121;9613.230941524662;7756.88364674519;7783.80540486481;7850.607469626496;7934.087579928267;7935.690611049227;3080.353125843598;3110.424571454288;3115.4859448191246;3140.4190224808485;3162.734906037603;885.588201486312;940.2524992630875;962.4850704872999;1022.8775291270643;1065.8134826405503;28033.43933121326;28182.43635127286;28430.573541396894;28865.422691546053;29006.12981610555;957.6121670723368;958.6578789694483;971.0483725948469;988.5156273426113;1029.8249297619423;14955.102693838404;15130.621734456727;15142.924285378502;15225;15523.922380388252;374725;380232;382340;385026;385296;48441.515584844405;49019.754901225264;49042.50957490451;49228.507714922394;49347.75326123346;1194.2140866319482;1211.987880121205;1230.680023193976;1231.954954775087;1235.0305010566663;27095.86452067727;27666.723332766414;27852.16443506698;28557.28606784847;28654.42691146207;41663;41894.16211675688;41943.58056419519;42046.159076818905;42171.7891410541;310699;314350;314465;315422;315577;24665.506689866463;25093.87453062723;25150.49699005973;25190.118345857805;25237.11670091538;41424.37863431991;41736.58263417327;41757.58242417537;43030.56969430391;43599.34600980925;35347.88472104229;36213.45679814752;36862.262754745294;37133.442998354505;37257.813710931274;35746.8212658935;36281.45577816388;36354;36379.63620363762;36404.63595364012;35432.82283588668;37907;38439.61560384472;39527.209455811295;41730.1653966925;35597.64402356047;36319.818400907825;36447.27105457823;39142;39792.403113952736;29716.85141574278;31480.37039259156;31543.842280789366;31767.205819854687;32148 16:47:18 INFO - PROCESS | 19720 | |2;jquery.html;360.54571240237294;372.3186568579499;378.56465065175047;381.8810884109558;385.43918598439274;15693.136877471734;16054.357825686973;17079.914600426997;17152.82847171528;17164.9701017939;16629.50111496654;17541.21064552095;17833.286668533274;17918.820811791877;17927.282908683635;5089.618278629099;5296.285001524783;5298.23175639532;5300.231466437364;5302.522772950434;5107.4892510749;5247.527722504974;5283.788648454077;5287.762050707727;5359.892802143955;5422.75597598107;5446.91829622556;5448.400675925645;5456.7544460499175;5463.672179669233;5247;5367.892642147135;5379.677219366831;5385.084535628933;5410.3507579090365;5203.661761985459;5218.66078704883;5221.425643179247;5450.427705090988;5482.2873026506695;12082.516699332016;12319;12328.260304381765;12339.814902776465;18528.258869645197;1897.1178402043117;1918.8656794024423;1941.7766956800008;1950.4636225038087;2319.22306027481;9036.683716069905;9251.583678734472;9281.53592320388;9362.859557106649;9373.671921482715;1688.4006177806948;1725.240894006633;1797.290070422189;1818.572635430686;1830.3502256698946;65863.67068164676;66073;66222;66669;68474;8245.95877020623;8617.82764344722;8839.867401988975;8899.555022248862;9451.385659932082;11647.242929209575;11674.416279186007;11693;11711;11740.354280514654;6367.777127800505;6469.805905822833;6523.543351965412;6665.50008749336;6683.2648408675;6210.968945155245;6324.620522768649;6458.321876203025;6461.095446637474;6514.120593719882;3597.6222496638;3697.242065376591;3723.566426925599;3788.3559794834946;3811.676007539335;1665.8250883657283;1705.2582126774892;1742.8344307290788;1746.0967545375602;1782.7504149419092;864.9567521623893;919.0946917286467;920.2408013388981;941.3457646935315;986.8306057322096;17288.740668889975;17804.55488612795;18631.254749809857;18871.716924246146;19051.523711907037;846.8983721953405;856.7172832965107;898.23201163006;917.9357444978788;935.6397786852111;9522.571484283224;9762.755931101638;9818.901810981799;9952.303338766362;10100.292979491513;381148.3770324578;388835;396631;396972;396977;80487.59756201299;81383;81512;81885.59057204676;85136.14863851282;900.4237288135467;932.1051790281406;955.1737746849064;962.7929995051097;966.40566051879;14860.256987150815;15096.337285375917;15254.618634534225;15371.154586497403;15721.135337556545;38013.429798553596;38796.41805372978;39389.80305098456;39519.604803952745;40092.79953600213;52952.75492458134;53766.19350709664;54777.45222547883;54907.72546137404;57157.14264285956;7658.846823063396;7683.500572462772;7727.150013498623;7832.216778322122;8004.639791209526;9945.453000084775;11618.244814087395;11668;12714.87285127137;12740.4266807992;10675.359478431319;10818.29681070728;10991.285566438157;11045.558177672803;11177.497012634289;10861.45692715377;10895.346279223271;11019.283746556768;11162.832557511807;11282.210245282751;10257.435841028815;10808.135349171891;10853.620123295646;10978.835317470084;11175.832362514406;7557.811054723676;7589.58257295854;7611.733589324347;7622.8094297643;7849.646765895434;9451.621935122794;10290.279680422598;10543.895508250538;10734.677959661223;10754.83867742 16:47:18 INFO - PROCESS | 19720 | |3;mootools.html;1372.8901687864973;1382.5230295548035;1492.0230694330016;1635.9509214723548;1693.4919524142763;6552.836179095525;7402.888956665654;7537.84924301515;8099.987501562312;8106.270435660789;7613.543187408745;7965.243301886311;7981.760547183594;7997.7600671979935;8017.879731804028;2186.4533866533325;2211.292386436341;2228.9777102229014;2236.9888150559304;2238.3620668109593;2195.3084778294788;2217.4788924602703;2233.8771367574777;2240.473488730147;2252.3355610094977;2200.9559808803815;2219.2676416782424;2223.6886835842993;2227.5544891021777;2234.575430668176;2141.1328411993168;2146.1844499090325;2149.2155363292363;2155.23489161347;2168.9783102168935;2141.229157503313;2162.178372218563;2162.3945295317335;2171.7502487214015;2172.5872084303933;7840.09838868526;7846.450748447611;7899.763007109796;7916.920830791733;7978.162292959272;4405.427294451732;4513.300438432048;4577.22187228172;4583.220852455091;4591.977040114812;2750.188694335176;2839.1198728394265;2879.5824605432094;2892.0889919675446;2933.6039634649264;852.4672079950032;909.0999910088964;913.5569248914271;923.0446487885074;939.6194541210821;10799.082078023377;10811.729706757314;10824.40465774382;10832.837507437394;10860.67417977462;3906.453096566483;4139.627433530996;4215.704900656925;4236.91526169481;4247.6389506892265;9050.230730387992;9078.591463384164;9098.31762617793;9110.954445227731;9115.134062264075;4574.153781550423;4616.976915115403;4622.329762184464;4636.536346365404;4647.9767601161775;3373.4433818420175;3972.900677483086;4070.0842310479907;4255.851045213464;4264.33902745075;3504.141485336109;3513.6135025147214;3540.5397298351563;3641.7450778445254;3759.9060023499082;1160.6634076117832;1169.8011338072547;1170.1341007654444;1177.952881884715;1185.0934035462878;729.7956572159803;842.7471758472434;844.1221130024705;844.7212419901418;851.4763420496474;4962.15643340633;5200.063988482034;5211.973940130351;5294;5330.92003619946;387.7634642867848;391.37966323377765;395.33188910740756;398.0307950141415;398.99453377488567;3464.7747896386654;3494.7029502492064;3549.8047607381327;3558.893233203008;3583.0830505679337;9143.954280228556;9417.434953902788;9471.337006409623;9503.524823758784;9537.189338906272;9454.33819632633;9459.479728614991;9469.715908522756;9470.763230919145;9476.526173691287;7195.496315257882;7294.635268236567;7296.489245752747;7317.085364329459;7336.889946650805;5151.484851514819;5171.81898633546;5188.636795424435;5208.374995000624;5214.687118772886;8737.781555461164;8750.47497150173;8765;8777.736667899973;8789.604467799092;8507.532085735344;8835.204831564934;8843.60203790818;8894.866577001221;9098.590563424794;5670.858228544154;6386.393292637192;6481.060246264359;6785.6946437411425;6848.520603557703;7575.924240757522;7652.311291983749;7666.310032097138;7676.923230767621;7691.923080769121;6710.966445167743;6783.762568310283;6828.385445309946;6850;7050.471214659024;6486.2216534016225;6496.610203387811;6636.83407914806;6695.163104611924;6702.899456508058;6245.96877015612;6339.841503962253;6342.968285158545;6346.936530634819;6347.206599175103;4501.752403617701;4514.909701806011;4564.0643668047305;4570.360149578995;4644.628429725682;4558.179527685049;4695.788689509049;4721.834735784231;4753.5008824072975;4835.201854815071 16:47:18 INFO - PROCESS | 19720 | |4;prototype.html;287.55429084918376;290.65702471084126;292.6692837094083;303.9696030396959;305.36484113044867;4871.585915197204;4976.929960058586;5008.949910500894;5108.616853735971;5110.700184916793;4987.401511818578;5036.949630503703;5039.59683225342;5043.546080852722;5053.242013697938;3905.9804700976524;3908.5505166905887;3922.941155882664;3942.9211415771665;3944.7435916665327;3856.7878766667823;3902.2975864344407;3905.297046531623;3922.705797065217;3923.4114882767526;3871.7870517121546;3907.870210735156;3915.4126880967797;3918.3338832398563;3924.313245182096;3906.609339066071;3911.9022024449473;3912.6478616924614;3920.607939206085;3934.272159650474;3485.89542313731;3487.89536313911;3489.8080605566684;3490.5985811631735;3498.4227602445567;4696.600788932945;4902.509749025105;4914.213725803854;4968.850934471971;4970.204767237261;4384.583464570861;4419.337099435078;4422.734635921823;4430.313301438282;4441.512093448699;5278.1291086970605;5287.841364759063;5302.602304827154;5303.867403314909;5321.760520776575;3591.5633746501608;3664.2305115925687;3686.907827304312;3693.132113953219;3699.3711069118312;5483.40981115476;5537.889242215173;5541.367850271129;5541.727891564439;5550.555955523549;3776.3580191367532;3776.564905335955;3777.697784177259;3785.261873934556;3788.1287303920253;3811.3520701480816;3833.654971052563;3839.349079895616;3886.689064874803;3887.125396785757;4159.376093585925;4385.649148068147;4398.560143985575;4420.624246939046;4446.5553444655925;5354.41101478837;5429.348478182565;5441.891162176814;5447.237386765856;5458.754356053987;1257.5409975358928;1327.2633688302892;1338.7991801229894;1368.213277365499;1378.4555100735154;910.3718434280325;926.7961048569304;959.8176346494143;965.9082387173207;967.7967626798311;4054.7972601369815;4117.629413352813;4138.52406973202;4149.211649786531;4151.771652559078;4754.857354279377;4776.462360757295;4779.713217206979;4801.375821143229;4811.422629284508;4051.554329023805;4112.355057976773;4118.814653340607;4128.60778226068;4142.627163555295;2566.615007748853;2691.515527205122;2905.389868127717;2914.927126821804;2951.778616603763;5150;5181.5595674368105;5185.170372740344;5204.531592156724;5227.921581176285;5344.171653393731;5603.355614104348;5638.577106717013;5652.208690783294;5661.915071273934;5130.920917870302;5159.793608255703;5177.213861217874;5181.766820493011;5183.196604526304;5499.697516636624;5529.474699903502;5573.829495805926;5590.2453168821685;5599.244102046335;5224.947750522598;5422.891542169214;5441.918371224514;5451.591130665295;5480.355893231935;5134.512221338967;5134.820281290137;5162.819301324435;5213.817516386908;5216.921746173734;3775.320442320409;3823.1397935464297;3825.1967086910945;3826.1964987352967;3833.926500579842;5224.9216261756865;5328.653637513549;5531.091773338192;5560.443955604407;5572;5190.195519694454;5366.168243922199;5390.838274851761;5396.676199428047;5415.620906536505;5374.4625537445945;5379.601303661155;5390.814020915393;5397.649152805212;5402.432744561922;5124.5131712487255;5305.389880163831;5307.256984022163;5307.3100496936695;5338.439463856239;5338.343234884117;5390.326209223847;5405.567554595702;5417.458254174551;5440.483154100512;5309.610675196254;5316.548093412103;5316.627836051439;5353.678779273256;5372.892542149213 16:47:18 INFO - PROCESS | 19720 | |5;yui.html;626.2297374229697;632.5951391109691;636.8407898025492;637.5537124013192;721.9458540609455;11646.592369267077;12201.572944946929;12393.19444236124;12462.937685311561;12623.431945562448;12758.68103297418;12823.61529154127;12883.098183127186;12900.354982250898;12904.870951290484;640.5100098424709;774.6630215856106;795.8487887301424;797.1390897830358;797.5573556676071;774.2180397798236;776.9766906992771;778.3889646627399;798.0184373220942;798.5727635714894;828.8508068547659;829.8589239829213;830.3979614779297;832.5587438657491;835.0980940584154;825.6986200037003;826.0582935453558;826.1408135539032;826.8925039744795;827.5489858027389;599.3916175082295;603.5473394953784;604.0727483313137;605.9212302400704;606.233115109387;12780.61658150257;12869.420876060507;12891.290978996152;12894.161879477804;12952.093353465261;12987;13098.41057152421;13246.933765331112;13309;13486.932565337209;9957.352772069793;10008.79982400348;10046;10229.795404091876;10380.480975951248;3282.6553211912883;3283.195617073832;3283.40898638245;3297.5218593303834;3338.749593780476;64163;65176.67411662959;65985;66142.66928665373;67524.6623766883;9509.762255943657;9696.61213551464;9756.609735610497;9805.264605154642;9850;16849.747253791204;17612.647747044986;19454.513637159183;19660.115294811767;19806.60386792256;6794.524383293221;6815.965920170466;6829.351211634887;6833.4191593714095;6996.090508233897;3712.925741485209;3786.73492855503;3802.9567464811726;3816.9427458588143;3843.8270277837005;2846.0892514395196;3021.289996850738;3034.757219422441;3037.240689827543;3052;478.1369627821815;490.66389523176736;510.316176323728;535.8392482255308;538.733327003136;514.8403994761636;576.7174084698468;596.8597379615787;606.8088552106072;617.9134921111048;8145.79635509117;8288.383765165856;8292.12932642076;8405.831883362422;8511.787205319917;494.31537320810935;538.3270911360798;540.5594440530955;540.7296351824087;560.8233406477028;3798.8290526925803;3910.550286717007;4019.397090436458;4103.8974025649;4128.504579450425;86731.13268867231;90282.54858725796;90441;91633;91770.54114729517;78154;82134;83021.58489207637;83901.58049209714;84107.5794621023;70061.64969175223;73108;73125;73360.63319683367;73376.63311683407;7489.812754681177;7617.885731713918;7701.614919254127;7709.3447057000785;7857.882131767914;42245.36631950462;42889.57110428856;42926.570734292254;43287.13425731405;44763.55236447594;56495.71752141213;58957.41042589519;62524.374756251855;63195;65294.34705652883;9407.2003879671;9716.222702183666;9768.36505627132;9850.556724947537;10034.29759916828;10583.417912014605;10787.406692631981;11009.229353945148;11280.435978201222;11568.363739994382;9533.285003624616;9556.904430955601;9650.179734722346;9728.854067189139;9949.054839790208;9893.901060989587;10148.644797432054;10308.793824123626;10387.324823886423;10667;10309.948450257702;10384.065434110966;10469.424181670081;10580.788384232426;10684.57261709523;8298.626561804613;8405.243528082501;8594.613242404232;8712.825743485222;8817;9362.344635875423;9950.203983681433;10015.849762253427;10048.598056077675;10082.747931301483 16:47:18 INFO - PROCESS | 19720 | __end_tp_report 16:47:18 INFO - PROCESS | 19720 | __start_cc_report 16:47:18 INFO - PROCESS | 19720 | _x_x_mozilla_cycle_collect,371 16:47:18 INFO - PROCESS | 19720 | __end_cc_report 16:47:18 INFO - PROCESS | 19720 | __startTimestamp1470613638741__endTimestamp 16:47:18 INFO - PROCESS | 19720 | 16:47:18 INFO - PROCESS | 19720 | ------- Summary: start ------- 16:47:18 INFO - PROCESS | 19720 | Number of tests: 6 16:47:18 INFO - PROCESS | 19720 | 16:47:18 INFO - PROCESS | 19720 | [#0] dojo.html Cycles:165 Average:4770.17 Median:4870.12 stddev:507.79 (10.4%) stddev-sans-first:481.29 16:47:18 INFO - PROCESS | 19720 | Values: 2648.1 2656.6 2681.2 2686.9 2699.8 4595.2 4812.4 4843.3 4851.7 4866.8 4770.9 4804.8 4818.1 4839.7 4870.1 4380.0 4384.0 4430.1 4521.9 4545.0 4474.3 4527.3 4566.2 4567.3 4568.6 4248.7 4368.6 4374.4 4482.2 4524.8 4455.5 4462.9 4488.2 4494.0 4512.3 4402.9 4414.1 4418.6 4419.9 4463.5 4635.1 4749.4 4775.0 4802.0 4835.5 5213.5 5217.1 5224.2 5227.1 5246.1 5259.1 5259.9 5261.9 5267.1 5298.6 4621.2 4833.9 4866.6 4876.7 4878.0 5330.7 5336.6 5345.7 5380.8 5391.7 5113.0 5114.1 5115.2 5120.8 5164.5 4966.5 5153.2 5216.8 5229.8 5232.0 5200.2 5201.2 5205.5 5217.5 5249.6 5150.4 5193.5 5205.8 5212.2 5266.4 4197.4 4358.4 4368.9 4377.7 4427.2 3828.4 3841.7 3842.2 3856.3 3878.0 4434.8 4450.6 4452.0 4490.8 4508.8 4944.5 4958.6 5092.5 5118.5 5232.5 4414.5 4423.4 4445.6 4461.8 4462.8 4620.5 4626.7 4630.2 4641.8 4694.9 4639.0 4826.8 4829.5 4849.5 4890.1 5268.8 5277.3 5279.5 5300.8 5321.9 4914.9 4920.4 4929.2 4930.2 4973.8 4902.3 4978.6 5024.9 5036.1 5179.3 5112.8 5137.2 5140.1 5145.1 5192.3 4970.1 4994.9 5002.6 5002.6 5036.5 4833.8 4908.5 4948.3 4962.6 4969.7 4861.4 4876.5 4911.8 4945.5 4973.0 5004.5 5011.9 5016.3 5030.0 5031.5 4757.7 4761.4 4797.5 4851.5 4933.8 16:47:18 INFO - PROCESS | 19720 | 16:47:18 INFO - PROCESS | 19720 | [#1] ext.html Cycles:180 Average:44711.09 Median:36939.35 stddev:82085.36 (222.2%) stddev-sans-first:82248.55 16:47:18 INFO - PROCESS | 19720 | Values: 510.8 516.6 517.2 560.9 595.6 34353.1 38548.4 38608.0 38651.4 38699.0 39042.8 39386.8 39414.8 39434.8 39668.8 7642.3 7789.6 7795.1 7818.1 7843.7 7732.8 7820.1 7824.2 7840.0 7840.5 7824.5 7849.8 7871.5 7875.1 7881.5 7790.8 7793.4 7844.3 7848.5 7853.4 7727.9 7771.8 7818.0 7823.8 7841.8 37016.4 37071.6 37244.0 37244.8 37324.0 2670.6 2895.2 3013.3 3103.1 3211.9 26136.3 27403.0 27738.7 28214.7 28555.6 3073.0 3126.7 3222.7 3254.1 3277.7 213001.0 213922.0 214780.0 215157.0 216714.0 31036.0 31742.5 31886.0 31927.5 31962.7 32232.7 33774.7 33959.5 34005.5 34010.3 12137.3 12346.6 12353.3 12359.4 12367.2 9525.6 9533.0 9554.3 9556.3 9613.2 7756.9 7783.8 7850.6 7934.1 7935.7 3080.4 3110.4 3115.5 3140.4 3162.7 885.6 940.3 962.5 1022.9 1065.8 28033.4 28182.4 28430.6 28865.4 29006.1 957.6 958.7 971.0 988.5 1029.8 14955.1 15130.6 15142.9 15225.0 15523.9 374725.0 380232.0 382340.0 385026.0 385296.0 48441.5 49019.8 49042.5 49228.5 49347.8 1194.2 1212.0 1230.7 1232.0 1235.0 27095.9 27666.7 27852.2 28557.3 28654.4 41663.0 41894.2 41943.6 42046.2 42171.8 310699.0 314350.0 314465.0 315422.0 315577.0 24665.5 25093.9 25150.5 25190.1 25237.1 41424.4 41736.6 41757.6 43030.6 43599.3 35347.9 36213.5 36862.3 37133.4 37257.8 35746.8 36281.5 36354.0 36379.6 36404.6 35432.8 37907.0 38439.6 39527.2 41730.2 35597.6 36319.8 36447.3 39142.0 39792.4 29716.9 31480.4 31543.8 31767.2 32148.0 16:47:18 INFO - PROCESS | 19720 | 16:47:18 INFO - PROCESS | 19720 | [#2] jquery.html Cycles:180 Average:24385.91 Median:5155.58 stddev:64905.52 (1258.9%) stddev-sans-first:65062.53 16:47:18 INFO - PROCESS | 19720 | Values: 360.5 372.3 378.6 381.9 385.4 15693.1 16054.4 17079.9 17152.8 17165.0 16629.5 17541.2 17833.3 17918.8 17927.3 5089.6 5296.3 5298.2 5300.2 5302.5 5107.5 5247.5 5283.8 5287.8 5359.9 5422.8 5446.9 5448.4 5456.8 5463.7 5247.0 5367.9 5379.7 5385.1 5410.4 5203.7 5218.7 5221.4 5450.4 5482.3 12082.5 12319.0 12328.3 12339.8 18528.3 1897.1 1918.9 1941.8 1950.5 2319.2 9036.7 9251.6 9281.5 9362.9 9373.7 1688.4 1725.2 1797.3 1818.6 1830.4 65863.7 66073.0 66222.0 66669.0 68474.0 8246.0 8617.8 8839.9 8899.6 9451.4 11647.2 11674.4 11693.0 11711.0 11740.4 6367.8 6469.8 6523.5 6665.5 6683.3 6211.0 6324.6 6458.3 6461.1 6514.1 3597.6 3697.2 3723.6 3788.4 3811.7 1665.8 1705.3 1742.8 1746.1 1782.8 865.0 919.1 920.2 941.3 986.8 17288.7 17804.6 18631.3 18871.7 19051.5 846.9 856.7 898.2 917.9 935.6 9522.6 9762.8 9818.9 9952.3 10100.3 381148.4 388835.0 396631.0 396972.0 396977.0 80487.6 81383.0 81512.0 81885.6 85136.1 900.4 932.1 955.2 962.8 966.4 14860.3 15096.3 15254.6 15371.2 15721.1 38013.4 38796.4 39389.8 39519.6 40092.8 52952.8 53766.2 54777.5 54907.7 57157.1 7658.8 7683.5 7727.2 7832.2 8004.6 9945.5 11618.2 11668.0 12714.9 12740.4 10675.4 10818.3 10991.3 11045.6 11177.5 10861.5 10895.3 11019.3 11162.8 11282.2 10257.4 10808.1 10853.6 10978.8 11175.8 7557.8 7589.6 7611.7 7622.8 7849.6 9451.6 10290.3 10543.9 10734.7 10754.8 16:47:18 INFO - PROCESS | 19720 | 16:47:18 INFO - PROCESS | 19720 | [#3] mootools.html Cycles:180 Average:5100.66 Median:5056.82 stddev:2882.80 (57.0%) stddev-sans-first:2877.28 16:47:18 INFO - PROCESS | 19720 | Values: 1372.9 1382.5 1492.0 1636.0 1693.5 6552.8 7402.9 7537.8 8100.0 8106.3 7613.5 7965.2 7981.8 7997.8 8017.9 2186.5 2211.3 2229.0 2237.0 2238.4 2195.3 2217.5 2233.9 2240.5 2252.3 2201.0 2219.3 2223.7 2227.6 2234.6 2141.1 2146.2 2149.2 2155.2 2169.0 2141.2 2162.2 2162.4 2171.8 2172.6 7840.1 7846.5 7899.8 7916.9 7978.2 4405.4 4513.3 4577.2 4583.2 4592.0 2750.2 2839.1 2879.6 2892.1 2933.6 852.5 909.1 913.6 923.0 939.6 10799.1 10811.7 10824.4 10832.8 10860.7 3906.5 4139.6 4215.7 4236.9 4247.6 9050.2 9078.6 9098.3 9111.0 9115.1 4574.2 4617.0 4622.3 4636.5 4648.0 3373.4 3972.9 4070.1 4255.9 4264.3 3504.1 3513.6 3540.5 3641.7 3759.9 1160.7 1169.8 1170.1 1178.0 1185.1 729.8 842.7 844.1 844.7 851.5 4962.2 5200.1 5212.0 5294.0 5330.9 387.8 391.4 395.3 398.0 399.0 3464.8 3494.7 3549.8 3558.9 3583.1 9144.0 9417.4 9471.3 9503.5 9537.2 9454.3 9459.5 9469.7 9470.8 9476.5 7195.5 7294.6 7296.5 7317.1 7336.9 5151.5 5171.8 5188.6 5208.4 5214.7 8737.8 8750.5 8765.0 8777.7 8789.6 8507.5 8835.2 8843.6 8894.9 9098.6 5670.9 6386.4 6481.1 6785.7 6848.5 7575.9 7652.3 7666.3 7676.9 7691.9 6711.0 6783.8 6828.4 6850.0 7050.5 6486.2 6496.6 6636.8 6695.2 6702.9 6246.0 6339.8 6343.0 6346.9 6347.2 4501.8 4514.9 4564.1 4570.4 4644.6 4558.2 4695.8 4721.8 4753.5 4835.2 16:47:18 INFO - PROCESS | 19720 | 16:47:18 INFO - PROCESS | 19720 | [#4] prototype.html Cycles:180 Average:4358.33 Median:4973.57 stddev:1291.83 (26.0%) stddev-sans-first:1258.81 16:47:18 INFO - PROCESS | 19720 | Values: 287.6 290.7 292.7 304.0 305.4 4871.6 4976.9 5008.9 5108.6 5110.7 4987.4 5036.9 5039.6 5043.5 5053.2 3906.0 3908.6 3922.9 3942.9 3944.7 3856.8 3902.3 3905.3 3922.7 3923.4 3871.8 3907.9 3915.4 3918.3 3924.3 3906.6 3911.9 3912.6 3920.6 3934.3 3485.9 3487.9 3489.8 3490.6 3498.4 4696.6 4902.5 4914.2 4968.9 4970.2 4384.6 4419.3 4422.7 4430.3 4441.5 5278.1 5287.8 5302.6 5303.9 5321.8 3591.6 3664.2 3686.9 3693.1 3699.4 5483.4 5537.9 5541.4 5541.7 5550.6 3776.4 3776.6 3777.7 3785.3 3788.1 3811.4 3833.7 3839.3 3886.7 3887.1 4159.4 4385.6 4398.6 4420.6 4446.6 5354.4 5429.3 5441.9 5447.2 5458.8 1257.5 1327.3 1338.8 1368.2 1378.5 910.4 926.8 959.8 965.9 967.8 4054.8 4117.6 4138.5 4149.2 4151.8 4754.9 4776.5 4779.7 4801.4 4811.4 4051.6 4112.4 4118.8 4128.6 4142.6 2566.6 2691.5 2905.4 2914.9 2951.8 5150.0 5181.6 5185.2 5204.5 5227.9 5344.2 5603.4 5638.6 5652.2 5661.9 5130.9 5159.8 5177.2 5181.8 5183.2 5499.7 5529.5 5573.8 5590.2 5599.2 5224.9 5422.9 5441.9 5451.6 5480.4 5134.5 5134.8 5162.8 5213.8 5216.9 3775.3 3823.1 3825.2 3826.2 3833.9 5224.9 5328.7 5531.1 5560.4 5572.0 5190.2 5366.2 5390.8 5396.7 5415.6 5374.5 5379.6 5390.8 5397.6 5402.4 5124.5 5305.4 5307.3 5307.3 5338.4 5338.3 5390.3 5405.6 5417.5 5440.5 5309.6 5316.5 5316.6 5353.7 5372.9 16:47:18 INFO - PROCESS | 19720 | 16:47:18 INFO - PROCESS | 19720 | [#5] yui.html Cycles:180 Average:17162.18 Median:606.08 stddev:24605.49 (4059.8%) stddev-sans-first:24643.19 16:47:18 INFO - PROCESS | 19720 | Values: 626.2 632.6 636.8 637.6 721.9 11646.6 12201.6 12393.2 12462.9 12623.4 12758.7 12823.6 12883.1 12900.4 12904.9 640.5 774.7 795.8 797.1 797.6 774.2 777.0 778.4 798.0 798.6 828.9 829.9 830.4 832.6 835.1 825.7 826.1 826.1 826.9 827.5 599.4 603.5 604.1 605.9 606.2 12780.6 12869.4 12891.3 12894.2 12952.1 12987.0 13098.4 13246.9 13309.0 13486.9 9957.4 10008.8 10046.0 10229.8 10380.5 3282.7 3283.2 3283.4 3297.5 3338.7 64163.0 65176.7 65985.0 66142.7 67524.7 9509.8 9696.6 9756.6 9805.3 9850.0 16849.7 17612.6 19454.5 19660.1 19806.6 6794.5 6816.0 6829.4 6833.4 6996.1 3712.9 3786.7 3803.0 3816.9 3843.8 2846.1 3021.3 3034.8 3037.2 3052.0 478.1 490.7 510.3 535.8 538.7 514.8 576.7 596.9 606.8 617.9 8145.8 8288.4 8292.1 8405.8 8511.8 494.3 538.3 540.6 540.7 560.8 3798.8 3910.6 4019.4 4103.9 4128.5 86731.1 90282.5 90441.0 91633.0 91770.5 78154.0 82134.0 83021.6 83901.6 84107.6 70061.6 73108.0 73125.0 73360.6 73376.6 7489.8 7617.9 7701.6 7709.3 7857.9 42245.4 42889.6 42926.6 43287.1 44763.6 56495.7 58957.4 62524.4 63195.0 65294.3 9407.2 9716.2 9768.4 9850.6 10034.3 10583.4 10787.4 11009.2 11280.4 11568.4 9533.3 9556.9 9650.2 9728.9 9949.1 9893.9 10148.6 10308.8 10387.3 10667.0 10309.9 10384.1 10469.4 10580.8 10684.6 8298.6 8405.2 8594.6 8712.8 8817.0 9362.3 9950.2 10015.8 10048.6 10082.7 16:47:18 INFO - PROCESS | 19720 | -------- Summary: end -------- 16:47:18 INFO - PROCESS | 19720 | 16:47:19 INFO - TEST-INFO | 19720: exit 0 16:47:19 INFO - TEST-OK | dromaeo_css | took 1117197ms 16:47:19 INFO - TEST-START | kraken 16:47:19 INFO - operating with platform_type : linux_ 16:47:19 INFO - Initialising browser for kraken test... 16:47:19 INFO - TEST-INFO | started process 19964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYWTCp5/profile http://localhost:38483/getInfo.html) 16:47:24 INFO - PROCESS | 19964 | __metrics Screen width/height:1600/1200 16:47:24 INFO - PROCESS | 19964 | colorDepth:24 16:47:24 INFO - PROCESS | 19964 | Browser inner width/height: 1024/697 16:47:24 INFO - PROCESS | 19964 | __metrics 16:47:25 ERROR - PROCESS | 19964 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:47:25 INFO - TEST-INFO | 19964: exit 0 16:47:25 INFO - Browser initialized. 16:47:25 INFO - Running cycle 1/1 for kraken test... 16:47:25 INFO - TEST-INFO | started process 20084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYWTCp5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:47:37 INFO - PROCESS | 20084 | RSS: Main: 165314560 16:47:37 INFO - PROCESS | 20084 | 16:47:40 INFO - PROCESS | 20084 | Cycle 1(1): loaded http://localhost:38483/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38483/tests/kraken/driver.html?testName=audio-beat-detection) 16:47:41 INFO - PROCESS | 20084 | RSS: Main: 170299392 16:47:41 INFO - PROCESS | 20084 | 16:47:44 INFO - PROCESS | 20084 | Cycle 1(1): loaded http://localhost:38483/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38483/tests/kraken/driver.html?testName=audio-dft) 16:47:44 INFO - PROCESS | 20084 | RSS: Main: 169521152 16:47:44 INFO - PROCESS | 20084 | 16:47:47 INFO - PROCESS | 20084 | Cycle 1(1): loaded http://localhost:38483/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38483/tests/kraken/driver.html?testName=audio-fft) 16:47:48 INFO - PROCESS | 20084 | RSS: Main: 166154240 16:47:48 INFO - PROCESS | 20084 | 16:47:50 INFO - PROCESS | 20084 | Cycle 1(1): loaded http://localhost:38483/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38483/tests/kraken/driver.html?testName=audio-oscillator) 16:47:51 INFO - PROCESS | 20084 | RSS: Main: 165916672 16:47:51 INFO - PROCESS | 20084 | 16:47:53 INFO - PROCESS | 20084 | Cycle 1(1): loaded http://localhost:38483/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38483/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:47:54 INFO - PROCESS | 20084 | RSS: Main: 166891520 16:47:54 INFO - PROCESS | 20084 | 16:47:57 INFO - PROCESS | 20084 | Cycle 1(1): loaded http://localhost:38483/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38483/tests/kraken/driver.html?testName=imaging-darkroom) 16:47:58 INFO - PROCESS | 20084 | RSS: Main: 166772736 16:47:58 INFO - PROCESS | 20084 | 16:48:01 INFO - PROCESS | 20084 | Cycle 1(1): loaded http://localhost:38483/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38483/tests/kraken/driver.html?testName=imaging-desaturate) 16:48:02 INFO - PROCESS | 20084 | RSS: Main: 164290560 16:48:02 INFO - PROCESS | 20084 | 16:48:05 INFO - PROCESS | 20084 | Cycle 1(1): loaded http://localhost:38483/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38483/tests/kraken/driver.html?testName=json-parse-financial) 16:48:05 INFO - PROCESS | 20084 | RSS: Main: 165998592 16:48:05 INFO - PROCESS | 20084 | 16:48:07 INFO - PROCESS | 20084 | Cycle 1(1): loaded http://localhost:38483/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38483/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:48:08 INFO - PROCESS | 20084 | RSS: Main: 165974016 16:48:08 INFO - PROCESS | 20084 | 16:48:10 INFO - PROCESS | 20084 | Cycle 1(1): loaded http://localhost:38483/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38483/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:48:10 INFO - PROCESS | 20084 | RSS: Main: 165748736 16:48:10 INFO - PROCESS | 20084 | 16:48:12 INFO - PROCESS | 20084 | Cycle 1(1): loaded http://localhost:38483/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38483/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:48:13 INFO - PROCESS | 20084 | RSS: Main: 166354944 16:48:13 INFO - PROCESS | 20084 | 16:48:16 INFO - PROCESS | 20084 | Cycle 1(1): loaded http://localhost:38483/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38483/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:48:17 INFO - PROCESS | 20084 | RSS: Main: 166952960 16:48:17 INFO - PROCESS | 20084 | 16:48:19 INFO - PROCESS | 20084 | Cycle 1(1): loaded http://localhost:38483/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38483/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:48:20 INFO - PROCESS | 20084 | RSS: Main: 167096320 16:48:20 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | Cycle 1(1): loaded http://localhost:38483/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38483/tests/kraken/driver.html?testName=ai-astar) 16:48:22 INFO - PROCESS | 20084 | RSS: Main: 167518208 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | __start_tp_report 16:48:22 INFO - PROCESS | 20084 | _x_x_mozilla_page_load 16:48:22 INFO - PROCESS | 20084 | _x_x_mozilla_page_load_details 16:48:22 INFO - PROCESS | 20084 | |i|pagename|runs| 16:48:22 INFO - PROCESS | 20084 | |0;ai-astar;105;114;111;116;118;115;114;114;119;115 16:48:22 INFO - PROCESS | 20084 | |1;audio-beat-detection;161;128;150;184;129;150;151;124;185;125 16:48:22 INFO - PROCESS | 20084 | |2;audio-dft;165;163;164;176;163;164;162;166;163;164 16:48:22 INFO - PROCESS | 20084 | |3;audio-fft;77;76;76;163;77;76;76;77;164;78 16:48:22 INFO - PROCESS | 20084 | |4;audio-oscillator;86;86;138;86;86;87;146;85;86;147 16:48:22 INFO - PROCESS | 20084 | |5;imaging-gaussian-blur;118;117;118;118;118;118;119;120;118;117 16:48:22 INFO - PROCESS | 20084 | |6;imaging-darkroom;149;148;147;148;148;148;147;150;149;148 16:48:22 INFO - PROCESS | 20084 | |7;imaging-desaturate;96;96;95;96;95;99;96;97;96;96 16:48:22 INFO - PROCESS | 20084 | |8;json-parse-financial;65;64;66;65;67;65;65;64;65;64 16:48:22 INFO - PROCESS | 20084 | |9;json-stringify-tinderbox;67;65;76;70;68;66;65;66;67;65 16:48:22 INFO - PROCESS | 20084 | |10;stanford-crypto-aes;80;81;80;80;81;80;81;79;85;80 16:48:22 INFO - PROCESS | 20084 | |11;stanford-crypto-ccm;134;134;147;141;135;132;133;137;161;134 16:48:22 INFO - PROCESS | 20084 | |12;stanford-crypto-pbkdf2;169;166;169;168;168;166;166;163;166;167 16:48:22 INFO - PROCESS | 20084 | |13;stanford-crypto-sha256-iterative;70;69;69;73;69;71;72;69;68;68 16:48:22 INFO - PROCESS | 20084 | __end_tp_report 16:48:22 INFO - PROCESS | 20084 | __start_cc_report 16:48:22 INFO - PROCESS | 20084 | _x_x_mozilla_cycle_collect,938 16:48:22 INFO - PROCESS | 20084 | __end_cc_report 16:48:22 INFO - PROCESS | 20084 | __startTimestamp1470613702658__endTimestamp 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | ------- Summary: start ------- 16:48:22 INFO - PROCESS | 20084 | Number of tests: 14 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:3.90 (3.4%) stddev-sans-first:2.37 16:48:22 INFO - PROCESS | 20084 | Values: 105.0 114.0 111.0 116.0 118.0 115.0 114.0 114.0 119.0 115.0 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:150.50 stddev:22.88 (15.2%) stddev-sans-first:23.83 16:48:22 INFO - PROCESS | 20084 | Values: 161.0 128.0 150.0 184.0 129.0 150.0 151.0 124.0 185.0 125.0 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:4.03 (2.5%) stddev-sans-first:4.27 16:48:22 INFO - PROCESS | 20084 | Values: 165.0 163.0 164.0 176.0 163.0 164.0 162.0 166.0 163.0 164.0 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.50 stddev:36.64 (47.9%) stddev-sans-first:38.34 16:48:22 INFO - PROCESS | 20084 | Values: 77.0 76.0 76.0 163.0 77.0 76.0 76.0 77.0 164.0 78.0 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:86.00 stddev:27.96 (32.5%) stddev-sans-first:28.94 16:48:22 INFO - PROCESS | 20084 | Values: 86.0 86.0 138.0 86.0 86.0 87.0 146.0 85.0 86.0 147.0 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 16:48:22 INFO - PROCESS | 20084 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 119.0 120.0 118.0 117.0 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 16:48:22 INFO - PROCESS | 20084 | Values: 149.0 148.0 147.0 148.0 148.0 148.0 147.0 150.0 149.0 148.0 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.14 (1.2%) stddev-sans-first:1.20 16:48:22 INFO - PROCESS | 20084 | Values: 96.0 96.0 95.0 96.0 95.0 99.0 96.0 97.0 96.0 96.0 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 16:48:22 INFO - PROCESS | 20084 | Values: 65.0 64.0 66.0 65.0 67.0 65.0 65.0 64.0 65.0 64.0 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:3.37 (5.0%) stddev-sans-first:3.57 16:48:22 INFO - PROCESS | 20084 | Values: 67.0 65.0 76.0 70.0 68.0 66.0 65.0 66.0 67.0 65.0 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.50 stddev:1.64 (2.0%) stddev-sans-first:1.72 16:48:22 INFO - PROCESS | 20084 | Values: 80.0 81.0 80.0 80.0 81.0 80.0 81.0 79.0 85.0 80.0 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:136.00 stddev:9.02 (6.6%) stddev-sans-first:9.39 16:48:22 INFO - PROCESS | 20084 | Values: 134.0 134.0 147.0 141.0 135.0 132.0 133.0 137.0 161.0 134.0 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.50 stddev:1.81 (1.1%) stddev-sans-first:1.74 16:48:22 INFO - PROCESS | 20084 | Values: 169.0 166.0 169.0 168.0 168.0 166.0 166.0 163.0 166.0 167.0 16:48:22 INFO - PROCESS | 20084 | 16:48:22 INFO - PROCESS | 20084 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:69.50 stddev:1.69 (2.4%) stddev-sans-first:1.79 16:48:22 INFO - PROCESS | 20084 | Values: 70.0 69.0 69.0 73.0 69.0 71.0 72.0 69.0 68.0 68.0 16:48:22 INFO - PROCESS | 20084 | -------- Summary: end -------- 16:48:22 INFO - PROCESS | 20084 | 16:48:23 INFO - TEST-INFO | 20084: exit 0 16:48:23 INFO - TEST-OK | kraken | took 64123ms 16:48:23 INFO - SUITE-END | took 1181s 16:48:23 INFO - Completed test suite (00:19:41) 16:48:23 INFO - javascript benchmark 16:48:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6305.73603745849, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2648.0864101884845, 2656.588228824532, 2681.209043332217, 2686.9328266793327, 2699.770519505843, 4595.2417851054615, 4812.42250929888, 4843.273508973656, 4851.708897466155, 4866.829660961867, 4770.928436073462, 4804.83183088592, 4818.108649899771, 4839.7338146401935, 4870.123377791996, 4379.956200438002, 4383.978080109603, 4430.069685366061, 4521.909561808762, 4544.97727511362, 4474.328850672393, 4527.275635898257, 4566.1780879441685, 4567.2920697291975, 4568.56598623132, 4248.702590818644, 4368.628666563346, 4374.431323927869, 4482.238019536687, 4524.796384162688, 4455.509893911667, 4462.866114016585, 4488.192125417456, 4493.955060449386, 4512.323151527265, 4402.8679139625865, 4414.095110502371, 4418.5581441855875, 4419.9337009944875, 4463.4866990296205, 4635.072985402933, 4749.4063242094735, 4775.021120670254, 4801.975990120062, 4835.468098509161, 5213.4525874782985, 5217.060929032773, 5224.190250511177, 5227.111391063529, 5246.108161612497, 5259.053370393328, 5259.894802103937, 5261.921071183935, 5267.104592219293, 5298.602604804655, 4621.19129152397, 4833.854984350475, 4866.635002374801, 4876.683015603974, 4877.95122048775, 5330.733463326818, 5336.626436149432, 5345.679259244458, 5380.838574842761, 5391.676499410048, 5112.9744351278005, 5114.079465696136, 5115.232715092691, 5120.769565369567, 5164.483551644806, 4966.453690094159, 5153.2270159476375, 5216.765245563959, 5229.843104706865, 5232.0, 5200.167973124282, 5201.167813149954, 5205.479452054764, 5217.504337088047, 5249.632525723239, 5150.381954165524, 5193.532582067556, 5205.817796377109, 5212.192110222845, 5266.3943646480375, 4197.412362269285, 4358.389825424443, 4368.868933931987, 4377.671674624416, 4427.180971520279, 3828.425736139601, 3841.692664586826, 3842.212346468967, 3856.305864944337, 3878.049877779962, 4434.822607095744, 4450.6439484841785, 4451.955480445219, 4490.820367185342, 4508.797104130322, 4944.480829512921, 4958.553730164231, 5092.490750924952, 5118.513741194581, 5232.450592687713, 4414.492333381638, 4423.380726698265, 4445.59989600931, 4461.843835465743, 4462.843800466968, 4620.53794620542, 4626.745528995937, 4630.21286381316, 4641.767911604406, 4694.906101877943, 4639.025804581076, 4826.806927722922, 4829.517048295143, 4849.4908034657265, 4890.095332363524, 5268.841934741964, 5277.261183434399, 5279.52484276417, 5300.814471493479, 5321.866953326198, 4914.852554423373, 4920.384951881015, 4929.211326187793, 4930.235813448921, 4973.825916092919, 4902.289168070539, 4978.60171186297, 5024.874378140429, 5036.118679231193, 5179.274901513866, 5112.795488180431, 5137.152369858932, 5140.074786538459, 5145.125328694206, 5192.27308176848, 4970.105381031449, 4994.925076123788, 5002.574781143498, 5002.574781143643, 5036.521530454601, 4833.758312084452, 4908.509149085063, 4948.282499037691, 4962.5533701967, 4969.676970996874, 4861.440934292602, 4876.512348765095, 4911.8280860169725, 4945.530174633404, 4973.030259099441, 5004.499550044967, 5011.924821127759, 5016.3227964225825, 5030.044291584587, 5031.52200540948, 4757.738324392053, 4761.40482439695, 4797.520247975174, 4851.490593487633, 4933.802647894044], "value": 4737.424821461171, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.80078769279976, 516.6073783924217, 517.1905967161392, 560.8990381731287, 595.6009473652653, 34353.14117147073, 38548.42177367335, 38608.0, 38651.420228696596, 38699.03252418684, 39042.80478597603, 39386.8030659847, 39414.8029259854, 39434.80282598583, 39668.80165599168, 7642.3121919027135, 7789.571573563452, 7795.14253432122, 7818.14000459949, 7843.68625254992, 7732.845343093135, 7820.100688420819, 7824.178461261543, 7840.0, 7840.490368126082, 7824.5305281682995, 7849.764507064797, 7871.5277083374895, 7875.133735289113, 7881.527108373487, 7790.766277011699, 7793.376529877596, 7844.333231675286, 7848.489848159851, 7853.371730261565, 7727.922720772776, 7771.844563108706, 7818.0, 7823.8435231295625, 7841.803954901116, 37016.444753328724, 37071.62928370709, 37244.0, 37244.81377593095, 37324.0, 2670.6127611496418, 2895.1893469828483, 3013.291876409064, 3103.1311232854837, 3211.887583934551, 26136.34659133518, 27403.0, 27738.722612773814, 28214.717852821414, 28555.57166642502, 3072.9692703072906, 3126.6716994715453, 3222.7099561039618, 3254.137653521795, 3277.721393681516, 213001.0, 213922.0, 214780.0, 215157.0, 216714.0, 31036.0, 31742.523862141625, 31886.0, 31927.52108718371, 31962.680373196436, 32232.677673223436, 33774.662253377646, 33959.4906076409, 34005.489917651255, 34010.31979360399, 12137.271763694207, 12346.567870124503, 12353.32056736888, 12359.443825027894, 12367.196132251374, 9525.5713492893, 9533.0, 9554.331196816294, 9556.283278754121, 9613.230941524662, 7756.88364674519, 7783.80540486481, 7850.607469626496, 7934.087579928267, 7935.690611049227, 3080.353125843598, 3110.424571454288, 3115.4859448191246, 3140.4190224808485, 3162.734906037603, 885.588201486312, 940.2524992630875, 962.4850704872999, 1022.8775291270643, 1065.8134826405503, 28033.43933121326, 28182.43635127286, 28430.573541396894, 28865.422691546053, 29006.12981610555, 957.6121670723368, 958.6578789694483, 971.0483725948469, 988.5156273426113, 1029.8249297619423, 14955.102693838404, 15130.621734456727, 15142.924285378502, 15225.0, 15523.922380388252, 374725.0, 380232.0, 382340.0, 385026.0, 385296.0, 48441.515584844405, 49019.754901225264, 49042.50957490451, 49228.507714922394, 49347.75326123346, 1194.2140866319482, 1211.987880121205, 1230.680023193976, 1231.954954775087, 1235.0305010566663, 27095.86452067727, 27666.723332766414, 27852.16443506698, 28557.28606784847, 28654.42691146207, 41663.0, 41894.16211675688, 41943.58056419519, 42046.159076818905, 42171.7891410541, 310699.0, 314350.0, 314465.0, 315422.0, 315577.0, 24665.506689866463, 25093.87453062723, 25150.49699005973, 25190.118345857805, 25237.11670091538, 41424.37863431991, 41736.58263417327, 41757.58242417537, 43030.56969430391, 43599.34600980925, 35347.88472104229, 36213.45679814752, 36862.262754745294, 37133.442998354505, 37257.813710931274, 35746.8212658935, 36281.45577816388, 36354.0, 36379.63620363762, 36404.63595364012, 35432.82283588668, 37907.0, 38439.61560384472, 39527.209455811295, 41730.1653966925, 35597.64402356047, 36319.818400907825, 36447.27105457823, 39142.0, 39792.403113952736, 29716.85141574278, 31480.37039259156, 31543.842280789366, 31767.205819854687, 32148.0], "value": 16183.721170835288, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.54571240237294, 372.3186568579499, 378.56465065175047, 381.8810884109558, 385.43918598439274, 15693.136877471734, 16054.357825686973, 17079.914600426997, 17152.82847171528, 17164.9701017939, 16629.50111496654, 17541.21064552095, 17833.286668533274, 17918.820811791877, 17927.282908683635, 5089.618278629099, 5296.285001524783, 5298.23175639532, 5300.231466437364, 5302.522772950434, 5107.4892510749, 5247.527722504974, 5283.788648454077, 5287.762050707727, 5359.892802143955, 5422.75597598107, 5446.91829622556, 5448.400675925645, 5456.7544460499175, 5463.672179669233, 5247.0, 5367.892642147135, 5379.677219366831, 5385.084535628933, 5410.3507579090365, 5203.661761985459, 5218.66078704883, 5221.425643179247, 5450.427705090988, 5482.2873026506695, 12082.516699332016, 12319.0, 12328.260304381765, 12339.814902776465, 18528.258869645197, 1897.1178402043117, 1918.8656794024423, 1941.7766956800008, 1950.4636225038087, 2319.22306027481, 9036.683716069905, 9251.583678734472, 9281.53592320388, 9362.859557106649, 9373.671921482715, 1688.4006177806948, 1725.240894006633, 1797.290070422189, 1818.572635430686, 1830.3502256698946, 65863.67068164676, 66073.0, 66222.0, 66669.0, 68474.0, 8245.95877020623, 8617.82764344722, 8839.867401988975, 8899.555022248862, 9451.385659932082, 11647.242929209575, 11674.416279186007, 11693.0, 11711.0, 11740.354280514654, 6367.777127800505, 6469.805905822833, 6523.543351965412, 6665.50008749336, 6683.2648408675, 6210.968945155245, 6324.620522768649, 6458.321876203025, 6461.095446637474, 6514.120593719882, 3597.6222496638, 3697.242065376591, 3723.566426925599, 3788.3559794834946, 3811.676007539335, 1665.8250883657283, 1705.2582126774892, 1742.8344307290788, 1746.0967545375602, 1782.7504149419092, 864.9567521623893, 919.0946917286467, 920.2408013388981, 941.3457646935315, 986.8306057322096, 17288.740668889975, 17804.55488612795, 18631.254749809857, 18871.716924246146, 19051.523711907037, 846.8983721953405, 856.7172832965107, 898.23201163006, 917.9357444978788, 935.6397786852111, 9522.571484283224, 9762.755931101638, 9818.901810981799, 9952.303338766362, 10100.292979491513, 381148.3770324578, 388835.0, 396631.0, 396972.0, 396977.0, 80487.59756201299, 81383.0, 81512.0, 81885.59057204676, 85136.14863851282, 900.4237288135467, 932.1051790281406, 955.1737746849064, 962.7929995051097, 966.40566051879, 14860.256987150815, 15096.337285375917, 15254.618634534225, 15371.154586497403, 15721.135337556545, 38013.429798553596, 38796.41805372978, 39389.80305098456, 39519.604803952745, 40092.79953600213, 52952.75492458134, 53766.19350709664, 54777.45222547883, 54907.72546137404, 57157.14264285956, 7658.846823063396, 7683.500572462772, 7727.150013498623, 7832.216778322122, 8004.639791209526, 9945.453000084775, 11618.244814087395, 11668.0, 12714.87285127137, 12740.4266807992, 10675.359478431319, 10818.29681070728, 10991.285566438157, 11045.558177672803, 11177.497012634289, 10861.45692715377, 10895.346279223271, 11019.283746556768, 11162.832557511807, 11282.210245282751, 10257.435841028815, 10808.135349171891, 10853.620123295646, 10978.835317470084, 11175.832362514406, 7557.811054723676, 7589.58257295854, 7611.733589324347, 7622.8094297643, 7849.646765895434, 9451.621935122794, 10290.279680422598, 10543.895508250538, 10734.677959661223, 10754.83867742], "value": 8115.628635838844, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.8901687864973, 1382.5230295548035, 1492.0230694330016, 1635.9509214723548, 1693.4919524142763, 6552.836179095525, 7402.888956665654, 7537.84924301515, 8099.987501562312, 8106.270435660789, 7613.543187408745, 7965.243301886311, 7981.760547183594, 7997.7600671979935, 8017.879731804028, 2186.4533866533325, 2211.292386436341, 2228.9777102229014, 2236.9888150559304, 2238.3620668109593, 2195.3084778294788, 2217.4788924602703, 2233.8771367574777, 2240.473488730147, 2252.3355610094977, 2200.9559808803815, 2219.2676416782424, 2223.6886835842993, 2227.5544891021777, 2234.575430668176, 2141.1328411993168, 2146.1844499090325, 2149.2155363292363, 2155.23489161347, 2168.9783102168935, 2141.229157503313, 2162.178372218563, 2162.3945295317335, 2171.7502487214015, 2172.5872084303933, 7840.09838868526, 7846.450748447611, 7899.763007109796, 7916.920830791733, 7978.162292959272, 4405.427294451732, 4513.300438432048, 4577.22187228172, 4583.220852455091, 4591.977040114812, 2750.188694335176, 2839.1198728394265, 2879.5824605432094, 2892.0889919675446, 2933.6039634649264, 852.4672079950032, 909.0999910088964, 913.5569248914271, 923.0446487885074, 939.6194541210821, 10799.082078023377, 10811.729706757314, 10824.40465774382, 10832.837507437394, 10860.67417977462, 3906.453096566483, 4139.627433530996, 4215.704900656925, 4236.91526169481, 4247.6389506892265, 9050.230730387992, 9078.591463384164, 9098.31762617793, 9110.954445227731, 9115.134062264075, 4574.153781550423, 4616.976915115403, 4622.329762184464, 4636.536346365404, 4647.9767601161775, 3373.4433818420175, 3972.900677483086, 4070.0842310479907, 4255.851045213464, 4264.33902745075, 3504.141485336109, 3513.6135025147214, 3540.5397298351563, 3641.7450778445254, 3759.9060023499082, 1160.6634076117832, 1169.8011338072547, 1170.1341007654444, 1177.952881884715, 1185.0934035462878, 729.7956572159803, 842.7471758472434, 844.1221130024705, 844.7212419901418, 851.4763420496474, 4962.15643340633, 5200.063988482034, 5211.973940130351, 5294.0, 5330.92003619946, 387.7634642867848, 391.37966323377765, 395.33188910740756, 398.0307950141415, 398.99453377488567, 3464.7747896386654, 3494.7029502492064, 3549.8047607381327, 3558.893233203008, 3583.0830505679337, 9143.954280228556, 9417.434953902788, 9471.337006409623, 9503.524823758784, 9537.189338906272, 9454.33819632633, 9459.479728614991, 9469.715908522756, 9470.763230919145, 9476.526173691287, 7195.496315257882, 7294.635268236567, 7296.489245752747, 7317.085364329459, 7336.889946650805, 5151.484851514819, 5171.81898633546, 5188.636795424435, 5208.374995000624, 5214.687118772886, 8737.781555461164, 8750.47497150173, 8765.0, 8777.736667899973, 8789.604467799092, 8507.532085735344, 8835.204831564934, 8843.60203790818, 8894.866577001221, 9098.590563424794, 5670.858228544154, 6386.393292637192, 6481.060246264359, 6785.6946437411425, 6848.520603557703, 7575.924240757522, 7652.311291983749, 7666.310032097138, 7676.923230767621, 7691.923080769121, 6710.966445167743, 6783.762568310283, 6828.385445309946, 6850.0, 7050.471214659024, 6486.2216534016225, 6496.610203387811, 6636.83407914806, 6695.163104611924, 6702.899456508058, 6245.96877015612, 6339.841503962253, 6342.968285158545, 6346.936530634819, 6347.206599175103, 4501.752403617701, 4514.909701806011, 4564.0643668047305, 4570.360149578995, 4644.628429725682, 4558.179527685049, 4695.788689509049, 4721.834735784231, 4753.5008824072975, 4835.201854815071], "value": 4034.2963740412138, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.55429084918376, 290.65702471084126, 292.6692837094083, 303.9696030396959, 305.36484113044867, 4871.585915197204, 4976.929960058586, 5008.949910500894, 5108.616853735971, 5110.700184916793, 4987.401511818578, 5036.949630503703, 5039.59683225342, 5043.546080852722, 5053.242013697938, 3905.9804700976524, 3908.5505166905887, 3922.941155882664, 3942.9211415771665, 3944.7435916665327, 3856.7878766667823, 3902.2975864344407, 3905.297046531623, 3922.705797065217, 3923.4114882767526, 3871.7870517121546, 3907.870210735156, 3915.4126880967797, 3918.3338832398563, 3924.313245182096, 3906.609339066071, 3911.9022024449473, 3912.6478616924614, 3920.607939206085, 3934.272159650474, 3485.89542313731, 3487.89536313911, 3489.8080605566684, 3490.5985811631735, 3498.4227602445567, 4696.600788932945, 4902.509749025105, 4914.213725803854, 4968.850934471971, 4970.204767237261, 4384.583464570861, 4419.337099435078, 4422.734635921823, 4430.313301438282, 4441.512093448699, 5278.1291086970605, 5287.841364759063, 5302.602304827154, 5303.867403314909, 5321.760520776575, 3591.5633746501608, 3664.2305115925687, 3686.907827304312, 3693.132113953219, 3699.3711069118312, 5483.40981115476, 5537.889242215173, 5541.367850271129, 5541.727891564439, 5550.555955523549, 3776.3580191367532, 3776.564905335955, 3777.697784177259, 3785.261873934556, 3788.1287303920253, 3811.3520701480816, 3833.654971052563, 3839.349079895616, 3886.689064874803, 3887.125396785757, 4159.376093585925, 4385.649148068147, 4398.560143985575, 4420.624246939046, 4446.5553444655925, 5354.41101478837, 5429.348478182565, 5441.891162176814, 5447.237386765856, 5458.754356053987, 1257.5409975358928, 1327.2633688302892, 1338.7991801229894, 1368.213277365499, 1378.4555100735154, 910.3718434280325, 926.7961048569304, 959.8176346494143, 965.9082387173207, 967.7967626798311, 4054.7972601369815, 4117.629413352813, 4138.52406973202, 4149.211649786531, 4151.771652559078, 4754.857354279377, 4776.462360757295, 4779.713217206979, 4801.375821143229, 4811.422629284508, 4051.554329023805, 4112.355057976773, 4118.814653340607, 4128.60778226068, 4142.627163555295, 2566.615007748853, 2691.515527205122, 2905.389868127717, 2914.927126821804, 2951.778616603763, 5150.0, 5181.5595674368105, 5185.170372740344, 5204.531592156724, 5227.921581176285, 5344.171653393731, 5603.355614104348, 5638.577106717013, 5652.208690783294, 5661.915071273934, 5130.920917870302, 5159.793608255703, 5177.213861217874, 5181.766820493011, 5183.196604526304, 5499.697516636624, 5529.474699903502, 5573.829495805926, 5590.2453168821685, 5599.244102046335, 5224.947750522598, 5422.891542169214, 5441.918371224514, 5451.591130665295, 5480.355893231935, 5134.512221338967, 5134.820281290137, 5162.819301324435, 5213.817516386908, 5216.921746173734, 3775.320442320409, 3823.1397935464297, 3825.1967086910945, 3826.1964987352967, 3833.926500579842, 5224.9216261756865, 5328.653637513549, 5531.091773338192, 5560.443955604407, 5572.0, 5190.195519694454, 5366.168243922199, 5390.838274851761, 5396.676199428047, 5415.620906536505, 5374.4625537445945, 5379.601303661155, 5390.814020915393, 5397.649152805212, 5402.432744561922, 5124.5131712487255, 5305.389880163831, 5307.256984022163, 5307.3100496936695, 5338.439463856239, 5338.343234884117, 5390.326209223847, 5405.567554595702, 5417.458254174551, 5440.483154100512, 5309.610675196254, 5316.548093412103, 5316.627836051439, 5353.678779273256, 5372.892542149213], "value": 3949.3832968332736, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.2297374229697, 632.5951391109691, 636.8407898025492, 637.5537124013192, 721.9458540609455, 11646.592369267077, 12201.572944946929, 12393.19444236124, 12462.937685311561, 12623.431945562448, 12758.68103297418, 12823.61529154127, 12883.098183127186, 12900.354982250898, 12904.870951290484, 640.5100098424709, 774.6630215856106, 795.8487887301424, 797.1390897830358, 797.5573556676071, 774.2180397798236, 776.9766906992771, 778.3889646627399, 798.0184373220942, 798.5727635714894, 828.8508068547659, 829.8589239829213, 830.3979614779297, 832.5587438657491, 835.0980940584154, 825.6986200037003, 826.0582935453558, 826.1408135539032, 826.8925039744795, 827.5489858027389, 599.3916175082295, 603.5473394953784, 604.0727483313137, 605.9212302400704, 606.233115109387, 12780.61658150257, 12869.420876060507, 12891.290978996152, 12894.161879477804, 12952.093353465261, 12987.0, 13098.41057152421, 13246.933765331112, 13309.0, 13486.932565337209, 9957.352772069793, 10008.79982400348, 10046.0, 10229.795404091876, 10380.480975951248, 3282.6553211912883, 3283.195617073832, 3283.40898638245, 3297.5218593303834, 3338.749593780476, 64163.0, 65176.67411662959, 65985.0, 66142.66928665373, 67524.6623766883, 9509.762255943657, 9696.61213551464, 9756.609735610497, 9805.264605154642, 9850.0, 16849.747253791204, 17612.647747044986, 19454.513637159183, 19660.115294811767, 19806.60386792256, 6794.524383293221, 6815.965920170466, 6829.351211634887, 6833.4191593714095, 6996.090508233897, 3712.925741485209, 3786.73492855503, 3802.9567464811726, 3816.9427458588143, 3843.8270277837005, 2846.0892514395196, 3021.289996850738, 3034.757219422441, 3037.240689827543, 3052.0, 478.1369627821815, 490.66389523176736, 510.316176323728, 535.8392482255308, 538.733327003136, 514.8403994761636, 576.7174084698468, 596.8597379615787, 606.8088552106072, 617.9134921111048, 8145.79635509117, 8288.383765165856, 8292.12932642076, 8405.831883362422, 8511.787205319917, 494.31537320810935, 538.3270911360798, 540.5594440530955, 540.7296351824087, 560.8233406477028, 3798.8290526925803, 3910.550286717007, 4019.397090436458, 4103.8974025649, 4128.504579450425, 86731.13268867231, 90282.54858725796, 90441.0, 91633.0, 91770.54114729517, 78154.0, 82134.0, 83021.58489207637, 83901.58049209714, 84107.5794621023, 70061.64969175223, 73108.0, 73125.0, 73360.63319683367, 73376.63311683407, 7489.812754681177, 7617.885731713918, 7701.614919254127, 7709.3447057000785, 7857.882131767914, 42245.36631950462, 42889.57110428856, 42926.570734292254, 43287.13425731405, 44763.55236447594, 56495.71752141213, 58957.41042589519, 62524.374756251855, 63195.0, 65294.34705652883, 9407.2003879671, 9716.222702183666, 9768.36505627132, 9850.556724947537, 10034.29759916828, 10583.417912014605, 10787.406692631981, 11009.229353945148, 11280.435978201222, 11568.363739994382, 9533.285003624616, 9556.904430955601, 9650.179734722346, 9728.854067189139, 9949.054839790208, 9893.901060989587, 10148.644797432054, 10308.793824123626, 10387.324823886423, 10667.0, 10309.948450257702, 10384.065434110966, 10469.424181670081, 10580.788384232426, 10684.57261709523, 8298.626561804613, 8405.243528082501, 8594.613242404232, 8712.825743485222, 8817.0, 9362.344635875423, 9950.203983681433, 10015.849762253427, 10048.598056077675, 10082.747931301483], "value": 6340.592922367841, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 111.0, 116.0, 118.0, 115.0, 114.0, 114.0, 119.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 128.0, 150.0, 184.0, 129.0, 150.0, 151.0, 124.0, 185.0, 125.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 176.0, 163.0, 164.0, 162.0, 166.0, 163.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 163.0, 77.0, 76.0, 76.0, 77.0, 164.0, 78.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 138.0, 86.0, 86.0, 87.0, 146.0, 85.0, 86.0, 147.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 120.0, 118.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 150.0, 149.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 99.0, 96.0, 97.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 65.0, 67.0, 65.0, 65.0, 64.0, 65.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 76.0, 70.0, 68.0, 66.0, 65.0, 66.0, 67.0, 65.0], "value": 67.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 80.0, 81.0, 80.0, 81.0, 79.0, 85.0, 80.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 147.0, 141.0, 135.0, 132.0, 133.0, 137.0, 161.0, 134.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 169.0, 168.0, 168.0, 166.0, 166.0, 163.0, 166.0, 167.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 73.0, 69.0, 71.0, 72.0, 69.0, 68.0, 68.0], "value": 69.8, "unit": "score"}]}]} 16:48:23 INFO - Return code: 0 16:48:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:48:23 ERROR - # TBPL SUCCESS # 16:48:23 INFO - Running post-action listener: _resource_record_post_action 16:48:23 INFO - [mozharness: 2016-08-07 23:48:23.952520Z] Finished run-tests step (success) 16:48:23 INFO - Running post-run listener: _resource_record_post_run 16:48:24 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 20480; Write bytes: 537038848; Read time: 216; Write time: 535392 16:48:24 INFO - TinderboxPrint: CPU usage
13.3% 16:48:24 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 216 16:48:24 INFO - TinderboxPrint: I/O write bytes / time
537,038,848 / 535,392 16:48:24 INFO - TinderboxPrint: CPU idle
8,283.3 (86.6%) 16:48:24 INFO - TinderboxPrint: CPU user
1,218.6 (12.7%) 16:48:24 INFO - TinderboxPrint: Swap in / out
0 / 0 16:48:24 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 249597952; Read time: 44; Write time: 259944 16:48:24 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 16384; Write bytes: 287162368; Read time: 172; Write time: 275424 16:48:24 INFO - Running post-run listener: _upload_blobber_files 16:48:24 INFO - Blob upload gear active. 16:48:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:48:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:48:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:48:25 INFO - (blobuploader) - INFO - Open directory for files ... 16:48:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:48:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:48:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:28 INFO - (blobuploader) - INFO - Done attempting. 16:48:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:48:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:48:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:29 INFO - (blobuploader) - INFO - Done attempting. 16:48:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:48:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:48:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:29 INFO - (blobuploader) - INFO - Done attempting. 16:48:29 INFO - (blobuploader) - INFO - Iteration through files over. 16:48:29 INFO - Return code: 0 16:48:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:48:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:48:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05492f96447026767688c3a1e5398b2d0d5816bfe41666b4174ca722b83b4a76d9cd782c47f74f66c2943ccda6b730f9fd77b5bd9ce4790715f74fb06f24c648", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d63b775aa122d02a6f515932a0abcc627e7eb8cf07bdce53aa859d81211a936ea17fd8ef4a8b85a8d6dd622f141aaf0b2d92e9166d7e94e06f5ad5a1239c027", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66b6fae0f8c087dba96db9c826edbd5cc4ad43e05c96ef077e8abd081417ce009d64aa981cf1bc53143c4edd2b0e7e938e15542ac3b4ca9b1f4985b421c935af"} 16:48:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:48:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:48:29 INFO - Contents: 16:48:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05492f96447026767688c3a1e5398b2d0d5816bfe41666b4174ca722b83b4a76d9cd782c47f74f66c2943ccda6b730f9fd77b5bd9ce4790715f74fb06f24c648", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d63b775aa122d02a6f515932a0abcc627e7eb8cf07bdce53aa859d81211a936ea17fd8ef4a8b85a8d6dd622f141aaf0b2d92e9166d7e94e06f5ad5a1239c027", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66b6fae0f8c087dba96db9c826edbd5cc4ad43e05c96ef077e8abd081417ce009d64aa981cf1bc53143c4edd2b0e7e938e15542ac3b4ca9b1f4985b421c935af"} 16:48:29 INFO - Running post-run listener: copy_logs_to_upload_dir 16:48:29 INFO - Copying logs to upload dir... 16:48:29 INFO - mkdir: /builds/slave/test/build/upload/logs 16:48:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.967029 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-07 16:48:29.167510) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 16:48:29.170692) ========= 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=03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05492f96447026767688c3a1e5398b2d0d5816bfe41666b4174ca722b83b4a76d9cd782c47f74f66c2943ccda6b730f9fd77b5bd9ce4790715f74fb06f24c648", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d63b775aa122d02a6f515932a0abcc627e7eb8cf07bdce53aa859d81211a936ea17fd8ef4a8b85a8d6dd622f141aaf0b2d92e9166d7e94e06f5ad5a1239c027", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66b6fae0f8c087dba96db9c826edbd5cc4ad43e05c96ef077e8abd081417ce009d64aa981cf1bc53143c4edd2b0e7e938e15542ac3b4ca9b1f4985b421c935af"} build_url:https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/PTFyqbStT3-v9HN48tOJSw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05492f96447026767688c3a1e5398b2d0d5816bfe41666b4174ca722b83b4a76d9cd782c47f74f66c2943ccda6b730f9fd77b5bd9ce4790715f74fb06f24c648", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d63b775aa122d02a6f515932a0abcc627e7eb8cf07bdce53aa859d81211a936ea17fd8ef4a8b85a8d6dd622f141aaf0b2d92e9166d7e94e06f5ad5a1239c027", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/66b6fae0f8c087dba96db9c826edbd5cc4ad43e05c96ef077e8abd081417ce009d64aa981cf1bc53143c4edd2b0e7e938e15542ac3b4ca9b1f4985b421c935af"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 16:48:29.196911) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:48:29.197311) ========= 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=03627c79f6bb3d1578c4a402000001ba-1470595884.339475-609426252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:48:29.280591) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 16:48:29.280968) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 16:48:29.281312) ========= ========= Total master_lag: 0.18 =========