builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1468500508.81 results: success (0) buildid: 20160714030208 builduid: 092f3aad2b1b4eaf98c514ea48b51436 revision: 08f8a5aacd8308a73f6040fe522be7ba38497561 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 05:48:28.805695) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 05:48:28.806261) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 05:48:28.806585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 05:48:28.822159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:48:28.822590) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 05:48:28-- 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.3M=0s 2016-07-14 05:48:29 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090375 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:48:28.929839) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:48:28.930369) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017257 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:48:28.980649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:48:28.981074) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 08f8a5aacd8308a73f6040fe522be7ba38497561 --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 08f8a5aacd8308a73f6040fe522be7ba38497561 --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=516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 05:48:29,180 truncating revision to first 12 chars 2016-07-14 05:48:29,180 Setting DEBUG logging. 2016-07-14 05:48:29,180 attempt 1/10 2016-07-14 05:48:29,180 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/08f8a5aacd83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 05:48:29,481 unpacking tar archive at: mozilla-central-08f8a5aacd83/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635326 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:48:29.634159) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 05:48:29.634842) ========= script_repo_revision: 08f8a5aacd8308a73f6040fe522be7ba38497561 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 05:48:29.635793) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 05:48:29.636491) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 05:48:29.648158) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-14 05:48:29.648484) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:48:29 INFO - MultiFileLogger online at 20160714 05:48:29 in /builds/slave/test 05:48:29 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:48:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:48:29 INFO - {'append_to_log': False, 05:48:29 INFO - 'base_work_dir': '/builds/slave/test', 05:48:29 INFO - 'blob_upload_branch': 'Firefox', 05:48:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:48:29 INFO - 'branch': 'Firefox', 05:48:29 INFO - 'buildbot_json_path': 'buildprops.json', 05:48:29 INFO - 'config_files': ('talos/linux_config.py',), 05:48:29 INFO - 'default_actions': ('clobber', 05:48:29 INFO - 'read-buildbot-config', 05:48:29 INFO - 'download-and-extract', 05:48:29 INFO - 'populate-webroot', 05:48:29 INFO - 'create-virtualenv', 05:48:29 INFO - 'install', 05:48:29 INFO - 'run-tests'), 05:48:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:48:29 INFO - 'download_minidump_stackwalk': True, 05:48:29 INFO - 'download_symbols': 'ondemand', 05:48:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:48:29 INFO - 'tooltool.py': '/tools/tooltool.py', 05:48:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:48:29 INFO - '/tools/misc-python/virtualenv.py')}, 05:48:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:48:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:48:29 INFO - 'installer_path': 'installer.exe', 05:48:29 INFO - 'log_level': 'info', 05:48:29 INFO - 'log_name': 'talos', 05:48:29 INFO - 'log_to_console': True, 05:48:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:48:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:48:29 INFO - 'opt_config_files': (), 05:48:29 INFO - 'pip_index': False, 05:48:29 INFO - 'sps_profile': False, 05:48:29 INFO - 'sps_profile_interval': 0, 05:48:29 INFO - 'suite': 'dromaeojs-e10s', 05:48:29 INFO - 'system_bits': '32', 05:48:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:48:29 INFO - 'title': 'talos-linux64-ix-061', 05:48:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:48:29 INFO - 'use_talos_json': True, 05:48:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:48:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:48:29 INFO - 'work_dir': 'build'} 05:48:29 INFO - ##### 05:48:29 INFO - ##### Running clobber step. 05:48:29 INFO - ##### 05:48:29 INFO - Running pre-action listener: _resource_record_pre_action 05:48:29 INFO - Running main action method: clobber 05:48:29 INFO - rmtree: /builds/slave/test/build 05:48:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:48:30 INFO - Running post-action listener: _resource_record_post_action 05:48:30 INFO - ##### 05:48:30 INFO - ##### Finished clobber step (success) 05:48:30 INFO - ##### 05:48:30 INFO - ##### 05:48:30 INFO - ##### Running read-buildbot-config step. 05:48:30 INFO - ##### 05:48:30 INFO - Running pre-action listener: _resource_record_pre_action 05:48:30 INFO - Running main action method: read_buildbot_config 05:48:30 INFO - Using buildbot properties: 05:48:30 INFO - { 05:48:30 INFO - "project": "", 05:48:30 INFO - "product": "firefox", 05:48:30 INFO - "script_repo_revision": "production", 05:48:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:48:30 INFO - "repository": "", 05:48:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:48:30 INFO - "buildid": "20160714030208", 05:48:30 INFO - "stage_platform": "linux64-pgo", 05:48:30 INFO - "basedir": "/builds/slave/test", 05:48:30 INFO - "nightly_build": "True", 05:48:30 INFO - "buildnumber": 91, 05:48:30 INFO - "slavename": "talos-linux64-ix-061", 05:48:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:48:30 INFO - "platform": "ubuntu64_hw", 05:48:30 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:48:30 INFO - "branch": "mozilla-central", 05:48:30 INFO - "repo_path": "mozilla-central", 05:48:30 INFO - "revision": "08f8a5aacd8308a73f6040fe522be7ba38497561", 05:48:30 INFO - "pgo_build": "True", 05:48:30 INFO - "builduid": "092f3aad2b1b4eaf98c514ea48b51436", 05:48:30 INFO - "slavebuilddir": "test" 05:48:30 INFO - } 05:48:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:48:30 INFO - Running post-action listener: _resource_record_post_action 05:48:30 INFO - ##### 05:48:30 INFO - ##### Finished read-buildbot-config step (success) 05:48:30 INFO - ##### 05:48:30 INFO - ##### 05:48:30 INFO - ##### Running download-and-extract step. 05:48:30 INFO - ##### 05:48:30 INFO - Running pre-action listener: _resource_record_pre_action 05:48:30 INFO - Running main action method: download_and_extract 05:48:30 INFO - mkdir: /builds/slave/test/build/tests 05:48: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:48:30 INFO - https://queue.taskcluster.net/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:48:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:48:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:48:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/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:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/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:48:31 INFO - Downloaded 1361 bytes. 05:48:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:48:31 INFO - Using the following test package requirements: 05:48:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:48:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:48:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:48:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:31 INFO - u'jsshell-linux-x86_64.zip'], 05:48:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:48:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:48:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:48:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:48:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:48:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:48:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:48:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:48:31 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:31 INFO - https://queue.taskcluster.net/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:48:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:48:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:48:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/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:48:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/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:48:32 INFO - Downloaded 24326411 bytes. 05:48:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:48:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:48:33 INFO - Return code: 0 05:48:33 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:48: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:48:33 INFO - https://queue.taskcluster.net/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:48:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:48:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:48:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/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:48:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/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:48:34 INFO - Downloaded 24326411 bytes. 05:48:34 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:48:34 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:48:35 INFO - Return code: 0 05:48: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:48:35 INFO - https://queue.taskcluster.net/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:48:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:48:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:48:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/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:48:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/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:48:36 INFO - Downloaded 14403317 bytes. 05:48:36 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:48:36 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:48:37 INFO - Return code: 0 05:48:37 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:37 INFO - https://queue.taskcluster.net/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:48:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:48:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:48:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/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:48:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/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:48:38 INFO - Downloaded 60792860 bytes. 05:48:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:48:38 INFO - mkdir: /builds/slave/test/properties 05:48:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:48:38 INFO - Writing to file /builds/slave/test/properties/build_url 05:48:38 INFO - Contents: 05:48:38 INFO - build_url:https://queue.taskcluster.net/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:48:39 INFO - Running post-action listener: _resource_record_post_action 05:48:39 INFO - Running post-action listener: set_extra_try_arguments 05:48:39 INFO - ##### 05:48:39 INFO - ##### Finished download-and-extract step (success) 05:48:39 INFO - ##### 05:48:39 INFO - ##### 05:48:39 INFO - ##### Running populate-webroot step. 05:48:39 INFO - ##### 05:48:39 INFO - Running pre-action listener: _resource_record_pre_action 05:48:39 INFO - Running main action method: populate_webroot 05:48:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:48:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:48:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:48:39 INFO - '--tppagecycles', 05:48:39 INFO - '7'], 05:48:39 INFO - 'tests': ['tsvgm']}}, 05:48:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:48:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:48:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:48:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:48:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:48:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:48:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:39 INFO - 'talos_options': ['--disable-e10s'], 05:48:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:39 INFO - 'talos_options': ['--disable-e10s'], 05:48:39 INFO - 'tests': ['damp', 'tps']}, 05:48:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:39 INFO - 'tests': ['damp', 'tps']}, 05:48:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:48:39 INFO - 'tests': ['dromaeo_dom']}, 05:48:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:48:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:48:39 INFO - 'tests': ['basic_compositor_video']}, 05:48:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:48:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:48:39 INFO - 'tests': ['a11yr', 05:48:39 INFO - 'ts_paint', 05:48:39 INFO - 'tpaint', 05:48:39 INFO - 'sessionrestore', 05:48:39 INFO - 'sessionrestore_no_auto_restore', 05:48:39 INFO - 'tabpaint']}, 05:48:39 INFO - 'other-e10s': {'tests': ['a11yr', 05:48:39 INFO - 'ts_paint', 05:48:39 INFO - 'tpaint', 05:48:39 INFO - 'sessionrestore', 05:48:39 INFO - 'sessionrestore_no_auto_restore', 05:48:39 INFO - 'tabpaint']}, 05:48:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:48:39 INFO - 'ts_paint', 05:48:39 INFO - 'tpaint', 05:48:39 INFO - 'sessionrestore', 05:48:39 INFO - 'sessionrestore_no_auto_restore', 05:48:39 INFO - 'tabpaint']}, 05:48:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:48:39 INFO - 'ts_paint', 05:48:39 INFO - 'tpaint', 05:48:39 INFO - 'sessionrestore', 05:48:39 INFO - 'sessionrestore_no_auto_restore', 05:48:39 INFO - 'tabpaint']}, 05:48:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:48:39 INFO - 'tests': ['a11yr', 05:48:39 INFO - 'ts_paint', 05:48:39 INFO - 'tpaint', 05:48:39 INFO - 'sessionrestore', 05:48:39 INFO - 'sessionrestore_no_auto_restore', 05:48:39 INFO - 'tabpaint']}, 05:48:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:48:39 INFO - 'tests': ['a11yr', 05:48:39 INFO - 'ts_paint', 05:48:39 INFO - 'tpaint', 05:48:39 INFO - 'sessionrestore', 05:48:39 INFO - 'sessionrestore_no_auto_restore', 05:48:39 INFO - 'tabpaint']}, 05:48:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:48:39 INFO - 'tests': ['tsvgx', 05:48:39 INFO - 'tsvgr_opacity', 05:48:39 INFO - 'tart', 05:48:39 INFO - 'tscrollx', 05:48:39 INFO - 'cart']}, 05:48:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:48:39 INFO - 'tsvgr_opacity', 05:48:39 INFO - 'tart', 05:48:39 INFO - 'tscrollx', 05:48:39 INFO - 'cart']}, 05:48:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:39 INFO - 'talos_options': ['--disable-e10s'], 05:48:39 INFO - 'tests': ['tp5o']}, 05:48:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:39 INFO - 'tests': ['tp5o']}, 05:48:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:39 INFO - 'talos_options': ['--disable-e10s', 05:48:39 INFO - '--xperf_path', 05:48:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:39 INFO - 'tests': ['tp5n']}, 05:48:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:48:39 INFO - 'talos_options': ['--xperf_path', 05:48:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:39 INFO - 'tests': ['tp5n']}}, 05:48:39 INFO - 'talos.zip': {'path': '', 05:48:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:48:39 INFO - Running post-action listener: _resource_record_post_action 05:48:39 INFO - ##### 05:48:39 INFO - ##### Finished populate-webroot step (success) 05:48:39 INFO - ##### 05:48:39 INFO - ##### 05:48:39 INFO - ##### Running create-virtualenv step. 05:48:39 INFO - ##### 05:48:39 INFO - Running pre-action listener: _resource_record_pre_action 05:48:39 INFO - Running main action method: create_virtualenv 05:48:39 INFO - Creating virtualenv /builds/slave/test/build/venv 05:48:39 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:48:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:48:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:48:39 INFO - Using real prefix '/usr' 05:48:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:48:39 INFO - Installing distribute.............................................................................................................................................................................................done. 05:48:41 INFO - Installing pip.................done. 05:48:41 INFO - Return code: 0 05:48:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:41 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 0xb3a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf93b0>, '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 0xdfa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfa740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', '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:48:41 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:48:41 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:48:41 INFO - Using env: {'DISPLAY': ':0', 05:48:41 INFO - 'HOME': '/home/cltbld', 05:48:41 INFO - 'LANG': 'en_US.UTF-8', 05:48:41 INFO - 'LANGUAGE': 'en_US:en', 05:48:41 INFO - 'LOGNAME': 'cltbld', 05:48:41 INFO - 'MAIL': '/var/mail/cltbld', 05:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:41 INFO - 'MOZ_NO_REMOTE': '1', 05:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:41 INFO - 'NO_EM_RESTART': '1', 05:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:41 INFO - 'PWD': '/builds/slave/test', 05:48:41 INFO - 'SHELL': '/bin/bash', 05:48:41 INFO - 'SHLVL': '1', 05:48:41 INFO - 'TERM': 'linux', 05:48:41 INFO - 'TMOUT': '86400', 05:48:41 INFO - 'USER': 'cltbld', 05:48:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', 05:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:41 INFO - '_': '/tools/buildbot/bin/python'} 05:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:42 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:48:42 INFO - Cleaning up... 05:48:42 INFO - Return code: 0 05:48:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:48: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:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:42 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 0xb3a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf93b0>, '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 0xdfa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfa740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', '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:48:42 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:48:42 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:48:42 INFO - Using env: {'DISPLAY': ':0', 05:48:42 INFO - 'HOME': '/home/cltbld', 05:48:42 INFO - 'LANG': 'en_US.UTF-8', 05:48:42 INFO - 'LANGUAGE': 'en_US:en', 05:48:42 INFO - 'LOGNAME': 'cltbld', 05:48:42 INFO - 'MAIL': '/var/mail/cltbld', 05:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:42 INFO - 'MOZ_NO_REMOTE': '1', 05:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:42 INFO - 'NO_EM_RESTART': '1', 05:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:42 INFO - 'PWD': '/builds/slave/test', 05:48:42 INFO - 'SHELL': '/bin/bash', 05:48:42 INFO - 'SHLVL': '1', 05:48:42 INFO - 'TERM': 'linux', 05:48:42 INFO - 'TMOUT': '86400', 05:48:42 INFO - 'USER': 'cltbld', 05:48:42 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', 05:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:42 INFO - '_': '/tools/buildbot/bin/python'} 05:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:42 INFO - Downloading/unpacking psutil>=3.1.1 05:48:42 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:48:42 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:48:42 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:48:42 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:48:42 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:48:42 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:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:48:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:44 INFO - Installing collected packages: psutil 05:48:44 INFO - Running setup.py install for psutil 05:48:44 INFO - building 'psutil._psutil_linux' extension 05:48:44 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:48:44 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:48:44 INFO - building 'psutil._psutil_posix' extension 05:48:44 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:48:44 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:48:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:44 INFO - Successfully installed psutil 05:48:44 INFO - Cleaning up... 05:48:44 INFO - Return code: 0 05:48:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:48:44 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:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:44 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:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:44 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 0xb3a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf93b0>, '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 0xdfa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfa740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', '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:48:44 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:48:44 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:48:44 INFO - Using env: {'DISPLAY': ':0', 05:48:44 INFO - 'HOME': '/home/cltbld', 05:48:44 INFO - 'LANG': 'en_US.UTF-8', 05:48:44 INFO - 'LANGUAGE': 'en_US:en', 05:48:44 INFO - 'LOGNAME': 'cltbld', 05:48:44 INFO - 'MAIL': '/var/mail/cltbld', 05:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:44 INFO - 'MOZ_NO_REMOTE': '1', 05:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:44 INFO - 'NO_EM_RESTART': '1', 05:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:44 INFO - 'PWD': '/builds/slave/test', 05:48:44 INFO - 'SHELL': '/bin/bash', 05:48:44 INFO - 'SHLVL': '1', 05:48:44 INFO - 'TERM': 'linux', 05:48:44 INFO - 'TMOUT': '86400', 05:48:44 INFO - 'USER': 'cltbld', 05:48:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', 05:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:44 INFO - '_': '/tools/buildbot/bin/python'} 05:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:48:47 INFO - Installing collected packages: mozsystemmonitor 05:48:47 INFO - Running setup.py install for mozsystemmonitor 05:48:47 INFO - Successfully installed mozsystemmonitor 05:48:47 INFO - Cleaning up... 05:48:47 INFO - Return code: 0 05:48:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:47 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 0xb3a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf93b0>, '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 0xdfa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfa740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', '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:48:47 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:48:47 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:48:47 INFO - Using env: {'DISPLAY': ':0', 05:48:47 INFO - 'HOME': '/home/cltbld', 05:48:47 INFO - 'LANG': 'en_US.UTF-8', 05:48:47 INFO - 'LANGUAGE': 'en_US:en', 05:48:47 INFO - 'LOGNAME': 'cltbld', 05:48:47 INFO - 'MAIL': '/var/mail/cltbld', 05:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:47 INFO - 'MOZ_NO_REMOTE': '1', 05:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:47 INFO - 'NO_EM_RESTART': '1', 05:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:47 INFO - 'PWD': '/builds/slave/test', 05:48:47 INFO - 'SHELL': '/bin/bash', 05:48:47 INFO - 'SHLVL': '1', 05:48:47 INFO - 'TERM': 'linux', 05:48:47 INFO - 'TMOUT': '86400', 05:48:47 INFO - 'USER': 'cltbld', 05:48:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', 05:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:47 INFO - '_': '/tools/buildbot/bin/python'} 05:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:47 INFO - Downloading/unpacking jsonschema==2.5.1 05:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:48:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:48:49 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:48:49 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:48:49 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:48:49 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:48:49 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:48:49 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:48:49 INFO - Downloading functools32-3.2.3-2.tar.gz 05:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:48:49 INFO - warning: no files found matching '*.txt' 05:48:49 INFO - no previously-included directories found matching 'build' 05:48:49 INFO - no previously-included directories found matching 'dist' 05:48:49 INFO - no previously-included directories found matching '.git*' 05:48:49 INFO - Installing collected packages: jsonschema, functools32 05:48:49 INFO - Running setup.py install for functools32 05:48:49 INFO - warning: no files found matching '*.txt' 05:48:49 INFO - no previously-included directories found matching 'build' 05:48:49 INFO - no previously-included directories found matching 'dist' 05:48:49 INFO - no previously-included directories found matching '.git*' 05:48:49 INFO - Successfully installed jsonschema functools32 05:48:49 INFO - Cleaning up... 05:48:49 INFO - Return code: 0 05:48:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:48: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:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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', '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 0xb3a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf93b0>, '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 0xdfa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfa740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', '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:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:48: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 blobuploader==1.2.4 05:48:49 INFO - Using env: {'DISPLAY': ':0', 05:48:49 INFO - 'HOME': '/home/cltbld', 05:48:49 INFO - 'LANG': 'en_US.UTF-8', 05:48:49 INFO - 'LANGUAGE': 'en_US:en', 05:48:49 INFO - 'LOGNAME': 'cltbld', 05:48:49 INFO - 'MAIL': '/var/mail/cltbld', 05:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:49 INFO - 'MOZ_NO_REMOTE': '1', 05:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:49 INFO - 'NO_EM_RESTART': '1', 05:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:49 INFO - 'PWD': '/builds/slave/test', 05:48:49 INFO - 'SHELL': '/bin/bash', 05:48:49 INFO - 'SHLVL': '1', 05:48:49 INFO - 'TERM': 'linux', 05:48:49 INFO - 'TMOUT': '86400', 05:48:49 INFO - 'USER': 'cltbld', 05:48:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', 05:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:49 INFO - '_': '/tools/buildbot/bin/python'} 05:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:50 INFO - Downloading/unpacking blobuploader==1.2.4 05:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:48:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:48:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 INFO - Downloading docopt-0.6.1.tar.gz 05:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:48:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:48:52 INFO - Running setup.py install for blobuploader 05:48:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:48:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:48:52 INFO - Running setup.py install for requests 05:48:53 INFO - Running setup.py install for docopt 05:48:53 INFO - Successfully installed blobuploader requests docopt 05:48:53 INFO - Cleaning up... 05:48:53 INFO - Return code: 0 05:48:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:53 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 0xb3a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf93b0>, '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 0xdfa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfa740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', '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:48:53 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:48:53 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:48:53 INFO - Using env: {'DISPLAY': ':0', 05:48:53 INFO - 'HOME': '/home/cltbld', 05:48:53 INFO - 'LANG': 'en_US.UTF-8', 05:48:53 INFO - 'LANGUAGE': 'en_US:en', 05:48:53 INFO - 'LOGNAME': 'cltbld', 05:48:53 INFO - 'MAIL': '/var/mail/cltbld', 05:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:53 INFO - 'MOZ_NO_REMOTE': '1', 05:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:53 INFO - 'NO_EM_RESTART': '1', 05:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:53 INFO - 'PWD': '/builds/slave/test', 05:48:53 INFO - 'SHELL': '/bin/bash', 05:48:53 INFO - 'SHLVL': '1', 05:48:53 INFO - 'TERM': 'linux', 05:48:53 INFO - 'TMOUT': '86400', 05:48:53 INFO - 'USER': 'cltbld', 05:48:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', 05:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:53 INFO - '_': '/tools/buildbot/bin/python'} 05:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:53 INFO - Running setup.py (path:/tmp/pip-ZdDJWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:53 INFO - Running setup.py (path:/tmp/pip-UqPdS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:53 INFO - Running setup.py (path:/tmp/pip-Fiyr6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:53 INFO - Running setup.py (path:/tmp/pip-LZXjn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:53 INFO - Running setup.py (path:/tmp/pip-K0gAFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:53 INFO - Running setup.py (path:/tmp/pip-EXXcIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:54 INFO - Running setup.py (path:/tmp/pip-cBJiKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:54 INFO - Running setup.py (path:/tmp/pip-sDPWbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:54 INFO - Running setup.py (path:/tmp/pip-rZCLYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:54 INFO - Running setup.py (path:/tmp/pip-bvB1pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:54 INFO - Running setup.py (path:/tmp/pip-nsxhSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:54 INFO - Running setup.py (path:/tmp/pip-2gHAGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:54 INFO - Running setup.py (path:/tmp/pip-_zmlH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:54 INFO - Running setup.py (path:/tmp/pip-Fa7Kqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:54 INFO - Running setup.py (path:/tmp/pip-UwbkGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:54 INFO - Running setup.py (path:/tmp/pip-rrUNvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:54 INFO - Running setup.py (path:/tmp/pip-hLnU5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:48:54 INFO - Running setup.py install for manifestparser 05:48:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:48:54 INFO - Running setup.py install for mozcrash 05:48:54 INFO - Running setup.py install for mozdebug 05:48:55 INFO - Running setup.py install for mozdevice 05:48:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Running setup.py install for mozfile 05:48:55 INFO - Running setup.py install for mozhttpd 05:48:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Running setup.py install for mozinfo 05:48:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Running setup.py install for mozInstall 05:48:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Running setup.py install for mozleak 05:48:55 INFO - Running setup.py install for mozlog 05:48:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Running setup.py install for moznetwork 05:48:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:48:55 INFO - Running setup.py install for mozprocess 05:48:56 INFO - Running setup.py install for mozprofile 05:48:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:48:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:48:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:48:56 INFO - Running setup.py install for mozrunner 05:48:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:48:56 INFO - Running setup.py install for mozscreenshot 05:48:56 INFO - Running setup.py install for moztest 05:48:56 INFO - Running setup.py install for mozversion 05:48:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:48:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:48:56 INFO - Cleaning up... 05:48:56 INFO - Return code: 0 05:48:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:56 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 0xb3a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf93b0>, '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 0xdfa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfa740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', '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:48:56 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:48:56 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:48:56 INFO - Using env: {'DISPLAY': ':0', 05:48:56 INFO - 'HOME': '/home/cltbld', 05:48:56 INFO - 'LANG': 'en_US.UTF-8', 05:48:56 INFO - 'LANGUAGE': 'en_US:en', 05:48:56 INFO - 'LOGNAME': 'cltbld', 05:48:56 INFO - 'MAIL': '/var/mail/cltbld', 05:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:56 INFO - 'MOZ_NO_REMOTE': '1', 05:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:56 INFO - 'NO_EM_RESTART': '1', 05:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:56 INFO - 'PWD': '/builds/slave/test', 05:48:56 INFO - 'SHELL': '/bin/bash', 05:48:56 INFO - 'SHLVL': '1', 05:48:56 INFO - 'TERM': 'linux', 05:48:56 INFO - 'TMOUT': '86400', 05:48:56 INFO - 'USER': 'cltbld', 05:48:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', 05:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:56 INFO - '_': '/tools/buildbot/bin/python'} 05:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:56 INFO - Running setup.py (path:/tmp/pip-IIuPpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:56 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:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:56 INFO - Running setup.py (path:/tmp/pip-mZehGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:56 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:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:56 INFO - Running setup.py (path:/tmp/pip-r_DHDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:57 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:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:57 INFO - Running setup.py (path:/tmp/pip-EwayXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:57 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:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:57 INFO - Running setup.py (path:/tmp/pip-kYMu55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:57 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:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:57 INFO - Running setup.py (path:/tmp/pip-F2Q1UF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:57 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:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:57 INFO - Running setup.py (path:/tmp/pip-rCURI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:57 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:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:57 INFO - Running setup.py (path:/tmp/pip-XRPISo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:57 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:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:57 INFO - Running setup.py (path:/tmp/pip-5KaRTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:57 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:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:57 INFO - Running setup.py (path:/tmp/pip-mWhuNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:57 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:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:57 INFO - Running setup.py (path:/tmp/pip-ipOjQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:57 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:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:57 INFO - Running setup.py (path:/tmp/pip-5f5IfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:57 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:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:57 INFO - Running setup.py (path:/tmp/pip-sCUVX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:57 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:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:57 INFO - Running setup.py (path:/tmp/pip-GyGCI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:57 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:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:57 INFO - Running setup.py (path:/tmp/pip-jgvNcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:57 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:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:57 INFO - Running setup.py (path:/tmp/pip-NChcDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:57 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:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:57 INFO - Running setup.py (path:/tmp/pip-VrEh1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:58 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:48:58 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:48:58 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:48:58 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:48:58 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:48:58 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:48:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:00 INFO - Downloading blessings-1.6.tar.gz 05:49:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:49:00 INFO - Installing collected packages: blessings 05:49:00 INFO - Running setup.py install for blessings 05:49:00 INFO - Successfully installed blessings 05:49:00 INFO - Cleaning up... 05:49:00 INFO - Return code: 0 05:49:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:49:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:00 INFO - Reading from file tmpfile_stdout 05:49:00 INFO - Current package versions: 05:49:00 INFO - argparse == 1.2.1 05:49:00 INFO - blessings == 1.6 05:49:00 INFO - blobuploader == 1.2.4 05:49:00 INFO - docopt == 0.6.1 05:49:00 INFO - functools32 == 3.2.3-2 05:49:00 INFO - jsonschema == 2.5.1 05:49:00 INFO - manifestparser == 1.1 05:49:00 INFO - mozInstall == 1.12 05:49:00 INFO - mozcrash == 0.17 05:49:00 INFO - mozdebug == 0.1 05:49:00 INFO - mozdevice == 0.48 05:49:00 INFO - mozfile == 1.2 05:49:00 INFO - mozhttpd == 0.7 05:49:00 INFO - mozinfo == 0.9 05:49:00 INFO - mozleak == 0.1 05:49:00 INFO - mozlog == 3.2 05:49:00 INFO - moznetwork == 0.27 05:49:00 INFO - mozprocess == 0.23 05:49:00 INFO - mozprofile == 0.28 05:49:00 INFO - mozrunner == 6.12 05:49:00 INFO - mozscreenshot == 0.1 05:49:00 INFO - mozsystemmonitor == 0.3 05:49:00 INFO - moztest == 0.7 05:49:00 INFO - mozversion == 1.4 05:49:00 INFO - psutil == 3.1.1 05:49:00 INFO - requests == 1.2.3 05:49:00 INFO - wsgiref == 0.1.2 05:49:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:00 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 0xb3a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf93b0>, '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 0xdfa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfa740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', '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:49:00 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:49:00 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:49:00 INFO - Using env: {'DISPLAY': ':0', 05:49:00 INFO - 'HOME': '/home/cltbld', 05:49:00 INFO - 'LANG': 'en_US.UTF-8', 05:49:00 INFO - 'LANGUAGE': 'en_US:en', 05:49:00 INFO - 'LOGNAME': 'cltbld', 05:49:00 INFO - 'MAIL': '/var/mail/cltbld', 05:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:00 INFO - 'MOZ_NO_REMOTE': '1', 05:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:00 INFO - 'NO_EM_RESTART': '1', 05:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:00 INFO - 'PWD': '/builds/slave/test', 05:49:00 INFO - 'SHELL': '/bin/bash', 05:49:00 INFO - 'SHLVL': '1', 05:49:00 INFO - 'TERM': 'linux', 05:49:00 INFO - 'TMOUT': '86400', 05:49:00 INFO - 'USER': 'cltbld', 05:49:00 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', 05:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:00 INFO - '_': '/tools/buildbot/bin/python'} 05:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:00 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:49:00 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:49:00 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:49:00 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:49:00 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:49:00 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:49:00 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:49:00 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:49:00 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:49:00 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:49:00 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:49:00 INFO - Cleaning up... 05:49:00 INFO - Return code: 0 05:49:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:00 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 0xb3a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc9d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf93b0>, '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 0xdfa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfa740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', '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:49:00 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:49:00 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:49:00 INFO - Using env: {'DISPLAY': ':0', 05:49:00 INFO - 'HOME': '/home/cltbld', 05:49:00 INFO - 'LANG': 'en_US.UTF-8', 05:49:00 INFO - 'LANGUAGE': 'en_US:en', 05:49:00 INFO - 'LOGNAME': 'cltbld', 05:49:00 INFO - 'MAIL': '/var/mail/cltbld', 05:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:00 INFO - 'MOZ_NO_REMOTE': '1', 05:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:00 INFO - 'NO_EM_RESTART': '1', 05:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:00 INFO - 'PWD': '/builds/slave/test', 05:49:00 INFO - 'SHELL': '/bin/bash', 05:49:00 INFO - 'SHLVL': '1', 05:49:00 INFO - 'TERM': 'linux', 05:49:00 INFO - 'TMOUT': '86400', 05:49:00 INFO - 'USER': 'cltbld', 05:49:00 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', 05:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:00 INFO - '_': '/tools/buildbot/bin/python'} 05:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:49:01 INFO - Cleaning up... 05:49:01 INFO - Return code: 0 05:49:01 INFO - Running post-action listener: _resource_record_post_action 05:49:01 INFO - Running post-action listener: _start_resource_monitoring 05:49:01 INFO - Starting resource monitoring. 05:49:01 INFO - ##### 05:49:01 INFO - ##### Finished create-virtualenv step (success) 05:49:01 INFO - ##### 05:49:01 INFO - ##### 05:49:01 INFO - ##### Running install step. 05:49:01 INFO - ##### 05:49:01 INFO - Running pre-action listener: _resource_record_pre_action 05:49:01 INFO - Running main action method: install 05:49:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:01 INFO - Reading from file tmpfile_stdout 05:49:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:49:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:49:01 INFO - Reading from file tmpfile_stdout 05:49:01 INFO - Output received: 05:49:01 INFO - Usage: mozinstall [options] installer 05:49:01 INFO - Options: 05:49:01 INFO - -h, --help show this help message and exit 05:49:01 INFO - -d DEST, --destination=DEST 05:49:01 INFO - Directory to install application into. [default: 05:49:01 INFO - "/builds/slave/test"] 05:49:01 INFO - --app=APP Application being installed. [default: firefox] 05:49:01 INFO - mkdir: /builds/slave/test/build/application 05:49:01 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:49:01 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:49:18 INFO - Reading from file tmpfile_stdout 05:49:18 INFO - Output received: 05:49:18 INFO - /builds/slave/test/build/application/firefox/firefox 05:49:18 INFO - Running post-action listener: _resource_record_post_action 05:49:18 INFO - ##### 05:49:18 INFO - ##### Finished install step (success) 05:49:18 INFO - ##### 05:49:18 INFO - ##### 05:49:18 INFO - ##### Running run-tests step. 05:49:18 INFO - ##### 05:49:18 INFO - Running pre-action listener: _resource_record_pre_action 05:49:18 INFO - Running main action method: run_tests 05:49:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:49:18 INFO - Python 2.7.3 05:49:18 INFO - Return code: 0 05:49:18 INFO - grabbing minidump binary from tooltool 05:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:18 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 0xdf93b0>, '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 0xdfa2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfa740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:49:18 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:49:18 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:49:18 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:49:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:49:18 INFO - Return code: 0 05:49:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:49:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:49:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:49:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:49:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:49:18 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/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:49:18 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/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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:49:18 INFO - Using env: {'DISPLAY': ':0', 05:49:18 INFO - 'HOME': '/home/cltbld', 05:49:18 INFO - 'LANG': 'en_US.UTF-8', 05:49:18 INFO - 'LANGUAGE': 'en_US:en', 05:49:18 INFO - 'LOGNAME': 'cltbld', 05:49:18 INFO - 'MAIL': '/var/mail/cltbld', 05:49:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:49:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:18 INFO - 'MOZ_NO_REMOTE': '1', 05:49:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:18 INFO - 'NO_EM_RESTART': '1', 05:49:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:18 INFO - 'PWD': '/builds/slave/test', 05:49:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:49:18 INFO - 'SHELL': '/bin/bash', 05:49:18 INFO - 'SHLVL': '1', 05:49:18 INFO - 'TERM': 'linux', 05:49:18 INFO - 'TMOUT': '86400', 05:49:18 INFO - 'USER': 'cltbld', 05:49:18 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098', 05:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:18 INFO - '_': '/tools/buildbot/bin/python'} 05:49:18 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/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:49:18 INFO - mozversion application_buildid: 20160714030208 05:49:18 INFO - mozversion application_changeset: 08f8a5aacd8308a73f6040fe522be7ba38497561 05:49:18 INFO - mozversion application_display_name: Nightly 05:49:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:49:18 INFO - mozversion application_name: Firefox 05:49:18 INFO - mozversion application_remotingname: firefox 05:49:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:49:18 INFO - mozversion application_vendor: Mozilla 05:49:18 INFO - mozversion application_version: 50.0a1 05:49:18 INFO - mozversion platform_buildid: 20160714030208 05:49:18 INFO - mozversion platform_changeset: 08f8a5aacd8308a73f6040fe522be7ba38497561 05:49:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:49:18 INFO - mozversion platform_version: 50.0a1 05:49:18 INFO - using testdate: 1468500558 05:49:18 INFO - actual date: 1468500558 05:49:18 INFO - starting webserver on 'localhost:41678' 05:49:18 INFO - SUITE-START | Running 2 tests 05:49:18 INFO - TEST-START | dromaeo_css 05:49:18 INFO - operating with platform_type : linux_ 05:49:18 INFO - Initialising browser for dromaeo_css test... 05:49:18 INFO - TEST-INFO | started process 1235 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsVUj7M/profile http://localhost:41678/getInfo.html) 05:49:23 INFO - PROCESS | 1235 | __metrics Screen width/height:1600/1200 05:49:23 INFO - PROCESS | 1235 | colorDepth:24 05:49:23 INFO - PROCESS | 1235 | Browser inner width/height: 1024/697 05:49:23 INFO - PROCESS | 1235 | __metrics 05:49:24 ERROR - PROCESS | 1235 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 05:49:25 INFO - TEST-INFO | 1235: exit 0 05:49:25 INFO - Browser initialized. 05:49:25 INFO - Running cycle 1/1 for dromaeo_css test... 05:49:25 INFO - TEST-INFO | started process 1367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsVUj7M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:37 INFO - PROCESS | 1367 | RSS: Main: 167944192 05:49:37 INFO - PROCESS | 1367 | 05:50:26 INFO - PROCESS | 1367 | 1468500626729 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:52:34 INFO - PROCESS | 1367 | Cycle 1(1): loaded http://localhost:41678/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41678/tests/dromaeo/cssquery-ext.html) 05:52:36 INFO - PROCESS | 1367 | RSS: Main: 171978752 05:52:36 INFO - PROCESS | 1367 | 05:55:38 INFO - PROCESS | 1367 | Cycle 1(1): loaded http://localhost:41678/tests/dromaeo/cssquery-ext.html (next: http://localhost:41678/tests/dromaeo/cssquery-jquery.html) 05:55:38 INFO - PROCESS | 1367 | RSS: Main: 167919616 05:55:38 INFO - PROCESS | 1367 | 05:58:40 INFO - PROCESS | 1367 | Cycle 1(1): loaded http://localhost:41678/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41678/tests/dromaeo/cssquery-mootools.html) 05:58:41 INFO - PROCESS | 1367 | RSS: Main: 171708416 05:58:41 INFO - PROCESS | 1367 | 06:01:43 INFO - PROCESS | 1367 | Cycle 1(1): loaded http://localhost:41678/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41678/tests/dromaeo/cssquery-prototype.html) 06:01:43 INFO - PROCESS | 1367 | RSS: Main: 166658048 06:01:43 INFO - PROCESS | 1367 | 06:04:46 INFO - PROCESS | 1367 | Cycle 1(1): loaded http://localhost:41678/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41678/tests/dromaeo/cssquery-yui.html) 06:04:47 INFO - PROCESS | 1367 | RSS: Main: 169578496 06:04:47 INFO - PROCESS | 1367 | 06:07:50 INFO - PROCESS | 1367 | Cycle 1(1): loaded http://localhost:41678/tests/dromaeo/cssquery-yui.html (next: http://localhost:41678/tests/dromaeo/cssquery-dojo.html) 06:07:50 INFO - PROCESS | 1367 | RSS: Main: 170336256 06:07:50 INFO - PROCESS | 1367 | 06:07:50 INFO - PROCESS | 1367 | __start_tp_report 06:07:50 INFO - PROCESS | 1367 | _x_x_mozilla_page_load 06:07:50 INFO - PROCESS | 1367 | _x_x_mozilla_page_load_details 06:07:50 INFO - PROCESS | 1367 | |i|pagename|runs| 06:07:50 INFO - PROCESS | 1367 | |0;dojo.html;3056.5873607063045;3105.0684794561625;3133.1383869435904;3134.717875391215;3143.9685603143976;5484.670919744818;5528.7788488460465;5549.250851135095;5627.859303517414;5636.605437619368;5445.128779395298;5493.066178749612;5497.312835895513;5548.0845660465975;5597.020521408747;4950.15847305958;4969.751512424365;5070.29015937769;5116.8976620467565;5156.407013193474;805.4938696976634;4956.281339205813;4962.106820772259;4992;5086.593072554187;4998.2002879539095;5003.899922001576;5032.295478632976;5041.218611115283;5047.217681259411;5056.696598204083;5073.822416215452;5107.642465027449;5110.28456016158;5120.539151476385;4966.354373931402;4981.775820088104;5024.271480635324;5044.54599086084;5067.0879241736475;5527.50252477279;5531.834044978657;5538.141588053858;5546.057170281021;5610.354809196954;5729.627574207663;5902.6163299385835;5926.140709597084;5970.04479283317;5974.044152935553;5969.5821292509545;6004.189434426384;6017.548683848685;6032.66820324882;6085.087236914454;5567;5599.356074051455;5600.5799565032785;5608.523275521586;5612.438756124355;5963.373845746221;6094.177286066324;6127.908081378783;6148;6160.229971253593;5849.093390524476;5854.18041474194;5864.648121112747;5869.119632055141;5872.324682661549;6003.939960600425;6021.307549631761;6033.215681961317;6041.335453100155;6048.818535443944;5888.676122813286;5913.733881975321;5940.940590594125;5980.55145864062;5991.191189189403;5980.760769569256;5987.43119403656;5990.430909063632;6007.579469437185;6008.879822403527;4476.865694029184;4572.6799124061;4577.496475387705;4582.106489234634;4623.953760462352;3962.167944731581;4004.039030632627;4008.8997775055273;4030.5767894371256;4079.326911059701;5665.433456654384;5704.80033198836;5711.657300561979;5753.626014309057;5769;5834.3290521589715;5948.405159484104;6008.279006519246;6013.849653758691;6041.969790151021;5636.154576813511;5640.238567793295;5723.513501352349;5747.827565173052;5754.913676294859;5197.220416937414;5203.531682148625;5209.791608335624;5222.7127507987425;5242.318498595235;6237.656928868865;6251.156093927261;6253.37466253371;6264.029075493306;6276.717547710364;5899.616524925866;5998.610090344114;6019.759209631653;6020.277566692025;6026.427489388501;6343.080253363329;6354.968225158845;6358.427741503102;6359.427651511386;6369.617822930639;5962.25471816023;5966;5970.164177015308;5972.552058595709;5977;5774.94225057744;5865.794697185578;5882.176495290748;5912.113183022409;6032.3967603239325;5787.681677507778;5814.680192589448;5815.680137592304;5818.970905145617;5827.650340979555;5793.826185214451;5799.681017544076;5802.709864506842;5803.245578074823;5805.129230615273;5628.324601047737;5718.885622287614;5746.42535746422;5759.51044161251;5792.391798861059;5821.155932389865;5835.766569337179;5886.381929897299;5887.499562537232;5888.146218798164;5578.107502799533;5758.856028599319;5762.250907382014;5767;5783.450572195635 06:07:50 INFO - PROCESS | 1367 | |1;ext.html;552.8777998298835;577.3937365765946;588.8233529941017;606.3602898941616;615.0773839241139;39001.80499097504;44919.326210106876;44934.77532612332;44935.77532112335;45046.77476612617;43301;43795.56204437955;43824.12351752963;43902.34146487797;44086.7795661022;8952.060033696465;9006.96419911712;9050.27597792175;9058.411203271799;9094.408863423856;8906.955465222698;8963.731088067336;8965.820683586324;8998.730038098867;9035.232005279559;8968.327375446836;9028.32287578431;9082.727518174466;9089.500077495735;9104.36269461138;9020.188183063523;9043.864342034874;9060.909390906105;9066.048064953216;9075.591598378089;8959.193672569434;8983.460992340415;9046.547672616343;9049.592768325441;9059.094090590954;33514.6648533514;42846.57153428457;43377.34933975993;43439.565604343865;43484.56515434868;3351.514030465569;3636.7636103653444;3897.5850511228027;4335.479742430897;4517.706349087299;31711.365772684418;31934.201644959063;33237.6676233237;35295.823520882484;35689;4455.955440445587;4596.931046034312;4627.421572303462;4766.571008609207;4806.75966201692;383189;391526.99999999715;395970;397814;398652;35562.64437355645;36459;65116;65492;65995.34004659989;38119.61880381216;38283.425748613794;38437.615623843965;38474.6152538471;38592.61407385946;16087.356505739874;16106.838931610533;16345.918270408572;16390.180490975403;16443.917780411022;13532.661683457993;13566.728665426635;13644.795328070088;13655.180689158682;13666.658333541542;8477.152284771597;8517.48895066298;8609.311255099577;8620.91379086201;8654;3350.4974253862115;3398.3713013092656;3404.0808981575333;3404.14896275931;3440.122768694017;1030.8762948446235;1033.8242498775226;1034.906858382749;1099.961501347465;1129.0346753525616;33790.15524611855;33855.49216761751;33917.83041084779;34123.658763412546;34148.48777268343;1106;1118.2284223885656;1146.6574934067266;1191.1007189571817;1194.940252987347;16461.423850165185;17457.301707931794;17527.38654147124;17660.293588256583;17710.29158833658;602639;602963;603682;604778;608202;61026.69486652538;61834;62002.689986549776;62226.37773622297;62229.37770622236;1314.5530519623182;1347.6226656536185;1372.5196181336653;1374.066368303679;1392.484780631173;32269.35461290808;33258.334833303685;33280.334393312485;33708.831455843545;33740.49389259114;54770.726146369016;54800.45199547953;55353.16970245369;55477.722611386685;55587.72206138943;488561;489246;489890;491631;491661;28692.71307286984;29170.708292917647;29245.85377073101;29412.852935735184;30745.231369215948;49653.50346496489;50634.49365506298;50897.74551127221;51110;52107.478925210264;42647.57352426436;43255.567444325156;43500;43877.56122438735;44561;43160.78419607882;43262.56737432585;43357.56642433535;43581.78209108934;43798;42088;42753.358699620156;42881.35677964771;43365.566344336155;43387.132257354046;36780.81609591935;38779.418308724824;39168.6083139165;39256;39482.60517394904;28683.85658071696;28687.522974060223;29449.263768405963;29569.85215073911;29687.85156074292 06:07:50 INFO - PROCESS | 1367 | |2;jquery.html;385.84180486000747;387.19270321379923;390.340324851002;394.1525719702639;413.18396167569057;14093.859061409383;18854.245830166776;19877.714062882773;20642.793572064274;20672.896635516838;19282.61434771307;19556.413307600797;19559.511012224666;20484.89757551214;20588.176472941064;5802.303723553169;5979.252593425822;6002.339742628307;6024.9698751506185;6041;5796;5881.059030555112;5893.941060589404;5919.88160236795;5940.019896717036;5743.224664670279;5826.504747096481;5854.20968169296;5883.588148829584;5915.349311575745;5783.479486846162;5837.562182836305;5841.941580584204;5846.7076646167525;5867.442592953663;5157.819476318348;5228.320318358589;5229.843104706865;5241.921371179397;5275.894482110336;24345.1479198229;24419.63370549443;24431.389215269584;24702.76486175684;24780.25659230226;2390.3904504351453;2514.59766437371;2652.071774878796;2705.40481094159;3078.815271083742;15009.474668386554;15488.767668484981;15574.221288935621;15624.921875390664;16047.438339658056;1970.1036028607093;2045.3148195354424;2084.791520847918;2091.26805618034;2105.221068204774;83394;84742.57628711879;85951.57024214901;85994.57002715008;88046.11953880443;10743.51654175564;10743.623973161059;10910.454477276104;10965.671029869116;11022.118230541537;15000.849991500163;15017.924910375597;15080.472183473526;15095.169765662775;15104.169270690218;8376.916230837736;8688.565571721389;8704.216620504058;8815.338849586307;8826.249768769727;8339.708110216114;8415.579221038923;8470.618822152896;8656.61045252965;8775.912240877637;6640.701168447432;6643.900341494881;6786.76246331376;6800.829979250559;6802.931970680329;1921.5580416504004;1927.4795805132535;1945.9902700486407;1949.1618604000132;1979.9901000494906;955.5365647660878;1047.2145890582065;1053.8155822730992;1058.2486434631344;1077.450500244865;20708.378748637566;21271;21294.467638308855;21307.8934605326;21409.892950535148;1037.3257382701304;1039.8180318444242;1050.579768092769;1104.8839871813343;1109.5007246738999;11613.36126513033;11973.476037673105;12048.819267710991;12055.517779288906;12159.635210943687;498930;506266;513894;514992;524033;84425.57787211024;91295;104710.4764476188;110119;110246;1030.3354336452946;1046.210111365914;1070.314998401024;1090.8145615245428;1103.823388257875;18491.167897444917;18753.812461875754;19051.19013693697;19081.42755717331;19383.641413085385;31309;34650.82674586611;43075.784621076695;43286.78356608323;43568.580821150936;60501.39498604958;65761.34238657744;66297.66851165713;66478.33521664722;66992.3300766986;8531.91468085336;8848.867266991128;8928.687495937611;8938.124508114175;9045.366824322235;9666.661666841626;13422.731545369234;13789;14122;14265.786013210018;11977.940110299392;12241.938790305992;12419.875801241871;12474.18917770342;12620.873791261969;11911.880881191077;11960.342181180118;12127.272363657856;12170.939145304217;12397.876021239672;12166.148369614042;12336.383180840743;12592.118551701293;12692.301923394301;12824.166429182073;8667.479951202948;8772.122787721431;8857.335699822668;9015.81968360616;9015.864762028443;11194.44027798623;11773.88226117728;12236.877631223573;12422.565210217599;12485.687857803627 06:07:50 INFO - PROCESS | 1367 | |3;mootools.html;1505.2172870107545;1528.7783271425642;1715.2624371520242;1814.8094450082733;1869;7859.29266366027;8674.783130421743;8743.475391476515;9293.721188364352;9299;8740.562971851414;9024.323175761827;9103.954480227607;9111.68109116181;9113.45319280842;2370.9881450592766;2407.8555286682767;2413.2880800163907;2414.9034038638433;2421.128393778238;2373.905043798246;2401.0755858994326;2422.6729391532094;2423.442608200115;2436.841605295659;2381.3927448500694;2382.2376839411395;2400.9555843208173;2409.084547871806;2419.189571493543;2348.659444380555;2351.1535847095033;2360.221127028077;2362.6456031595226;2363.9409014774596;2276.8292378071546;2296.5866144094057;2310.318456055468;2318.4783423729696;2318.7565305642834;9024;9098.181163695233;9131.634734610607;9138.634454621808;9197.448153110769;5334.413214546396;5517.862053448655;5555.833325000256;5558.777648894039;5559.833205003816;3350.8492117854753;3382.594088709346;3431.811250381228;3444.9827750861336;3455.6371580983887;1021.2902033087007;1026.8305729554615;1043.8674038668055;1071.0788721699332;1084.3060441317564;12537.122401431903;12692.365381730877;12727.618171454871;12740.980721542348;12742.872571274354;4727.550882666142;4822.180229361017;4825.346787508129;4913.87715307113;4938.654294199371;10540.051395374454;10638.361698298128;10646.201534884915;10655;10658.360498369968;5458.699771512605;5458.808941687102;5469.15228139639;5479.671219726829;5503.036968530491;4400.713953593006;4905.386826646669;4990.426100998359;5043.092243396224;5051.06555287273;4010.538788039413;4042.6159514846045;4082.3060079786505;4107.151781698248;4113.835446582163;1291.2704322058007;1305.3929922586044;1320.3464285178898;1326.9203847769165;1327.8472975607929;969.7575606098476;976.3409698453515;1030.6650338639972;1038.055369613648;1045.2369770067742;6315.147455093595;6334.873302533923;6454.290028096905;6559.180102487189;6599.53803233769;1008.8133695266399;1029.073833549811;1032.2155162076876;1033.194108595297;1070.2294348069377;4319.07139964909;4590.40324757786;4620.4686461056735;4627.190241707688;4636.466806317317;11091.72270693223;11393.715157120972;11423.200375973602;11423.314601123959;11526.94236528812;10879.238453308193;11304.321740695585;11352.602658906899;11371.488283027284;11410.885891141148;8199.549024803573;8273.379496537784;8344.958275208584;8345.791355216168;8348.707795227137;6347.365263473615;6492.513061520311;6667.433268172065;6715.4627629790475;6729.427998620172;10256.07695307426;10356.326838755456;10628.734281643021;10656.360618362924;10771.784564308513;10683.839742404025;10721.624743133953;10728.624498142528;10809.189310801565;10816.729581760519;7927.920720792718;8040.195980401913;8111.594420279081;8117.715879944174;8131.024277086787;9028.322875784474;9035.683751068682;9055.501947392957;9074.45553266806;9129;7945.920540794749;8139.674413023413;8157.06193787722;8287.212714792326;8314.750557483285;7742.225777422438;7789.5715735635085;7934.325582325336;8047.83904321922;8064.596770161351;7227.349538541556;7237.63811809418;7274.054372931485;7300.780976570712;7332.523385979895;5095.15929871567;5138.254953031864;5186.170212765939;5220.738963051908;5245;4907.288443175791;4928.728919909296;4936.827211047596;5005.149124648746;5025.497450255091 06:07:50 INFO - PROCESS | 1367 | |4;prototype.html;313.9152428844212;322.66604064792944;324.99576309204554;334.7673367009928;336.42639299993516;5466;5591;5631.943680563193;5687.289088863892;5714.971425142874;5521.171824226358;5529.889402211953;5555.944440555593;5611.915821262684;5649.209110724501;4378.190034843564;4379.627731642814;4385.671074669397;4393.626541743955;4404.361367601696;4115.9176816463805;4202.70581059326;4292.163028209485;4300.204462174508;4330.870073897788;4266.8293268269235;4276.166147601219;4283.207606592775;4287.528371879091;4308.0737641407095;4274.7435153890865;4316.633086187678;4317.784110794448;4320.524742278347;4330.415393921811;3686.391745362012;3742.700583953277;3748.100455890594;3748.306563285801;3756.5116534850567;5305.389880163753;5329.440408757102;5348.983693098299;5363.356397232357;5388.461153884619;4837.371141751585;4850.5877000455;4889.242167464014;4891.804327826882;4913.8771530711665;5533.501984821345;5742.454466825687;5763.567732420085;5769.682667453289;5779.3642699303045;4202.835539697058;4224.788760561991;4253.617174454314;4264.275073237526;4268.637165840907;5995.640261584275;6087.6956152192215;6111.602745821552;6123.142760013601;6123.8162855114415;4231.30183519722;4334.43960174337;4336.761478118734;4367.711525100103;4381.3208952612395;4362.192994296065;4378.365137055172;4403.4495688039;4404.207242696281;4407.933880991788;4962.404511458648;4979.30289759434;4996.000799840047;5001.4998500149695;5035.723035233024;5738.311402631627;5840.620359676607;5844.26946631671;5858.443447872445;5860.853478663067;1512.9319180636678;1527.5188315680525;1535.5239875638588;1543.104999100519;1545.5749668840933;957.3155194036298;985.4136788610765;988.9851652225223;994.7761753605381;1004.0561871840447;5030.89938201234;5040.823571174991;5523.502884740393;5683.318001839806;5735.311762588516;6021.2473440819895;6024.493876530867;6038.516918646497;6064.302605200371;6114.6636934969;5539.6150962259435;5684.129514595103;5720.942790572041;5758.539316854725;5777.162311464814;3149.4331020416544;3171.63526194486;3176.5552822604855;3188;3192.840357982138;6246.843828904223;6248.4064013918605;6260.372303201109;6277.686115694197;6279.780207692709;5868.618539794985;6063.998880369468;6161.7227224775;6186.505079593621;6188.319284878659;6258.249010118815;6283.6858157091965;6311.936880631135;6329.240491141092;6333.276691022812;5885.529157667291;5973.5519836013345;5994.553131949234;6053.485453736305;6061.515078793598;5888.793892213924;5928.199693041384;5956.523478121827;5999.5800293979;6044.546659000681;6017.398260173947;6286.748530058747;6286.811395658137;6300.149479820166;6321.0834429008455;4203.138356636943;4213;4231.894202644959;4235.110626768414;4261.595148460891;6066.939330606638;6071.512479442565;6098.664573448503;6106;6110.541709371903;5606.579506537108;5860.208871802422;5866.3547009828035;5907.527397808251;5931.9406805931385;5838.182654428469;5841.474267315792;5852.4440178183;5853.824385268449;5893.852653683693;5713.9142912855505;5830;5860.970695146497;5885.411458854252;5895.29256489224;5327.9733601331745;5820.505257053198;5877;5886.146508756121;5899.646021238739;5757.165211044291;5765.308163020464;5771.509421699203;5835.94164058354;5852.561057920758 06:07:50 INFO - PROCESS | 1367 | |5;yui.html;729.8722723523385;753.3069575990089;765.5827573972184;775.352580595203;844.2064459408156;13938.651533711649;14744.631384215374;14764.187969661665;14840.25798710063;14927.253637318132;15093.169875656835;15405.152716600582;15424.383024679028;15441;15459.69080618387;655.6852710698868;775.9224077592224;797.131127071492;799.5083023940264;800.7998000499875;801.1387758159972;804.2761514636816;804.569555287921;808.8584497712877;811.853866304065;867.7353407210799;868.7437206024207;869.5174178331024;872.014623475475;872.2193636695154;857.1685465098844;859.5401460218816;864.3301441382947;864.9048604653483;865.1391865094208;624.6501958903029;625.1591609285549;630.0203184048802;630.0832289019512;630.2972186012609;15124.697506049928;15132.470363537333;15186.164760938143;15211.771823422658;15239.619009524851;14236.501722439769;14303.141811491343;14415.78376324356;14490.347934342979;14498.130112193303;12521.56174533887;12602.306873121976;12677.809832852514;12834.80747788784;13240.602781916557;3975.1453437511072;4001.779902105383;4101.384792281152;4156.750594964312;4161.791910404468;79389;79865.60067199628;80267;80531.5973420135;80998;11734.530618775154;11951.91688747175;12138.08964327679;12248.571300004634;12526.185797923106;21633.242836500645;21990.560188796135;22010.559788804134;22104.668429973564;22205.22281720132;8379.120192379834;8494.53280069602;8972.237359824358;9202.263818894473;9210.493422861673;4812.398450193726;4939.90120197594;4980.053789780002;5008.248762685554;5174.948250517522;3403.50649155871;3427.5886893572433;3491;3492.93465493022;3500.824958752052;601.2364297342351;623.5697368815503;626.3642402960999;664.64773669955;720.3049057659384;619.1332135011021;658.8616390557941;682.4097155960059;763.9197884222187;803.7910143362768;9711.223102151811;9822.312438129406;10124;10207.132393746466;10255.641052563124;681.4105798484276;722.6278466589711;723.5441671746871;731.7694926098262;768.0744702633314;4454.175977444183;4801.879953001203;4858.368412106403;4882.145624515767;4933.186024306021;101013.49493252486;114866;123237.38381308036;126610;126855.36572317264;88057;102979;103173.48413257886;103521.48239258755;103551.4822425883;64295.35704642894;71042;89234.55382723045;89627;92716;10178;10437.16502679799;10590.364578125336;10833.133349331876;10907.29102608328;54123;54373.72813135909;54447.45552544424;55257;55380;71846.64076679583;72816;79786;81301.59349203453;82633.58683206786;13802.86197138056;13811.768465625279;13874.722505549631;13970.231637260049;14392.064515806858;15269.312880920608;15610.141442220787;15676.662009575894;15746;16024.519264422086;14424.783628245375;14578.416863325772;14729.263536822902;14757.92621036888;14834.703305933604;13649.931750341184;13804.792928105886;14249.430022799386;14512.376975842193;14761.335739891945;13993.860061399255;14148.858511414754;14375.13749175011;14890.85109148938;14910.627234318796;10288;10344.586426351983;10638.946805265925;10941.83587246208;10979.87469430075;8665.2634526066;8944.239739622206;9976.650817221362;9978.401295922267;10008.599656013968 06:07:50 INFO - PROCESS | 1367 | __end_tp_report 06:07:50 INFO - PROCESS | 1367 | __start_cc_report 06:07:50 INFO - PROCESS | 1367 | _x_x_mozilla_cycle_collect,348 06:07:50 INFO - PROCESS | 1367 | __end_cc_report 06:07:50 INFO - PROCESS | 1367 | __startTimestamp1468501670327__endTimestamp 06:07:50 INFO - PROCESS | 1367 | 06:07:50 INFO - PROCESS | 1367 | ------- Summary: start ------- 06:07:50 INFO - PROCESS | 1367 | Number of tests: 6 06:07:50 INFO - PROCESS | 1367 | 06:07:50 INFO - PROCESS | 1367 | [#0] dojo.html Cycles:165 Average:5519.38 Median:5769.00 stddev:754.10 (13.1%) stddev-sans-first:731.25 06:07:50 INFO - PROCESS | 1367 | Values: 3056.6 3105.1 3133.1 3134.7 3144.0 5484.7 5528.8 5549.3 5627.9 5636.6 5445.1 5493.1 5497.3 5548.1 5597.0 4950.2 4969.8 5070.3 5116.9 5156.4 805.5 4956.3 4962.1 4992.0 5086.6 4998.2 5003.9 5032.3 5041.2 5047.2 5056.7 5073.8 5107.6 5110.3 5120.5 4966.4 4981.8 5024.3 5044.5 5067.1 5527.5 5531.8 5538.1 5546.1 5610.4 5729.6 5902.6 5926.1 5970.0 5974.0 5969.6 6004.2 6017.5 6032.7 6085.1 5567.0 5599.4 5600.6 5608.5 5612.4 5963.4 6094.2 6127.9 6148.0 6160.2 5849.1 5854.2 5864.6 5869.1 5872.3 6003.9 6021.3 6033.2 6041.3 6048.8 5888.7 5913.7 5940.9 5980.6 5991.2 5980.8 5987.4 5990.4 6007.6 6008.9 4476.9 4572.7 4577.5 4582.1 4624.0 3962.2 4004.0 4008.9 4030.6 4079.3 5665.4 5704.8 5711.7 5753.6 5769.0 5834.3 5948.4 6008.3 6013.8 6042.0 5636.2 5640.2 5723.5 5747.8 5754.9 5197.2 5203.5 5209.8 5222.7 5242.3 6237.7 6251.2 6253.4 6264.0 6276.7 5899.6 5998.6 6019.8 6020.3 6026.4 6343.1 6355.0 6358.4 6359.4 6369.6 5962.3 5966.0 5970.2 5972.6 5977.0 5774.9 5865.8 5882.2 5912.1 6032.4 5787.7 5814.7 5815.7 5819.0 5827.7 5793.8 5799.7 5802.7 5803.2 5805.1 5628.3 5718.9 5746.4 5759.5 5792.4 5821.2 5835.8 5886.4 5887.5 5888.1 5578.1 5758.9 5762.3 5767.0 5783.5 06:07:50 INFO - PROCESS | 1367 | 06:07:50 INFO - PROCESS | 1367 | [#1] ext.html Cycles:180 Average:64505.20 Median:23818.24 stddev:134102.14 (563.0%) stddev-sans-first:134392.37 06:07:50 INFO - PROCESS | 1367 | Values: 552.9 577.4 588.8 606.4 615.1 39001.8 44919.3 44934.8 44935.8 45046.8 43301.0 43795.6 43824.1 43902.3 44086.8 8952.1 9007.0 9050.3 9058.4 9094.4 8907.0 8963.7 8965.8 8998.7 9035.2 8968.3 9028.3 9082.7 9089.5 9104.4 9020.2 9043.9 9060.9 9066.0 9075.6 8959.2 8983.5 9046.5 9049.6 9059.1 33514.7 42846.6 43377.3 43439.6 43484.6 3351.5 3636.8 3897.6 4335.5 4517.7 31711.4 31934.2 33237.7 35295.8 35689.0 4456.0 4596.9 4627.4 4766.6 4806.8 383189.0 391527.0 395970.0 397814.0 398652.0 35562.6 36459.0 65116.0 65492.0 65995.3 38119.6 38283.4 38437.6 38474.6 38592.6 16087.4 16106.8 16345.9 16390.2 16443.9 13532.7 13566.7 13644.8 13655.2 13666.7 8477.2 8517.5 8609.3 8620.9 8654.0 3350.5 3398.4 3404.1 3404.1 3440.1 1030.9 1033.8 1034.9 1100.0 1129.0 33790.2 33855.5 33917.8 34123.7 34148.5 1106.0 1118.2 1146.7 1191.1 1194.9 16461.4 17457.3 17527.4 17660.3 17710.3 602639.0 602963.0 603682.0 604778.0 608202.0 61026.7 61834.0 62002.7 62226.4 62229.4 1314.6 1347.6 1372.5 1374.1 1392.5 32269.4 33258.3 33280.3 33708.8 33740.5 54770.7 54800.5 55353.2 55477.7 55587.7 488561.0 489246.0 489890.0 491631.0 491661.0 28692.7 29170.7 29245.9 29412.9 30745.2 49653.5 50634.5 50897.7 51110.0 52107.5 42647.6 43255.6 43500.0 43877.6 44561.0 43160.8 43262.6 43357.6 43581.8 43798.0 42088.0 42753.4 42881.4 43365.6 43387.1 36780.8 38779.4 39168.6 39256.0 39482.6 28683.9 28687.5 29449.3 29569.9 29687.9 06:07:50 INFO - PROCESS | 1367 | 06:07:50 INFO - PROCESS | 1367 | [#2] jquery.html Cycles:180 Average:30594.28 Median:11900.14 stddev:84502.45 (710.1%) stddev-sans-first:84709.06 06:07:50 INFO - PROCESS | 1367 | Values: 385.8 387.2 390.3 394.2 413.2 14093.9 18854.2 19877.7 20642.8 20672.9 19282.6 19556.4 19559.5 20484.9 20588.2 5802.3 5979.3 6002.3 6025.0 6041.0 5796.0 5881.1 5893.9 5919.9 5940.0 5743.2 5826.5 5854.2 5883.6 5915.3 5783.5 5837.6 5841.9 5846.7 5867.4 5157.8 5228.3 5229.8 5241.9 5275.9 24345.1 24419.6 24431.4 24702.8 24780.3 2390.4 2514.6 2652.1 2705.4 3078.8 15009.5 15488.8 15574.2 15624.9 16047.4 1970.1 2045.3 2084.8 2091.3 2105.2 83394.0 84742.6 85951.6 85994.6 88046.1 10743.5 10743.6 10910.5 10965.7 11022.1 15000.8 15017.9 15080.5 15095.2 15104.2 8376.9 8688.6 8704.2 8815.3 8826.2 8339.7 8415.6 8470.6 8656.6 8775.9 6640.7 6643.9 6786.8 6800.8 6802.9 1921.6 1927.5 1946.0 1949.2 1980.0 955.5 1047.2 1053.8 1058.2 1077.5 20708.4 21271.0 21294.5 21307.9 21409.9 1037.3 1039.8 1050.6 1104.9 1109.5 11613.4 11973.5 12048.8 12055.5 12159.6 498930.0 506266.0 513894.0 514992.0 524033.0 84425.6 91295.0 104710.5 110119.0 110246.0 1030.3 1046.2 1070.3 1090.8 1103.8 18491.2 18753.8 19051.2 19081.4 19383.6 31309.0 34650.8 43075.8 43286.8 43568.6 60501.4 65761.3 66297.7 66478.3 66992.3 8531.9 8848.9 8928.7 8938.1 9045.4 9666.7 13422.7 13789.0 14122.0 14265.8 11977.9 12241.9 12419.9 12474.2 12620.9 11911.9 11960.3 12127.3 12170.9 12397.9 12166.1 12336.4 12592.1 12692.3 12824.2 8667.5 8772.1 8857.3 9015.8 9015.9 11194.4 11773.9 12236.9 12422.6 12485.7 06:07:50 INFO - PROCESS | 1367 | 06:07:50 INFO - PROCESS | 1367 | [#3] mootools.html Cycles:180 Average:6023.37 Median:4605.44 stddev:3425.74 (74.4%) stddev-sans-first:3418.53 06:07:50 INFO - PROCESS | 1367 | Values: 1505.2 1528.8 1715.3 1814.8 1869.0 7859.3 8674.8 8743.5 9293.7 9299.0 8740.6 9024.3 9104.0 9111.7 9113.5 2371.0 2407.9 2413.3 2414.9 2421.1 2373.9 2401.1 2422.7 2423.4 2436.8 2381.4 2382.2 2401.0 2409.1 2419.2 2348.7 2351.2 2360.2 2362.6 2363.9 2276.8 2296.6 2310.3 2318.5 2318.8 9024.0 9098.2 9131.6 9138.6 9197.4 5334.4 5517.9 5555.8 5558.8 5559.8 3350.8 3382.6 3431.8 3445.0 3455.6 1021.3 1026.8 1043.9 1071.1 1084.3 12537.1 12692.4 12727.6 12741.0 12742.9 4727.6 4822.2 4825.3 4913.9 4938.7 10540.1 10638.4 10646.2 10655.0 10658.4 5458.7 5458.8 5469.2 5479.7 5503.0 4400.7 4905.4 4990.4 5043.1 5051.1 4010.5 4042.6 4082.3 4107.2 4113.8 1291.3 1305.4 1320.3 1326.9 1327.8 969.8 976.3 1030.7 1038.1 1045.2 6315.1 6334.9 6454.3 6559.2 6599.5 1008.8 1029.1 1032.2 1033.2 1070.2 4319.1 4590.4 4620.5 4627.2 4636.5 11091.7 11393.7 11423.2 11423.3 11526.9 10879.2 11304.3 11352.6 11371.5 11410.9 8199.5 8273.4 8345.0 8345.8 8348.7 6347.4 6492.5 6667.4 6715.5 6729.4 10256.1 10356.3 10628.7 10656.4 10771.8 10683.8 10721.6 10728.6 10809.2 10816.7 7927.9 8040.2 8111.6 8117.7 8131.0 9028.3 9035.7 9055.5 9074.5 9129.0 7945.9 8139.7 8157.1 8287.2 8314.8 7742.2 7789.6 7934.3 8047.8 8064.6 7227.3 7237.6 7274.1 7300.8 7332.5 5095.2 5138.3 5186.2 5220.7 5245.0 4907.3 4928.7 4936.8 5005.1 5025.5 06:07:50 INFO - PROCESS | 1367 | 06:07:50 INFO - PROCESS | 1367 | [#4] prototype.html Cycles:180 Average:4928.26 Median:5666.26 stddev:1460.27 (25.8%) stddev-sans-first:1422.71 06:07:50 INFO - PROCESS | 1367 | Values: 313.9 322.7 325.0 334.8 336.4 5466.0 5591.0 5631.9 5687.3 5715.0 5521.2 5529.9 5555.9 5611.9 5649.2 4378.2 4379.6 4385.7 4393.6 4404.4 4115.9 4202.7 4292.2 4300.2 4330.9 4266.8 4276.2 4283.2 4287.5 4308.1 4274.7 4316.6 4317.8 4320.5 4330.4 3686.4 3742.7 3748.1 3748.3 3756.5 5305.4 5329.4 5349.0 5363.4 5388.5 4837.4 4850.6 4889.2 4891.8 4913.9 5533.5 5742.5 5763.6 5769.7 5779.4 4202.8 4224.8 4253.6 4264.3 4268.6 5995.6 6087.7 6111.6 6123.1 6123.8 4231.3 4334.4 4336.8 4367.7 4381.3 4362.2 4378.4 4403.4 4404.2 4407.9 4962.4 4979.3 4996.0 5001.5 5035.7 5738.3 5840.6 5844.3 5858.4 5860.9 1512.9 1527.5 1535.5 1543.1 1545.6 957.3 985.4 989.0 994.8 1004.1 5030.9 5040.8 5523.5 5683.3 5735.3 6021.2 6024.5 6038.5 6064.3 6114.7 5539.6 5684.1 5720.9 5758.5 5777.2 3149.4 3171.6 3176.6 3188.0 3192.8 6246.8 6248.4 6260.4 6277.7 6279.8 5868.6 6064.0 6161.7 6186.5 6188.3 6258.2 6283.7 6311.9 6329.2 6333.3 5885.5 5973.6 5994.6 6053.5 6061.5 5888.8 5928.2 5956.5 5999.6 6044.5 6017.4 6286.7 6286.8 6300.1 6321.1 4203.1 4213.0 4231.9 4235.1 4261.6 6066.9 6071.5 6098.7 6106.0 6110.5 5606.6 5860.2 5866.4 5907.5 5931.9 5838.2 5841.5 5852.4 5853.8 5893.9 5713.9 5830.0 5861.0 5885.4 5895.3 5328.0 5820.5 5877.0 5886.1 5899.6 5757.2 5765.3 5771.5 5835.9 5852.6 06:07:50 INFO - PROCESS | 1367 | 06:07:50 INFO - PROCESS | 1367 | [#5] yui.html Cycles:180 Average:21274.80 Median:4129.07 stddev:30589.14 (740.8%) stddev-sans-first:30636.05 06:07:50 INFO - PROCESS | 1367 | Values: 729.9 753.3 765.6 775.4 844.2 13938.7 14744.6 14764.2 14840.3 14927.3 15093.2 15405.2 15424.4 15441.0 15459.7 655.7 775.9 797.1 799.5 800.8 801.1 804.3 804.6 808.9 811.9 867.7 868.7 869.5 872.0 872.2 857.2 859.5 864.3 864.9 865.1 624.7 625.2 630.0 630.1 630.3 15124.7 15132.5 15186.2 15211.8 15239.6 14236.5 14303.1 14415.8 14490.3 14498.1 12521.6 12602.3 12677.8 12834.8 13240.6 3975.1 4001.8 4101.4 4156.8 4161.8 79389.0 79865.6 80267.0 80531.6 80998.0 11734.5 11951.9 12138.1 12248.6 12526.2 21633.2 21990.6 22010.6 22104.7 22205.2 8379.1 8494.5 8972.2 9202.3 9210.5 4812.4 4939.9 4980.1 5008.2 5174.9 3403.5 3427.6 3491.0 3492.9 3500.8 601.2 623.6 626.4 664.6 720.3 619.1 658.9 682.4 763.9 803.8 9711.2 9822.3 10124.0 10207.1 10255.6 681.4 722.6 723.5 731.8 768.1 4454.2 4801.9 4858.4 4882.1 4933.2 101013.5 114866.0 123237.4 126610.0 126855.4 88057.0 102979.0 103173.5 103521.5 103551.5 64295.4 71042.0 89234.6 89627.0 92716.0 10178.0 10437.2 10590.4 10833.1 10907.3 54123.0 54373.7 54447.5 55257.0 55380.0 71846.6 72816.0 79786.0 81301.6 82633.6 13802.9 13811.8 13874.7 13970.2 14392.1 15269.3 15610.1 15676.7 15746.0 16024.5 14424.8 14578.4 14729.3 14757.9 14834.7 13649.9 13804.8 14249.4 14512.4 14761.3 13993.9 14148.9 14375.1 14890.9 14910.6 10288.0 10344.6 10638.9 10941.8 10979.9 8665.3 8944.2 9976.7 9978.4 10008.6 06:07:50 INFO - PROCESS | 1367 | -------- Summary: end -------- 06:07:50 INFO - PROCESS | 1367 | 06:07:51 INFO - TEST-INFO | 1367: exit 0 06:07:51 INFO - TEST-OK | dromaeo_css | took 1112153ms 06:07:51 INFO - TEST-START | kraken 06:07:51 INFO - operating with platform_type : linux_ 06:07:51 INFO - Initialising browser for kraken test... 06:07:51 INFO - TEST-INFO | started process 1611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwaXPuJ/profile http://localhost:41678/getInfo.html) 06:07:55 INFO - PROCESS | 1611 | __metrics Screen width/height:1600/1200 06:07:55 INFO - PROCESS | 1611 | colorDepth:24 06:07:55 INFO - PROCESS | 1611 | Browser inner width/height: 1024/697 06:07:55 INFO - PROCESS | 1611 | __metrics 06:07:56 ERROR - PROCESS | 1611 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 06:07:57 INFO - TEST-INFO | 1611: exit 0 06:07:57 INFO - Browser initialized. 06:07:57 INFO - Running cycle 1/1 for kraken test... 06:07:57 INFO - TEST-INFO | started process 1730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwaXPuJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:09 INFO - PROCESS | 1730 | RSS: Main: 167686144 06:08:09 INFO - PROCESS | 1730 | 06:08:11 INFO - PROCESS | 1730 | Cycle 1(1): loaded http://localhost:41678/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41678/tests/kraken/driver.html?testName=audio-beat-detection) 06:08:12 INFO - PROCESS | 1730 | RSS: Main: 173207552 06:08:12 INFO - PROCESS | 1730 | 06:08:15 INFO - PROCESS | 1730 | Cycle 1(1): loaded http://localhost:41678/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41678/tests/kraken/driver.html?testName=audio-dft) 06:08:15 INFO - PROCESS | 1730 | RSS: Main: 172539904 06:08:15 INFO - PROCESS | 1730 | 06:08:18 INFO - PROCESS | 1730 | Cycle 1(1): loaded http://localhost:41678/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41678/tests/kraken/driver.html?testName=audio-fft) 06:08:19 INFO - PROCESS | 1730 | RSS: Main: 167178240 06:08:19 INFO - PROCESS | 1730 | 06:08:21 INFO - PROCESS | 1730 | Cycle 1(1): loaded http://localhost:41678/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41678/tests/kraken/driver.html?testName=audio-oscillator) 06:08:22 INFO - PROCESS | 1730 | RSS: Main: 168247296 06:08:22 INFO - PROCESS | 1730 | 06:08:24 INFO - PROCESS | 1730 | Cycle 1(1): loaded http://localhost:41678/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41678/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:08:24 INFO - PROCESS | 1730 | RSS: Main: 169050112 06:08:24 INFO - PROCESS | 1730 | 06:08:27 INFO - PROCESS | 1730 | Cycle 1(1): loaded http://localhost:41678/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41678/tests/kraken/driver.html?testName=imaging-darkroom) 06:08:28 INFO - PROCESS | 1730 | RSS: Main: 168079360 06:08:28 INFO - PROCESS | 1730 | 06:08:32 INFO - PROCESS | 1730 | Cycle 1(1): loaded http://localhost:41678/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41678/tests/kraken/driver.html?testName=imaging-desaturate) 06:08:32 INFO - PROCESS | 1730 | RSS: Main: 166277120 06:08:32 INFO - PROCESS | 1730 | 06:08:35 INFO - PROCESS | 1730 | Cycle 1(1): loaded http://localhost:41678/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41678/tests/kraken/driver.html?testName=json-parse-financial) 06:08:36 INFO - PROCESS | 1730 | RSS: Main: 167686144 06:08:36 INFO - PROCESS | 1730 | 06:08:37 INFO - PROCESS | 1730 | Cycle 1(1): loaded http://localhost:41678/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41678/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:08:38 INFO - PROCESS | 1730 | RSS: Main: 167723008 06:08:38 INFO - PROCESS | 1730 | 06:08:40 INFO - PROCESS | 1730 | Cycle 1(1): loaded http://localhost:41678/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41678/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:08:40 INFO - PROCESS | 1730 | RSS: Main: 168026112 06:08:40 INFO - PROCESS | 1730 | 06:08:42 INFO - PROCESS | 1730 | Cycle 1(1): loaded http://localhost:41678/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41678/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:08:43 INFO - PROCESS | 1730 | RSS: Main: 168570880 06:08:43 INFO - PROCESS | 1730 | 06:08:46 INFO - PROCESS | 1730 | Cycle 1(1): loaded http://localhost:41678/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41678/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:08:46 INFO - PROCESS | 1730 | RSS: Main: 168935424 06:08:46 INFO - PROCESS | 1730 | 06:08:49 INFO - PROCESS | 1730 | Cycle 1(1): loaded http://localhost:41678/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41678/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:08:50 INFO - PROCESS | 1730 | RSS: Main: 168828928 06:08:50 INFO - PROCESS | 1730 | 06:08:51 INFO - PROCESS | 1730 | Cycle 1(1): loaded http://localhost:41678/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41678/tests/kraken/driver.html?testName=ai-astar) 06:08:52 INFO - PROCESS | 1730 | RSS: Main: 169873408 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | __start_tp_report 06:08:52 INFO - PROCESS | 1730 | _x_x_mozilla_page_load 06:08:52 INFO - PROCESS | 1730 | _x_x_mozilla_page_load_details 06:08:52 INFO - PROCESS | 1730 | |i|pagename|runs| 06:08:52 INFO - PROCESS | 1730 | |0;ai-astar;103;112;104;111;112;114;113;112;113;111 06:08:52 INFO - PROCESS | 1730 | |1;audio-beat-detection;147;120;142;166;117;144;151;119;179;119 06:08:52 INFO - PROCESS | 1730 | |2;audio-dft;162;164;164;162;163;164;176;163;165;161 06:08:52 INFO - PROCESS | 1730 | |3;audio-fft;77;75;76;151;77;75;78;75;183;76 06:08:52 INFO - PROCESS | 1730 | |4;audio-oscillator;85;85;149;84;85;84;146;84;84;155 06:08:52 INFO - PROCESS | 1730 | |5;imaging-gaussian-blur;119;117;117;118;118;118;118;118;117;118 06:08:52 INFO - PROCESS | 1730 | |6;imaging-darkroom;147;148;148;147;147;148;148;147;148;146 06:08:52 INFO - PROCESS | 1730 | |7;imaging-desaturate;95;96;96;96;96;95;97;96;96;96 06:08:52 INFO - PROCESS | 1730 | |8;json-parse-financial;54;54;53;54;54;55;62;54;54;54 06:08:52 INFO - PROCESS | 1730 | |9;json-stringify-tinderbox;63;65;64;64;65;65;63;64;64;64 06:08:52 INFO - PROCESS | 1730 | |10;stanford-crypto-aes;76;75;75;74;76;75;75;75;79;78 06:08:52 INFO - PROCESS | 1730 | |11;stanford-crypto-ccm;132;118;122;120;134;127;144;126;159;129 06:08:52 INFO - PROCESS | 1730 | |12;stanford-crypto-pbkdf2;160;158;157;155;164;165;154;154;156;155 06:08:52 INFO - PROCESS | 1730 | |13;stanford-crypto-sha256-iterative;62;64;66;63;63;62;61;68;63;62 06:08:52 INFO - PROCESS | 1730 | __end_tp_report 06:08:52 INFO - PROCESS | 1730 | __start_cc_report 06:08:52 INFO - PROCESS | 1730 | _x_x_mozilla_cycle_collect,927 06:08:52 INFO - PROCESS | 1730 | __end_cc_report 06:08:52 INFO - PROCESS | 1730 | __startTimestamp1468501732008__endTimestamp 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | ------- Summary: start ------- 06:08:52 INFO - PROCESS | 1730 | Number of tests: 14 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.81 (3.4%) stddev-sans-first:2.92 06:08:52 INFO - PROCESS | 1730 | Values: 103.0 112.0 104.0 111.0 112.0 114.0 113.0 112.0 113.0 111.0 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:145.50 stddev:21.59 (14.8%) stddev-sans-first:22.77 06:08:52 INFO - PROCESS | 1730 | Values: 147.0 120.0 142.0 166.0 117.0 144.0 151.0 119.0 179.0 119.0 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:4.25 (2.6%) stddev-sans-first:4.42 06:08:52 INFO - PROCESS | 1730 | Values: 162.0 164.0 164.0 162.0 163.0 164.0 176.0 163.0 165.0 161.0 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.00 stddev:39.06 (51.4%) stddev-sans-first:40.93 06:08:52 INFO - PROCESS | 1730 | Values: 77.0 75.0 76.0 151.0 77.0 75.0 78.0 75.0 183.0 76.0 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:84.00 stddev:31.75 (37.8%) stddev-sans-first:32.92 06:08:52 INFO - PROCESS | 1730 | Values: 85.0 85.0 149.0 84.0 85.0 84.0 146.0 84.0 84.0 155.0 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 06:08:52 INFO - PROCESS | 1730 | Values: 119.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 06:08:52 INFO - PROCESS | 1730 | Values: 147.0 148.0 148.0 147.0 147.0 148.0 148.0 147.0 148.0 146.0 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 06:08:52 INFO - PROCESS | 1730 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 97.0 96.0 96.0 96.0 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:2.57 (4.8%) stddev-sans-first:2.71 06:08:52 INFO - PROCESS | 1730 | Values: 54.0 54.0 53.0 54.0 54.0 55.0 62.0 54.0 54.0 54.0 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 06:08:52 INFO - PROCESS | 1730 | Values: 63.0 65.0 64.0 64.0 65.0 65.0 63.0 64.0 64.0 64.0 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.50 stddev:1.55 (2.1%) stddev-sans-first:1.64 06:08:52 INFO - PROCESS | 1730 | Values: 76.0 75.0 75.0 74.0 76.0 75.0 75.0 75.0 79.0 78.0 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:130.50 stddev:12.38 (9.5%) stddev-sans-first:13.12 06:08:52 INFO - PROCESS | 1730 | Values: 132.0 118.0 122.0 120.0 134.0 127.0 144.0 126.0 159.0 129.0 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.80 Median:157.50 stddev:3.99 (2.5%) stddev-sans-first:4.16 06:08:52 INFO - PROCESS | 1730 | Values: 160.0 158.0 157.0 155.0 164.0 165.0 154.0 154.0 156.0 155.0 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - PROCESS | 1730 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:2.12 (3.4%) stddev-sans-first:2.19 06:08:52 INFO - PROCESS | 1730 | Values: 62.0 64.0 66.0 63.0 63.0 62.0 61.0 68.0 63.0 62.0 06:08:52 INFO - PROCESS | 1730 | -------- Summary: end -------- 06:08:52 INFO - PROCESS | 1730 | 06:08:52 INFO - TEST-INFO | 1730: exit 0 06:08:53 INFO - TEST-OK | kraken | took 61973ms 06:08:53 INFO - SUITE-END | took 1174s 06:08:53 INFO - Completed test suite (00:19:34) 06:08:53 INFO - javascript benchmark 06:08:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7475.67040730855, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.5873607063045, 3105.0684794561625, 3133.1383869435904, 3134.717875391215, 3143.9685603143976, 5484.670919744818, 5528.7788488460465, 5549.250851135095, 5627.859303517414, 5636.605437619368, 5445.128779395298, 5493.066178749612, 5497.312835895513, 5548.0845660465975, 5597.020521408747, 4950.15847305958, 4969.751512424365, 5070.29015937769, 5116.8976620467565, 5156.407013193474, 805.4938696976634, 4956.281339205813, 4962.106820772259, 4992.0, 5086.593072554187, 4998.2002879539095, 5003.899922001576, 5032.295478632976, 5041.218611115283, 5047.217681259411, 5056.696598204083, 5073.822416215452, 5107.642465027449, 5110.28456016158, 5120.539151476385, 4966.354373931402, 4981.775820088104, 5024.271480635324, 5044.54599086084, 5067.0879241736475, 5527.50252477279, 5531.834044978657, 5538.141588053858, 5546.057170281021, 5610.354809196954, 5729.627574207663, 5902.6163299385835, 5926.140709597084, 5970.04479283317, 5974.044152935553, 5969.5821292509545, 6004.189434426384, 6017.548683848685, 6032.66820324882, 6085.087236914454, 5567.0, 5599.356074051455, 5600.5799565032785, 5608.523275521586, 5612.438756124355, 5963.373845746221, 6094.177286066324, 6127.908081378783, 6148.0, 6160.229971253593, 5849.093390524476, 5854.18041474194, 5864.648121112747, 5869.119632055141, 5872.324682661549, 6003.939960600425, 6021.307549631761, 6033.215681961317, 6041.335453100155, 6048.818535443944, 5888.676122813286, 5913.733881975321, 5940.940590594125, 5980.55145864062, 5991.191189189403, 5980.760769569256, 5987.43119403656, 5990.430909063632, 6007.579469437185, 6008.879822403527, 4476.865694029184, 4572.6799124061, 4577.496475387705, 4582.106489234634, 4623.953760462352, 3962.167944731581, 4004.039030632627, 4008.8997775055273, 4030.5767894371256, 4079.326911059701, 5665.433456654384, 5704.80033198836, 5711.657300561979, 5753.626014309057, 5769.0, 5834.3290521589715, 5948.405159484104, 6008.279006519246, 6013.849653758691, 6041.969790151021, 5636.154576813511, 5640.238567793295, 5723.513501352349, 5747.827565173052, 5754.913676294859, 5197.220416937414, 5203.531682148625, 5209.791608335624, 5222.7127507987425, 5242.318498595235, 6237.656928868865, 6251.156093927261, 6253.37466253371, 6264.029075493306, 6276.717547710364, 5899.616524925866, 5998.610090344114, 6019.759209631653, 6020.277566692025, 6026.427489388501, 6343.080253363329, 6354.968225158845, 6358.427741503102, 6359.427651511386, 6369.617822930639, 5962.25471816023, 5966.0, 5970.164177015308, 5972.552058595709, 5977.0, 5774.94225057744, 5865.794697185578, 5882.176495290748, 5912.113183022409, 6032.3967603239325, 5787.681677507778, 5814.680192589448, 5815.680137592304, 5818.970905145617, 5827.650340979555, 5793.826185214451, 5799.681017544076, 5802.709864506842, 5803.245578074823, 5805.129230615273, 5628.324601047737, 5718.885622287614, 5746.42535746422, 5759.51044161251, 5792.391798861059, 5821.155932389865, 5835.766569337179, 5886.381929897299, 5887.499562537232, 5888.146218798164, 5578.107502799533, 5758.856028599319, 5762.250907382014, 5767.0, 5783.450572195635], "value": 5467.140019267031, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.8777998298835, 577.3937365765946, 588.8233529941017, 606.3602898941616, 615.0773839241139, 39001.80499097504, 44919.326210106876, 44934.77532612332, 44935.77532112335, 45046.77476612617, 43301.0, 43795.56204437955, 43824.12351752963, 43902.34146487797, 44086.7795661022, 8952.060033696465, 9006.96419911712, 9050.27597792175, 9058.411203271799, 9094.408863423856, 8906.955465222698, 8963.731088067336, 8965.820683586324, 8998.730038098867, 9035.232005279559, 8968.327375446836, 9028.32287578431, 9082.727518174466, 9089.500077495735, 9104.36269461138, 9020.188183063523, 9043.864342034874, 9060.909390906105, 9066.048064953216, 9075.591598378089, 8959.193672569434, 8983.460992340415, 9046.547672616343, 9049.592768325441, 9059.094090590954, 33514.6648533514, 42846.57153428457, 43377.34933975993, 43439.565604343865, 43484.56515434868, 3351.514030465569, 3636.7636103653444, 3897.5850511228027, 4335.479742430897, 4517.706349087299, 31711.365772684418, 31934.201644959063, 33237.6676233237, 35295.823520882484, 35689.0, 4455.955440445587, 4596.931046034312, 4627.421572303462, 4766.571008609207, 4806.75966201692, 383189.0, 391526.99999999715, 395970.0, 397814.0, 398652.0, 35562.64437355645, 36459.0, 65116.0, 65492.0, 65995.34004659989, 38119.61880381216, 38283.425748613794, 38437.615623843965, 38474.6152538471, 38592.61407385946, 16087.356505739874, 16106.838931610533, 16345.918270408572, 16390.180490975403, 16443.917780411022, 13532.661683457993, 13566.728665426635, 13644.795328070088, 13655.180689158682, 13666.658333541542, 8477.152284771597, 8517.48895066298, 8609.311255099577, 8620.91379086201, 8654.0, 3350.4974253862115, 3398.3713013092656, 3404.0808981575333, 3404.14896275931, 3440.122768694017, 1030.8762948446235, 1033.8242498775226, 1034.906858382749, 1099.961501347465, 1129.0346753525616, 33790.15524611855, 33855.49216761751, 33917.83041084779, 34123.658763412546, 34148.48777268343, 1106.0, 1118.2284223885656, 1146.6574934067266, 1191.1007189571817, 1194.940252987347, 16461.423850165185, 17457.301707931794, 17527.38654147124, 17660.293588256583, 17710.29158833658, 602639.0, 602963.0, 603682.0, 604778.0, 608202.0, 61026.69486652538, 61834.0, 62002.689986549776, 62226.37773622297, 62229.37770622236, 1314.5530519623182, 1347.6226656536185, 1372.5196181336653, 1374.066368303679, 1392.484780631173, 32269.35461290808, 33258.334833303685, 33280.334393312485, 33708.831455843545, 33740.49389259114, 54770.726146369016, 54800.45199547953, 55353.16970245369, 55477.722611386685, 55587.72206138943, 488561.0, 489246.0, 489890.0, 491631.0, 491661.0, 28692.71307286984, 29170.708292917647, 29245.85377073101, 29412.852935735184, 30745.231369215948, 49653.50346496489, 50634.49365506298, 50897.74551127221, 51110.0, 52107.478925210264, 42647.57352426436, 43255.567444325156, 43500.0, 43877.56122438735, 44561.0, 43160.78419607882, 43262.56737432585, 43357.56642433535, 43581.78209108934, 43798.0, 42088.0, 42753.358699620156, 42881.35677964771, 43365.566344336155, 43387.132257354046, 36780.81609591935, 38779.418308724824, 39168.6083139165, 39256.0, 39482.60517394904, 28683.85658071696, 28687.522974060223, 29449.263768405963, 29569.85215073911, 29687.85156074292], "value": 19718.43746630857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.84180486000747, 387.19270321379923, 390.340324851002, 394.1525719702639, 413.18396167569057, 14093.859061409383, 18854.245830166776, 19877.714062882773, 20642.793572064274, 20672.896635516838, 19282.61434771307, 19556.413307600797, 19559.511012224666, 20484.89757551214, 20588.176472941064, 5802.303723553169, 5979.252593425822, 6002.339742628307, 6024.9698751506185, 6041.0, 5796.0, 5881.059030555112, 5893.941060589404, 5919.88160236795, 5940.019896717036, 5743.224664670279, 5826.504747096481, 5854.20968169296, 5883.588148829584, 5915.349311575745, 5783.479486846162, 5837.562182836305, 5841.941580584204, 5846.7076646167525, 5867.442592953663, 5157.819476318348, 5228.320318358589, 5229.843104706865, 5241.921371179397, 5275.894482110336, 24345.1479198229, 24419.63370549443, 24431.389215269584, 24702.76486175684, 24780.25659230226, 2390.3904504351453, 2514.59766437371, 2652.071774878796, 2705.40481094159, 3078.815271083742, 15009.474668386554, 15488.767668484981, 15574.221288935621, 15624.921875390664, 16047.438339658056, 1970.1036028607093, 2045.3148195354424, 2084.791520847918, 2091.26805618034, 2105.221068204774, 83394.0, 84742.57628711879, 85951.57024214901, 85994.57002715008, 88046.11953880443, 10743.51654175564, 10743.623973161059, 10910.454477276104, 10965.671029869116, 11022.118230541537, 15000.849991500163, 15017.924910375597, 15080.472183473526, 15095.169765662775, 15104.169270690218, 8376.916230837736, 8688.565571721389, 8704.216620504058, 8815.338849586307, 8826.249768769727, 8339.708110216114, 8415.579221038923, 8470.618822152896, 8656.61045252965, 8775.912240877637, 6640.701168447432, 6643.900341494881, 6786.76246331376, 6800.829979250559, 6802.931970680329, 1921.5580416504004, 1927.4795805132535, 1945.9902700486407, 1949.1618604000132, 1979.9901000494906, 955.5365647660878, 1047.2145890582065, 1053.8155822730992, 1058.2486434631344, 1077.450500244865, 20708.378748637566, 21271.0, 21294.467638308855, 21307.8934605326, 21409.892950535148, 1037.3257382701304, 1039.8180318444242, 1050.579768092769, 1104.8839871813343, 1109.5007246738999, 11613.36126513033, 11973.476037673105, 12048.819267710991, 12055.517779288906, 12159.635210943687, 498930.0, 506266.0, 513894.0, 514992.0, 524033.0, 84425.57787211024, 91295.0, 104710.4764476188, 110119.0, 110246.0, 1030.3354336452946, 1046.210111365914, 1070.314998401024, 1090.8145615245428, 1103.823388257875, 18491.167897444917, 18753.812461875754, 19051.19013693697, 19081.42755717331, 19383.641413085385, 31309.0, 34650.82674586611, 43075.784621076695, 43286.78356608323, 43568.580821150936, 60501.39498604958, 65761.34238657744, 66297.66851165713, 66478.33521664722, 66992.3300766986, 8531.91468085336, 8848.867266991128, 8928.687495937611, 8938.124508114175, 9045.366824322235, 9666.661666841626, 13422.731545369234, 13789.0, 14122.0, 14265.786013210018, 11977.940110299392, 12241.938790305992, 12419.875801241871, 12474.18917770342, 12620.873791261969, 11911.880881191077, 11960.342181180118, 12127.272363657856, 12170.939145304217, 12397.876021239672, 12166.148369614042, 12336.383180840743, 12592.118551701293, 12692.301923394301, 12824.166429182073, 8667.479951202948, 8772.122787721431, 8857.335699822668, 9015.81968360616, 9015.864762028443, 11194.44027798623, 11773.88226117728, 12236.877631223573, 12422.565210217599, 12485.687857803627], "value": 9784.835929976953, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1505.2172870107545, 1528.7783271425642, 1715.2624371520242, 1814.8094450082733, 1869.0, 7859.29266366027, 8674.783130421743, 8743.475391476515, 9293.721188364352, 9299.0, 8740.562971851414, 9024.323175761827, 9103.954480227607, 9111.68109116181, 9113.45319280842, 2370.9881450592766, 2407.8555286682767, 2413.2880800163907, 2414.9034038638433, 2421.128393778238, 2373.905043798246, 2401.0755858994326, 2422.6729391532094, 2423.442608200115, 2436.841605295659, 2381.3927448500694, 2382.2376839411395, 2400.9555843208173, 2409.084547871806, 2419.189571493543, 2348.659444380555, 2351.1535847095033, 2360.221127028077, 2362.6456031595226, 2363.9409014774596, 2276.8292378071546, 2296.5866144094057, 2310.318456055468, 2318.4783423729696, 2318.7565305642834, 9024.0, 9098.181163695233, 9131.634734610607, 9138.634454621808, 9197.448153110769, 5334.413214546396, 5517.862053448655, 5555.833325000256, 5558.777648894039, 5559.833205003816, 3350.8492117854753, 3382.594088709346, 3431.811250381228, 3444.9827750861336, 3455.6371580983887, 1021.2902033087007, 1026.8305729554615, 1043.8674038668055, 1071.0788721699332, 1084.3060441317564, 12537.122401431903, 12692.365381730877, 12727.618171454871, 12740.980721542348, 12742.872571274354, 4727.550882666142, 4822.180229361017, 4825.346787508129, 4913.87715307113, 4938.654294199371, 10540.051395374454, 10638.361698298128, 10646.201534884915, 10655.0, 10658.360498369968, 5458.699771512605, 5458.808941687102, 5469.15228139639, 5479.671219726829, 5503.036968530491, 4400.713953593006, 4905.386826646669, 4990.426100998359, 5043.092243396224, 5051.06555287273, 4010.538788039413, 4042.6159514846045, 4082.3060079786505, 4107.151781698248, 4113.835446582163, 1291.2704322058007, 1305.3929922586044, 1320.3464285178898, 1326.9203847769165, 1327.8472975607929, 969.7575606098476, 976.3409698453515, 1030.6650338639972, 1038.055369613648, 1045.2369770067742, 6315.147455093595, 6334.873302533923, 6454.290028096905, 6559.180102487189, 6599.53803233769, 1008.8133695266399, 1029.073833549811, 1032.2155162076876, 1033.194108595297, 1070.2294348069377, 4319.07139964909, 4590.40324757786, 4620.4686461056735, 4627.190241707688, 4636.466806317317, 11091.72270693223, 11393.715157120972, 11423.200375973602, 11423.314601123959, 11526.94236528812, 10879.238453308193, 11304.321740695585, 11352.602658906899, 11371.488283027284, 11410.885891141148, 8199.549024803573, 8273.379496537784, 8344.958275208584, 8345.791355216168, 8348.707795227137, 6347.365263473615, 6492.513061520311, 6667.433268172065, 6715.4627629790475, 6729.427998620172, 10256.07695307426, 10356.326838755456, 10628.734281643021, 10656.360618362924, 10771.784564308513, 10683.839742404025, 10721.624743133953, 10728.624498142528, 10809.189310801565, 10816.729581760519, 7927.920720792718, 8040.195980401913, 8111.594420279081, 8117.715879944174, 8131.024277086787, 9028.322875784474, 9035.683751068682, 9055.501947392957, 9074.45553266806, 9129.0, 7945.920540794749, 8139.674413023413, 8157.06193787722, 8287.212714792326, 8314.750557483285, 7742.225777422438, 7789.5715735635085, 7934.325582325336, 8047.83904321922, 8064.596770161351, 7227.349538541556, 7237.63811809418, 7274.054372931485, 7300.780976570712, 7332.523385979895, 5095.15929871567, 5138.254953031864, 5186.170212765939, 5220.738963051908, 5245.0, 4907.288443175791, 4928.728919909296, 4936.827211047596, 5005.149124648746, 5025.497450255091], "value": 4812.183298090652, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.9152428844212, 322.66604064792944, 324.99576309204554, 334.7673367009928, 336.42639299993516, 5466.0, 5591.0, 5631.943680563193, 5687.289088863892, 5714.971425142874, 5521.171824226358, 5529.889402211953, 5555.944440555593, 5611.915821262684, 5649.209110724501, 4378.190034843564, 4379.627731642814, 4385.671074669397, 4393.626541743955, 4404.361367601696, 4115.9176816463805, 4202.70581059326, 4292.163028209485, 4300.204462174508, 4330.870073897788, 4266.8293268269235, 4276.166147601219, 4283.207606592775, 4287.528371879091, 4308.0737641407095, 4274.7435153890865, 4316.633086187678, 4317.784110794448, 4320.524742278347, 4330.415393921811, 3686.391745362012, 3742.700583953277, 3748.100455890594, 3748.306563285801, 3756.5116534850567, 5305.389880163753, 5329.440408757102, 5348.983693098299, 5363.356397232357, 5388.461153884619, 4837.371141751585, 4850.5877000455, 4889.242167464014, 4891.804327826882, 4913.8771530711665, 5533.501984821345, 5742.454466825687, 5763.567732420085, 5769.682667453289, 5779.3642699303045, 4202.835539697058, 4224.788760561991, 4253.617174454314, 4264.275073237526, 4268.637165840907, 5995.640261584275, 6087.6956152192215, 6111.602745821552, 6123.142760013601, 6123.8162855114415, 4231.30183519722, 4334.43960174337, 4336.761478118734, 4367.711525100103, 4381.3208952612395, 4362.192994296065, 4378.365137055172, 4403.4495688039, 4404.207242696281, 4407.933880991788, 4962.404511458648, 4979.30289759434, 4996.000799840047, 5001.4998500149695, 5035.723035233024, 5738.311402631627, 5840.620359676607, 5844.26946631671, 5858.443447872445, 5860.853478663067, 1512.9319180636678, 1527.5188315680525, 1535.5239875638588, 1543.104999100519, 1545.5749668840933, 957.3155194036298, 985.4136788610765, 988.9851652225223, 994.7761753605381, 1004.0561871840447, 5030.89938201234, 5040.823571174991, 5523.502884740393, 5683.318001839806, 5735.311762588516, 6021.2473440819895, 6024.493876530867, 6038.516918646497, 6064.302605200371, 6114.6636934969, 5539.6150962259435, 5684.129514595103, 5720.942790572041, 5758.539316854725, 5777.162311464814, 3149.4331020416544, 3171.63526194486, 3176.5552822604855, 3188.0, 3192.840357982138, 6246.843828904223, 6248.4064013918605, 6260.372303201109, 6277.686115694197, 6279.780207692709, 5868.618539794985, 6063.998880369468, 6161.7227224775, 6186.505079593621, 6188.319284878659, 6258.249010118815, 6283.6858157091965, 6311.936880631135, 6329.240491141092, 6333.276691022812, 5885.529157667291, 5973.5519836013345, 5994.553131949234, 6053.485453736305, 6061.515078793598, 5888.793892213924, 5928.199693041384, 5956.523478121827, 5999.5800293979, 6044.546659000681, 6017.398260173947, 6286.748530058747, 6286.811395658137, 6300.149479820166, 6321.0834429008455, 4203.138356636943, 4213.0, 4231.894202644959, 4235.110626768414, 4261.595148460891, 6066.939330606638, 6071.512479442565, 6098.664573448503, 6106.0, 6110.541709371903, 5606.579506537108, 5860.208871802422, 5866.3547009828035, 5907.527397808251, 5931.9406805931385, 5838.182654428469, 5841.474267315792, 5852.4440178183, 5853.824385268449, 5893.852653683693, 5713.9142912855505, 5830.0, 5860.970695146497, 5885.411458854252, 5895.29256489224, 5327.9733601331745, 5820.505257053198, 5877.0, 5886.146508756121, 5899.646021238739, 5757.165211044291, 5765.308163020464, 5771.509421699203, 5835.94164058354, 5852.561057920758], "value": 4456.856566755734, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.8722723523385, 753.3069575990089, 765.5827573972184, 775.352580595203, 844.2064459408156, 13938.651533711649, 14744.631384215374, 14764.187969661665, 14840.25798710063, 14927.253637318132, 15093.169875656835, 15405.152716600582, 15424.383024679028, 15441.0, 15459.69080618387, 655.6852710698868, 775.9224077592224, 797.131127071492, 799.5083023940264, 800.7998000499875, 801.1387758159972, 804.2761514636816, 804.569555287921, 808.8584497712877, 811.853866304065, 867.7353407210799, 868.7437206024207, 869.5174178331024, 872.014623475475, 872.2193636695154, 857.1685465098844, 859.5401460218816, 864.3301441382947, 864.9048604653483, 865.1391865094208, 624.6501958903029, 625.1591609285549, 630.0203184048802, 630.0832289019512, 630.2972186012609, 15124.697506049928, 15132.470363537333, 15186.164760938143, 15211.771823422658, 15239.619009524851, 14236.501722439769, 14303.141811491343, 14415.78376324356, 14490.347934342979, 14498.130112193303, 12521.56174533887, 12602.306873121976, 12677.809832852514, 12834.80747788784, 13240.602781916557, 3975.1453437511072, 4001.779902105383, 4101.384792281152, 4156.750594964312, 4161.791910404468, 79389.0, 79865.60067199628, 80267.0, 80531.5973420135, 80998.0, 11734.530618775154, 11951.91688747175, 12138.08964327679, 12248.571300004634, 12526.185797923106, 21633.242836500645, 21990.560188796135, 22010.559788804134, 22104.668429973564, 22205.22281720132, 8379.120192379834, 8494.53280069602, 8972.237359824358, 9202.263818894473, 9210.493422861673, 4812.398450193726, 4939.90120197594, 4980.053789780002, 5008.248762685554, 5174.948250517522, 3403.50649155871, 3427.5886893572433, 3491.0, 3492.93465493022, 3500.824958752052, 601.2364297342351, 623.5697368815503, 626.3642402960999, 664.64773669955, 720.3049057659384, 619.1332135011021, 658.8616390557941, 682.4097155960059, 763.9197884222187, 803.7910143362768, 9711.223102151811, 9822.312438129406, 10124.0, 10207.132393746466, 10255.641052563124, 681.4105798484276, 722.6278466589711, 723.5441671746871, 731.7694926098262, 768.0744702633314, 4454.175977444183, 4801.879953001203, 4858.368412106403, 4882.145624515767, 4933.186024306021, 101013.49493252486, 114866.0, 123237.38381308036, 126610.0, 126855.36572317264, 88057.0, 102979.0, 103173.48413257886, 103521.48239258755, 103551.4822425883, 64295.35704642894, 71042.0, 89234.55382723045, 89627.0, 92716.0, 10178.0, 10437.16502679799, 10590.364578125336, 10833.133349331876, 10907.29102608328, 54123.0, 54373.72813135909, 54447.45552544424, 55257.0, 55380.0, 71846.64076679583, 72816.0, 79786.0, 81301.59349203453, 82633.58683206786, 13802.86197138056, 13811.768465625279, 13874.722505549631, 13970.231637260049, 14392.064515806858, 15269.312880920608, 15610.141442220787, 15676.662009575894, 15746.0, 16024.519264422086, 14424.783628245375, 14578.416863325772, 14729.263536822902, 14757.92621036888, 14834.703305933604, 13649.931750341184, 13804.792928105886, 14249.430022799386, 14512.376975842193, 14761.335739891945, 13993.860061399255, 14148.858511414754, 14375.13749175011, 14890.85109148938, 14910.627234318796, 10288.0, 10344.586426351983, 10638.946805265925, 10941.83587246208, 10979.87469430075, 8665.2634526066, 8944.239739622206, 9976.650817221362, 9978.401295922267, 10008.599656013968], "value": 7714.407103097186, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 104.0, 111.0, 112.0, 114.0, 113.0, 112.0, 113.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 142.0, 166.0, 117.0, 144.0, 151.0, 119.0, 179.0, 119.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 162.0, 163.0, 164.0, 176.0, 163.0, 165.0, 161.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 151.0, 77.0, 75.0, 78.0, 75.0, 183.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 149.0, 84.0, 85.0, 84.0, 146.0, 84.0, 84.0, 155.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 54.0, 55.0, 62.0, 54.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 65.0, 65.0, 63.0, 64.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 74.0, 76.0, 75.0, 75.0, 75.0, 79.0, 78.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 118.0, 122.0, 120.0, 134.0, 127.0, 144.0, 126.0, 159.0, 129.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 157.0, 155.0, 164.0, 165.0, 154.0, 154.0, 156.0, 155.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 66.0, 63.0, 63.0, 62.0, 61.0, 68.0, 63.0, 62.0], "value": 63.4, "unit": "score"}]}]} 06:08:53 INFO - Return code: 0 06:08:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:08:53 ERROR - # TBPL SUCCESS # 06:08:53 INFO - Running post-action listener: _resource_record_post_action 06:08:53 INFO - ##### 06:08:53 INFO - ##### Finished run-tests step (success) 06:08:53 INFO - ##### 06:08:53 INFO - Running post-run listener: _resource_record_post_run 06:08:53 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 552751104; Read time: 0; Write time: 481352 06:08:53 INFO - TinderboxPrint: CPU usage
13.3% 06:08:53 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:08:53 INFO - TinderboxPrint: I/O write bytes / time
552,751,104 / 481,352 06:08:53 INFO - TinderboxPrint: CPU idle
8,244.3 (86.7%) 06:08:53 INFO - TinderboxPrint: CPU user
1,213.1 (12.8%) 06:08:53 INFO - TinderboxPrint: Swap in / out
0 / 0 06:08:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 257437696; Read time: 0; Write time: 228296 06:08:53 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295313408; Read time: 0; Write time: 253056 06:08:53 INFO - Running post-run listener: _upload_blobber_files 06:08:53 INFO - Blob upload gear active. 06:08:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:08:53 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:08:53 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:08:53 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:08:54 INFO - (blobuploader) - INFO - Open directory for files ... 06:08:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:08:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:08:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:55 INFO - (blobuploader) - INFO - Done attempting. 06:08:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:08:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:08:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:58 INFO - (blobuploader) - INFO - Done attempting. 06:08:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:08:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:08:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:59 INFO - (blobuploader) - INFO - Done attempting. 06:08:59 INFO - (blobuploader) - INFO - Iteration through files over. 06:08:59 INFO - Return code: 0 06:08:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:08:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:08:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0b7cb29ad4b872b429bf3fc2549e21be32004e006749ab028a3b44f43c4cdd542a4ce3f7aeec6722ab853415068ee576ca8ebbe4de246f4a0bff1ff9b50f968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59f132fc3b05ff1661023099e487be5a50063c936bacbf47f489aead60459c1c480dc8fb3ab12f6c57d6a177241a7d0bef84d1b5a1c841360b4241ef98ea5810", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca66991bc6735e520dbf7cd584910f3c097f54bc7a0b55514ac6c8851baa757ab04dabf48480d097d822c63b83bae7850168c97ec7006d77817a7030a1173558"} 06:08:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:08:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:08:59 INFO - Contents: 06:08:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0b7cb29ad4b872b429bf3fc2549e21be32004e006749ab028a3b44f43c4cdd542a4ce3f7aeec6722ab853415068ee576ca8ebbe4de246f4a0bff1ff9b50f968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59f132fc3b05ff1661023099e487be5a50063c936bacbf47f489aead60459c1c480dc8fb3ab12f6c57d6a177241a7d0bef84d1b5a1c841360b4241ef98ea5810", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca66991bc6735e520dbf7cd584910f3c097f54bc7a0b55514ac6c8851baa757ab04dabf48480d097d822c63b83bae7850168c97ec7006d77817a7030a1173558"} 06:08:59 INFO - Running post-run listener: copy_logs_to_upload_dir 06:08:59 INFO - Copying logs to upload dir... 06:08:59 INFO - mkdir: /builds/slave/test/build/upload/logs 06:08:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.897357 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-14 06:08:59.557462) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 06:08:59.560791) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098 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/e0b7cb29ad4b872b429bf3fc2549e21be32004e006749ab028a3b44f43c4cdd542a4ce3f7aeec6722ab853415068ee576ca8ebbe4de246f4a0bff1ff9b50f968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59f132fc3b05ff1661023099e487be5a50063c936bacbf47f489aead60459c1c480dc8fb3ab12f6c57d6a177241a7d0bef84d1b5a1c841360b4241ef98ea5810", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca66991bc6735e520dbf7cd584910f3c097f54bc7a0b55514ac6c8851baa757ab04dabf48480d097d822c63b83bae7850168c97ec7006d77817a7030a1173558"} build_url:https://queue.taskcluster.net/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/cEl2NsG-Qh6_8WYWHMNqqA/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/e0b7cb29ad4b872b429bf3fc2549e21be32004e006749ab028a3b44f43c4cdd542a4ce3f7aeec6722ab853415068ee576ca8ebbe4de246f4a0bff1ff9b50f968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59f132fc3b05ff1661023099e487be5a50063c936bacbf47f489aead60459c1c480dc8fb3ab12f6c57d6a177241a7d0bef84d1b5a1c841360b4241ef98ea5810", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca66991bc6735e520dbf7cd584910f3c097f54bc7a0b55514ac6c8851baa757ab04dabf48480d097d822c63b83bae7850168c97ec7006d77817a7030a1173558"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 06:08:59.595257) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:08:59.595618) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1468500507.760943-1890667098 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:08:59.652938) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 06:08:59.653286) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 06:08:59.653617) ========= ========= Total master_lag: 0.16 =========