builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1468932417.12 results: success (0) buildid: 20160719030224 builduid: d8a10a6df2a44252acc4188e3048ce61 revision: feaaf1af1065257b9178faca8b67eed9657b4a17 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:57.118451) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:57.118857) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:57.119135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:57.134436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:57.134723) ========= 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=836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 05:46:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-07-19 05:46:57 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077961 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:57.226490) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:57.226919) ========= 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=836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020740 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:57.276618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:57.277080) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev feaaf1af1065257b9178faca8b67eed9657b4a17 --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 feaaf1af1065257b9178faca8b67eed9657b4a17 --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=836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 05:46:57,568 truncating revision to first 12 chars 2016-07-19 05:46:57,568 Setting DEBUG logging. 2016-07-19 05:46:57,568 attempt 1/10 2016-07-19 05:46:57,568 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/feaaf1af1065?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 05:46:58,014 unpacking tar archive at: mozilla-central-feaaf1af1065/testing/mozharness/ program finished with exit code 0 elapsedTime=0.819325 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:58.109950) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:58.110233) ========= script_repo_revision: feaaf1af1065257b9178faca8b67eed9657b4a17 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:58.110711) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:58.111016) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 05:46:58.121795) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-19 05:46:58.122083) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:46:58 INFO - MultiFileLogger online at 20160719 05:46:58 in /builds/slave/test 05:46:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:46:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:46:58 INFO - {'append_to_log': False, 05:46:58 INFO - 'base_work_dir': '/builds/slave/test', 05:46:58 INFO - 'blob_upload_branch': 'Firefox', 05:46:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:46:58 INFO - 'branch': 'Firefox', 05:46:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:46:58 INFO - 'config_files': ('talos/linux_config.py',), 05:46:58 INFO - 'default_actions': ('clobber', 05:46:58 INFO - 'read-buildbot-config', 05:46:58 INFO - 'download-and-extract', 05:46:58 INFO - 'populate-webroot', 05:46:58 INFO - 'create-virtualenv', 05:46:58 INFO - 'install', 05:46:58 INFO - 'run-tests'), 05:46:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:46:58 INFO - 'download_minidump_stackwalk': True, 05:46:58 INFO - 'download_symbols': 'ondemand', 05:46:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:46:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:46:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:46:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:46:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:46:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:46:58 INFO - 'installer_path': 'installer.exe', 05:46:58 INFO - 'log_level': 'info', 05:46:58 INFO - 'log_name': 'talos', 05:46:58 INFO - 'log_to_console': True, 05:46:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:46:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:46:58 INFO - 'opt_config_files': (), 05:46:58 INFO - 'pip_index': False, 05:46:58 INFO - 'sps_profile': False, 05:46:58 INFO - 'sps_profile_interval': 0, 05:46:58 INFO - 'suite': 'dromaeojs-e10s', 05:46:58 INFO - 'system_bits': '32', 05:46:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:46:58 INFO - 'title': 'talos-linux64-ix-028', 05:46:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:46:58 INFO - 'use_talos_json': True, 05:46:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:46:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:46:58 INFO - 'work_dir': 'build'} 05:46:58 INFO - ##### 05:46:58 INFO - ##### Running clobber step. 05:46:58 INFO - ##### 05:46:58 INFO - Running pre-action listener: _resource_record_pre_action 05:46:58 INFO - Running main action method: clobber 05:46:58 INFO - rmtree: /builds/slave/test/build 05:46:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:46:59 INFO - Running post-action listener: _resource_record_post_action 05:46:59 INFO - ##### 05:46:59 INFO - ##### Finished clobber step (success) 05:46:59 INFO - ##### 05:46:59 INFO - ##### 05:46:59 INFO - ##### Running read-buildbot-config step. 05:46:59 INFO - ##### 05:46:59 INFO - Running pre-action listener: _resource_record_pre_action 05:46:59 INFO - Running main action method: read_buildbot_config 05:46:59 INFO - Using buildbot properties: 05:46:59 INFO - { 05:46:59 INFO - "project": "", 05:46:59 INFO - "product": "firefox", 05:46:59 INFO - "script_repo_revision": "production", 05:46:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:46:59 INFO - "repository": "", 05:46:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:46:59 INFO - "buildid": "20160719030224", 05:46:59 INFO - "stage_platform": "linux64-pgo", 05:46:59 INFO - "basedir": "/builds/slave/test", 05:46:59 INFO - "nightly_build": "True", 05:46:59 INFO - "buildnumber": 10, 05:46:59 INFO - "slavename": "talos-linux64-ix-028", 05:46:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:46:59 INFO - "platform": "ubuntu64_hw", 05:46:59 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:46:59 INFO - "branch": "mozilla-central", 05:46:59 INFO - "repo_path": "mozilla-central", 05:46:59 INFO - "revision": "feaaf1af1065257b9178faca8b67eed9657b4a17", 05:46:59 INFO - "pgo_build": "True", 05:46:59 INFO - "builduid": "d8a10a6df2a44252acc4188e3048ce61", 05:46:59 INFO - "slavebuilddir": "test" 05:46:59 INFO - } 05:46:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:46:59 INFO - Running post-action listener: _resource_record_post_action 05:46:59 INFO - ##### 05:46:59 INFO - ##### Finished read-buildbot-config step (success) 05:46:59 INFO - ##### 05:46:59 INFO - ##### 05:46:59 INFO - ##### Running download-and-extract step. 05:46:59 INFO - ##### 05:46:59 INFO - Running pre-action listener: _resource_record_pre_action 05:46:59 INFO - Running main action method: download_and_extract 05:46:59 INFO - mkdir: /builds/slave/test/build/tests 05:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:59 INFO - https://queue.taskcluster.net/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:46:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:46:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:46:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:46:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:47:06 INFO - Downloaded 1361 bytes. 05:47:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:47:06 INFO - Using the following test package requirements: 05:47:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:47:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:47:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:06 INFO - u'jsshell-linux-x86_64.zip'], 05:47:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:47:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:47:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:47:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:47:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:47:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:06 INFO - https://queue.taskcluster.net/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:47:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:47:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:47:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:47:07 INFO - Downloaded 24332227 bytes. 05:47:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:47:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:47:09 INFO - Return code: 0 05:47:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:09 INFO - https://queue.taskcluster.net/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:47:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:47:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:47:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:47:23 INFO - Downloaded 24332227 bytes. 05:47:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:47:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:47:24 INFO - Return code: 0 05:47: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:24 INFO - https://queue.taskcluster.net/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:47:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:47:25 INFO - Downloaded 14403317 bytes. 05:47:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:47:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:47:25 INFO - Return code: 0 05:47: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:25 INFO - https://queue.taskcluster.net/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:47:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:47:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:47:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:47:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:47:27 INFO - Downloaded 60858407 bytes. 05:47:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:47:27 INFO - mkdir: /builds/slave/test/properties 05:47:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:47:27 INFO - Writing to file /builds/slave/test/properties/build_url 05:47:27 INFO - Contents: 05:47:27 INFO - build_url:https://queue.taskcluster.net/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:47:27 INFO - Running post-action listener: _resource_record_post_action 05:47:27 INFO - Running post-action listener: set_extra_try_arguments 05:47:27 INFO - ##### 05:47:27 INFO - ##### Finished download-and-extract step (success) 05:47:27 INFO - ##### 05:47:27 INFO - ##### 05:47:27 INFO - ##### Running populate-webroot step. 05:47:27 INFO - ##### 05:47:27 INFO - Running pre-action listener: _resource_record_pre_action 05:47:27 INFO - Running main action method: populate_webroot 05:47:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:47:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:47:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:47:27 INFO - '--tppagecycles', 05:47:27 INFO - '7'], 05:47:27 INFO - 'tests': ['tsvgm']}}, 05:47:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:47:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:47:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:47:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:47:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:47:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:47:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:27 INFO - 'talos_options': ['--disable-e10s'], 05:47:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:27 INFO - 'talos_options': ['--disable-e10s'], 05:47:27 INFO - 'tests': ['damp', 'tps']}, 05:47:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:27 INFO - 'tests': ['damp', 'tps']}, 05:47:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:47:27 INFO - 'tests': ['dromaeo_dom']}, 05:47:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:47:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:47:27 INFO - 'tests': ['basic_compositor_video']}, 05:47:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:47:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:47:27 INFO - 'tests': ['a11yr', 05:47:27 INFO - 'ts_paint', 05:47:27 INFO - 'tpaint', 05:47:27 INFO - 'sessionrestore', 05:47:27 INFO - 'sessionrestore_no_auto_restore', 05:47:27 INFO - 'tabpaint']}, 05:47:27 INFO - 'other-e10s': {'tests': ['a11yr', 05:47:27 INFO - 'ts_paint', 05:47:27 INFO - 'tpaint', 05:47:27 INFO - 'sessionrestore', 05:47:27 INFO - 'sessionrestore_no_auto_restore', 05:47:27 INFO - 'tabpaint']}, 05:47:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:47:27 INFO - 'ts_paint', 05:47:27 INFO - 'tpaint', 05:47:27 INFO - 'sessionrestore', 05:47:27 INFO - 'sessionrestore_no_auto_restore', 05:47:27 INFO - 'tabpaint']}, 05:47:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:47:27 INFO - 'ts_paint', 05:47:27 INFO - 'tpaint', 05:47:27 INFO - 'sessionrestore', 05:47:27 INFO - 'sessionrestore_no_auto_restore', 05:47:27 INFO - 'tabpaint']}, 05:47:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:47:27 INFO - 'tests': ['a11yr', 05:47:27 INFO - 'ts_paint', 05:47:27 INFO - 'tpaint', 05:47:27 INFO - 'sessionrestore', 05:47:27 INFO - 'sessionrestore_no_auto_restore', 05:47:27 INFO - 'tabpaint']}, 05:47:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:47:27 INFO - 'tests': ['a11yr', 05:47:27 INFO - 'ts_paint', 05:47:27 INFO - 'tpaint', 05:47:27 INFO - 'sessionrestore', 05:47:27 INFO - 'sessionrestore_no_auto_restore', 05:47:27 INFO - 'tabpaint']}, 05:47:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:47:27 INFO - 'tests': ['tsvgx', 05:47:27 INFO - 'tsvgr_opacity', 05:47:27 INFO - 'tart', 05:47:27 INFO - 'tscrollx', 05:47:27 INFO - 'cart']}, 05:47:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:47:27 INFO - 'tsvgr_opacity', 05:47:27 INFO - 'tart', 05:47:27 INFO - 'tscrollx', 05:47:27 INFO - 'cart']}, 05:47:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:27 INFO - 'talos_options': ['--disable-e10s'], 05:47:27 INFO - 'tests': ['tp5o']}, 05:47:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:27 INFO - 'tests': ['tp5o']}, 05:47:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:27 INFO - 'talos_options': ['--disable-e10s', 05:47:27 INFO - '--xperf_path', 05:47:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:27 INFO - 'tests': ['tp5n']}, 05:47:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:27 INFO - 'talos_options': ['--xperf_path', 05:47:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:27 INFO - 'tests': ['tp5n']}}, 05:47:27 INFO - 'talos.zip': {'path': '', 05:47:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:47:27 INFO - Running post-action listener: _resource_record_post_action 05:47:27 INFO - ##### 05:47:27 INFO - ##### Finished populate-webroot step (success) 05:47:27 INFO - ##### 05:47:27 INFO - ##### 05:47:27 INFO - ##### Running create-virtualenv step. 05:47:27 INFO - ##### 05:47:27 INFO - Running pre-action listener: _resource_record_pre_action 05:47:27 INFO - Running main action method: create_virtualenv 05:47:27 INFO - Creating virtualenv /builds/slave/test/build/venv 05:47:27 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 05:47:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:47:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:47:28 INFO - Using real prefix '/usr' 05:47:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:47:28 INFO - Installing distribute.............................................................................................................................................................................................done. 05:47:30 INFO - Installing pip.................done. 05:47:30 INFO - Return code: 0 05:47:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:30 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 0x194f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e3b0>, '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 0x1c0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f740>, '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': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', '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 05:47:30 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 05:47:30 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 05:47:30 INFO - Using env: {'DISPLAY': ':0', 05:47:30 INFO - 'HOME': '/home/cltbld', 05:47:30 INFO - 'LANG': 'en_US.UTF-8', 05:47:30 INFO - 'LANGUAGE': 'en_US:en', 05:47:30 INFO - 'LOGNAME': 'cltbld', 05:47:30 INFO - 'MAIL': '/var/mail/cltbld', 05:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:30 INFO - 'MOZ_NO_REMOTE': '1', 05:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:30 INFO - 'NO_EM_RESTART': '1', 05:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:30 INFO - 'PWD': '/builds/slave/test', 05:47:30 INFO - 'SHELL': '/bin/bash', 05:47:30 INFO - 'SHLVL': '1', 05:47:30 INFO - 'TERM': 'linux', 05:47:30 INFO - 'TMOUT': '86400', 05:47:30 INFO - 'USER': 'cltbld', 05:47:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', 05:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:30 INFO - '_': '/tools/buildbot/bin/python'} 05:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:30 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 05:47:30 INFO - Cleaning up... 05:47:30 INFO - Return code: 0 05:47:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:30 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 0x194f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e3b0>, '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 0x1c0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f740>, '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': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', '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 05:47:30 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 05:47:30 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 05:47:30 INFO - Using env: {'DISPLAY': ':0', 05:47:30 INFO - 'HOME': '/home/cltbld', 05:47:30 INFO - 'LANG': 'en_US.UTF-8', 05:47:30 INFO - 'LANGUAGE': 'en_US:en', 05:47:30 INFO - 'LOGNAME': 'cltbld', 05:47:30 INFO - 'MAIL': '/var/mail/cltbld', 05:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:30 INFO - 'MOZ_NO_REMOTE': '1', 05:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:30 INFO - 'NO_EM_RESTART': '1', 05:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:30 INFO - 'PWD': '/builds/slave/test', 05:47:30 INFO - 'SHELL': '/bin/bash', 05:47:30 INFO - 'SHLVL': '1', 05:47:30 INFO - 'TERM': 'linux', 05:47:30 INFO - 'TMOUT': '86400', 05:47:30 INFO - 'USER': 'cltbld', 05:47:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', 05:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:30 INFO - '_': '/tools/buildbot/bin/python'} 05:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:30 INFO - Downloading/unpacking psutil>=3.1.1 05:47:30 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 05:47:30 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 05:47:30 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 05:47:30 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 05:47:30 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 05:47:30 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 05:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:47:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:33 INFO - Installing collected packages: psutil 05:47:33 INFO - Running setup.py install for psutil 05:47:33 INFO - building 'psutil._psutil_linux' extension 05:47:33 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 05:47:33 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 05:47:33 INFO - building 'psutil._psutil_posix' extension 05:47:33 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 05:47:33 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 05:47:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:33 INFO - Successfully installed psutil 05:47:33 INFO - Cleaning up... 05:47:33 INFO - Return code: 0 05:47:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:33 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 0x194f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e3b0>, '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 0x1c0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f740>, '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': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', '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 05:47:33 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 05:47:33 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 05:47:33 INFO - Using env: {'DISPLAY': ':0', 05:47:33 INFO - 'HOME': '/home/cltbld', 05:47:33 INFO - 'LANG': 'en_US.UTF-8', 05:47:33 INFO - 'LANGUAGE': 'en_US:en', 05:47:33 INFO - 'LOGNAME': 'cltbld', 05:47:33 INFO - 'MAIL': '/var/mail/cltbld', 05:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:33 INFO - 'MOZ_NO_REMOTE': '1', 05:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:33 INFO - 'NO_EM_RESTART': '1', 05:47:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:33 INFO - 'PWD': '/builds/slave/test', 05:47:33 INFO - 'SHELL': '/bin/bash', 05:47:33 INFO - 'SHLVL': '1', 05:47:33 INFO - 'TERM': 'linux', 05:47:33 INFO - 'TMOUT': '86400', 05:47:33 INFO - 'USER': 'cltbld', 05:47:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', 05:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:33 INFO - '_': '/tools/buildbot/bin/python'} 05:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:47:33 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 05:47:33 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 05:47:33 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 05:47:33 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 05:47:33 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 05:47:33 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 05:47:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:47:35 INFO - Installing collected packages: mozsystemmonitor 05:47:35 INFO - Running setup.py install for mozsystemmonitor 05:47:35 INFO - Successfully installed mozsystemmonitor 05:47:35 INFO - Cleaning up... 05:47:35 INFO - Return code: 0 05:47:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:35 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 0x194f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e3b0>, '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 0x1c0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f740>, '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': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', '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 05:47:35 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 05:47:35 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 05:47:35 INFO - Using env: {'DISPLAY': ':0', 05:47:35 INFO - 'HOME': '/home/cltbld', 05:47:35 INFO - 'LANG': 'en_US.UTF-8', 05:47:35 INFO - 'LANGUAGE': 'en_US:en', 05:47:35 INFO - 'LOGNAME': 'cltbld', 05:47:35 INFO - 'MAIL': '/var/mail/cltbld', 05:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:35 INFO - 'MOZ_NO_REMOTE': '1', 05:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:35 INFO - 'NO_EM_RESTART': '1', 05:47:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:35 INFO - 'PWD': '/builds/slave/test', 05:47:35 INFO - 'SHELL': '/bin/bash', 05:47:35 INFO - 'SHLVL': '1', 05:47:35 INFO - 'TERM': 'linux', 05:47:35 INFO - 'TMOUT': '86400', 05:47:35 INFO - 'USER': 'cltbld', 05:47:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', 05:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:35 INFO - '_': '/tools/buildbot/bin/python'} 05:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:36 INFO - Downloading/unpacking jsonschema==2.5.1 05:47:36 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 05:47:36 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 05:47:36 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 05:47:36 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 05:47:36 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 05:47:36 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 05:47:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:47:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 INFO - Downloading functools32-3.2.3-2.tar.gz 05:47:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:47:38 INFO - warning: no files found matching '*.txt' 05:47:38 INFO - no previously-included directories found matching 'build' 05:47:38 INFO - no previously-included directories found matching 'dist' 05:47:38 INFO - no previously-included directories found matching '.git*' 05:47:38 INFO - Installing collected packages: jsonschema, functools32 05:47:38 INFO - Running setup.py install for functools32 05:47:38 INFO - warning: no files found matching '*.txt' 05:47:38 INFO - no previously-included directories found matching 'build' 05:47:38 INFO - no previously-included directories found matching 'dist' 05:47:38 INFO - no previously-included directories found matching '.git*' 05:47:38 INFO - Successfully installed jsonschema functools32 05:47:38 INFO - Cleaning up... 05:47:38 INFO - Return code: 0 05:47:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:38 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 0x194f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e3b0>, '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 0x1c0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f740>, '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': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', '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 05:47:38 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 05:47:38 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 05:47:38 INFO - Using env: {'DISPLAY': ':0', 05:47:38 INFO - 'HOME': '/home/cltbld', 05:47:38 INFO - 'LANG': 'en_US.UTF-8', 05:47:38 INFO - 'LANGUAGE': 'en_US:en', 05:47:38 INFO - 'LOGNAME': 'cltbld', 05:47:38 INFO - 'MAIL': '/var/mail/cltbld', 05:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:38 INFO - 'MOZ_NO_REMOTE': '1', 05:47:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:38 INFO - 'NO_EM_RESTART': '1', 05:47:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:38 INFO - 'PWD': '/builds/slave/test', 05:47:38 INFO - 'SHELL': '/bin/bash', 05:47:38 INFO - 'SHLVL': '1', 05:47:38 INFO - 'TERM': 'linux', 05:47:38 INFO - 'TMOUT': '86400', 05:47:38 INFO - 'USER': 'cltbld', 05:47:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', 05:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:38 INFO - '_': '/tools/buildbot/bin/python'} 05:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:38 INFO - Downloading/unpacking blobuploader==1.2.4 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 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 05:47:38 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 05:47:40 INFO - Downloading blobuploader-1.2.4.tar.gz 05:47:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:47:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:47:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:47:41 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 05:47:41 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 05:47:41 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 05:47:41 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 05:47:41 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 05:47:41 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 05:47:41 INFO - Downloading docopt-0.6.1.tar.gz 05:47:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:47:41 INFO - Installing collected packages: blobuploader, requests, docopt 05:47:41 INFO - Running setup.py install for blobuploader 05:47:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:47:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:47:41 INFO - Running setup.py install for requests 05:47:41 INFO - Running setup.py install for docopt 05:47:41 INFO - Successfully installed blobuploader requests docopt 05:47:41 INFO - Cleaning up... 05:47:42 INFO - Return code: 0 05:47:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:42 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 0x194f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e3b0>, '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 0x1c0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f740>, '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': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', '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 05:47:42 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 05:47:42 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 05:47:42 INFO - Using env: {'DISPLAY': ':0', 05:47:42 INFO - 'HOME': '/home/cltbld', 05:47:42 INFO - 'LANG': 'en_US.UTF-8', 05:47:42 INFO - 'LANGUAGE': 'en_US:en', 05:47:42 INFO - 'LOGNAME': 'cltbld', 05:47:42 INFO - 'MAIL': '/var/mail/cltbld', 05:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:42 INFO - 'MOZ_NO_REMOTE': '1', 05:47:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:42 INFO - 'NO_EM_RESTART': '1', 05:47:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:42 INFO - 'PWD': '/builds/slave/test', 05:47:42 INFO - 'SHELL': '/bin/bash', 05:47:42 INFO - 'SHLVL': '1', 05:47:42 INFO - 'TERM': 'linux', 05:47:42 INFO - 'TMOUT': '86400', 05:47:42 INFO - 'USER': 'cltbld', 05:47:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', 05:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:42 INFO - '_': '/tools/buildbot/bin/python'} 05:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:42 INFO - Running setup.py (path:/tmp/pip-nTPAXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:42 INFO - Running setup.py (path:/tmp/pip-tVnaj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:42 INFO - Running setup.py (path:/tmp/pip-80z7f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:42 INFO - Running setup.py (path:/tmp/pip-JC_Um5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:42 INFO - Running setup.py (path:/tmp/pip-eQ1fUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:42 INFO - Running setup.py (path:/tmp/pip-n2tfgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:42 INFO - Running setup.py (path:/tmp/pip-4LiaDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:42 INFO - Running setup.py (path:/tmp/pip-7a9N23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:42 INFO - Running setup.py (path:/tmp/pip-b5ucnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:42 INFO - Running setup.py (path:/tmp/pip-yovccW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:42 INFO - Running setup.py (path:/tmp/pip-kI6iOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:43 INFO - Running setup.py (path:/tmp/pip-7xNQoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:43 INFO - Running setup.py (path:/tmp/pip-MBUvP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:43 INFO - Running setup.py (path:/tmp/pip-kEHvis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:43 INFO - Running setup.py (path:/tmp/pip-Bo8lZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:43 INFO - Running setup.py (path:/tmp/pip-SNWxCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:43 INFO - Running setup.py (path:/tmp/pip-QVDurK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:47:43 INFO - Running setup.py install for manifestparser 05:47:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:47:43 INFO - Running setup.py install for mozcrash 05:47:43 INFO - Running setup.py install for mozdebug 05:47:43 INFO - Running setup.py install for mozdevice 05:47:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:47:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:47:43 INFO - Running setup.py install for mozfile 05:47:43 INFO - Running setup.py install for mozhttpd 05:47:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:47:44 INFO - Running setup.py install for mozinfo 05:47:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:47:44 INFO - Running setup.py install for mozInstall 05:47:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:47:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:47:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:47:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:47:44 INFO - Running setup.py install for mozleak 05:47:44 INFO - Running setup.py install for mozlog 05:47:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:47:44 INFO - Running setup.py install for moznetwork 05:47:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:47:44 INFO - Running setup.py install for mozprocess 05:47:44 INFO - Running setup.py install for mozprofile 05:47:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:47:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:47:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:47:44 INFO - Running setup.py install for mozrunner 05:47:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:47:44 INFO - Running setup.py install for mozscreenshot 05:47:45 INFO - Running setup.py install for moztest 05:47:45 INFO - Running setup.py install for mozversion 05:47:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:47:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:47:45 INFO - Cleaning up... 05:47:45 INFO - Return code: 0 05:47:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:45 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 0x194f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e3b0>, '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 0x1c0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f740>, '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': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', '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 05:47:45 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 05:47:45 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 05:47:45 INFO - Using env: {'DISPLAY': ':0', 05:47:45 INFO - 'HOME': '/home/cltbld', 05:47:45 INFO - 'LANG': 'en_US.UTF-8', 05:47:45 INFO - 'LANGUAGE': 'en_US:en', 05:47:45 INFO - 'LOGNAME': 'cltbld', 05:47:45 INFO - 'MAIL': '/var/mail/cltbld', 05:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:45 INFO - 'MOZ_NO_REMOTE': '1', 05:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:45 INFO - 'NO_EM_RESTART': '1', 05:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:45 INFO - 'PWD': '/builds/slave/test', 05:47:45 INFO - 'SHELL': '/bin/bash', 05:47:45 INFO - 'SHLVL': '1', 05:47:45 INFO - 'TERM': 'linux', 05:47:45 INFO - 'TMOUT': '86400', 05:47:45 INFO - 'USER': 'cltbld', 05:47:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', 05:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:45 INFO - '_': '/tools/buildbot/bin/python'} 05:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:45 INFO - Running setup.py (path:/tmp/pip-sZNIZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:45 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)) 05:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:45 INFO - Running setup.py (path:/tmp/pip-bh4lg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:45 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)) 05:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:45 INFO - Running setup.py (path:/tmp/pip-v2YaPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:45 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)) 05:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:45 INFO - Running setup.py (path:/tmp/pip-mmHllA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:45 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)) 05:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:45 INFO - Running setup.py (path:/tmp/pip-TEo2qN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:45 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)) 05:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:45 INFO - Running setup.py (path:/tmp/pip-I4Fo2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:45 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)) 05:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:45 INFO - Running setup.py (path:/tmp/pip-WrpmZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:45 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)) 05:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:45 INFO - Running setup.py (path:/tmp/pip-M7Ctt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:46 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)) 05:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:46 INFO - Running setup.py (path:/tmp/pip-hAgR0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:46 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)) 05:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:46 INFO - Running setup.py (path:/tmp/pip-6KqHxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:46 INFO - Running setup.py (path:/tmp/pip-MHJAej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:46 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)) 05:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:46 INFO - Running setup.py (path:/tmp/pip-P1FznM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:46 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)) 05:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:46 INFO - Running setup.py (path:/tmp/pip-2Hqmxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:46 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)) 05:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:46 INFO - Running setup.py (path:/tmp/pip-6FHNHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:46 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)) 05:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:46 INFO - Running setup.py (path:/tmp/pip-gi2alM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:46 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)) 05:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:46 INFO - Running setup.py (path:/tmp/pip-C8tVIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:46 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)) 05:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:46 INFO - Running setup.py (path:/tmp/pip-lyyCSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:46 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)) 05:47:46 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)) 05:47:46 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)) 05:47:46 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)) 05:47:46 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)) 05:47:46 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)) 05:47:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:47:46 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 05:47:46 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 05:47:46 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 05:47:46 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 05:47:46 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 05:47:46 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 05:47:48 INFO - Downloading blessings-1.6.tar.gz 05:47:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:47:48 INFO - Installing collected packages: blessings 05:47:48 INFO - Running setup.py install for blessings 05:47:49 INFO - Successfully installed blessings 05:47:49 INFO - Cleaning up... 05:47:49 INFO - Return code: 0 05:47:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:47:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:49 INFO - Reading from file tmpfile_stdout 05:47:49 INFO - Current package versions: 05:47:49 INFO - argparse == 1.2.1 05:47:49 INFO - blessings == 1.6 05:47:49 INFO - blobuploader == 1.2.4 05:47:49 INFO - docopt == 0.6.1 05:47:49 INFO - functools32 == 3.2.3-2 05:47:49 INFO - jsonschema == 2.5.1 05:47:49 INFO - manifestparser == 1.1 05:47:49 INFO - mozInstall == 1.12 05:47:49 INFO - mozcrash == 0.17 05:47:49 INFO - mozdebug == 0.1 05:47:49 INFO - mozdevice == 0.48 05:47:49 INFO - mozfile == 1.2 05:47:49 INFO - mozhttpd == 0.7 05:47:49 INFO - mozinfo == 0.9 05:47:49 INFO - mozleak == 0.1 05:47:49 INFO - mozlog == 3.2 05:47:49 INFO - moznetwork == 0.27 05:47:49 INFO - mozprocess == 0.23 05:47:49 INFO - mozprofile == 0.28 05:47:49 INFO - mozrunner == 6.12 05:47:49 INFO - mozscreenshot == 0.1 05:47:49 INFO - mozsystemmonitor == 0.3 05:47:49 INFO - moztest == 0.7 05:47:49 INFO - mozversion == 1.4 05:47:49 INFO - psutil == 3.1.1 05:47:49 INFO - requests == 1.2.3 05:47:49 INFO - wsgiref == 0.1.2 05:47:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:49 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 0x194f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e3b0>, '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 0x1c0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f740>, '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': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', '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 05:47:49 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 05:47:49 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 05:47:49 INFO - Using env: {'DISPLAY': ':0', 05:47:49 INFO - 'HOME': '/home/cltbld', 05:47:49 INFO - 'LANG': 'en_US.UTF-8', 05:47:49 INFO - 'LANGUAGE': 'en_US:en', 05:47:49 INFO - 'LOGNAME': 'cltbld', 05:47:49 INFO - 'MAIL': '/var/mail/cltbld', 05:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:49 INFO - 'MOZ_NO_REMOTE': '1', 05:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:49 INFO - 'NO_EM_RESTART': '1', 05:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:49 INFO - 'PWD': '/builds/slave/test', 05:47:49 INFO - 'SHELL': '/bin/bash', 05:47:49 INFO - 'SHLVL': '1', 05:47:49 INFO - 'TERM': 'linux', 05:47:49 INFO - 'TMOUT': '86400', 05:47:49 INFO - 'USER': 'cltbld', 05:47:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', 05:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:49 INFO - '_': '/tools/buildbot/bin/python'} 05:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:49 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)) 05:47:49 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)) 05:47:49 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)) 05:47:49 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)) 05:47:49 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)) 05:47:49 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)) 05:47:49 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)) 05:47:49 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)) 05:47:49 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)) 05:47:49 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)) 05:47:49 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)) 05:47:49 INFO - Cleaning up... 05:47:49 INFO - Return code: 0 05:47:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:49 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 0x194f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e3b0>, '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 0x1c0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f740>, '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': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', '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 05:47:49 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 05:47:49 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 05:47:49 INFO - Using env: {'DISPLAY': ':0', 05:47:49 INFO - 'HOME': '/home/cltbld', 05:47:49 INFO - 'LANG': 'en_US.UTF-8', 05:47:49 INFO - 'LANGUAGE': 'en_US:en', 05:47:49 INFO - 'LOGNAME': 'cltbld', 05:47:49 INFO - 'MAIL': '/var/mail/cltbld', 05:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:49 INFO - 'MOZ_NO_REMOTE': '1', 05:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:49 INFO - 'NO_EM_RESTART': '1', 05:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:49 INFO - 'PWD': '/builds/slave/test', 05:47:49 INFO - 'SHELL': '/bin/bash', 05:47:49 INFO - 'SHLVL': '1', 05:47:49 INFO - 'TERM': 'linux', 05:47:49 INFO - 'TMOUT': '86400', 05:47:49 INFO - 'USER': 'cltbld', 05:47:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', 05:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:49 INFO - '_': '/tools/buildbot/bin/python'} 05:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:47:49 INFO - Cleaning up... 05:47:49 INFO - Return code: 0 05:47:49 INFO - Running post-action listener: _resource_record_post_action 05:47:49 INFO - Running post-action listener: _start_resource_monitoring 05:47:49 INFO - Starting resource monitoring. 05:47:49 INFO - ##### 05:47:49 INFO - ##### Finished create-virtualenv step (success) 05:47:49 INFO - ##### 05:47:49 INFO - ##### 05:47:49 INFO - ##### Running install step. 05:47:49 INFO - ##### 05:47:49 INFO - Running pre-action listener: _resource_record_pre_action 05:47:49 INFO - Running main action method: install 05:47:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:49 INFO - Reading from file tmpfile_stdout 05:47:49 INFO - Detecting whether we're running mozinstall >=1.0... 05:47:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:47:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:47:50 INFO - Reading from file tmpfile_stdout 05:47:50 INFO - Output received: 05:47:50 INFO - Usage: mozinstall [options] installer 05:47:50 INFO - Options: 05:47:50 INFO - -h, --help show this help message and exit 05:47:50 INFO - -d DEST, --destination=DEST 05:47:50 INFO - Directory to install application into. [default: 05:47:50 INFO - "/builds/slave/test"] 05:47:50 INFO - --app=APP Application being installed. [default: firefox] 05:47:50 INFO - mkdir: /builds/slave/test/build/application 05:47:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:48:07 INFO - Reading from file tmpfile_stdout 05:48:07 INFO - Output received: 05:48:07 INFO - /builds/slave/test/build/application/firefox/firefox 05:48:07 INFO - Running post-action listener: _resource_record_post_action 05:48:07 INFO - ##### 05:48:07 INFO - ##### Finished install step (success) 05:48:07 INFO - ##### 05:48:07 INFO - ##### 05:48:07 INFO - ##### Running run-tests step. 05:48:07 INFO - ##### 05:48:07 INFO - Running pre-action listener: _resource_record_pre_action 05:48:07 INFO - Running main action method: run_tests 05:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:48:07 INFO - Python 2.7.3 05:48:07 INFO - Return code: 0 05:48:07 INFO - grabbing minidump binary from tooltool 05:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:07 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 0x1c0e3b0>, '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 0x1c0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:48:07 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 05:48:07 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 05:48:07 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 05:48:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:48:07 INFO - Return code: 0 05:48:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:48:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:48:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:48:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:48:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 05:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 05:48:07 INFO - Using env: {'DISPLAY': ':0', 05:48:07 INFO - 'HOME': '/home/cltbld', 05:48:07 INFO - 'LANG': 'en_US.UTF-8', 05:48:07 INFO - 'LANGUAGE': 'en_US:en', 05:48:07 INFO - 'LOGNAME': 'cltbld', 05:48:07 INFO - 'MAIL': '/var/mail/cltbld', 05:48:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:48:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:07 INFO - 'MOZ_NO_REMOTE': '1', 05:48:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:07 INFO - 'NO_EM_RESTART': '1', 05:48:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:07 INFO - 'PWD': '/builds/slave/test', 05:48:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:48:07 INFO - 'SHELL': '/bin/bash', 05:48:07 INFO - 'SHLVL': '1', 05:48:07 INFO - 'TERM': 'linux', 05:48:07 INFO - 'TMOUT': '86400', 05:48:07 INFO - 'USER': 'cltbld', 05:48:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261', 05:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:07 INFO - '_': '/tools/buildbot/bin/python'} 05:48:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 05:48:07 INFO - mozversion application_buildid: 20160719030224 05:48:07 INFO - mozversion application_changeset: feaaf1af1065257b9178faca8b67eed9657b4a17 05:48:07 INFO - mozversion application_display_name: Nightly 05:48:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:48:07 INFO - mozversion application_name: Firefox 05:48:07 INFO - mozversion application_remotingname: firefox 05:48:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:48:07 INFO - mozversion application_vendor: Mozilla 05:48:07 INFO - mozversion application_version: 50.0a1 05:48:07 INFO - mozversion platform_buildid: 20160719030224 05:48:07 INFO - mozversion platform_changeset: feaaf1af1065257b9178faca8b67eed9657b4a17 05:48:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:48:07 INFO - mozversion platform_version: 50.0a1 05:48:07 INFO - using testdate: 1468932487 05:48:07 INFO - actual date: 1468932487 05:48:07 INFO - starting webserver on 'localhost:55903' 05:48:07 INFO - SUITE-START | Running 2 tests 05:48:07 INFO - TEST-START | dromaeo_css 05:48:07 INFO - operating with platform_type : linux_ 05:48:07 INFO - Initialising browser for dromaeo_css test... 05:48:07 INFO - TEST-INFO | started process 31072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY58qML/profile http://localhost:55903/getInfo.html) 05:48:12 INFO - PROCESS | 31072 | __metrics Screen width/height:1600/1200 05:48:12 INFO - PROCESS | 31072 | colorDepth:24 05:48:12 INFO - PROCESS | 31072 | Browser inner width/height: 1024/697 05:48:12 INFO - PROCESS | 31072 | __metrics 05:48:13 ERROR - PROCESS | 31072 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:48:14 INFO - TEST-INFO | 31072: exit 0 05:48:14 INFO - Browser initialized. 05:48:14 INFO - Running cycle 1/1 for dromaeo_css test... 05:48:14 INFO - TEST-INFO | started process 31192 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY58qML/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:25 INFO - PROCESS | 31192 | RSS: Main: 167792640 05:48:25 INFO - PROCESS | 31192 | 05:49:15 INFO - PROCESS | 31192 | 1468932555485 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] 05:51:23 INFO - PROCESS | 31192 | Cycle 1(1): loaded http://localhost:55903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55903/tests/dromaeo/cssquery-ext.html) 05:51:24 INFO - PROCESS | 31192 | RSS: Main: 172716032 05:51:24 INFO - PROCESS | 31192 | 05:54:26 INFO - PROCESS | 31192 | Cycle 1(1): loaded http://localhost:55903/tests/dromaeo/cssquery-ext.html (next: http://localhost:55903/tests/dromaeo/cssquery-jquery.html) 05:54:27 INFO - PROCESS | 31192 | RSS: Main: 169279488 05:54:27 INFO - PROCESS | 31192 | 05:57:29 INFO - PROCESS | 31192 | Cycle 1(1): loaded http://localhost:55903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55903/tests/dromaeo/cssquery-mootools.html) 05:57:29 INFO - PROCESS | 31192 | RSS: Main: 172797952 05:57:29 INFO - PROCESS | 31192 | 06:00:31 INFO - PROCESS | 31192 | Cycle 1(1): loaded http://localhost:55903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55903/tests/dromaeo/cssquery-prototype.html) 06:00:32 INFO - PROCESS | 31192 | RSS: Main: 167075840 06:00:32 INFO - PROCESS | 31192 | 06:03:34 INFO - PROCESS | 31192 | Cycle 1(1): loaded http://localhost:55903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55903/tests/dromaeo/cssquery-yui.html) 06:03:35 INFO - PROCESS | 31192 | RSS: Main: 169271296 06:03:35 INFO - PROCESS | 31192 | 06:06:37 INFO - PROCESS | 31192 | Cycle 1(1): loaded http://localhost:55903/tests/dromaeo/cssquery-yui.html (next: http://localhost:55903/tests/dromaeo/cssquery-dojo.html) 06:06:38 INFO - PROCESS | 31192 | RSS: Main: 169820160 06:06:38 INFO - PROCESS | 31192 | 06:06:38 INFO - PROCESS | 31192 | __start_tp_report 06:06:38 INFO - PROCESS | 31192 | _x_x_mozilla_page_load 06:06:38 INFO - PROCESS | 31192 | _x_x_mozilla_page_load_details 06:06:38 INFO - PROCESS | 31192 | |i|pagename|runs| 06:06:38 INFO - PROCESS | 31192 | |0;dojo.html;3079.6304443466784;3101.193689640693;3110.1758034120976;3119.173419043954;3121.5785868907697;5484.314460692413;5522.3649280332775;5553.722313884305;5555.555555555556;5574.526165275946;5413.296271484702;5484;5488.643238189525;5543.6119471637;5563.527100196478;4970.826021089253;4977.1538838397555;5020.5983521318385;5025.798968041274;5054.772535235923;5005.824796132136;5119.59043276537;5121.820736274231;5134.435212126663;5152.562032227246;4977.07924034053;5031.169856973595;5080.542751152414;5088.23676448532;5110.080185566615;4991.550760431543;4998.12532806761;4999.475055119233;5004.84985450437;5041.621878359138;4982.153033984231;4982.57648099912;4985.102681517325;4990.6257030722845;5026.497350264981;5367.46325367464;5389.137737961907;5457.126859702468;5470.781168753245;5499.670019798825;5857.062869940832;5860.824175274749;5865.208196893407;5865.941340586583;5891.234139561872;5817.185594016841;5909.497692696126;5913.940860591382;5922;5929.673867937262;5533.253010843525;5580.804671836466;5586.273784408001;5592.608517403824;5640.0693885508435;6145.4161854623735;6145.877082458326;6151.815445536641;6161.815145545641;6161.907571386433;5684.488396044376;5819.301683797887;5897.52819774417;5899.67551784656;5907.793227237026;5919.348871624118;5931.110333450017;5955.642661440327;5961.195238642815;6029.939700603026;5919.822405327847;5947.702614869239;5973.940260597426;5992.250968628921;5997.610155339889;5834.03738383162;5892.057270836645;5907.822765317047;5957.940420595825;5985.880282394328;4400.163968845909;4466.486354069259;4501.482329532146;4552.886177845514;4586.72479651222;3948.9210215796097;3998.640122388999;4015.5783642717092;4046.7571945683353;4048.716589838683;5477.178423236546;5612.242347283064;5617.241672374259;5702.714864256771;5708.143778433186;5955;5967.9701601491715;5973.044312909914;5986.790462333797;6025.0359942409;5644.57665675076;5658.91511627326;5684.232628595169;5684.658920464785;5695.914561281584;5026.271190677405;5078.669886457368;5088.898222035538;5115.079285728604;5123.103456895028;6114.2662880453745;6117.785877494266;6142.293636231801;6171.352008039181;6180.598261113013;5937.524998000236;5942.851428714143;5944.613600115978;5946.4053594641055;5954.970225148846;5994.730237139426;6091.939080609137;6131.294901086254;6144.846378840565;6166.260048794174;5859.765609375748;5878.412158784087;5897.970510147422;5909.674967876808;5920.822375328747;5839.5036421904615;5949.167116603766;5994.790182343597;6012.759489620366;6013.609115407659;5754.136879468113;5771.220885180447;5782.363939966516;5795.536357091507;5803.419658034331;5801.680907550125;5844.47399734026;5851.21008663825;5855.531557475307;5859.2382990211;5650.745716442688;5779.2775903012125;5804.883902322014;5844.736986835687;5848.561357898089;5640.266765320482;5756.222909907109;5767.307923049261;5868.618539794899;5955.40445955401;5678.74445649955;5731.111677689964;5737.225474561048;5738.598298119092;5739.770409183586 06:06:38 INFO - PROCESS | 31192 | |1;ext.html;564.2605151987102;586.7095787585146;598.6527813867955;616.497554493088;627.6014730646039;40014.1997160057;43864.34203486946;44114.77942610286;44128.77935610325;44247.77876110623;43418.78290608551;43702.344464832975;43886.34170487437;43894.56105438944;44030.779846100806;8850.114988501147;8918.331125165638;8929.866052009225;8968.417052891573;8994.415363001384;8874.467531948072;8950.373473856833;8996.59515321812;9025.097490250988;9040.638374465014;9002.864957025617;9006.59470323837;9022;9053.275737940949;9060.41107328025;8927.330450216226;8933.776655583597;8976.3267754918;8993.415427997159;9011;8890.777730556787;8897.644094236222;8929.151730585583;8936.865947010736;8970.641174353019;41384.37923431151;41652.79173604112;41722.37416438756;41779.7911010443;41789.37315940263;2942.4850651135966;3491.5810102787573;3619.963800361989;3626.8005259710703;3720.720945929066;32134.678653213636;32142.196445088826;32642.510362344583;33025.265528651405;33067.83466082678;4251.532331443539;4381.737095774264;4388.429504164438;4393.494748103977;4474.932876006863;293584;294630;294992;295837;297032;31880.521792173135;33948.49077263843;34467.13832154166;34520;34531;37287.440688389695;37317.44023839645;37432.62567374346;37519.437208441894;37568.43647345292;14852;14983.925080374529;15049.54851354461;15106.471273505374;15111.773323400157;12845.357732113356;12908.09643324977;12924.289164096064;12939.870601294055;12964.092513523963;8149.755507334789;8230.465019773696;8265.132161122996;8309.542975136304;8316.501009939422;3168.2237851726472;3170.9207269817975;3186.553882456458;3236.207129253348;3245.870165193413;1009.5103874620803;1039.7556574205055;1084.2843723142846;1154.7228665120479;1195.354508565365;32174;32391.649761664376;32564.34871302608;32961.67038329634;33077.66922330746;1096.2928910852456;1106.690126764507;1125.234840308598;1138.698244965085;1178.1046404732465;16152.676946461004;16771;16851.91574042122;17100.835099090116;17186.570335741708;551177;551621.483785157;554095;556282;556906;59536.702316489005;59636.70181649064;59663.701681491315;59666.40333596608;60024.39975600188;1343.482759137739;1347.3734713358335;1364.9658758531116;1369.2127026959538;1375.9656008599866;31091.533626995162;31452.2136946569;31784.68215317817;32038.35923281568;32749.34501309913;51559;51834.74082629563;51919.74040129775;52103.47896520986;52243.216351753996;496489;496785;497271;497352;498115;27696.446071078062;27818.165455036382;28208.43583128367;28410.147695569165;28429.289267767643;48819.75590122027;49762;49930.75034624804;50049.74975125101;50439.74780126076;41894.7905260484;41955.1608967825;44823;45794.542054579026;45797.31304030509;42976.78511607547;43134.980551361106;43597.12805743931;43932.560674394124;44453;42568;43049.78475107605;43111.137777244905;44291;44959;35387.29225415529;37669;37806.62193378031;37862.43206351962;38613.61386386213;29033.7096629031;29365;29401.264968375963;29430.264243394085;29625 06:06:38 INFO - PROCESS | 31192 | |2;jquery.html;390.3890411505995;397.39000634026763;397.4971660849026;398.4441703823169;419.24117347600844;14553.490627828029;18758.2496700132;20129.29547465839;20402.795972040276;20568.38294851153;19446.416607501797;19599;19819.108140133692;20196.89901550494;20336;5714.200011998323;5777.306723193223;5804.216430781854;5926.229590153274;5932.495737862266;5354.866128346803;5633.464820842013;5661.264035675356;5802.216700745409;5812.244408226925;5530.557555395559;5644;5659.4340565943285;5667.234923285366;5690.487856092972;5741;5799;5832.883342333151;5846.473817356437;5851.531877449836;5568.638038527482;5632.098864181711;5658.547316214693;5705.172749951275;5823.272090988627;13777;13982.725048679355;23259.4185145371;23949;23953.520929581486;2211.292386436341;2292.518571100071;2303.285981345788;2304.5316500922963;2310.7920287174234;9866.802663946753;9940.403575785476;10108.39349639024;10412.531436085394;10446.216533759998;1962.470133064079;1981.6631172700675;1998.2706312195944;2039.7246371739923;2057.495913501202;81123.59438202772;82863;86718.5664071682;87878;88564.99999999936;10652.62715804943;10795.460226988776;10849.186311026546;10880.891191087987;11013;14737;14747.77878331826;14832.406703731729;14890.329935152944;14923.104613723212;7809.414293927978;7981.882536444902;7983.12185659577;8130.073173657479;8145.5927203639585;7684.423668224906;7726.9227307726205;7792.103908050533;7938.404619653549;7961.960190199128;4499.662525310549;4503.459584849774;4521.457425109008;4525.705829121097;4548.636109111263;1892.990535047316;1915.789263181049;1926.258390519632;1958.2950137950327;1959.5101224693826;972.4922215461861;1003.7841863999275;1048.4024106259512;1076.3649446826253;1083.6423980086552;19193.616127677647;20135.0939207736;20215.696764548542;20596.38210853647;20864.37406877796;1008.178334657252;1014.9594016239267;1041.5209003858158;1050.4957620342125;1106.2201148190507;10976.890231097586;11352.48913798881;11536;11544.422778861024;11588.826167607493;492039;502743;508002;508754;510046;60218;81769.59115204505;97744.51127744457;98252;99765;991.8363470027509;996.6412091647002;1006.5470538257813;1015.5430056474615;1017.2370721958679;16143.838561614233;17920.372786952394;18196.45410637683;18243.45269641913;18485.35301264503;41528.37707434451;42889.35665964951;43557.346639801064;44626;45504.089918200785;61663.38336616756;62545;62710.6864465693;63091.684541577;63276;8639.784005399915;8743.125687431206;8881.600327985127;8914.598843051948;9050.728478145666;12396.81404778947;13423.26172060546;13990.370433330729;14024.439022439396;14071.085379450304;11148.832767508331;11183.664490065312;11492.023178029627;11586.246893951866;11830.290182589073;11017.1186305097;11385.829212561652;11789.233699809485;11951.282923024646;11959.983401410629;11483;11702.473388697359;12268.263904165779;12293.508259669514;12308.876911231131;8334.458125246849;8424.500556740128;8632.179942905414;8674.349423793115;8800.91199088001;8580.227779499875;10592.523336449724;11223.270487418291;11566.248193867372;11607.187496875138 06:06:38 INFO - PROCESS | 31192 | |3;mootools.html;1477.7044591081783;1483.3843954758775;1648.7774150489681;1775.1834156288107;1794.0850166415125;7682.116556595993;8271.46235494694;8372.204640559145;8902.77743056423;8906.688265910694;8368.665253389872;8483.278921291681;8521.531315777629;8551.358648101386;8562.65749370026;2304.665823455598;2343.8242131840093;2345.5074434368803;2345.9178928737497;2346.038124369009;2317.7102862142233;2323.1172154581236;2352.6706261123454;2352.870592117433;2357.35172827473;2270.2962081754627;2299.3446867642724;2303.2284184798027;2320.1995311617466;2325.058351367699;2251.324602619224;2278.219190342179;2284.8400611957168;2295.3343530376087;2299.057386471547;2234.8770817605027;2240.115154513958;2240.630296001158;2245.8315626327926;2250.628646273363;8564.74305770828;8579.699710510102;8604;8673.568861137905;8679.956600217021;5026.447090820044;5113.872153196163;5120.92318615221;5128.051310507531;5143.996920600484;3221.806691598488;3305.3224089061923;3368.8147151906637;3390.86436542538;3417.3165366926464;1098.2092893116942;1106.31961343773;1112.3159257056932;1127.2954403497813;1148.5233628044352;11991;12009.519619215222;12087.27476351413;12088.214266072677;12109.091818113677;4446.644268458515;4480.14877173336;4591.540845915449;4605.654575906753;4605.861824145281;9992.25058120644;10050.69847904564;10058.14505767018;10073.194144468425;10100.646477373257;5241.816536421207;5267.71027593486;5281.9207711884355;5298.125809241509;5301.284326615858;4279.358096285582;4676.602488788423;4803.303520989437;4864.489228631013;4884.3650325458175;3790.2419516096893;3814.5803961564206;3909.863154789569;3919.470871432377;3924.4898163238595;1208.5649166300125;1211.0311750599485;1216.2033867816417;1217.4825699078033;1230.6431134970937;995.7560397702464;1025.041586116983;1026.609888242463;1033.7984093101923;1041.6093964763213;5893.823185304448;5911.054231322968;5982.46157845796;6034.969825150846;6067.271927368744;443.5586591341571;448.2514201283799;448.8788027232629;452.46834968911395;462.8703962890396;4166.312558427886;4185.142045880587;4192.182524407711;4203.76879271643;4250.3199488081755;10472.528736206888;10602;10648.520816563274;10711.732206694895;10716.142708583295;10590.417527035934;10590.788184236426;10615.25693201484;10623.097036751962;10628.36229826213;7858.17489163641;8100.635471403801;8110.837783244302;8143.18568143181;8262.958685206415;5898.439648233411;5944.732487038007;6030.48740857032;6116.877662446637;6162.168107305636;9846.950765246127;9933.900660993586;10003.249756268164;10015.39907605546;10041.347312424668;9479.383840050376;9940.055694708992;9977.251706121924;10038.64864729731;10071.446070466194;6924.169099708067;7359.4480413968095;7539.773806785805;7561.886571701539;7715.189905060112;8441.071482137082;8482.49105053674;8495.108013658477;8495.532745698798;8541.359398045295;7491.288327608869;7618.847623047397;7680.270374314431;7759.922400776146;7782.027246594176;7452;7520.285572870568;7615.4669173157345;7656.272654097852;7695.461317707706;6970.825729356807;6978.965105174441;7007.964960175166;7032.296770322927;7033.191183014019;5302.3637163540625;5332.600054995968;5474.0967740323995;5484.862878427912;5496.1755736639825;5304.389995150607;5371;5458.208559758733;5466.671999680032;5514.834554963358 06:06:38 INFO - PROCESS | 31192 | |4;prototype.html;326.68638107416876;331.8838406557705;336.3541999361226;337.2681281618887;339.07601785135506;5682.772689092437;5711.8000869969555;5734.197212390269;5754.683492407916;5765.855853603662;5594.021046316899;5599.468050535193;5618.0449323614985;5645.1814486899375;5651.1523271509295;4138.875833724993;4183.97908010461;4328.199283132615;4330.350447432878;4338.631216346615;4294.592013758704;4309.655227581801;4326.43756311679;4365.493904602907;4379;4335.869923902288;4352.673549483801;4357.803898824561;4360.520342762309;4361.302191649337;4256.318988961767;4264.381664658607;4327.307630779061;4330.198913201068;4347.152305300468;3771.679407250387;3787.696984241254;3793.2223894101644;3795.3168429682646;3808.619138086197;5459.089318738449;5471.534919531845;5472.2338872557875;5511.283533140706;5520.171974203901;4884.560389564921;4948.406191257036;4971.552560269557;4978.228374601942;4992.176290911995;5892.469677728982;5897.64614123154;5901.4098590141075;5924.407559244084;5943.524518038546;4227.408162857202;4235.449391579105;4236.809343579515;4237.957620423787;4240.936385954213;5918.201042859202;6036.577439579231;6085.9391406085815;6135.049067394561;6155.169052177988;4285.121550082225;4286.228478873771;4291.206126866539;4302.204092242945;4308.246056940023;4348.347747837786;4350.651947844165;4352.1948439538155;4355.539120396966;4365.236083685342;4652.790624421909;4945.554900059012;4969.422016148367;4972.83138462461;4996.4503904570465;5921.61509501881;5967.224260846149;5992.58051936369;6005.849853753603;6019.638821670714;1481.5999680086315;1488.8585584369469;1489.270257573781;1507.4723846653583;1513.17531945088;954.8997355277735;982.3123813330698;1009.6769033909079;1013.8023085498257;1018.8181709217272;5661.631993920464;5667.036603777367;5670.206171136044;5703;5734.971325143348;5998.3701711320555;6036.456718895321;6068.939310606837;6085.148079268906;6102.542309326729;5523.834284971457;5733.197352370671;5762.7694892203845;5763.769449221984;5827.79602713903;3229.4832826747606;3265.8367081645824;3278.770486066;3286.4905939579403;3292.1769557610596;6203.7828675996125;6319.24169099711;6334.8416289592205;6338.7464501420345;6341.270753863365;6101.389861013952;6138.846528836725;6141.293751218667;6156.907646385308;6174.228221472316;6102.69486525672;6278.529110316653;6282.994720844643;6295.37046295376;6305.369463053749;6017.247844019497;6075.058365953284;6093;6096.969515152573;6144.846378840565;6056.545759068;6059.3637668045985;6066.484348830399;6085.1785009023215;6096.159419565823;5889.882202356014;6231.725420221496;6234.345393733593;6280.309165991646;6285.74857005733;4338.501072376591;4371.912561748811;4398.274284742982;4412.448443944507;4415.558444155558;5885.941140588539;6052.122442245762;6085.847853803513;6113.694315284129;6127.3566275540425;5981.910271346021;6001.549883758823;6008.789692360921;6021.488173505301;6025.764718232839;6001.4298641628975;6016.548758843017;6033.12519684652;6038.365971573097;6058.454739073504;5720.256366672306;5987.0121429963565;6000.21997140369;6003.309619393825;6022.36765139654;6053.0012547930855;6080.574359794772;6080.847978800565;6083.604565703392;6086.1175129606845;5556.583256255878;5859.681571646345;5885.264341957255;5967.373425790403;5986.371430999682 06:06:38 INFO - PROCESS | 31192 | |5;yui.html;774.7094839435211;782.761257816366;807.737485317272;815.7430409421028;869.3045563549161;14985.850141498582;15105.924470377633;15220.619484512892;15303.923480382597;15306.387744490206;13863.23752193629;13864.4454221831;14010.719785604282;14898.553043408716;15472.226388680549;817.9345652347798;840.9285210757093;841.9452735572169;843.5782108945527;843.6541018182546;637.91069250305;794.9364050875917;808.8382323535317;827.3505298340774;830.3025458614762;844.9155084491532;845.2223953962339;845.4420082745359;845.5772113943028;845.8773477845708;828.8632375658009;841.7853447370912;842.0190478093015;842.2335674536173;842.2672275120623;607.74474720617;608.057510858168;611.9235095613049;612.5252928980032;614.4715544631613;14427;14484.710305793826;14487.681970884609;14495.057821241586;14528.709425811425;14575.416983320654;14906.180160091191;14993.625159370993;15020.699586008219;15118.09291442517;11545.616406246123;11825.172237943347;11898.226615270067;11919.642410727693;12020.819687704692;3945.4081887716784;3983.7410568312966;3983.9203215935518;4079.8776036718946;4082.8979275518054;80945.38109237842;81599.5920020402;82024.17975820226;82506.17493825045;82679;10918.50866711;11521.827172592419;11641.53433862653;11947.342896140623;12023.21849079807;21347;21348.893255533934;21352.572948540943;21443;21547.245846395614;8269.255766981001;8418.158184181533;8681.2186903179;8802.515861627544;8857.822843543094;4984.127777638899;5176.844694659167;5222.947770522323;5281.630285879952;5362.570994320523;3367.848446819899;3493.7729047611824;3522.225110475691;3524.8766293179615;3534.6642069003406;690.8963655451622;701.2566679319938;705.8694141583824;711.975080872167;722.4509372876652;628.7107930352089;635.7202830754453;674.7840690978937;705.932936371044;708.982275443118;9391.530423478798;9795.06946840049;9984.750381240527;10583.470826458646;10758.354498730101;701.8140192848899;719.5610677486729;730.087390761548;747.2191559820001;754.8301632132836;4663.417072865892;4696.81212751493;4715.481297057321;4800.808557230684;4846.975765121152;72385;72995.63502182561;123468;125779.37110314574;135297;67489.3251067483;70741.2925870745;92157;110303;116295;78159.60920195363;99045.00954990502;99514.5024274874;101312.49343753382;101894.49052754689;8901.287896968357;8924.955375223082;9020.81958360816;9041.819163616823;9121.543922803967;53489.918457746455;54676;56266.779991499985;57327.426725732206;58068;76489.23510764822;86110.56944715236;86782.56608716917;86865;87091;11726;12336.691582710504;13093.214407135602;13192.472301107848;13367.799483007957;16074.839251607802;16446.67106657836;16634.3346266148;16895.155242237593;17513.824861751218;13624.795628065389;13801.51694690681;14343.354549045109;14355.928220358832;14519.709605808035;14941.402343906557;15108.169050701877;15151.090934543963;15485.380584776933;16051.357945682508;13954.511592094228;14494.927525362305;14543.92728036353;14670.33983470725;14817.25913704332;11158.330500170016;11573.826392604286;11718.121140914294;11892.702682433008;12293.692657683629;11638.88361116378;11850.466728997044;12111.45498452554;12257.754844903231;12359.443825028075 06:06:38 INFO - PROCESS | 31192 | __end_tp_report 06:06:38 INFO - PROCESS | 31192 | __start_cc_report 06:06:38 INFO - PROCESS | 31192 | _x_x_mozilla_cycle_collect,372 06:06:38 INFO - PROCESS | 31192 | __end_cc_report 06:06:38 INFO - PROCESS | 31192 | __startTimestamp1468933598238__endTimestamp 06:06:38 INFO - PROCESS | 31192 | 06:06:38 INFO - PROCESS | 31192 | ------- Summary: start ------- 06:06:38 INFO - PROCESS | 31192 | Number of tests: 6 06:06:38 INFO - PROCESS | 31192 | 06:06:38 INFO - PROCESS | 31192 | [#0] dojo.html Cycles:165 Average:5509.28 Median:5739.77 stddev:647.85 (11.3%) stddev-sans-first:621.17 06:06:38 INFO - PROCESS | 31192 | Values: 3079.6 3101.2 3110.2 3119.2 3121.6 5484.3 5522.4 5553.7 5555.6 5574.5 5413.3 5484.0 5488.6 5543.6 5563.5 4970.8 4977.2 5020.6 5025.8 5054.8 5005.8 5119.6 5121.8 5134.4 5152.6 4977.1 5031.2 5080.5 5088.2 5110.1 4991.6 4998.1 4999.5 5004.8 5041.6 4982.2 4982.6 4985.1 4990.6 5026.5 5367.5 5389.1 5457.1 5470.8 5499.7 5857.1 5860.8 5865.2 5865.9 5891.2 5817.2 5909.5 5913.9 5922.0 5929.7 5533.3 5580.8 5586.3 5592.6 5640.1 6145.4 6145.9 6151.8 6161.8 6161.9 5684.5 5819.3 5897.5 5899.7 5907.8 5919.3 5931.1 5955.6 5961.2 6029.9 5919.8 5947.7 5973.9 5992.3 5997.6 5834.0 5892.1 5907.8 5957.9 5985.9 4400.2 4466.5 4501.5 4552.9 4586.7 3948.9 3998.6 4015.6 4046.8 4048.7 5477.2 5612.2 5617.2 5702.7 5708.1 5955.0 5968.0 5973.0 5986.8 6025.0 5644.6 5658.9 5684.2 5684.7 5695.9 5026.3 5078.7 5088.9 5115.1 5123.1 6114.3 6117.8 6142.3 6171.4 6180.6 5937.5 5942.9 5944.6 5946.4 5955.0 5994.7 6091.9 6131.3 6144.8 6166.3 5859.8 5878.4 5898.0 5909.7 5920.8 5839.5 5949.2 5994.8 6012.8 6013.6 5754.1 5771.2 5782.4 5795.5 5803.4 5801.7 5844.5 5851.2 5855.5 5859.2 5650.7 5779.3 5804.9 5844.7 5848.6 5640.3 5756.2 5767.3 5868.6 5955.4 5678.7 5731.1 5737.2 5738.6 5739.8 06:06:38 INFO - PROCESS | 31192 | 06:06:38 INFO - PROCESS | 31192 | [#1] ext.html Cycles:180 Average:59562.55 Median:41842.08 stddev:123218.59 (294.5%) stddev-sans-first:123484.63 06:06:38 INFO - PROCESS | 31192 | Values: 564.3 586.7 598.7 616.5 627.6 40014.2 43864.3 44114.8 44128.8 44247.8 43418.8 43702.3 43886.3 43894.6 44030.8 8850.1 8918.3 8929.9 8968.4 8994.4 8874.5 8950.4 8996.6 9025.1 9040.6 9002.9 9006.6 9022.0 9053.3 9060.4 8927.3 8933.8 8976.3 8993.4 9011.0 8890.8 8897.6 8929.2 8936.9 8970.6 41384.4 41652.8 41722.4 41779.8 41789.4 2942.5 3491.6 3620.0 3626.8 3720.7 32134.7 32142.2 32642.5 33025.3 33067.8 4251.5 4381.7 4388.4 4393.5 4474.9 293584.0 294630.0 294992.0 295837.0 297032.0 31880.5 33948.5 34467.1 34520.0 34531.0 37287.4 37317.4 37432.6 37519.4 37568.4 14852.0 14983.9 15049.5 15106.5 15111.8 12845.4 12908.1 12924.3 12939.9 12964.1 8149.8 8230.5 8265.1 8309.5 8316.5 3168.2 3170.9 3186.6 3236.2 3245.9 1009.5 1039.8 1084.3 1154.7 1195.4 32174.0 32391.6 32564.3 32961.7 33077.7 1096.3 1106.7 1125.2 1138.7 1178.1 16152.7 16771.0 16851.9 17100.8 17186.6 551177.0 551621.5 554095.0 556282.0 556906.0 59536.7 59636.7 59663.7 59666.4 60024.4 1343.5 1347.4 1365.0 1369.2 1376.0 31091.5 31452.2 31784.7 32038.4 32749.3 51559.0 51834.7 51919.7 52103.5 52243.2 496489.0 496785.0 497271.0 497352.0 498115.0 27696.4 27818.2 28208.4 28410.1 28429.3 48819.8 49762.0 49930.8 50049.7 50439.7 41894.8 41955.2 44823.0 45794.5 45797.3 42976.8 43135.0 43597.1 43932.6 44453.0 42568.0 43049.8 43111.1 44291.0 44959.0 35387.3 37669.0 37806.6 37862.4 38613.6 29033.7 29365.0 29401.3 29430.3 29625.0 06:06:38 INFO - PROCESS | 31192 | 06:06:38 INFO - PROCESS | 31192 | [#2] jquery.html Cycles:180 Average:29522.44 Median:12785.11 stddev:83179.20 (650.6%) stddev-sans-first:83383.78 06:06:38 INFO - PROCESS | 31192 | Values: 390.4 397.4 397.5 398.4 419.2 14553.5 18758.2 20129.3 20402.8 20568.4 19446.4 19599.0 19819.1 20196.9 20336.0 5714.2 5777.3 5804.2 5926.2 5932.5 5354.9 5633.5 5661.3 5802.2 5812.2 5530.6 5644.0 5659.4 5667.2 5690.5 5741.0 5799.0 5832.9 5846.5 5851.5 5568.6 5632.1 5658.5 5705.2 5823.3 13777.0 13982.7 23259.4 23949.0 23953.5 2211.3 2292.5 2303.3 2304.5 2310.8 9866.8 9940.4 10108.4 10412.5 10446.2 1962.5 1981.7 1998.3 2039.7 2057.5 81123.6 82863.0 86718.6 87878.0 88565.0 10652.6 10795.5 10849.2 10880.9 11013.0 14737.0 14747.8 14832.4 14890.3 14923.1 7809.4 7981.9 7983.1 8130.1 8145.6 7684.4 7726.9 7792.1 7938.4 7962.0 4499.7 4503.5 4521.5 4525.7 4548.6 1893.0 1915.8 1926.3 1958.3 1959.5 972.5 1003.8 1048.4 1076.4 1083.6 19193.6 20135.1 20215.7 20596.4 20864.4 1008.2 1015.0 1041.5 1050.5 1106.2 10976.9 11352.5 11536.0 11544.4 11588.8 492039.0 502743.0 508002.0 508754.0 510046.0 60218.0 81769.6 97744.5 98252.0 99765.0 991.8 996.6 1006.5 1015.5 1017.2 16143.8 17920.4 18196.5 18243.5 18485.4 41528.4 42889.4 43557.3 44626.0 45504.1 61663.4 62545.0 62710.7 63091.7 63276.0 8639.8 8743.1 8881.6 8914.6 9050.7 12396.8 13423.3 13990.4 14024.4 14071.1 11148.8 11183.7 11492.0 11586.2 11830.3 11017.1 11385.8 11789.2 11951.3 11960.0 11483.0 11702.5 12268.3 12293.5 12308.9 8334.5 8424.5 8632.2 8674.3 8800.9 8580.2 10592.5 11223.3 11566.2 11607.2 06:06:38 INFO - PROCESS | 31192 | 06:06:38 INFO - PROCESS | 31192 | [#3] mootools.html Cycles:180 Average:5718.84 Median:4598.60 stddev:3226.56 (70.2%) stddev-sans-first:3219.87 06:06:38 INFO - PROCESS | 31192 | Values: 1477.7 1483.4 1648.8 1775.2 1794.1 7682.1 8271.5 8372.2 8902.8 8906.7 8368.7 8483.3 8521.5 8551.4 8562.7 2304.7 2343.8 2345.5 2345.9 2346.0 2317.7 2323.1 2352.7 2352.9 2357.4 2270.3 2299.3 2303.2 2320.2 2325.1 2251.3 2278.2 2284.8 2295.3 2299.1 2234.9 2240.1 2240.6 2245.8 2250.6 8564.7 8579.7 8604.0 8673.6 8680.0 5026.4 5113.9 5120.9 5128.1 5144.0 3221.8 3305.3 3368.8 3390.9 3417.3 1098.2 1106.3 1112.3 1127.3 1148.5 11991.0 12009.5 12087.3 12088.2 12109.1 4446.6 4480.1 4591.5 4605.7 4605.9 9992.3 10050.7 10058.1 10073.2 10100.6 5241.8 5267.7 5281.9 5298.1 5301.3 4279.4 4676.6 4803.3 4864.5 4884.4 3790.2 3814.6 3909.9 3919.5 3924.5 1208.6 1211.0 1216.2 1217.5 1230.6 995.8 1025.0 1026.6 1033.8 1041.6 5893.8 5911.1 5982.5 6035.0 6067.3 443.6 448.3 448.9 452.5 462.9 4166.3 4185.1 4192.2 4203.8 4250.3 10472.5 10602.0 10648.5 10711.7 10716.1 10590.4 10590.8 10615.3 10623.1 10628.4 7858.2 8100.6 8110.8 8143.2 8263.0 5898.4 5944.7 6030.5 6116.9 6162.2 9847.0 9933.9 10003.2 10015.4 10041.3 9479.4 9940.1 9977.3 10038.6 10071.4 6924.2 7359.4 7539.8 7561.9 7715.2 8441.1 8482.5 8495.1 8495.5 8541.4 7491.3 7618.8 7680.3 7759.9 7782.0 7452.0 7520.3 7615.5 7656.3 7695.5 6970.8 6979.0 7008.0 7032.3 7033.2 5302.4 5332.6 5474.1 5484.9 5496.2 5304.4 5371.0 5458.2 5466.7 5514.8 06:06:38 INFO - PROCESS | 31192 | 06:06:38 INFO - PROCESS | 31192 | [#4] prototype.html Cycles:180 Average:4987.68 Median:5716.03 stddev:1484.66 (26.0%) stddev-sans-first:1447.01 06:06:38 INFO - PROCESS | 31192 | Values: 326.7 331.9 336.4 337.3 339.1 5682.8 5711.8 5734.2 5754.7 5765.9 5594.0 5599.5 5618.0 5645.2 5651.2 4138.9 4184.0 4328.2 4330.4 4338.6 4294.6 4309.7 4326.4 4365.5 4379.0 4335.9 4352.7 4357.8 4360.5 4361.3 4256.3 4264.4 4327.3 4330.2 4347.2 3771.7 3787.7 3793.2 3795.3 3808.6 5459.1 5471.5 5472.2 5511.3 5520.2 4884.6 4948.4 4971.6 4978.2 4992.2 5892.5 5897.6 5901.4 5924.4 5943.5 4227.4 4235.4 4236.8 4238.0 4240.9 5918.2 6036.6 6085.9 6135.0 6155.2 4285.1 4286.2 4291.2 4302.2 4308.2 4348.3 4350.7 4352.2 4355.5 4365.2 4652.8 4945.6 4969.4 4972.8 4996.5 5921.6 5967.2 5992.6 6005.8 6019.6 1481.6 1488.9 1489.3 1507.5 1513.2 954.9 982.3 1009.7 1013.8 1018.8 5661.6 5667.0 5670.2 5703.0 5735.0 5998.4 6036.5 6068.9 6085.1 6102.5 5523.8 5733.2 5762.8 5763.8 5827.8 3229.5 3265.8 3278.8 3286.5 3292.2 6203.8 6319.2 6334.8 6338.7 6341.3 6101.4 6138.8 6141.3 6156.9 6174.2 6102.7 6278.5 6283.0 6295.4 6305.4 6017.2 6075.1 6093.0 6097.0 6144.8 6056.5 6059.4 6066.5 6085.2 6096.2 5889.9 6231.7 6234.3 6280.3 6285.7 4338.5 4371.9 4398.3 4412.4 4415.6 5885.9 6052.1 6085.8 6113.7 6127.4 5981.9 6001.5 6008.8 6021.5 6025.8 6001.4 6016.5 6033.1 6038.4 6058.5 5720.3 5987.0 6000.2 6003.3 6022.4 6053.0 6080.6 6080.8 6083.6 6086.1 5556.6 5859.7 5885.3 5967.4 5986.4 06:06:38 INFO - PROCESS | 31192 | 06:06:38 INFO - PROCESS | 31192 | [#5] yui.html Cycles:180 Average:21361.70 Median:4706.15 stddev:30797.44 (654.4%) stddev-sans-first:30845.04 06:06:38 INFO - PROCESS | 31192 | Values: 774.7 782.8 807.7 815.7 869.3 14985.9 15105.9 15220.6 15303.9 15306.4 13863.2 13864.4 14010.7 14898.6 15472.2 817.9 840.9 841.9 843.6 843.7 637.9 794.9 808.8 827.4 830.3 844.9 845.2 845.4 845.6 845.9 828.9 841.8 842.0 842.2 842.3 607.7 608.1 611.9 612.5 614.5 14427.0 14484.7 14487.7 14495.1 14528.7 14575.4 14906.2 14993.6 15020.7 15118.1 11545.6 11825.2 11898.2 11919.6 12020.8 3945.4 3983.7 3983.9 4079.9 4082.9 80945.4 81599.6 82024.2 82506.2 82679.0 10918.5 11521.8 11641.5 11947.3 12023.2 21347.0 21348.9 21352.6 21443.0 21547.2 8269.3 8418.2 8681.2 8802.5 8857.8 4984.1 5176.8 5222.9 5281.6 5362.6 3367.8 3493.8 3522.2 3524.9 3534.7 690.9 701.3 705.9 712.0 722.5 628.7 635.7 674.8 705.9 709.0 9391.5 9795.1 9984.8 10583.5 10758.4 701.8 719.6 730.1 747.2 754.8 4663.4 4696.8 4715.5 4800.8 4847.0 72385.0 72995.6 123468.0 125779.4 135297.0 67489.3 70741.3 92157.0 110303.0 116295.0 78159.6 99045.0 99514.5 101312.5 101894.5 8901.3 8925.0 9020.8 9041.8 9121.5 53489.9 54676.0 56266.8 57327.4 58068.0 76489.2 86110.6 86782.6 86865.0 87091.0 11726.0 12336.7 13093.2 13192.5 13367.8 16074.8 16446.7 16634.3 16895.2 17513.8 13624.8 13801.5 14343.4 14355.9 14519.7 14941.4 15108.2 15151.1 15485.4 16051.4 13954.5 14494.9 14543.9 14670.3 14817.3 11158.3 11573.8 11718.1 11892.7 12293.7 11638.9 11850.5 12111.5 12257.8 12359.4 06:06:38 INFO - PROCESS | 31192 | -------- Summary: end -------- 06:06:38 INFO - PROCESS | 31192 | 06:06:38 INFO - TEST-INFO | 31192: exit 0 06:06:38 INFO - TEST-OK | dromaeo_css | took 1111350ms 06:06:38 INFO - TEST-START | kraken 06:06:38 INFO - operating with platform_type : linux_ 06:06:38 INFO - Initialising browser for kraken test... 06:06:38 INFO - TEST-INFO | started process 31438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf9GyEG/profile http://localhost:55903/getInfo.html) 06:06:43 INFO - PROCESS | 31438 | __metrics Screen width/height:1600/1200 06:06:43 INFO - PROCESS | 31438 | colorDepth:24 06:06:43 INFO - PROCESS | 31438 | Browser inner width/height: 1024/697 06:06:43 INFO - PROCESS | 31438 | __metrics 06:06:44 ERROR - PROCESS | 31438 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:06:45 INFO - TEST-INFO | 31438: exit 0 06:06:45 INFO - Browser initialized. 06:06:45 INFO - Running cycle 1/1 for kraken test... 06:06:45 INFO - TEST-INFO | started process 31563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf9GyEG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:56 INFO - PROCESS | 31563 | RSS: Main: 167735296 06:06:56 INFO - PROCESS | 31563 | 06:06:59 INFO - PROCESS | 31563 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55903/tests/kraken/driver.html?testName=audio-beat-detection) 06:07:00 INFO - PROCESS | 31563 | RSS: Main: 173215744 06:07:00 INFO - PROCESS | 31563 | 06:07:02 INFO - PROCESS | 31563 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55903/tests/kraken/driver.html?testName=audio-dft) 06:07:03 INFO - PROCESS | 31563 | RSS: Main: 172535808 06:07:03 INFO - PROCESS | 31563 | 06:07:06 INFO - PROCESS | 31563 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55903/tests/kraken/driver.html?testName=audio-fft) 06:07:07 INFO - PROCESS | 31563 | RSS: Main: 166928384 06:07:07 INFO - PROCESS | 31563 | 06:07:09 INFO - PROCESS | 31563 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55903/tests/kraken/driver.html?testName=audio-oscillator) 06:07:09 INFO - PROCESS | 31563 | RSS: Main: 168091648 06:07:09 INFO - PROCESS | 31563 | 06:07:12 INFO - PROCESS | 31563 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:07:12 INFO - PROCESS | 31563 | RSS: Main: 169328640 06:07:12 INFO - PROCESS | 31563 | 06:07:15 INFO - PROCESS | 31563 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55903/tests/kraken/driver.html?testName=imaging-darkroom) 06:07:16 INFO - PROCESS | 31563 | RSS: Main: 168075264 06:07:16 INFO - PROCESS | 31563 | 06:07:19 INFO - PROCESS | 31563 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55903/tests/kraken/driver.html?testName=imaging-desaturate) 06:07:20 INFO - PROCESS | 31563 | RSS: Main: 165949440 06:07:20 INFO - PROCESS | 31563 | 06:07:23 INFO - PROCESS | 31563 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55903/tests/kraken/driver.html?testName=json-parse-financial) 06:07:23 INFO - PROCESS | 31563 | RSS: Main: 167600128 06:07:23 INFO - PROCESS | 31563 | 06:07:25 INFO - PROCESS | 31563 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:07:26 INFO - PROCESS | 31563 | RSS: Main: 167792640 06:07:26 INFO - PROCESS | 31563 | 06:07:27 INFO - PROCESS | 31563 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:07:28 INFO - PROCESS | 31563 | RSS: Main: 168124416 06:07:28 INFO - PROCESS | 31563 | 06:07:30 INFO - PROCESS | 31563 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:07:31 INFO - PROCESS | 31563 | RSS: Main: 169074688 06:07:31 INFO - PROCESS | 31563 | 06:07:33 INFO - PROCESS | 31563 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:07:34 INFO - PROCESS | 31563 | RSS: Main: 169009152 06:07:34 INFO - PROCESS | 31563 | 06:07:37 INFO - PROCESS | 31563 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:07:37 INFO - PROCESS | 31563 | RSS: Main: 168542208 06:07:37 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | Cycle 1(1): loaded http://localhost:55903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55903/tests/kraken/driver.html?testName=ai-astar) 06:07:39 INFO - PROCESS | 31563 | RSS: Main: 169381888 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | __start_tp_report 06:07:39 INFO - PROCESS | 31563 | _x_x_mozilla_page_load 06:07:39 INFO - PROCESS | 31563 | _x_x_mozilla_page_load_details 06:07:39 INFO - PROCESS | 31563 | |i|pagename|runs| 06:07:39 INFO - PROCESS | 31563 | |0;ai-astar;102;111;105;111;112;116;113;110;112;111 06:07:39 INFO - PROCESS | 31563 | |1;audio-beat-detection;147;117;147;177;118;150;147;119;182;119 06:07:39 INFO - PROCESS | 31563 | |2;audio-dft;162;164;163;163;162;165;178;172;162;162 06:07:39 INFO - PROCESS | 31563 | |3;audio-fft;73;75;76;139;78;76;85;77;171;76 06:07:39 INFO - PROCESS | 31563 | |4;audio-oscillator;83;84;143;84;84;84;144;84;85;146 06:07:39 INFO - PROCESS | 31563 | |5;imaging-gaussian-blur;117;118;118;118;118;119;117;117;118;118 06:07:39 INFO - PROCESS | 31563 | |6;imaging-darkroom;146;147;147;149;148;148;147;148;148;147 06:07:39 INFO - PROCESS | 31563 | |7;imaging-desaturate;96;96;95;96;95;96;96;96;95;95 06:07:39 INFO - PROCESS | 31563 | |8;json-parse-financial;67;63;54;54;55;56;52;54;53;54 06:07:39 INFO - PROCESS | 31563 | |9;json-stringify-tinderbox;61;61;61;62;62;61;62;62;61;62 06:07:39 INFO - PROCESS | 31563 | |10;stanford-crypto-aes;78;76;78;76;79;85;77;76;87;76 06:07:39 INFO - PROCESS | 31563 | |11;stanford-crypto-ccm;129;127;122;131;122;131;132;142;153;121 06:07:39 INFO - PROCESS | 31563 | |12;stanford-crypto-pbkdf2;165;163;161;161;161;158;169;170;170;159 06:07:39 INFO - PROCESS | 31563 | |13;stanford-crypto-sha256-iterative;63;64;65;64;69;63;67;64;62;64 06:07:39 INFO - PROCESS | 31563 | __end_tp_report 06:07:39 INFO - PROCESS | 31563 | __start_cc_report 06:07:39 INFO - PROCESS | 31563 | _x_x_mozilla_cycle_collect,910 06:07:39 INFO - PROCESS | 31563 | __end_cc_report 06:07:39 INFO - PROCESS | 31563 | __startTimestamp1468933659854__endTimestamp 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | ------- Summary: start ------- 06:07:39 INFO - PROCESS | 31563 | Number of tests: 14 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:4.00 (3.6%) stddev-sans-first:2.91 06:07:39 INFO - PROCESS | 31563 | Values: 102.0 111.0 105.0 111.0 112.0 116.0 113.0 110.0 112.0 111.0 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:147.00 stddev:24.09 (16.4%) stddev-sans-first:25.49 06:07:39 INFO - PROCESS | 31563 | Values: 147.0 117.0 147.0 177.0 118.0 150.0 147.0 119.0 182.0 119.0 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | [#2] audio-dft Cycles:10 Average:165.30 Median:163.50 stddev:5.40 (3.3%) stddev-sans-first:5.59 06:07:39 INFO - PROCESS | 31563 | Values: 162.0 164.0 163.0 163.0 162.0 165.0 178.0 172.0 162.0 162.0 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.00 stddev:33.89 (44.6%) stddev-sans-first:35.19 06:07:39 INFO - PROCESS | 31563 | Values: 73.0 75.0 76.0 139.0 78.0 76.0 85.0 77.0 171.0 76.0 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:84.00 stddev:29.16 (34.7%) stddev-sans-first:30.09 06:07:39 INFO - PROCESS | 31563 | Values: 83.0 84.0 143.0 84.0 84.0 84.0 144.0 84.0 85.0 146.0 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 06:07:39 INFO - PROCESS | 31563 | Values: 117.0 118.0 118.0 118.0 118.0 119.0 117.0 117.0 118.0 118.0 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 06:07:39 INFO - PROCESS | 31563 | Values: 146.0 147.0 147.0 149.0 148.0 148.0 147.0 148.0 148.0 147.0 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:07:39 INFO - PROCESS | 31563 | Values: 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:54.50 stddev:4.85 (8.9%) stddev-sans-first:3.20 06:07:39 INFO - PROCESS | 31563 | Values: 67.0 63.0 54.0 54.0 55.0 56.0 52.0 54.0 53.0 54.0 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 06:07:39 INFO - PROCESS | 31563 | Values: 61.0 61.0 61.0 62.0 62.0 61.0 62.0 62.0 61.0 62.0 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:3.97 (5.1%) stddev-sans-first:4.20 06:07:39 INFO - PROCESS | 31563 | Values: 78.0 76.0 78.0 76.0 79.0 85.0 77.0 76.0 87.0 76.0 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:131.00 stddev:9.93 (7.6%) stddev-sans-first:10.51 06:07:39 INFO - PROCESS | 31563 | Values: 129.0 127.0 122.0 131.0 122.0 131.0 132.0 142.0 153.0 121.0 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:164.00 stddev:4.55 (2.8%) stddev-sans-first:4.80 06:07:39 INFO - PROCESS | 31563 | Values: 165.0 163.0 161.0 161.0 161.0 158.0 169.0 170.0 170.0 159.0 06:07:39 INFO - PROCESS | 31563 | 06:07:39 INFO - PROCESS | 31563 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.00 stddev:2.07 (3.2%) stddev-sans-first:2.12 06:07:39 INFO - PROCESS | 31563 | Values: 63.0 64.0 65.0 64.0 69.0 63.0 67.0 64.0 62.0 64.0 06:07:39 INFO - PROCESS | 31563 | -------- Summary: end -------- 06:07:39 INFO - PROCESS | 31563 | 06:07:40 INFO - TEST-INFO | 31563: exit 0 06:07:40 INFO - TEST-OK | kraken | took 61868ms 06:07:40 INFO - SUITE-END | took 1173s 06:07:41 INFO - Completed test suite (00:19:33) 06:07:41 INFO - javascript benchmark 06:07:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7294.130665322192, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.6304443466784, 3101.193689640693, 3110.1758034120976, 3119.173419043954, 3121.5785868907697, 5484.314460692413, 5522.3649280332775, 5553.722313884305, 5555.555555555556, 5574.526165275946, 5413.296271484702, 5484.0, 5488.643238189525, 5543.6119471637, 5563.527100196478, 4970.826021089253, 4977.1538838397555, 5020.5983521318385, 5025.798968041274, 5054.772535235923, 5005.824796132136, 5119.59043276537, 5121.820736274231, 5134.435212126663, 5152.562032227246, 4977.07924034053, 5031.169856973595, 5080.542751152414, 5088.23676448532, 5110.080185566615, 4991.550760431543, 4998.12532806761, 4999.475055119233, 5004.84985450437, 5041.621878359138, 4982.153033984231, 4982.57648099912, 4985.102681517325, 4990.6257030722845, 5026.497350264981, 5367.46325367464, 5389.137737961907, 5457.126859702468, 5470.781168753245, 5499.670019798825, 5857.062869940832, 5860.824175274749, 5865.208196893407, 5865.941340586583, 5891.234139561872, 5817.185594016841, 5909.497692696126, 5913.940860591382, 5922.0, 5929.673867937262, 5533.253010843525, 5580.804671836466, 5586.273784408001, 5592.608517403824, 5640.0693885508435, 6145.4161854623735, 6145.877082458326, 6151.815445536641, 6161.815145545641, 6161.907571386433, 5684.488396044376, 5819.301683797887, 5897.52819774417, 5899.67551784656, 5907.793227237026, 5919.348871624118, 5931.110333450017, 5955.642661440327, 5961.195238642815, 6029.939700603026, 5919.822405327847, 5947.702614869239, 5973.940260597426, 5992.250968628921, 5997.610155339889, 5834.03738383162, 5892.057270836645, 5907.822765317047, 5957.940420595825, 5985.880282394328, 4400.163968845909, 4466.486354069259, 4501.482329532146, 4552.886177845514, 4586.72479651222, 3948.9210215796097, 3998.640122388999, 4015.5783642717092, 4046.7571945683353, 4048.716589838683, 5477.178423236546, 5612.242347283064, 5617.241672374259, 5702.714864256771, 5708.143778433186, 5955.0, 5967.9701601491715, 5973.044312909914, 5986.790462333797, 6025.0359942409, 5644.57665675076, 5658.91511627326, 5684.232628595169, 5684.658920464785, 5695.914561281584, 5026.271190677405, 5078.669886457368, 5088.898222035538, 5115.079285728604, 5123.103456895028, 6114.2662880453745, 6117.785877494266, 6142.293636231801, 6171.352008039181, 6180.598261113013, 5937.524998000236, 5942.851428714143, 5944.613600115978, 5946.4053594641055, 5954.970225148846, 5994.730237139426, 6091.939080609137, 6131.294901086254, 6144.846378840565, 6166.260048794174, 5859.765609375748, 5878.412158784087, 5897.970510147422, 5909.674967876808, 5920.822375328747, 5839.5036421904615, 5949.167116603766, 5994.790182343597, 6012.759489620366, 6013.609115407659, 5754.136879468113, 5771.220885180447, 5782.363939966516, 5795.536357091507, 5803.419658034331, 5801.680907550125, 5844.47399734026, 5851.21008663825, 5855.531557475307, 5859.2382990211, 5650.745716442688, 5779.2775903012125, 5804.883902322014, 5844.736986835687, 5848.561357898089, 5640.266765320482, 5756.222909907109, 5767.307923049261, 5868.618539794899, 5955.40445955401, 5678.74445649955, 5731.111677689964, 5737.225474561048, 5738.598298119092, 5739.770409183586], "value": 5463.31773533817, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.2605151987102, 586.7095787585146, 598.6527813867955, 616.497554493088, 627.6014730646039, 40014.1997160057, 43864.34203486946, 44114.77942610286, 44128.77935610325, 44247.77876110623, 43418.78290608551, 43702.344464832975, 43886.34170487437, 43894.56105438944, 44030.779846100806, 8850.114988501147, 8918.331125165638, 8929.866052009225, 8968.417052891573, 8994.415363001384, 8874.467531948072, 8950.373473856833, 8996.59515321812, 9025.097490250988, 9040.638374465014, 9002.864957025617, 9006.59470323837, 9022.0, 9053.275737940949, 9060.41107328025, 8927.330450216226, 8933.776655583597, 8976.3267754918, 8993.415427997159, 9011.0, 8890.777730556787, 8897.644094236222, 8929.151730585583, 8936.865947010736, 8970.641174353019, 41384.37923431151, 41652.79173604112, 41722.37416438756, 41779.7911010443, 41789.37315940263, 2942.4850651135966, 3491.5810102787573, 3619.963800361989, 3626.8005259710703, 3720.720945929066, 32134.678653213636, 32142.196445088826, 32642.510362344583, 33025.265528651405, 33067.83466082678, 4251.532331443539, 4381.737095774264, 4388.429504164438, 4393.494748103977, 4474.932876006863, 293584.0, 294630.0, 294992.0, 295837.0, 297032.0, 31880.521792173135, 33948.49077263843, 34467.13832154166, 34520.0, 34531.0, 37287.440688389695, 37317.44023839645, 37432.62567374346, 37519.437208441894, 37568.43647345292, 14852.0, 14983.925080374529, 15049.54851354461, 15106.471273505374, 15111.773323400157, 12845.357732113356, 12908.09643324977, 12924.289164096064, 12939.870601294055, 12964.092513523963, 8149.755507334789, 8230.465019773696, 8265.132161122996, 8309.542975136304, 8316.501009939422, 3168.2237851726472, 3170.9207269817975, 3186.553882456458, 3236.207129253348, 3245.870165193413, 1009.5103874620803, 1039.7556574205055, 1084.2843723142846, 1154.7228665120479, 1195.354508565365, 32174.0, 32391.649761664376, 32564.34871302608, 32961.67038329634, 33077.66922330746, 1096.2928910852456, 1106.690126764507, 1125.234840308598, 1138.698244965085, 1178.1046404732465, 16152.676946461004, 16771.0, 16851.91574042122, 17100.835099090116, 17186.570335741708, 551177.0, 551621.483785157, 554095.0, 556282.0, 556906.0, 59536.702316489005, 59636.70181649064, 59663.701681491315, 59666.40333596608, 60024.39975600188, 1343.482759137739, 1347.3734713358335, 1364.9658758531116, 1369.2127026959538, 1375.9656008599866, 31091.533626995162, 31452.2136946569, 31784.68215317817, 32038.35923281568, 32749.34501309913, 51559.0, 51834.74082629563, 51919.74040129775, 52103.47896520986, 52243.216351753996, 496489.0, 496785.0, 497271.0, 497352.0, 498115.0, 27696.446071078062, 27818.165455036382, 28208.43583128367, 28410.147695569165, 28429.289267767643, 48819.75590122027, 49762.0, 49930.75034624804, 50049.74975125101, 50439.74780126076, 41894.7905260484, 41955.1608967825, 44823.0, 45794.542054579026, 45797.31304030509, 42976.78511607547, 43134.980551361106, 43597.12805743931, 43932.560674394124, 44453.0, 42568.0, 43049.78475107605, 43111.137777244905, 44291.0, 44959.0, 35387.29225415529, 37669.0, 37806.62193378031, 37862.43206351962, 38613.61386386213, 29033.7096629031, 29365.0, 29401.264968375963, 29430.264243394085, 29625.0], "value": 18872.039039865285, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.3890411505995, 397.39000634026763, 397.4971660849026, 398.4441703823169, 419.24117347600844, 14553.490627828029, 18758.2496700132, 20129.29547465839, 20402.795972040276, 20568.38294851153, 19446.416607501797, 19599.0, 19819.108140133692, 20196.89901550494, 20336.0, 5714.200011998323, 5777.306723193223, 5804.216430781854, 5926.229590153274, 5932.495737862266, 5354.866128346803, 5633.464820842013, 5661.264035675356, 5802.216700745409, 5812.244408226925, 5530.557555395559, 5644.0, 5659.4340565943285, 5667.234923285366, 5690.487856092972, 5741.0, 5799.0, 5832.883342333151, 5846.473817356437, 5851.531877449836, 5568.638038527482, 5632.098864181711, 5658.547316214693, 5705.172749951275, 5823.272090988627, 13777.0, 13982.725048679355, 23259.4185145371, 23949.0, 23953.520929581486, 2211.292386436341, 2292.518571100071, 2303.285981345788, 2304.5316500922963, 2310.7920287174234, 9866.802663946753, 9940.403575785476, 10108.39349639024, 10412.531436085394, 10446.216533759998, 1962.470133064079, 1981.6631172700675, 1998.2706312195944, 2039.7246371739923, 2057.495913501202, 81123.59438202772, 82863.0, 86718.5664071682, 87878.0, 88564.99999999936, 10652.62715804943, 10795.460226988776, 10849.186311026546, 10880.891191087987, 11013.0, 14737.0, 14747.77878331826, 14832.406703731729, 14890.329935152944, 14923.104613723212, 7809.414293927978, 7981.882536444902, 7983.12185659577, 8130.073173657479, 8145.5927203639585, 7684.423668224906, 7726.9227307726205, 7792.103908050533, 7938.404619653549, 7961.960190199128, 4499.662525310549, 4503.459584849774, 4521.457425109008, 4525.705829121097, 4548.636109111263, 1892.990535047316, 1915.789263181049, 1926.258390519632, 1958.2950137950327, 1959.5101224693826, 972.4922215461861, 1003.7841863999275, 1048.4024106259512, 1076.3649446826253, 1083.6423980086552, 19193.616127677647, 20135.0939207736, 20215.696764548542, 20596.38210853647, 20864.37406877796, 1008.178334657252, 1014.9594016239267, 1041.5209003858158, 1050.4957620342125, 1106.2201148190507, 10976.890231097586, 11352.48913798881, 11536.0, 11544.422778861024, 11588.826167607493, 492039.0, 502743.0, 508002.0, 508754.0, 510046.0, 60218.0, 81769.59115204505, 97744.51127744457, 98252.0, 99765.0, 991.8363470027509, 996.6412091647002, 1006.5470538257813, 1015.5430056474615, 1017.2370721958679, 16143.838561614233, 17920.372786952394, 18196.45410637683, 18243.45269641913, 18485.35301264503, 41528.37707434451, 42889.35665964951, 43557.346639801064, 44626.0, 45504.089918200785, 61663.38336616756, 62545.0, 62710.6864465693, 63091.684541577, 63276.0, 8639.784005399915, 8743.125687431206, 8881.600327985127, 8914.598843051948, 9050.728478145666, 12396.81404778947, 13423.26172060546, 13990.370433330729, 14024.439022439396, 14071.085379450304, 11148.832767508331, 11183.664490065312, 11492.023178029627, 11586.246893951866, 11830.290182589073, 11017.1186305097, 11385.829212561652, 11789.233699809485, 11951.282923024646, 11959.983401410629, 11483.0, 11702.473388697359, 12268.263904165779, 12293.508259669514, 12308.876911231131, 8334.458125246849, 8424.500556740128, 8632.179942905414, 8674.349423793115, 8800.91199088001, 8580.227779499875, 10592.523336449724, 11223.270487418291, 11566.248193867372, 11607.187496875138], "value": 9252.188206537603, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.7044591081783, 1483.3843954758775, 1648.7774150489681, 1775.1834156288107, 1794.0850166415125, 7682.116556595993, 8271.46235494694, 8372.204640559145, 8902.77743056423, 8906.688265910694, 8368.665253389872, 8483.278921291681, 8521.531315777629, 8551.358648101386, 8562.65749370026, 2304.665823455598, 2343.8242131840093, 2345.5074434368803, 2345.9178928737497, 2346.038124369009, 2317.7102862142233, 2323.1172154581236, 2352.6706261123454, 2352.870592117433, 2357.35172827473, 2270.2962081754627, 2299.3446867642724, 2303.2284184798027, 2320.1995311617466, 2325.058351367699, 2251.324602619224, 2278.219190342179, 2284.8400611957168, 2295.3343530376087, 2299.057386471547, 2234.8770817605027, 2240.115154513958, 2240.630296001158, 2245.8315626327926, 2250.628646273363, 8564.74305770828, 8579.699710510102, 8604.0, 8673.568861137905, 8679.956600217021, 5026.447090820044, 5113.872153196163, 5120.92318615221, 5128.051310507531, 5143.996920600484, 3221.806691598488, 3305.3224089061923, 3368.8147151906637, 3390.86436542538, 3417.3165366926464, 1098.2092893116942, 1106.31961343773, 1112.3159257056932, 1127.2954403497813, 1148.5233628044352, 11991.0, 12009.519619215222, 12087.27476351413, 12088.214266072677, 12109.091818113677, 4446.644268458515, 4480.14877173336, 4591.540845915449, 4605.654575906753, 4605.861824145281, 9992.25058120644, 10050.69847904564, 10058.14505767018, 10073.194144468425, 10100.646477373257, 5241.816536421207, 5267.71027593486, 5281.9207711884355, 5298.125809241509, 5301.284326615858, 4279.358096285582, 4676.602488788423, 4803.303520989437, 4864.489228631013, 4884.3650325458175, 3790.2419516096893, 3814.5803961564206, 3909.863154789569, 3919.470871432377, 3924.4898163238595, 1208.5649166300125, 1211.0311750599485, 1216.2033867816417, 1217.4825699078033, 1230.6431134970937, 995.7560397702464, 1025.041586116983, 1026.609888242463, 1033.7984093101923, 1041.6093964763213, 5893.823185304448, 5911.054231322968, 5982.46157845796, 6034.969825150846, 6067.271927368744, 443.5586591341571, 448.2514201283799, 448.8788027232629, 452.46834968911395, 462.8703962890396, 4166.312558427886, 4185.142045880587, 4192.182524407711, 4203.76879271643, 4250.3199488081755, 10472.528736206888, 10602.0, 10648.520816563274, 10711.732206694895, 10716.142708583295, 10590.417527035934, 10590.788184236426, 10615.25693201484, 10623.097036751962, 10628.36229826213, 7858.17489163641, 8100.635471403801, 8110.837783244302, 8143.18568143181, 8262.958685206415, 5898.439648233411, 5944.732487038007, 6030.48740857032, 6116.877662446637, 6162.168107305636, 9846.950765246127, 9933.900660993586, 10003.249756268164, 10015.39907605546, 10041.347312424668, 9479.383840050376, 9940.055694708992, 9977.251706121924, 10038.64864729731, 10071.446070466194, 6924.169099708067, 7359.4480413968095, 7539.773806785805, 7561.886571701539, 7715.189905060112, 8441.071482137082, 8482.49105053674, 8495.108013658477, 8495.532745698798, 8541.359398045295, 7491.288327608869, 7618.847623047397, 7680.270374314431, 7759.922400776146, 7782.027246594176, 7452.0, 7520.285572870568, 7615.4669173157345, 7656.272654097852, 7695.461317707706, 6970.825729356807, 6978.965105174441, 7007.964960175166, 7032.296770322927, 7033.191183014019, 5302.3637163540625, 5332.600054995968, 5474.0967740323995, 5484.862878427912, 5496.1755736639825, 5304.389995150607, 5371.0, 5458.208559758733, 5466.671999680032, 5514.834554963358], "value": 4519.251767108549, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.68638107416876, 331.8838406557705, 336.3541999361226, 337.2681281618887, 339.07601785135506, 5682.772689092437, 5711.8000869969555, 5734.197212390269, 5754.683492407916, 5765.855853603662, 5594.021046316899, 5599.468050535193, 5618.0449323614985, 5645.1814486899375, 5651.1523271509295, 4138.875833724993, 4183.97908010461, 4328.199283132615, 4330.350447432878, 4338.631216346615, 4294.592013758704, 4309.655227581801, 4326.43756311679, 4365.493904602907, 4379.0, 4335.869923902288, 4352.673549483801, 4357.803898824561, 4360.520342762309, 4361.302191649337, 4256.318988961767, 4264.381664658607, 4327.307630779061, 4330.198913201068, 4347.152305300468, 3771.679407250387, 3787.696984241254, 3793.2223894101644, 3795.3168429682646, 3808.619138086197, 5459.089318738449, 5471.534919531845, 5472.2338872557875, 5511.283533140706, 5520.171974203901, 4884.560389564921, 4948.406191257036, 4971.552560269557, 4978.228374601942, 4992.176290911995, 5892.469677728982, 5897.64614123154, 5901.4098590141075, 5924.407559244084, 5943.524518038546, 4227.408162857202, 4235.449391579105, 4236.809343579515, 4237.957620423787, 4240.936385954213, 5918.201042859202, 6036.577439579231, 6085.9391406085815, 6135.049067394561, 6155.169052177988, 4285.121550082225, 4286.228478873771, 4291.206126866539, 4302.204092242945, 4308.246056940023, 4348.347747837786, 4350.651947844165, 4352.1948439538155, 4355.539120396966, 4365.236083685342, 4652.790624421909, 4945.554900059012, 4969.422016148367, 4972.83138462461, 4996.4503904570465, 5921.61509501881, 5967.224260846149, 5992.58051936369, 6005.849853753603, 6019.638821670714, 1481.5999680086315, 1488.8585584369469, 1489.270257573781, 1507.4723846653583, 1513.17531945088, 954.8997355277735, 982.3123813330698, 1009.6769033909079, 1013.8023085498257, 1018.8181709217272, 5661.631993920464, 5667.036603777367, 5670.206171136044, 5703.0, 5734.971325143348, 5998.3701711320555, 6036.456718895321, 6068.939310606837, 6085.148079268906, 6102.542309326729, 5523.834284971457, 5733.197352370671, 5762.7694892203845, 5763.769449221984, 5827.79602713903, 3229.4832826747606, 3265.8367081645824, 3278.770486066, 3286.4905939579403, 3292.1769557610596, 6203.7828675996125, 6319.24169099711, 6334.8416289592205, 6338.7464501420345, 6341.270753863365, 6101.389861013952, 6138.846528836725, 6141.293751218667, 6156.907646385308, 6174.228221472316, 6102.69486525672, 6278.529110316653, 6282.994720844643, 6295.37046295376, 6305.369463053749, 6017.247844019497, 6075.058365953284, 6093.0, 6096.969515152573, 6144.846378840565, 6056.545759068, 6059.3637668045985, 6066.484348830399, 6085.1785009023215, 6096.159419565823, 5889.882202356014, 6231.725420221496, 6234.345393733593, 6280.309165991646, 6285.74857005733, 4338.501072376591, 4371.912561748811, 4398.274284742982, 4412.448443944507, 4415.558444155558, 5885.941140588539, 6052.122442245762, 6085.847853803513, 6113.694315284129, 6127.3566275540425, 5981.910271346021, 6001.549883758823, 6008.789692360921, 6021.488173505301, 6025.764718232839, 6001.4298641628975, 6016.548758843017, 6033.12519684652, 6038.365971573097, 6058.454739073504, 5720.256366672306, 5987.0121429963565, 6000.21997140369, 6003.309619393825, 6022.36765139654, 6053.0012547930855, 6080.574359794772, 6080.847978800565, 6083.604565703392, 6086.1175129606845, 5556.583256255878, 5859.681571646345, 5885.264341957255, 5967.373425790403, 5986.371430999682], "value": 4507.452152380958, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.7094839435211, 782.761257816366, 807.737485317272, 815.7430409421028, 869.3045563549161, 14985.850141498582, 15105.924470377633, 15220.619484512892, 15303.923480382597, 15306.387744490206, 13863.23752193629, 13864.4454221831, 14010.719785604282, 14898.553043408716, 15472.226388680549, 817.9345652347798, 840.9285210757093, 841.9452735572169, 843.5782108945527, 843.6541018182546, 637.91069250305, 794.9364050875917, 808.8382323535317, 827.3505298340774, 830.3025458614762, 844.9155084491532, 845.2223953962339, 845.4420082745359, 845.5772113943028, 845.8773477845708, 828.8632375658009, 841.7853447370912, 842.0190478093015, 842.2335674536173, 842.2672275120623, 607.74474720617, 608.057510858168, 611.9235095613049, 612.5252928980032, 614.4715544631613, 14427.0, 14484.710305793826, 14487.681970884609, 14495.057821241586, 14528.709425811425, 14575.416983320654, 14906.180160091191, 14993.625159370993, 15020.699586008219, 15118.09291442517, 11545.616406246123, 11825.172237943347, 11898.226615270067, 11919.642410727693, 12020.819687704692, 3945.4081887716784, 3983.7410568312966, 3983.9203215935518, 4079.8776036718946, 4082.8979275518054, 80945.38109237842, 81599.5920020402, 82024.17975820226, 82506.17493825045, 82679.0, 10918.50866711, 11521.827172592419, 11641.53433862653, 11947.342896140623, 12023.21849079807, 21347.0, 21348.893255533934, 21352.572948540943, 21443.0, 21547.245846395614, 8269.255766981001, 8418.158184181533, 8681.2186903179, 8802.515861627544, 8857.822843543094, 4984.127777638899, 5176.844694659167, 5222.947770522323, 5281.630285879952, 5362.570994320523, 3367.848446819899, 3493.7729047611824, 3522.225110475691, 3524.8766293179615, 3534.6642069003406, 690.8963655451622, 701.2566679319938, 705.8694141583824, 711.975080872167, 722.4509372876652, 628.7107930352089, 635.7202830754453, 674.7840690978937, 705.932936371044, 708.982275443118, 9391.530423478798, 9795.06946840049, 9984.750381240527, 10583.470826458646, 10758.354498730101, 701.8140192848899, 719.5610677486729, 730.087390761548, 747.2191559820001, 754.8301632132836, 4663.417072865892, 4696.81212751493, 4715.481297057321, 4800.808557230684, 4846.975765121152, 72385.0, 72995.63502182561, 123468.0, 125779.37110314574, 135297.0, 67489.3251067483, 70741.2925870745, 92157.0, 110303.0, 116295.0, 78159.60920195363, 99045.00954990502, 99514.5024274874, 101312.49343753382, 101894.49052754689, 8901.287896968357, 8924.955375223082, 9020.81958360816, 9041.819163616823, 9121.543922803967, 53489.918457746455, 54676.0, 56266.779991499985, 57327.426725732206, 58068.0, 76489.23510764822, 86110.56944715236, 86782.56608716917, 86865.0, 87091.0, 11726.0, 12336.691582710504, 13093.214407135602, 13192.472301107848, 13367.799483007957, 16074.839251607802, 16446.67106657836, 16634.3346266148, 16895.155242237593, 17513.824861751218, 13624.795628065389, 13801.51694690681, 14343.354549045109, 14355.928220358832, 14519.709605808035, 14941.402343906557, 15108.169050701877, 15151.090934543963, 15485.380584776933, 16051.357945682508, 13954.511592094228, 14494.927525362305, 14543.92728036353, 14670.33983470725, 14817.25913704332, 11158.330500170016, 11573.826392604286, 11718.121140914294, 11892.702682433008, 12293.692657683629, 11638.88361116378, 11850.466728997044, 12111.45498452554, 12257.754844903231, 12359.443825028075], "value": 7749.668861401847, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 105.0, 111.0, 112.0, 116.0, 113.0, 110.0, 112.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 147.0, 177.0, 118.0, 150.0, 147.0, 119.0, 182.0, 119.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 163.0, 162.0, 165.0, 178.0, 172.0, 162.0, 162.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 76.0, 139.0, 78.0, 76.0, 85.0, 77.0, 171.0, 76.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 143.0, 84.0, 84.0, 84.0, 144.0, 84.0, 85.0, 146.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 117.0, 117.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 149.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 54.0, 54.0, 55.0, 56.0, 52.0, 54.0, 53.0, 54.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 78.0, 76.0, 79.0, 85.0, 77.0, 76.0, 87.0, 76.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 122.0, 131.0, 122.0, 131.0, 132.0, 142.0, 153.0, 121.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 161.0, 161.0, 161.0, 158.0, 169.0, 170.0, 170.0, 159.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 64.0, 69.0, 63.0, 67.0, 64.0, 62.0, 64.0], "value": 64.5, "unit": "score"}]}]} 06:07:41 INFO - Return code: 0 06:07:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:07:41 ERROR - # TBPL SUCCESS # 06:07:41 INFO - Running post-action listener: _resource_record_post_action 06:07:41 INFO - ##### 06:07:41 INFO - ##### Finished run-tests step (success) 06:07:41 INFO - ##### 06:07:41 INFO - Running post-run listener: _resource_record_post_run 06:07:41 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553914368; Read time: 12; Write time: 503512 06:07:41 INFO - TinderboxPrint: CPU usage
13.2% 06:07:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:07:41 INFO - TinderboxPrint: I/O write bytes / time
553,914,368 / 503,512 06:07:41 INFO - TinderboxPrint: CPU idle
8,242.5 (86.7%) 06:07:41 INFO - TinderboxPrint: CPU user
1,206.0 (12.7%) 06:07:41 INFO - TinderboxPrint: Swap in / out
0 / 0 06:07:41 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257314816; Read time: 0; Write time: 304428 06:07:41 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 296345600; Read time: 0; Write time: 199040 06:07:41 INFO - Running post-run listener: _upload_blobber_files 06:07:41 INFO - Blob upload gear active. 06:07:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:07:41 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 06:07:41 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:07:41 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:07:42 INFO - (blobuploader) - INFO - Open directory for files ... 06:07:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:07:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:07:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:42 INFO - (blobuploader) - INFO - Done attempting. 06:07:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:07:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:07:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:46 INFO - (blobuploader) - INFO - Done attempting. 06:07:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:07:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:07:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:47 INFO - (blobuploader) - INFO - Done attempting. 06:07:47 INFO - (blobuploader) - INFO - Iteration through files over. 06:07:47 INFO - Return code: 0 06:07:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:07:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:07:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d03efd52cb213f998faa3991fdb8844d225fd0b46eaa7e57306a7c1b3347dd03e2f9571cc00f531c75e461080935b68745b33c3d60ff93578463d682af42e7d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cc45e27b8e3015a7aef5cc07aead183b8b54d7a5010df7df54b45cfe7285657c43e898a8273f4e7304a15cecfe1b927dee52c60bc1b3926f7b9ec02ccd4f38f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df46a1320319cadf70d8d3ac62ad8ba65ff42ebe5498251892a2e1cc80d4540be265806bb62c20cc170e192be7431237d43e128be2f1209a54af743dd860b7d3"} 06:07:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:07:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:07:47 INFO - Contents: 06:07:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d03efd52cb213f998faa3991fdb8844d225fd0b46eaa7e57306a7c1b3347dd03e2f9571cc00f531c75e461080935b68745b33c3d60ff93578463d682af42e7d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cc45e27b8e3015a7aef5cc07aead183b8b54d7a5010df7df54b45cfe7285657c43e898a8273f4e7304a15cecfe1b927dee52c60bc1b3926f7b9ec02ccd4f38f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df46a1320319cadf70d8d3ac62ad8ba65ff42ebe5498251892a2e1cc80d4540be265806bb62c20cc170e192be7431237d43e128be2f1209a54af743dd860b7d3"} 06:07:47 INFO - Running post-run listener: copy_logs_to_upload_dir 06:07:47 INFO - Copying logs to upload dir... 06:07:47 INFO - mkdir: /builds/slave/test/build/upload/logs 06:07:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.995790 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-19 06:07:47.126938) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 06:07:47.130809) ========= 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=836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261 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/sha512/d03efd52cb213f998faa3991fdb8844d225fd0b46eaa7e57306a7c1b3347dd03e2f9571cc00f531c75e461080935b68745b33c3d60ff93578463d682af42e7d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cc45e27b8e3015a7aef5cc07aead183b8b54d7a5010df7df54b45cfe7285657c43e898a8273f4e7304a15cecfe1b927dee52c60bc1b3926f7b9ec02ccd4f38f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df46a1320319cadf70d8d3ac62ad8ba65ff42ebe5498251892a2e1cc80d4540be265806bb62c20cc170e192be7431237d43e128be2f1209a54af743dd860b7d3"} build_url:https://queue.taskcluster.net/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/JBWaWkv3SHeW7bN5Hdt0Pg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d03efd52cb213f998faa3991fdb8844d225fd0b46eaa7e57306a7c1b3347dd03e2f9571cc00f531c75e461080935b68745b33c3d60ff93578463d682af42e7d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2cc45e27b8e3015a7aef5cc07aead183b8b54d7a5010df7df54b45cfe7285657c43e898a8273f4e7304a15cecfe1b927dee52c60bc1b3926f7b9ec02ccd4f38f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df46a1320319cadf70d8d3ac62ad8ba65ff42ebe5498251892a2e1cc80d4540be265806bb62c20cc170e192be7431237d43e128be2f1209a54af743dd860b7d3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 06:07:47.156135) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 06:07:47.156531) ========= 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=836cfdc75598d54cb747368e000001a9-1468931705.456820-1185523261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 06:07:47.239253) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 06:07:47.239577) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 06:07:47.239877) ========= ========= Total master_lag: 0.16 =========