builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1469011698.1 results: success (0) buildid: 20160720022221 builduid: d8dff228b12c4230ba3ccd84ec2d1bc7 revision: e904e18d7dfcd8097f92d44104ca1462fc5d1335 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 03:48:18.101646) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 03:48:18.102095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 03:48:18.102380) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 03:48:18.118569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 03:48:18.118980) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 03:48:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-07-20 03:48:18 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120807 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 03:48:18.255711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 03:48:18.256052) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020344 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 03:48:18.306130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 03:48:18.306500) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e904e18d7dfcd8097f92d44104ca1462fc5d1335 --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 e904e18d7dfcd8097f92d44104ca1462fc5d1335 --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=a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 03:48:18,750 truncating revision to first 12 chars 2016-07-20 03:48:18,750 Setting DEBUG logging. 2016-07-20 03:48:18,750 attempt 1/10 2016-07-20 03:48:18,750 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e904e18d7dfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 03:48:19,059 unpacking tar archive at: mozilla-central-e904e18d7dfc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644280 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 03:48:18.965015) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 03:48:18.965407) ========= script_repo_revision: e904e18d7dfcd8097f92d44104ca1462fc5d1335 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 03:48:18.965897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 03:48:18.966354) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 03:48:18.977044) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-20 03:48:18.977485) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:48:19 INFO - MultiFileLogger online at 20160720 03:48:19 in /builds/slave/test 03:48:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:48:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:48:19 INFO - {'append_to_log': False, 03:48:19 INFO - 'base_work_dir': '/builds/slave/test', 03:48:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:48:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:48:19 INFO - 'branch': 'Firefox-Non-PGO', 03:48:19 INFO - 'buildbot_json_path': 'buildprops.json', 03:48:19 INFO - 'config_files': ('talos/linux_config.py',), 03:48:19 INFO - 'default_actions': ('clobber', 03:48:19 INFO - 'read-buildbot-config', 03:48:19 INFO - 'download-and-extract', 03:48:19 INFO - 'populate-webroot', 03:48:19 INFO - 'create-virtualenv', 03:48:19 INFO - 'install', 03:48:19 INFO - 'run-tests'), 03:48:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:48:19 INFO - 'download_minidump_stackwalk': True, 03:48:19 INFO - 'download_symbols': 'ondemand', 03:48:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:48:19 INFO - 'tooltool.py': '/tools/tooltool.py', 03:48:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:48:19 INFO - '/tools/misc-python/virtualenv.py')}, 03:48:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:48:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:48:19 INFO - 'installer_path': 'installer.exe', 03:48:19 INFO - 'log_level': 'info', 03:48:19 INFO - 'log_name': 'talos', 03:48:19 INFO - 'log_to_console': True, 03:48:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:48:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:48:19 INFO - 'opt_config_files': (), 03:48:19 INFO - 'pip_index': False, 03:48:19 INFO - 'sps_profile': False, 03:48:19 INFO - 'sps_profile_interval': 0, 03:48:19 INFO - 'suite': 'dromaeojs-e10s', 03:48:19 INFO - 'system_bits': '32', 03:48:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:48:19 INFO - 'title': 'talos-linux64-ix-002', 03:48:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:48:19 INFO - 'use_talos_json': True, 03:48:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:48:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:48:19 INFO - 'work_dir': 'build'} 03:48:19 INFO - [mozharness: 2016-07-20 10:48:19.508376Z] Running clobber step. 03:48:19 INFO - Running pre-action listener: _resource_record_pre_action 03:48:19 INFO - Running main action method: clobber 03:48:19 INFO - rmtree: /builds/slave/test/build 03:48:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:48:20 INFO - Running post-action listener: _resource_record_post_action 03:48:20 INFO - [mozharness: 2016-07-20 10:48:20.014165Z] Finished clobber step (success) 03:48:20 INFO - [mozharness: 2016-07-20 10:48:20.014266Z] Running read-buildbot-config step. 03:48:20 INFO - Running pre-action listener: _resource_record_pre_action 03:48:20 INFO - Running main action method: read_buildbot_config 03:48:20 INFO - Using buildbot properties: 03:48:20 INFO - { 03:48:20 INFO - "project": "", 03:48:20 INFO - "product": "firefox", 03:48:20 INFO - "script_repo_revision": "production", 03:48:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:48:20 INFO - "repository": "", 03:48:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:48:20 INFO - "buildid": "20160720022221", 03:48:20 INFO - "pgo_build": "False", 03:48:20 INFO - "basedir": "/builds/slave/test", 03:48:20 INFO - "buildnumber": 386, 03:48:20 INFO - "slavename": "talos-linux64-ix-002", 03:48:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:48:20 INFO - "platform": "ubuntu64_hw", 03:48:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:48:20 INFO - "branch": "mozilla-central", 03:48:20 INFO - "repo_path": "mozilla-central", 03:48:20 INFO - "revision": "e904e18d7dfcd8097f92d44104ca1462fc5d1335", 03:48:20 INFO - "stage_platform": "linux64", 03:48:20 INFO - "builduid": "d8dff228b12c4230ba3ccd84ec2d1bc7", 03:48:20 INFO - "slavebuilddir": "test" 03:48:20 INFO - } 03:48:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:48:20 INFO - Running post-action listener: _resource_record_post_action 03:48:20 INFO - [mozharness: 2016-07-20 10:48:20.016703Z] Finished read-buildbot-config step (success) 03:48:20 INFO - [mozharness: 2016-07-20 10:48:20.016792Z] Running download-and-extract step. 03:48:20 INFO - Running pre-action listener: _resource_record_pre_action 03:48:20 INFO - Running main action method: download_and_extract 03:48:20 INFO - mkdir: /builds/slave/test/build/tests 03:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:20 INFO - https://queue.taskcluster.net/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:48:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:48:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:48:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/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 03:48:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/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 03:48:20 INFO - Downloaded 1361 bytes. 03:48:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:48:20 INFO - Using the following test package requirements: 03:48:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:48:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:48:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:20 INFO - u'jsshell-linux-x86_64.zip'], 03:48:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:48:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:48:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:48:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:48:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:48:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:20 INFO - https://queue.taskcluster.net/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:48:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:48:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:48:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/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 03:48:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/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 03:48:21 INFO - Downloaded 22771726 bytes. 03:48:21 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'] 03:48:21 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 03:48:22 INFO - Return code: 0 03:48:22 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 03:48:22 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')]} 03:48:22 INFO - https://queue.taskcluster.net/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:48:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:48:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:48:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/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 03:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/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 03:48:23 INFO - Downloaded 22771726 bytes. 03:48:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:48:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:48:25 INFO - Return code: 0 03:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:25 INFO - https://queue.taskcluster.net/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:48:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/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 03:48:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/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 03:48:26 INFO - Downloaded 14403317 bytes. 03:48:26 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'] 03:48:26 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 03:48:26 INFO - Return code: 0 03:48:26 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')]} 03:48:26 INFO - https://queue.taskcluster.net/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:48:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:48:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:48:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/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 03:48:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B17JYcUmRqek5J51Aulq3g/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 03:48:29 INFO - Downloaded 57115962 bytes. 03:48:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:48:29 INFO - mkdir: /builds/slave/test/properties 03:48:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:48:29 INFO - Writing to file /builds/slave/test/properties/build_url 03:48:29 INFO - Contents: 03:48:29 INFO - build_url:https://queue.taskcluster.net/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:48:29 INFO - Running post-action listener: _resource_record_post_action 03:48:29 INFO - Running post-action listener: set_extra_try_arguments 03:48:29 INFO - [mozharness: 2016-07-20 10:48:29.898030Z] Finished download-and-extract step (success) 03:48:29 INFO - [mozharness: 2016-07-20 10:48:29.898349Z] Running populate-webroot step. 03:48:29 INFO - Running pre-action listener: _resource_record_pre_action 03:48:29 INFO - Running main action method: populate_webroot 03:48:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:48:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:48:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:48:29 INFO - '--tppagecycles', 03:48:29 INFO - '7'], 03:48:29 INFO - 'tests': ['tsvgm']}}, 03:48:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:48:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:48:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:48:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:48:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:48:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:48:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:29 INFO - 'talos_options': ['--disable-e10s'], 03:48:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:29 INFO - 'talos_options': ['--disable-e10s'], 03:48:29 INFO - 'tests': ['damp', 'tps']}, 03:48:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:29 INFO - 'tests': ['damp', 'tps']}, 03:48:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:48:29 INFO - 'tests': ['dromaeo_dom']}, 03:48:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:48:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:48:29 INFO - 'tests': ['basic_compositor_video']}, 03:48:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:48:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:48:29 INFO - 'tests': ['a11yr', 03:48:29 INFO - 'ts_paint', 03:48:29 INFO - 'tpaint', 03:48:29 INFO - 'sessionrestore', 03:48:29 INFO - 'sessionrestore_no_auto_restore', 03:48:29 INFO - 'tabpaint']}, 03:48:29 INFO - 'other-e10s': {'tests': ['a11yr', 03:48:29 INFO - 'ts_paint', 03:48:29 INFO - 'tpaint', 03:48:29 INFO - 'sessionrestore', 03:48:29 INFO - 'sessionrestore_no_auto_restore', 03:48:29 INFO - 'tabpaint']}, 03:48:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:48:29 INFO - 'ts_paint', 03:48:29 INFO - 'tpaint', 03:48:29 INFO - 'sessionrestore', 03:48:29 INFO - 'sessionrestore_no_auto_restore', 03:48:29 INFO - 'tabpaint']}, 03:48:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:48:29 INFO - 'ts_paint', 03:48:29 INFO - 'tpaint', 03:48:29 INFO - 'sessionrestore', 03:48:29 INFO - 'sessionrestore_no_auto_restore', 03:48:29 INFO - 'tabpaint']}, 03:48:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:48:29 INFO - 'tests': ['a11yr', 03:48:29 INFO - 'ts_paint', 03:48:29 INFO - 'tpaint', 03:48:29 INFO - 'sessionrestore', 03:48:29 INFO - 'sessionrestore_no_auto_restore', 03:48:29 INFO - 'tabpaint']}, 03:48:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:48:29 INFO - 'tests': ['a11yr', 03:48:29 INFO - 'ts_paint', 03:48:29 INFO - 'tpaint', 03:48:29 INFO - 'sessionrestore', 03:48:29 INFO - 'sessionrestore_no_auto_restore', 03:48:29 INFO - 'tabpaint']}, 03:48:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:48:29 INFO - 'tests': ['tsvgx', 03:48:29 INFO - 'tsvgr_opacity', 03:48:29 INFO - 'tart', 03:48:29 INFO - 'tscrollx', 03:48:29 INFO - 'cart']}, 03:48:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:48:29 INFO - 'tsvgr_opacity', 03:48:29 INFO - 'tart', 03:48:29 INFO - 'tscrollx', 03:48:29 INFO - 'cart']}, 03:48:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:29 INFO - 'talos_options': ['--disable-e10s'], 03:48:29 INFO - 'tests': ['tp5o']}, 03:48:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:29 INFO - 'tests': ['tp5o']}, 03:48:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:29 INFO - 'talos_options': ['--disable-e10s', 03:48:29 INFO - '--xperf_path', 03:48:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:29 INFO - 'tests': ['tp5n']}, 03:48:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:29 INFO - 'talos_options': ['--xperf_path', 03:48:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:29 INFO - 'tests': ['tp5n']}}, 03:48:29 INFO - 'talos.zip': {'path': '', 03:48:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:48:29 INFO - Running post-action listener: _resource_record_post_action 03:48:29 INFO - [mozharness: 2016-07-20 10:48:29.916610Z] Finished populate-webroot step (success) 03:48:29 INFO - [mozharness: 2016-07-20 10:48:29.916699Z] Running create-virtualenv step. 03:48:29 INFO - Running pre-action listener: _resource_record_pre_action 03:48:29 INFO - Running main action method: create_virtualenv 03:48:29 INFO - Creating virtualenv /builds/slave/test/build/venv 03:48:29 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 03:48:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:48:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:48:30 INFO - Using real prefix '/usr' 03:48:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:48:30 INFO - Installing distribute.............................................................................................................................................................................................done. 03:48:32 INFO - Installing pip.................done. 03:48:32 INFO - Return code: 0 03:48:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:48:32 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')]} 03:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:32 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')]} 03:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:32 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 0xe35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3570>, '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 0x10f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', '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 03:48:32 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 03:48:32 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 03:48:32 INFO - Using env: {'DISPLAY': ':0', 03:48:32 INFO - 'HOME': '/home/cltbld', 03:48:32 INFO - 'LANG': 'en_US.UTF-8', 03:48:32 INFO - 'LANGUAGE': 'en_US:en', 03:48:32 INFO - 'LOGNAME': 'cltbld', 03:48:32 INFO - 'MAIL': '/var/mail/cltbld', 03:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:32 INFO - 'MOZ_NO_REMOTE': '1', 03:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:32 INFO - 'NO_EM_RESTART': '1', 03:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:32 INFO - 'PWD': '/builds/slave/test', 03:48:32 INFO - 'SHELL': '/bin/bash', 03:48:32 INFO - 'SHLVL': '1', 03:48:32 INFO - 'TERM': 'linux', 03:48:32 INFO - 'TMOUT': '86400', 03:48:32 INFO - 'USER': 'cltbld', 03:48:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', 03:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:32 INFO - '_': '/tools/buildbot/bin/python'} 03:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:32 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 03:48:32 INFO - Cleaning up... 03:48:32 INFO - Return code: 0 03:48:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:48:32 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')]} 03:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:32 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')]} 03:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:32 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 0xe35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3570>, '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 0x10f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', '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 03:48:32 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 03:48:32 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 03:48:32 INFO - Using env: {'DISPLAY': ':0', 03:48:32 INFO - 'HOME': '/home/cltbld', 03:48:32 INFO - 'LANG': 'en_US.UTF-8', 03:48:32 INFO - 'LANGUAGE': 'en_US:en', 03:48:32 INFO - 'LOGNAME': 'cltbld', 03:48:32 INFO - 'MAIL': '/var/mail/cltbld', 03:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:32 INFO - 'MOZ_NO_REMOTE': '1', 03:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:32 INFO - 'NO_EM_RESTART': '1', 03:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:32 INFO - 'PWD': '/builds/slave/test', 03:48:32 INFO - 'SHELL': '/bin/bash', 03:48:32 INFO - 'SHLVL': '1', 03:48:32 INFO - 'TERM': 'linux', 03:48:32 INFO - 'TMOUT': '86400', 03:48:32 INFO - 'USER': 'cltbld', 03:48:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', 03:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:32 INFO - '_': '/tools/buildbot/bin/python'} 03:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:32 INFO - Downloading/unpacking psutil>=3.1.1 03:48:32 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 03:48:32 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 03:48:32 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 03:48:32 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 03:48:32 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 03:48:32 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 03:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:48:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:34 INFO - Installing collected packages: psutil 03:48:34 INFO - Running setup.py install for psutil 03:48:35 INFO - building 'psutil._psutil_linux' extension 03:48:35 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 03:48:35 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 03:48:35 INFO - building 'psutil._psutil_posix' extension 03:48:35 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 03:48:35 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 03:48:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:35 INFO - Successfully installed psutil 03:48:35 INFO - Cleaning up... 03:48:35 INFO - Return code: 0 03:48:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3570>, '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 0x10f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', '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 03:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:48:35 INFO - Using env: {'DISPLAY': ':0', 03:48:35 INFO - 'HOME': '/home/cltbld', 03:48:35 INFO - 'LANG': 'en_US.UTF-8', 03:48:35 INFO - 'LANGUAGE': 'en_US:en', 03:48:35 INFO - 'LOGNAME': 'cltbld', 03:48:35 INFO - 'MAIL': '/var/mail/cltbld', 03:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:35 INFO - 'MOZ_NO_REMOTE': '1', 03:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:35 INFO - 'NO_EM_RESTART': '1', 03:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:35 INFO - 'PWD': '/builds/slave/test', 03:48:35 INFO - 'SHELL': '/bin/bash', 03:48:35 INFO - 'SHLVL': '1', 03:48:35 INFO - 'TERM': 'linux', 03:48:35 INFO - 'TMOUT': '86400', 03:48:35 INFO - 'USER': 'cltbld', 03:48:35 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', 03:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:35 INFO - '_': '/tools/buildbot/bin/python'} 03:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:48:35 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 03:48:35 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 03:48:35 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 03:48:35 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 03:48:35 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 03:48:35 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 03:48:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:48:37 INFO - Installing collected packages: mozsystemmonitor 03:48:37 INFO - Running setup.py install for mozsystemmonitor 03:48:37 INFO - Successfully installed mozsystemmonitor 03:48:37 INFO - Cleaning up... 03:48:37 INFO - Return code: 0 03:48:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:37 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 0xe35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3570>, '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 0x10f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', '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 03:48:37 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 03:48:37 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 03:48:37 INFO - Using env: {'DISPLAY': ':0', 03:48:37 INFO - 'HOME': '/home/cltbld', 03:48:37 INFO - 'LANG': 'en_US.UTF-8', 03:48:37 INFO - 'LANGUAGE': 'en_US:en', 03:48:37 INFO - 'LOGNAME': 'cltbld', 03:48:37 INFO - 'MAIL': '/var/mail/cltbld', 03:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:37 INFO - 'MOZ_NO_REMOTE': '1', 03:48:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:37 INFO - 'NO_EM_RESTART': '1', 03:48:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:37 INFO - 'PWD': '/builds/slave/test', 03:48:37 INFO - 'SHELL': '/bin/bash', 03:48:37 INFO - 'SHLVL': '1', 03:48:37 INFO - 'TERM': 'linux', 03:48:37 INFO - 'TMOUT': '86400', 03:48:37 INFO - 'USER': 'cltbld', 03:48:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', 03:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:37 INFO - '_': '/tools/buildbot/bin/python'} 03:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:38 INFO - Downloading/unpacking jsonschema==2.5.1 03:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:48:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:48:39 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 03:48:39 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 03:48:39 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 03:48:39 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 03:48:39 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 03:48:39 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 03:48:40 INFO - Downloading functools32-3.2.3-2.tar.gz 03:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:48:40 INFO - warning: no files found matching '*.txt' 03:48:40 INFO - no previously-included directories found matching 'build' 03:48:40 INFO - no previously-included directories found matching 'dist' 03:48:40 INFO - no previously-included directories found matching '.git*' 03:48:40 INFO - Installing collected packages: jsonschema, functools32 03:48:40 INFO - Running setup.py install for functools32 03:48:40 INFO - warning: no files found matching '*.txt' 03:48:40 INFO - no previously-included directories found matching 'build' 03:48:40 INFO - no previously-included directories found matching 'dist' 03:48:40 INFO - no previously-included directories found matching '.git*' 03:48:40 INFO - Successfully installed jsonschema functools32 03:48:40 INFO - Cleaning up... 03:48:40 INFO - Return code: 0 03:48:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3570>, '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 0x10f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', '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 03:48:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:48:40 INFO - Using env: {'DISPLAY': ':0', 03:48:40 INFO - 'HOME': '/home/cltbld', 03:48:40 INFO - 'LANG': 'en_US.UTF-8', 03:48:40 INFO - 'LANGUAGE': 'en_US:en', 03:48:40 INFO - 'LOGNAME': 'cltbld', 03:48:40 INFO - 'MAIL': '/var/mail/cltbld', 03:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:40 INFO - 'MOZ_NO_REMOTE': '1', 03:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:40 INFO - 'NO_EM_RESTART': '1', 03:48:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:40 INFO - 'PWD': '/builds/slave/test', 03:48:40 INFO - 'SHELL': '/bin/bash', 03:48:40 INFO - 'SHLVL': '1', 03:48:40 INFO - 'TERM': 'linux', 03:48:40 INFO - 'TMOUT': '86400', 03:48:40 INFO - 'USER': 'cltbld', 03:48:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', 03:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:40 INFO - '_': '/tools/buildbot/bin/python'} 03:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:40 INFO - Downloading/unpacking blobuploader==1.2.4 03:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:44 INFO - Downloading blobuploader-1.2.4.tar.gz 03:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:48:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:48:44 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 03:48:44 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 03:48:44 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 03:48:44 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 03:48:44 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 03:48:44 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 03:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:48:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03: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 03: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 03: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 03: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 03: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 03: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 03:48:45 INFO - Downloading docopt-0.6.1.tar.gz 03:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:48:45 INFO - Installing collected packages: blobuploader, requests, docopt 03:48:45 INFO - Running setup.py install for blobuploader 03:48:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:48:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:48:45 INFO - Running setup.py install for requests 03:48:46 INFO - Running setup.py install for docopt 03:48:46 INFO - Successfully installed blobuploader requests docopt 03:48:46 INFO - Cleaning up... 03:48:46 INFO - Return code: 0 03:48:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:46 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')]} 03:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:46 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')]} 03:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:46 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 0xe35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3570>, '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 0x10f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', '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 03:48:46 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 03:48:46 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 03:48:46 INFO - Using env: {'DISPLAY': ':0', 03:48:46 INFO - 'HOME': '/home/cltbld', 03:48:46 INFO - 'LANG': 'en_US.UTF-8', 03:48:46 INFO - 'LANGUAGE': 'en_US:en', 03:48:46 INFO - 'LOGNAME': 'cltbld', 03:48:46 INFO - 'MAIL': '/var/mail/cltbld', 03:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:46 INFO - 'MOZ_NO_REMOTE': '1', 03:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:46 INFO - 'NO_EM_RESTART': '1', 03:48:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:46 INFO - 'PWD': '/builds/slave/test', 03:48:46 INFO - 'SHELL': '/bin/bash', 03:48:46 INFO - 'SHLVL': '1', 03:48:46 INFO - 'TERM': 'linux', 03:48:46 INFO - 'TMOUT': '86400', 03:48:46 INFO - 'USER': 'cltbld', 03:48:46 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', 03:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:46 INFO - '_': '/tools/buildbot/bin/python'} 03:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:46 INFO - Running setup.py (path:/tmp/pip-WaJQAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:46 INFO - Running setup.py (path:/tmp/pip-dWq7Jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:46 INFO - Running setup.py (path:/tmp/pip-UyX8Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:46 INFO - Running setup.py (path:/tmp/pip-4_K5pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:46 INFO - Running setup.py (path:/tmp/pip-ud9NUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:46 INFO - Running setup.py (path:/tmp/pip-uT5z65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:46 INFO - Running setup.py (path:/tmp/pip-ksLRFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:46 INFO - Running setup.py (path:/tmp/pip-D3FCIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:46 INFO - Running setup.py (path:/tmp/pip-7Y7SQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:47 INFO - Running setup.py (path:/tmp/pip-YtXImr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:47 INFO - Running setup.py (path:/tmp/pip-J1R5vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:47 INFO - Running setup.py (path:/tmp/pip-0Y4KEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:47 INFO - Running setup.py (path:/tmp/pip-mOoLr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:47 INFO - Running setup.py (path:/tmp/pip-7ubpDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:47 INFO - Running setup.py (path:/tmp/pip-8FxN0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:47 INFO - Running setup.py (path:/tmp/pip-T9HLCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:47 INFO - Running setup.py (path:/tmp/pip-hobuHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:48:47 INFO - Running setup.py install for manifestparser 03:48:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:48:47 INFO - Running setup.py install for mozcrash 03:48:47 INFO - Running setup.py install for mozdebug 03:48:47 INFO - Running setup.py install for mozdevice 03:48:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:48:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Running setup.py install for mozfile 03:48:48 INFO - Running setup.py install for mozhttpd 03:48:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Running setup.py install for mozinfo 03:48:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Running setup.py install for mozInstall 03:48:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Running setup.py install for mozleak 03:48:48 INFO - Running setup.py install for mozlog 03:48:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Running setup.py install for moznetwork 03:48:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Running setup.py install for mozprocess 03:48:48 INFO - Running setup.py install for mozprofile 03:48:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:48:48 INFO - Running setup.py install for mozrunner 03:48:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:48:49 INFO - Running setup.py install for mozscreenshot 03:48:49 INFO - Running setup.py install for moztest 03:48:49 INFO - Running setup.py install for mozversion 03:48:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:48:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:48:49 INFO - Cleaning up... 03:48:49 INFO - Return code: 0 03:48:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03: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')]} 03:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:49 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 0xe35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3570>, '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 0x10f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', '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 03:48:49 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 03:48:49 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 03:48:49 INFO - Using env: {'DISPLAY': ':0', 03:48:49 INFO - 'HOME': '/home/cltbld', 03:48:49 INFO - 'LANG': 'en_US.UTF-8', 03:48:49 INFO - 'LANGUAGE': 'en_US:en', 03:48:49 INFO - 'LOGNAME': 'cltbld', 03:48:49 INFO - 'MAIL': '/var/mail/cltbld', 03:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:49 INFO - 'MOZ_NO_REMOTE': '1', 03:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:49 INFO - 'NO_EM_RESTART': '1', 03:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:49 INFO - 'PWD': '/builds/slave/test', 03:48:49 INFO - 'SHELL': '/bin/bash', 03:48:49 INFO - 'SHLVL': '1', 03:48:49 INFO - 'TERM': 'linux', 03:48:49 INFO - 'TMOUT': '86400', 03:48:49 INFO - 'USER': 'cltbld', 03:48:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', 03:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:49 INFO - '_': '/tools/buildbot/bin/python'} 03:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:49 INFO - Running setup.py (path:/tmp/pip-vLrR9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:49 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)) 03:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:49 INFO - Running setup.py (path:/tmp/pip-G_5_F5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:49 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)) 03:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:49 INFO - Running setup.py (path:/tmp/pip-IZ1JzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:49 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)) 03:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:49 INFO - Running setup.py (path:/tmp/pip-IOhHb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:49 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)) 03:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:49 INFO - Running setup.py (path:/tmp/pip-JL1JWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:49 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)) 03:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:49 INFO - Running setup.py (path:/tmp/pip-3oYpmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:50 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)) 03:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:50 INFO - Running setup.py (path:/tmp/pip-irOkjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:50 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)) 03:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:50 INFO - Running setup.py (path:/tmp/pip-ENfgRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:50 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)) 03:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:50 INFO - Running setup.py (path:/tmp/pip-dIICzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:50 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)) 03:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:50 INFO - Running setup.py (path:/tmp/pip-FjPaWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:50 INFO - Running setup.py (path:/tmp/pip-yn1Guy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:50 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)) 03:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:50 INFO - Running setup.py (path:/tmp/pip-p6pgC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:50 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)) 03:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:50 INFO - Running setup.py (path:/tmp/pip-LA6lPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:50 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)) 03:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:50 INFO - Running setup.py (path:/tmp/pip-6N3xBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:50 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)) 03:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:50 INFO - Running setup.py (path:/tmp/pip-wthZ3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:50 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)) 03:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:50 INFO - Running setup.py (path:/tmp/pip-GiBnXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:50 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)) 03:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:50 INFO - Running setup.py (path:/tmp/pip-rUz0ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:50 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)) 03:48:50 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)) 03:48:50 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)) 03:48:50 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)) 03:48:50 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)) 03:48:50 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)) 03:48:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03: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 03: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 03: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 03: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 03: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 03: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 03:48:52 INFO - Downloading blessings-1.6.tar.gz 03:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:48:52 INFO - Installing collected packages: blessings 03:48:52 INFO - Running setup.py install for blessings 03:48:52 INFO - Successfully installed blessings 03:48:52 INFO - Cleaning up... 03:48:53 INFO - Return code: 0 03:48:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:53 INFO - Reading from file tmpfile_stdout 03:48:53 INFO - Current package versions: 03:48:53 INFO - argparse == 1.2.1 03:48:53 INFO - blessings == 1.6 03:48:53 INFO - blobuploader == 1.2.4 03:48:53 INFO - docopt == 0.6.1 03:48:53 INFO - functools32 == 3.2.3-2 03:48:53 INFO - jsonschema == 2.5.1 03:48:53 INFO - manifestparser == 1.1 03:48:53 INFO - mozInstall == 1.12 03:48:53 INFO - mozcrash == 0.17 03:48:53 INFO - mozdebug == 0.1 03:48:53 INFO - mozdevice == 0.48 03:48:53 INFO - mozfile == 1.2 03:48:53 INFO - mozhttpd == 0.7 03:48:53 INFO - mozinfo == 0.9 03:48:53 INFO - mozleak == 0.1 03:48:53 INFO - mozlog == 3.3 03:48:53 INFO - moznetwork == 0.27 03:48:53 INFO - mozprocess == 0.23 03:48:53 INFO - mozprofile == 0.28 03:48:53 INFO - mozrunner == 6.12 03:48:53 INFO - mozscreenshot == 0.1 03:48:53 INFO - mozsystemmonitor == 0.3 03:48:53 INFO - moztest == 0.7 03:48:53 INFO - mozversion == 1.4 03:48:53 INFO - psutil == 3.1.1 03:48:53 INFO - requests == 1.2.3 03:48:53 INFO - wsgiref == 0.1.2 03:48:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03: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')]} 03:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:53 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 0xe35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3570>, '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 0x10f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', '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 03:48:53 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 03:48:53 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 03:48:53 INFO - Using env: {'DISPLAY': ':0', 03:48:53 INFO - 'HOME': '/home/cltbld', 03:48:53 INFO - 'LANG': 'en_US.UTF-8', 03:48:53 INFO - 'LANGUAGE': 'en_US:en', 03:48:53 INFO - 'LOGNAME': 'cltbld', 03:48:53 INFO - 'MAIL': '/var/mail/cltbld', 03:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:53 INFO - 'MOZ_NO_REMOTE': '1', 03:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:53 INFO - 'NO_EM_RESTART': '1', 03:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:53 INFO - 'PWD': '/builds/slave/test', 03:48:53 INFO - 'SHELL': '/bin/bash', 03:48:53 INFO - 'SHLVL': '1', 03:48:53 INFO - 'TERM': 'linux', 03:48:53 INFO - 'TMOUT': '86400', 03:48:53 INFO - 'USER': 'cltbld', 03:48:53 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', 03:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:53 INFO - '_': '/tools/buildbot/bin/python'} 03:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:53 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)) 03:48:53 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)) 03:48:53 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)) 03:48:53 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)) 03:48:53 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)) 03:48:53 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)) 03:48:53 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)) 03:48:53 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)) 03:48:53 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)) 03:48:53 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)) 03:48:53 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)) 03:48:53 INFO - Cleaning up... 03:48:53 INFO - Return code: 0 03:48:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03: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')]} 03:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe35030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3570>, '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 0x10f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', '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 03:48:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:48:53 INFO - Using env: {'DISPLAY': ':0', 03:48:53 INFO - 'HOME': '/home/cltbld', 03:48:53 INFO - 'LANG': 'en_US.UTF-8', 03:48:53 INFO - 'LANGUAGE': 'en_US:en', 03:48:53 INFO - 'LOGNAME': 'cltbld', 03:48:53 INFO - 'MAIL': '/var/mail/cltbld', 03:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:53 INFO - 'MOZ_NO_REMOTE': '1', 03:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:53 INFO - 'NO_EM_RESTART': '1', 03:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:53 INFO - 'PWD': '/builds/slave/test', 03:48:53 INFO - 'SHELL': '/bin/bash', 03:48:53 INFO - 'SHLVL': '1', 03:48:53 INFO - 'TERM': 'linux', 03:48:53 INFO - 'TMOUT': '86400', 03:48:53 INFO - 'USER': 'cltbld', 03:48:53 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', 03:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:53 INFO - '_': '/tools/buildbot/bin/python'} 03:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:48:53 INFO - Cleaning up... 03:48:53 INFO - Return code: 0 03:48:53 INFO - Running post-action listener: _resource_record_post_action 03:48:53 INFO - Running post-action listener: _start_resource_monitoring 03:48:53 INFO - Starting resource monitoring. 03:48:53 INFO - [mozharness: 2016-07-20 10:48:53.714785Z] Finished create-virtualenv step (success) 03:48:53 INFO - [mozharness: 2016-07-20 10:48:53.715218Z] Running install step. 03:48:53 INFO - Running pre-action listener: _resource_record_pre_action 03:48:53 INFO - Running main action method: install 03:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:53 INFO - Reading from file tmpfile_stdout 03:48:53 INFO - Detecting whether we're running mozinstall >=1.0... 03:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:48:53 INFO - Reading from file tmpfile_stdout 03:48:53 INFO - Output received: 03:48:53 INFO - Usage: mozinstall [options] installer 03:48:53 INFO - Options: 03:48:53 INFO - -h, --help show this help message and exit 03:48:54 INFO - -d DEST, --destination=DEST 03:48:54 INFO - Directory to install application into. [default: 03:48:54 INFO - "/builds/slave/test"] 03:48:54 INFO - --app=APP Application being installed. [default: firefox] 03:48:54 INFO - mkdir: /builds/slave/test/build/application 03:48:54 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'] 03:48:54 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 03:49:10 INFO - Reading from file tmpfile_stdout 03:49:10 INFO - Output received: 03:49:10 INFO - /builds/slave/test/build/application/firefox/firefox 03:49:10 INFO - Running post-action listener: _resource_record_post_action 03:49:10 INFO - [mozharness: 2016-07-20 10:49:10.437649Z] Finished install step (success) 03:49:10 INFO - [mozharness: 2016-07-20 10:49:10.437924Z] Running run-tests step. 03:49:10 INFO - Running pre-action listener: _resource_record_pre_action 03:49:10 INFO - Running main action method: run_tests 03:49:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:49:10 INFO - Python 2.7.3 03:49:10 INFO - Return code: 0 03:49:10 INFO - grabbing minidump binary from tooltool 03:49:10 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')]} 03:49:10 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 0x10f3570>, '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 0x10f4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:49:10 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 03:49:10 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 03:49:10 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 03:49:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:49:10 INFO - Return code: 0 03:49:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:49:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:49:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:49:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:49:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:49:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 03:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 03:49:10 INFO - Using env: {'DISPLAY': ':0', 03:49:10 INFO - 'HOME': '/home/cltbld', 03:49:10 INFO - 'LANG': 'en_US.UTF-8', 03:49:10 INFO - 'LANGUAGE': 'en_US:en', 03:49:10 INFO - 'LOGNAME': 'cltbld', 03:49:10 INFO - 'MAIL': '/var/mail/cltbld', 03:49:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:49:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:10 INFO - 'MOZ_NO_REMOTE': '1', 03:49:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:10 INFO - 'NO_EM_RESTART': '1', 03:49:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:10 INFO - 'PWD': '/builds/slave/test', 03:49:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:49:10 INFO - 'SHELL': '/bin/bash', 03:49:10 INFO - 'SHLVL': '1', 03:49:10 INFO - 'TERM': 'linux', 03:49:10 INFO - 'TMOUT': '86400', 03:49:10 INFO - 'USER': 'cltbld', 03:49:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452', 03:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:10 INFO - '_': '/tools/buildbot/bin/python'} 03:49:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 03:49:10 INFO - mozversion application_buildid: 20160720022221 03:49:10 INFO - mozversion application_changeset: e904e18d7dfcd8097f92d44104ca1462fc5d1335 03:49:10 INFO - mozversion application_display_name: Nightly 03:49:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:49:10 INFO - mozversion application_name: Firefox 03:49:10 INFO - mozversion application_remotingname: firefox 03:49:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:49:10 INFO - mozversion application_vendor: Mozilla 03:49:10 INFO - mozversion application_version: 50.0a1 03:49:10 INFO - mozversion platform_buildid: 20160720022221 03:49:10 INFO - mozversion platform_changeset: e904e18d7dfcd8097f92d44104ca1462fc5d1335 03:49:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:49:10 INFO - mozversion platform_version: 50.0a1 03:49:10 INFO - using testdate: 1469011750 03:49:10 INFO - actual date: 1469011750 03:49:10 INFO - starting webserver on 'localhost:46893' 03:49:10 INFO - SUITE-START | Running 2 tests 03:49:10 INFO - TEST-START | dromaeo_css 03:49:10 INFO - operating with platform_type : linux_ 03:49:10 INFO - Initialising browser for dromaeo_css test... 03:49:10 INFO - TEST-INFO | started process 18148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA9ZNBN/profile http://localhost:46893/getInfo.html) 03:49:15 INFO - PROCESS | 18148 | __metrics Screen width/height:1600/1200 03:49:15 INFO - PROCESS | 18148 | colorDepth:24 03:49:15 INFO - PROCESS | 18148 | Browser inner width/height: 1024/697 03:49:15 INFO - PROCESS | 18148 | __metrics 03:49:16 ERROR - PROCESS | 18148 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:49:17 INFO - TEST-INFO | 18148: exit 0 03:49:17 INFO - Browser initialized. 03:49:17 INFO - Running cycle 1/1 for dromaeo_css test... 03:49:17 INFO - TEST-INFO | started process 18267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA9ZNBN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:29 INFO - PROCESS | 18267 | RSS: Main: 168230912 03:49:29 INFO - PROCESS | 18267 | 03:50:18 INFO - PROCESS | 18267 | 1469011818990 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] 03:52:31 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:46893/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46893/tests/dromaeo/cssquery-ext.html) 03:52:32 INFO - PROCESS | 18267 | RSS: Main: 170373120 03:52:32 INFO - PROCESS | 18267 | 03:55:35 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:46893/tests/dromaeo/cssquery-ext.html (next: http://localhost:46893/tests/dromaeo/cssquery-jquery.html) 03:55:35 INFO - PROCESS | 18267 | RSS: Main: 169738240 03:55:35 INFO - PROCESS | 18267 | 03:58:37 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:46893/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46893/tests/dromaeo/cssquery-mootools.html) 03:58:38 INFO - PROCESS | 18267 | RSS: Main: 173600768 03:58:38 INFO - PROCESS | 18267 | 04:01:40 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:46893/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46893/tests/dromaeo/cssquery-prototype.html) 04:01:41 INFO - PROCESS | 18267 | RSS: Main: 168284160 04:01:41 INFO - PROCESS | 18267 | 04:04:43 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:46893/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46893/tests/dromaeo/cssquery-yui.html) 04:04:44 INFO - PROCESS | 18267 | RSS: Main: 169889792 04:04:44 INFO - PROCESS | 18267 | 04:07:47 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:46893/tests/dromaeo/cssquery-yui.html (next: http://localhost:46893/tests/dromaeo/cssquery-dojo.html) 04:07:47 INFO - PROCESS | 18267 | RSS: Main: 171319296 04:07:47 INFO - PROCESS | 18267 | 04:07:47 INFO - PROCESS | 18267 | __start_tp_report 04:07:47 INFO - PROCESS | 18267 | _x_x_mozilla_page_load 04:07:47 INFO - PROCESS | 18267 | _x_x_mozilla_page_load_details 04:07:47 INFO - PROCESS | 18267 | |i|pagename|runs| 04:07:47 INFO - PROCESS | 18267 | |0;dojo.html;2551.1198636470417;2564.4230048239147;2609.0607381342725;2610.034287313694;2614.137334679555;4619.884502887429;4691.366665500156;4799.496052914446;4827.710337379755;4856.174450343441;4694.718316900989;4775.212090005145;4792.520747925206;4815.590674792638;4877.902441951159;4429.114177164563;4458.464984201901;4583.816647334119;4585.633149348044;4599.195140850355;4239.448871646681;4529.388532548097;4554.089182163564;4581.3128030795315;4594.678372513926;4358.389825424443;4360.760158191299;4401.295792673157;4482.103579284156;4577;4433.800478978422;4443.822247110112;4445.73325600465;4462.419885414875;4558.452985641744;4459.888502787424;4468.955310446887;4475.820967161309;4481.887952801173;4512.593866551993;4787.042591481718;4853.587445067174;4864.075825593126;4878.024395120954;4889.3888263967;5227.059129356714;5233.895322093536;5239.633225674204;5257.053730328539;5259.132243179871;5295.4969277918535;5300.893982120375;5303.178007408819;5322.148456246982;5366.195070739382;4618.145643056012;4852.393450818648;4910.312556242129;4913.041956818386;4984.476629953875;5382.273393091961;5390.8921821563345;5390.8921821563345;5399.055165346127;5404.189371594292;5148.665336753099;5154.5360917516855;5191.247269146028;5194.194899790538;5214.009338225725;5023.120953833065;5084.694918304914;5146.794128234828;5191.195364718475;5194.35070616173;5148.6910785353;5149.794008239628;5151.330327057459;5162.406323272871;5195.19474481456;5091.847244582668;5123.180291153398;5139.665921715076;5150.896982060338;5182.1190397631735;4196.517400498981;4288.18524480354;4319.8488052918;4322.567743225715;4326.459192600925;3776.773393596393;3786.7159963002887;3787.962120378816;3817.9427308590393;3835.290471262825;4426.26966550522;4529.728216307032;4532.138893610204;4557.658175636774;4568.451785785661;5087.720175390389;5094.4141423736;5094.694318340911;5104.744762761921;5276.050310943991;4379.189849877783;4380.561943805594;4383.758893260838;4406.471223453206;4418.9337159942625;4530.275155975094;4530.796114174804;4547.8635640930825;4554.931676024862;4579.6794224403975;4805.7597120143855;4827.734474603931;4883.658143929891;4891.192953162688;4930.964497455575;5197.740112994259;5217.869553261199;5218.765155568084;5226.425093239816;5252.763625636779;4942.703437793743;4956;4958.652894297365;4959.82640607577;5010.49895010496;5031.295618613471;5056.140456122542;5077.847664570068;5087.389513258433;5174.223866420067;5151.1243088675765;5196.350456192976;5208.140656791587;5222.973885130702;5230.424653288212;5026.698398096126;5051.747412629427;5057.064443078042;5074.492550744896;5106.7701953412925;4934.309196712391;4935.679180853233;4984.651074424755;5022.020705962303;5090.745462726774;4860.708357498562;4932.901341973212;4959.380077490314;4971.254311853251;5038.168702164102;4970.900581988412;4985.077760614153;4994.825181118644;5004.224345226496;5053.646244762831;4728.31439441286;4842.661013729005;4848.296996935495;4876.731779752147;4911.557959783637 04:07:47 INFO - PROCESS | 18267 | |1;ext.html;529.7510170219998;555.84714203594;566.1875209074977;579.9710014499277;605.4581149870868;36874.078148046276;40065.1986960261;40309.19381612366;40318.992025199346;40335.596644033554;39522;40169.79915100428;40222.7988860056;40240.39639405404;40339.59660403395;7748.612569371523;7913.366930645535;7918.168592297812;7923.2869041786225;7934.523928564276;7843.764687059369;7915.050193976702;7919.326857217144;7933.722319718811;7938.126806051329;7958.4826986246;7958.721444749435;7985.800354991114;7989.081255655587;7995.320397766197;7892.250236227578;7913.0899946506315;7930.603469826486;7951.483153594998;7965.840683186362;7675.923240767576;7740;7775.222477752236;7779;7807.102183248886;38324.425133623015;38617;38751;38833.805830970945;38860.222795544214;2967.74774144198;3250.821204833733;3263.9184020399443;3654.6162652921594;3749.456328832331;29623.450905624377;29812.254693632614;29902.850485747433;30010.549841752392;30345.393092138034;3093.597832281789;3273.6562660920736;3307.536944827726;3321.9003429897143;3429.331280400323;275588;276226;277789;278568;279231;31230.37539249248;32217.35565288728;55549.44450555443;55734;56066.159007614915;32753.672463275063;33019.3396132076;33071;33247.66752332446;33255.66744332574;13319;13399.062065655311;13461.394237259346;13560.932195339157;13593.320333983262;11333.206675532634;11436.59971900996;11470.36912969778;11496.540138394537;11522.366269855238;7963.362930965624;7964.283214510722;7986.281234688906;8107.108218096005;8112.22933821286;3126.265327648001;3150.5904232449634;3175.237942893689;3182.156728466958;3223.903282901517;892.3575025981283;910.3354551177678;919.8758167647281;927.5501381829807;1048.1509976918721;28133.71866281352;28694.713052869203;29018.854905725337;29028.274293142418;29127.563086553717;940.431039221275;968.3947532792005;1003.934744241622;1008.2740426892625;1012.0688966151158;14754.336054877342;15452.459163929208;15602.141882196589;15618.609534761721;15847.207639617973;396975;399091;401114;401364;401897;48575.514244857804;48855.75572122117;49115;49152.26271605857;49315.50684493109;1200.2816083182922;1209.1777591238042;1213.8604060533153;1216.2398500936915;1236.097648716442;27075;27992.160235192976;28520.14439566816;28570.857145714137;28895.5665665011;43310;43695;43766;43844;43874.78062609667;336523;337180;339533;340053;340228;25818.35454113662;26117.216483505526;26147.869260653573;26201.34496637523;26213.606795897696;43512.78243608762;44443.66668999935;44646.77676611726;47391;48138.5186148134;35239.82380088083;35690;36894.446583300734;37265.441018384205;37590.812045939594;36592.817035915716;37084.81457592803;37554;37634.059148521505;38106;35904.64095359117;39579.60420395874;40079.39880901847;40086.79956600198;40855.38716919308;35401.468977965866;37244;37540.2491950154;39553.406698898965;40024.599754003255;28814.423711526073;31111.377772444877;31203.84398077995;31362.372752545278;31904.521432178073 04:07:47 INFO - PROCESS | 18267 | |2;jquery.html;362.4979403526116;368.6534657422023;378.16425699204757;381.07779174397956;388.97471664341816;16019.279132439038;16846.326146954107;17259.395921142746;17361.91319043406;17395;16197;16951.57621059474;17150;17212.827871721278;17248.137593120355;4753.429588449391;4971.428285747131;4985.476524964881;4987.576056035223;4992.101421744084;3793.943090853639;5225.425203227642;5931.703414829263;6178.413050760193;6187.969060154693;6219.844503887393;6282.183316168892;6282.465990390822;6292.8741425171465;6310.779122730705;6040.184575082351;6139;6160.691965401712;6169.074638804171;6173.382661733835;4765.594924431428;5028.899422011576;5404.5946554008215;5417.45825417459;5418.458154184589;12177.756444871142;12284.692882677915;12434.129610927239;12506.249625022529;12548.874511254862;1795.8473529749988;1811.8641101917408;1814.7731533558306;2156.4608847788054;2421.4430680943483;9210.815783684357;9406.38858474197;10023.799524009552;10497.685069447929;13476.326183690875;1662.384917580503;1683.7306031035098;1713.4859542137433;1721.4921598128583;1747.1002433746503;40472;66695;71524.64237678831;71563.64218178876;71587.64206178988;9850.261230407605;9876.80246395068;10109.191264698806;10188.847167292497;10328.122109620615;13801.585952421443;13932.303384830719;13962.650933726534;13977.091489053382;13983.091099078527;6945.652717364213;7196.784096477114;7225.494215404871;7370.299821517055;7473.252674732484;6853.772523929742;6898.586084834926;7012.193597736224;7070.257622949516;7091.716331346792;4251.128518653669;4340.891477713082;4356.281213599784;4455.754933478625;4471.195184866755;1659.7842280503457;1714.5199344183648;1749.9737503937451;1814.5100822777777;1820.5063653550947;813.8413009463217;831.1439217605875;850.9829803403898;904.674317245791;946.0539460539461;16761;17204.677368555334;17266.395676151275;17692.823071769373;17697.469075927744;867.2005588404087;869.9608517616722;903.3089686389917;914.3873604684877;918.3158546882615;9522.571484283224;9760.219182465386;9780.804383912282;9892.55483503244;9968.900310996942;420502;424868;430822;430900;431844;77745;80868;81274.59362703266;81519;82974.17025829664;901.2789768185426;941.223490620241;949.9097585729345;963.2582911158509;963.5904740485406;16039.438619648256;16149.838501614833;16488.67022659564;16658.58353541171;16779.077150756337;38406.4310674945;38949.22101558009;39149.21701565896;39913.80043099766;40790.18419631531;47307;48531;49719.25421118759;56155.71922140363;56356.71821641029;6920.446364290744;7747.457677962489;7972.800679983046;8066.7579972600915;8083.676652934052;9943.602255909682;12373.566925157576;12608.243505389706;12648.494060237488;12985.805212922003;10345.948270258901;10691.09125724322;10969;11210.159238057015;11351.035162011322;10563.207759418228;10581.788364232827;10816.891831081588;10850.620228291971;10859.34843909368;10270.948645256725;10463.11063559606;10667.039966403061;10677.9466102669;11287.604933827277;6739.831504212434;7043.7534686285735;7210.567365958059;7293.708251669874;7559.130699969354;10386.428746418716;10692.411917344309;10818.188635852186;11036.11711063097;11261.774764504828 04:07:47 INFO - PROCESS | 18267 | |3;mootools.html;1378.7793952967527;1423.5373503611327;1489.3744627256551;1664.4424117920496;1737.2790292028808;7005.8598828023405;7609.54342739436;7637.1980942001055;8174.100848906623;8185.427020108595;7748.496347737393;8046.517208967466;8062.072861620915;8092.069412017605;8108.391870609698;2257.243823319186;2280.3387017764912;2280.350100221437;2292.896819643112;2296.1848543766973;2262.7737226277404;2284.5088306014204;2290.9885450572806;2299.619559247903;2302.0101356416735;2235.3629215673536;2245.820334373246;2256.9774302256933;2259.141526220034;2266.5240299537118;2151.8278537716947;2180.9127634894585;2184.9344519664437;2190.463336482556;2192.3422973108163;2206.746224184223;2225.221172589597;2230;2232.821374290053;2233.0286325448483;7887.881681774778;8024.317932975704;8041.8793718094275;8043.39674524413;8066.757997260033;4674.088552732219;4797.160496913027;4804.735739534324;4805.735684537349;4822.541858523435;2796.4546913351905;2898.4637841999297;2899.246195989037;2928.282570770175;2956.2904902823384;893.8614514750224;914.4787471141452;940.4498368454463;957.0716405087054;961.1397798969883;10765.62320318793;10795.08241799448;10870.891291087146;10890.509927053301;10921.235513514057;4021.4369988201674;4241.936370954438;4320.870373888788;4411.669124815588;4428.468583769968;9238.769030774285;9264.39781414206;9268.165865072042;9270.490123043297;9323.207527360115;4768.546988036131;4782.282657601318;4782.832600858953;4787.138315103245;4803.567678908915;3754.0614846288427;4209;4317;4349.934750978738;4389.407429996973;3627.5646922369483;3642.162302670348;3767.7174211934216;3785.242951409729;3823.770573765583;1184.088252045937;1205.4394706461537;1223.424990254579;1223.8347823043775;1240.4418011894684;778.0352363069753;807.4428644235459;810.5947026486757;819.713100414862;829.2371018662844;5062.4684408137355;5103.055934652101;5149.691018538825;5172.767225474862;5312.946870531323;406.09035759898205;420.6760794188458;425.5064125614273;425.8275398463627;427.01998912495895;3592.3174596827043;3643.617420170897;3648.543932008499;3671.7980511072146;3744.5319335083113;8557.914420855712;8891.066438024043;8916.197542221102;8918.910810891937;9026.413283136575;8812.779680508038;8843.292536597057;8853.468791872509;8979.46123232608;8999.415038022507;6871.175458944958;6961.199462061826;6962.025316455701;6978.371946524736;6987.790366289019;4693.530646935279;4745.881352966204;4780.259059845729;4928.852134435972;4996.900061998813;8150.510969341858;8240.587970601566;8283.337333013465;8328.875066873881;8436.367272454714;8277.130901255523;8287.171282871665;8379.120192379713;8434.451760635538;8457.661693532189;6239;6508;6508.284088750139;6734.865302693821;6907.6891539879825;7612.048493938258;7720.3051725344985;7721.189275126031;7728.806779830549;7731;6819.863602727818;6895.55178913369;6927.89608155868;6933.5493192942295;7129.679164437509;6790.490713196431;6811.489138314745;6819.079424277659;6855.4172895304455;6876.862462750817;5944.970275148597;6176.258848938156;6226.750929962751;6236.438720515175;6264.68676566179;4483.484399294123;4508.1659892919915;4556.726596404226;4651.3023046543285;4672.836450724209;4438.889027774331;4530.478994915627;4554.111948170207;4582.106489234568;4593.28804035375 04:07:47 INFO - PROCESS | 18267 | |4;prototype.html;293.0855730122021;301.8988638806;306.98158110513356;308.36169129901106;308.86255616250764;4888.31563581098;4933.720918617081;4997.575206107481;5091.15995860683;5102;4959.900801983958;4980.203167493201;4983.729149066983;5005.199168133099;5007.22388029855;3965.662918651918;3975.4633124528254;3975.7415767975135;3992.7205095643317;3998.400239964014;3898.1813819098024;3946.842126314944;3976.284268831609;3983.3825757007567;4000.4399384086105;3923.431102490137;3927.252372694152;3944.408338749182;3949.111449923773;3952.980235098835;3968.285708572456;3969.761814291152;3971.702122340807;3971.9007024824323;3980.1840622672285;3478.808665523395;3502.7548071634997;3517.8944631661093;3535.3207226567433;3538.9646103538894;4822.734749588772;4922.581580565657;4929.134957760243;4955.182394904837;4999.750112449412;4513.616342610882;4515.977420112911;4516.887077823048;4525.932111018337;4545.499995000548;5306.575473962073;5309.495597918191;5319.840404787863;5329.626926115174;5343.358796944352;3738.6448287412654;3775.8867233983024;3820.7707537547835;3827.2585973382043;3842.5965273646143;5473.31583552056;5486.231927530149;5521.282233309644;5527.53015993641;5527.618095476131;3870.8838734838;3896.759363366076;3903.6877049835944;3903.980480097581;3924.7841368724994;3612.4039533477207;3971.900702482461;3975.582563830756;3981.6814654827544;3997.320455522568;4386.320120381346;4404.515503294635;4410.3825464435;4413.183561041217;4421.336799480039;5306;5325.949509438894;5329.866753331198;5331.626786125012;5353.839384818461;1259.8677138900466;1301.73965206959;1322.3784821134052;1326.9914864702896;1328.4221363706818;877.9692710755221;889.1464194373474;906.5059542549326;910.822389634015;913.2328843771131;4541.568550987651;4571.337156112345;4592.311153327028;4594.540545945446;4597.931031034537;5379.220013098157;5386.326709161355;5395.244665746799;5402.594805389612;5415.566754659618;4471.977640111779;4568.406107206042;4579;4591.1965406053805;4595.747233902101;2551.234629611109;2554.93612659685;2574.7811436027773;2575.660656458631;2592.844429334246;4530.61489773373;4551.837877008461;4570.88572785683;4594.782382668595;4606.677532572755;4667.562289932259;4885.679302331364;4887.458521568764;4899;4916.877078073006;4499.775011249424;4577.22187228172;4606.236258245026;4616.838410655611;4627.444706635225;4752.857414277577;4768.3085952537385;4777.163996300703;4794.376731024944;4811.687240329367;4516.367708520876;4714.457837348748;4717.834875779331;4737.076270127292;4743.810247590058;4563.566461186182;4580.519045500175;4587.7017993830295;4593.402857628487;4599.379083823641;3476.634953329864;3480.512728218102;3506.070891213881;3510.982445087758;3519.947200791939;4767.761611919321;4770.260609605517;4806.625970366949;4811.27830825379;5188.922166167586;5016.899662006813;5282.788688452419;5289.444608316071;5293.030227329503;5315.681059136464;5260.473952604709;5261.3686357637325;5261.763220655003;5261.789528418821;5266.920996184984;5042.319286896369;5182.663126896739;5198.16829307309;5202.765875535686;5204.34945631796;5226.398964119175;5236.816711415082;5268.315119034501;5269.1832765921345;5271.551918087006;5135.998480296306;5154.175331946871;5164.767585458739;5174.586033117266;5184.055979007872 04:07:47 INFO - PROCESS | 18267 | |5;yui.html;630.8485963368793;659.6899457255091;660.0561197487593;691.5297597633607;745.1765798792336;12769.361531923401;13695.589132326022;13744.175349479014;13761.655958601028;13799.034067615272;12978.22130672158;13326.400311985959;13527.526536571222;13948.163110213394;13986.440542378292;780.1418439716323;798.0901771979918;799.6481548118809;800.4676889868259;801.4149670740363;623.5354660777705;774.4733581164805;794.4597673581991;797.8643630582786;800.9559474228915;840.9117042710519;843.2200214801314;844.877492763549;845.8562044452427;849.3035710717214;842.6882053640193;843.9071702112763;844.0377969115214;844.0841686769862;845.9957700211521;613.3621034124506;617.3826173826174;617.4257940115691;617.6263360666821;617.8270084376381;13918.652033699138;13931.30343482832;13938.094023888414;13948.372323245378;13966.022378433514;12672.873271267354;13087.214767114003;13128.606141815666;13179.472821087145;13272.800907986388;10043;10101.898981010168;10617.522211500424;10677.092447142002;10768.676939691823;3249.2039450334582;3273.9508907366408;3330.184104894292;3345.7825241359233;3423.760336776427;65053.349466505206;66755;67374;67852;69372.65313673399;10335.328203666737;10419.218558608134;10435.478226088817;10475.94762026185;10566.313189642802;16619.169041547873;16642.833571664127;16658.916705416395;16751.664966700842;17869;6498.5126115541525;6698.66506674674;6766.18805743314;6776.966115169393;7121.89317160243;3595.442706380515;3819.732618716663;3911.2177564487215;3925.3523168676847;4001.4998125234347;2837.7446029857;2980.418818330405;3004.023692300011;3029.2275469755073;3049.374878149974;527.0407857698951;530.6285600079959;531.7607076815449;553.5543887170786;554.0498045851384;519.366373024909;533.1922137960992;582.9941700583024;605.6063558686889;609.2719200555293;7952.721654742057;8036.959815200887;8096.149904260085;8241.670333186605;8348.499090054494;517.6816258001302;542.0189457082693;548.0655482402494;555.8276934150426;562.412279168262;3718.2563487302646;3736.458213559073;3738.6635202831876;3764.4541541476333;3863.111484358557;93092;93697;95983;97106;100769;69513.3048669517;71741.64129179425;84245;85754.57122714346;87242.56378718065;66167.33832661709;71540.64229678818;73506.63246683733;73661;74346.25653743393;8521.616527256412;9003.549822508718;9039.819203616022;9251.398659087406;9411.85882211781;29891;40354.79822600868;40794.388084178165;43328;46906;36719.63280367162;36952.26095478129;37496.43755343727;53575;66830;11621.535138594361;11717.238379505305;11717.941410292893;11795.469203885674;12092.576759813364;12256.142070055368;12450.190737602026;13144.342782860627;13159.342032898508;13195;11433.771324573296;11955.76088478243;11993.82009269879;11995.40022998864;12749.617511474671;12010;12337.444814983168;12494.250344978967;12531.248125112523;13095.69624302121;12532.937335313265;12574.559890403792;12785.744285114431;12933.224006559636;13368;9489.593657086223;9851.753706157404;9981.750456238653;10061.647842325483;10400.479976001321;8661.566921653766;9151.359404841598;9739.805203895741;9750.658726944806;9830.262730295113 04:07:47 INFO - PROCESS | 18267 | __end_tp_report 04:07:47 INFO - PROCESS | 18267 | __start_cc_report 04:07:47 INFO - PROCESS | 18267 | _x_x_mozilla_cycle_collect,399 04:07:47 INFO - PROCESS | 18267 | __end_cc_report 04:07:47 INFO - PROCESS | 18267 | __startTimestamp1469012867505__endTimestamp 04:07:47 INFO - PROCESS | 18267 | 04:07:47 INFO - PROCESS | 18267 | ------- Summary: start ------- 04:07:47 INFO - PROCESS | 18267 | Number of tests: 6 04:07:47 INFO - PROCESS | 18267 | 04:07:47 INFO - PROCESS | 18267 | [#0] dojo.html Cycles:165 Average:4779.15 Median:4911.56 stddev:526.60 (10.7%) stddev-sans-first:498.36 04:07:47 INFO - PROCESS | 18267 | Values: 2551.1 2564.4 2609.1 2610.0 2614.1 4619.9 4691.4 4799.5 4827.7 4856.2 4694.7 4775.2 4792.5 4815.6 4877.9 4429.1 4458.5 4583.8 4585.6 4599.2 4239.4 4529.4 4554.1 4581.3 4594.7 4358.4 4360.8 4401.3 4482.1 4577.0 4433.8 4443.8 4445.7 4462.4 4558.5 4459.9 4469.0 4475.8 4481.9 4512.6 4787.0 4853.6 4864.1 4878.0 4889.4 5227.1 5233.9 5239.6 5257.1 5259.1 5295.5 5300.9 5303.2 5322.1 5366.2 4618.1 4852.4 4910.3 4913.0 4984.5 5382.3 5390.9 5390.9 5399.1 5404.2 5148.7 5154.5 5191.2 5194.2 5214.0 5023.1 5084.7 5146.8 5191.2 5194.4 5148.7 5149.8 5151.3 5162.4 5195.2 5091.8 5123.2 5139.7 5150.9 5182.1 4196.5 4288.2 4319.8 4322.6 4326.5 3776.8 3786.7 3788.0 3817.9 3835.3 4426.3 4529.7 4532.1 4557.7 4568.5 5087.7 5094.4 5094.7 5104.7 5276.1 4379.2 4380.6 4383.8 4406.5 4418.9 4530.3 4530.8 4547.9 4554.9 4579.7 4805.8 4827.7 4883.7 4891.2 4931.0 5197.7 5217.9 5218.8 5226.4 5252.8 4942.7 4956.0 4958.7 4959.8 5010.5 5031.3 5056.1 5077.8 5087.4 5174.2 5151.1 5196.4 5208.1 5223.0 5230.4 5026.7 5051.7 5057.1 5074.5 5106.8 4934.3 4935.7 4984.7 5022.0 5090.7 4860.7 4932.9 4959.4 4971.3 5038.2 4970.9 4985.1 4994.8 5004.2 5053.6 4728.3 4842.7 4848.3 4876.7 4911.6 04:07:47 INFO - PROCESS | 18267 | 04:07:47 INFO - PROCESS | 18267 | [#1] ext.html Cycles:180 Average:48575.08 Median:20644.85 stddev:90332.82 (437.6%) stddev-sans-first:90514.20 04:07:47 INFO - PROCESS | 18267 | Values: 529.8 555.8 566.2 580.0 605.5 36874.1 40065.2 40309.2 40319.0 40335.6 39522.0 40169.8 40222.8 40240.4 40339.6 7748.6 7913.4 7918.2 7923.3 7934.5 7843.8 7915.1 7919.3 7933.7 7938.1 7958.5 7958.7 7985.8 7989.1 7995.3 7892.3 7913.1 7930.6 7951.5 7965.8 7675.9 7740.0 7775.2 7779.0 7807.1 38324.4 38617.0 38751.0 38833.8 38860.2 2967.7 3250.8 3263.9 3654.6 3749.5 29623.5 29812.3 29902.9 30010.5 30345.4 3093.6 3273.7 3307.5 3321.9 3429.3 275588.0 276226.0 277789.0 278568.0 279231.0 31230.4 32217.4 55549.4 55734.0 56066.2 32753.7 33019.3 33071.0 33247.7 33255.7 13319.0 13399.1 13461.4 13560.9 13593.3 11333.2 11436.6 11470.4 11496.5 11522.4 7963.4 7964.3 7986.3 8107.1 8112.2 3126.3 3150.6 3175.2 3182.2 3223.9 892.4 910.3 919.9 927.6 1048.2 28133.7 28694.7 29018.9 29028.3 29127.6 940.4 968.4 1003.9 1008.3 1012.1 14754.3 15452.5 15602.1 15618.6 15847.2 396975.0 399091.0 401114.0 401364.0 401897.0 48575.5 48855.8 49115.0 49152.3 49315.5 1200.3 1209.2 1213.9 1216.2 1236.1 27075.0 27992.2 28520.1 28570.9 28895.6 43310.0 43695.0 43766.0 43844.0 43874.8 336523.0 337180.0 339533.0 340053.0 340228.0 25818.4 26117.2 26147.9 26201.3 26213.6 43512.8 44443.7 44646.8 47391.0 48138.5 35239.8 35690.0 36894.4 37265.4 37590.8 36592.8 37084.8 37554.0 37634.1 38106.0 35904.6 39579.6 40079.4 40086.8 40855.4 35401.5 37244.0 37540.2 39553.4 40024.6 28814.4 31111.4 31203.8 31362.4 31904.5 04:07:47 INFO - PROCESS | 18267 | 04:07:47 INFO - PROCESS | 18267 | [#2] jquery.html Cycles:180 Average:25384.17 Median:430861.00 stddev:70456.52 (16.4%) stddev-sans-first:70629.12 04:07:47 INFO - PROCESS | 18267 | Values: 362.5 368.7 378.2 381.1 389.0 16019.3 16846.3 17259.4 17361.9 17395.0 16197.0 16951.6 17150.0 17212.8 17248.1 4753.4 4971.4 4985.5 4987.6 4992.1 3793.9 5225.4 5931.7 6178.4 6188.0 6219.8 6282.2 6282.5 6292.9 6310.8 6040.2 6139.0 6160.7 6169.1 6173.4 4765.6 5028.9 5404.6 5417.5 5418.5 12177.8 12284.7 12434.1 12506.2 12548.9 1795.8 1811.9 1814.8 2156.5 2421.4 9210.8 9406.4 10023.8 10497.7 13476.3 1662.4 1683.7 1713.5 1721.5 1747.1 40472.0 66695.0 71524.6 71563.6 71587.6 9850.3 9876.8 10109.2 10188.8 10328.1 13801.6 13932.3 13962.7 13977.1 13983.1 6945.7 7196.8 7225.5 7370.3 7473.3 6853.8 6898.6 7012.2 7070.3 7091.7 4251.1 4340.9 4356.3 4455.8 4471.2 1659.8 1714.5 1750.0 1814.5 1820.5 813.8 831.1 851.0 904.7 946.1 16761.0 17204.7 17266.4 17692.8 17697.5 867.2 870.0 903.3 914.4 918.3 9522.6 9760.2 9780.8 9892.6 9968.9 420502.0 424868.0 430822.0 430900.0 431844.0 77745.0 80868.0 81274.6 81519.0 82974.2 901.3 941.2 949.9 963.3 963.6 16039.4 16149.8 16488.7 16658.6 16779.1 38406.4 38949.2 39149.2 39913.8 40790.2 47307.0 48531.0 49719.3 56155.7 56356.7 6920.4 7747.5 7972.8 8066.8 8083.7 9943.6 12373.6 12608.2 12648.5 12985.8 10345.9 10691.1 10969.0 11210.2 11351.0 10563.2 10581.8 10816.9 10850.6 10859.3 10270.9 10463.1 10667.0 10677.9 11287.6 6739.8 7043.8 7210.6 7293.7 7559.1 10386.4 10692.4 10818.2 11036.1 11261.8 04:07:47 INFO - PROCESS | 18267 | 04:07:47 INFO - PROCESS | 18267 | [#3] mootools.html Cycles:180 Average:5084.67 Median:4805.24 stddev:2803.85 (58.3%) stddev-sans-first:2797.88 04:07:47 INFO - PROCESS | 18267 | Values: 1378.8 1423.5 1489.4 1664.4 1737.3 7005.9 7609.5 7637.2 8174.1 8185.4 7748.5 8046.5 8062.1 8092.1 8108.4 2257.2 2280.3 2280.4 2292.9 2296.2 2262.8 2284.5 2291.0 2299.6 2302.0 2235.4 2245.8 2257.0 2259.1 2266.5 2151.8 2180.9 2184.9 2190.5 2192.3 2206.7 2225.2 2230.0 2232.8 2233.0 7887.9 8024.3 8041.9 8043.4 8066.8 4674.1 4797.2 4804.7 4805.7 4822.5 2796.5 2898.5 2899.2 2928.3 2956.3 893.9 914.5 940.4 957.1 961.1 10765.6 10795.1 10870.9 10890.5 10921.2 4021.4 4241.9 4320.9 4411.7 4428.5 9238.8 9264.4 9268.2 9270.5 9323.2 4768.5 4782.3 4782.8 4787.1 4803.6 3754.1 4209.0 4317.0 4349.9 4389.4 3627.6 3642.2 3767.7 3785.2 3823.8 1184.1 1205.4 1223.4 1223.8 1240.4 778.0 807.4 810.6 819.7 829.2 5062.5 5103.1 5149.7 5172.8 5312.9 406.1 420.7 425.5 425.8 427.0 3592.3 3643.6 3648.5 3671.8 3744.5 8557.9 8891.1 8916.2 8918.9 9026.4 8812.8 8843.3 8853.5 8979.5 8999.4 6871.2 6961.2 6962.0 6978.4 6987.8 4693.5 4745.9 4780.3 4928.9 4996.9 8150.5 8240.6 8283.3 8328.9 8436.4 8277.1 8287.2 8379.1 8434.5 8457.7 6239.0 6508.0 6508.3 6734.9 6907.7 7612.0 7720.3 7721.2 7728.8 7731.0 6819.9 6895.6 6927.9 6933.5 7129.7 6790.5 6811.5 6819.1 6855.4 6876.9 5945.0 6176.3 6226.8 6236.4 6264.7 4483.5 4508.2 4556.7 4651.3 4672.8 4438.9 4530.5 4554.1 4582.1 4593.3 04:07:47 INFO - PROCESS | 18267 | 04:07:47 INFO - PROCESS | 18267 | [#4] prototype.html Cycles:180 Average:4253.14 Median:4598.66 stddev:1223.20 (26.6%) stddev-sans-first:1189.97 04:07:47 INFO - PROCESS | 18267 | Values: 293.1 301.9 307.0 308.4 308.9 4888.3 4933.7 4997.6 5091.2 5102.0 4959.9 4980.2 4983.7 5005.2 5007.2 3965.7 3975.5 3975.7 3992.7 3998.4 3898.2 3946.8 3976.3 3983.4 4000.4 3923.4 3927.3 3944.4 3949.1 3953.0 3968.3 3969.8 3971.7 3971.9 3980.2 3478.8 3502.8 3517.9 3535.3 3539.0 4822.7 4922.6 4929.1 4955.2 4999.8 4513.6 4516.0 4516.9 4525.9 4545.5 5306.6 5309.5 5319.8 5329.6 5343.4 3738.6 3775.9 3820.8 3827.3 3842.6 5473.3 5486.2 5521.3 5527.5 5527.6 3870.9 3896.8 3903.7 3904.0 3924.8 3612.4 3971.9 3975.6 3981.7 3997.3 4386.3 4404.5 4410.4 4413.2 4421.3 5306.0 5325.9 5329.9 5331.6 5353.8 1259.9 1301.7 1322.4 1327.0 1328.4 878.0 889.1 906.5 910.8 913.2 4541.6 4571.3 4592.3 4594.5 4597.9 5379.2 5386.3 5395.2 5402.6 5415.6 4472.0 4568.4 4579.0 4591.2 4595.7 2551.2 2554.9 2574.8 2575.7 2592.8 4530.6 4551.8 4570.9 4594.8 4606.7 4667.6 4885.7 4887.5 4899.0 4916.9 4499.8 4577.2 4606.2 4616.8 4627.4 4752.9 4768.3 4777.2 4794.4 4811.7 4516.4 4714.5 4717.8 4737.1 4743.8 4563.6 4580.5 4587.7 4593.4 4599.4 3476.6 3480.5 3506.1 3511.0 3519.9 4767.8 4770.3 4806.6 4811.3 5188.9 5016.9 5282.8 5289.4 5293.0 5315.7 5260.5 5261.4 5261.8 5261.8 5266.9 5042.3 5182.7 5198.2 5202.8 5204.3 5226.4 5236.8 5268.3 5269.2 5271.6 5136.0 5154.2 5164.8 5174.6 5184.1 04:07:47 INFO - PROCESS | 18267 | 04:07:47 INFO - PROCESS | 18267 | [#5] yui.html Cycles:180 Average:17190.93 Median:23711.84 stddev:24279.49 (102.4%) stddev-sans-first:24315.76 04:07:47 INFO - PROCESS | 18267 | Values: 630.8 659.7 660.1 691.5 745.2 12769.4 13695.6 13744.2 13761.7 13799.0 12978.2 13326.4 13527.5 13948.2 13986.4 780.1 798.1 799.6 800.5 801.4 623.5 774.5 794.5 797.9 801.0 840.9 843.2 844.9 845.9 849.3 842.7 843.9 844.0 844.1 846.0 613.4 617.4 617.4 617.6 617.8 13918.7 13931.3 13938.1 13948.4 13966.0 12672.9 13087.2 13128.6 13179.5 13272.8 10043.0 10101.9 10617.5 10677.1 10768.7 3249.2 3274.0 3330.2 3345.8 3423.8 65053.3 66755.0 67374.0 67852.0 69372.7 10335.3 10419.2 10435.5 10475.9 10566.3 16619.2 16642.8 16658.9 16751.7 17869.0 6498.5 6698.7 6766.2 6777.0 7121.9 3595.4 3819.7 3911.2 3925.4 4001.5 2837.7 2980.4 3004.0 3029.2 3049.4 527.0 530.6 531.8 553.6 554.0 519.4 533.2 583.0 605.6 609.3 7952.7 8037.0 8096.1 8241.7 8348.5 517.7 542.0 548.1 555.8 562.4 3718.3 3736.5 3738.7 3764.5 3863.1 93092.0 93697.0 95983.0 97106.0 100769.0 69513.3 71741.6 84245.0 85754.6 87242.6 66167.3 71540.6 73506.6 73661.0 74346.3 8521.6 9003.5 9039.8 9251.4 9411.9 29891.0 40354.8 40794.4 43328.0 46906.0 36719.6 36952.3 37496.4 53575.0 66830.0 11621.5 11717.2 11717.9 11795.5 12092.6 12256.1 12450.2 13144.3 13159.3 13195.0 11433.8 11955.8 11993.8 11995.4 12749.6 12010.0 12337.4 12494.3 12531.2 13095.7 12532.9 12574.6 12785.7 12933.2 13368.0 9489.6 9851.8 9981.8 10061.6 10400.5 8661.6 9151.4 9739.8 9750.7 9830.3 04:07:47 INFO - PROCESS | 18267 | -------- Summary: end -------- 04:07:47 INFO - PROCESS | 18267 | 04:07:48 INFO - TEST-INFO | 18267: exit 0 04:07:48 INFO - TEST-OK | dromaeo_css | took 1117598ms 04:07:48 INFO - TEST-START | kraken 04:07:48 INFO - operating with platform_type : linux_ 04:07:48 INFO - Initialising browser for kraken test... 04:07:48 INFO - TEST-INFO | started process 18514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp52Wf_0/profile http://localhost:46893/getInfo.html) 04:07:53 INFO - PROCESS | 18514 | __metrics Screen width/height:1600/1200 04:07:53 INFO - PROCESS | 18514 | colorDepth:24 04:07:53 INFO - PROCESS | 18514 | Browser inner width/height: 1024/697 04:07:53 INFO - PROCESS | 18514 | __metrics 04:07:53 ERROR - PROCESS | 18514 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:07:54 INFO - TEST-INFO | 18514: exit 0 04:07:54 INFO - Browser initialized. 04:07:54 INFO - Running cycle 1/1 for kraken test... 04:07:54 INFO - TEST-INFO | started process 18630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp52Wf_0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:06 INFO - PROCESS | 18630 | RSS: Main: 168685568 04:08:06 INFO - PROCESS | 18630 | 04:08:09 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:46893/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46893/tests/kraken/driver.html?testName=audio-beat-detection) 04:08:10 INFO - PROCESS | 18630 | RSS: Main: 172875776 04:08:10 INFO - PROCESS | 18630 | 04:08:13 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:46893/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46893/tests/kraken/driver.html?testName=audio-dft) 04:08:13 INFO - PROCESS | 18630 | RSS: Main: 172593152 04:08:13 INFO - PROCESS | 18630 | 04:08:16 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:46893/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46893/tests/kraken/driver.html?testName=audio-fft) 04:08:17 INFO - PROCESS | 18630 | RSS: Main: 168894464 04:08:17 INFO - PROCESS | 18630 | 04:08:19 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:46893/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46893/tests/kraken/driver.html?testName=audio-oscillator) 04:08:20 INFO - PROCESS | 18630 | RSS: Main: 169594880 04:08:20 INFO - PROCESS | 18630 | 04:08:22 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:46893/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46893/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:08:22 INFO - PROCESS | 18630 | RSS: Main: 169840640 04:08:22 INFO - PROCESS | 18630 | 04:08:26 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:46893/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46893/tests/kraken/driver.html?testName=imaging-darkroom) 04:08:26 INFO - PROCESS | 18630 | RSS: Main: 170467328 04:08:26 INFO - PROCESS | 18630 | 04:08:30 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:46893/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46893/tests/kraken/driver.html?testName=imaging-desaturate) 04:08:31 INFO - PROCESS | 18630 | RSS: Main: 167763968 04:08:31 INFO - PROCESS | 18630 | 04:08:34 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:46893/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46893/tests/kraken/driver.html?testName=json-parse-financial) 04:08:34 INFO - PROCESS | 18630 | RSS: Main: 168853504 04:08:34 INFO - PROCESS | 18630 | 04:08:36 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:46893/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46893/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:08:37 INFO - PROCESS | 18630 | RSS: Main: 169660416 04:08:37 INFO - PROCESS | 18630 | 04:08:38 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:46893/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46893/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:08:39 INFO - PROCESS | 18630 | RSS: Main: 169574400 04:08:39 INFO - PROCESS | 18630 | 04:08:41 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:46893/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46893/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:08:42 INFO - PROCESS | 18630 | RSS: Main: 169574400 04:08:42 INFO - PROCESS | 18630 | 04:08:45 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:46893/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:08:45 INFO - PROCESS | 18630 | RSS: Main: 170586112 04:08:45 INFO - PROCESS | 18630 | 04:08:48 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:46893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:08:49 INFO - PROCESS | 18630 | RSS: Main: 170201088 04:08:49 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:46893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46893/tests/kraken/driver.html?testName=ai-astar) 04:08:51 INFO - PROCESS | 18630 | RSS: Main: 171278336 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | __start_tp_report 04:08:51 INFO - PROCESS | 18630 | _x_x_mozilla_page_load 04:08:51 INFO - PROCESS | 18630 | _x_x_mozilla_page_load_details 04:08:51 INFO - PROCESS | 18630 | |i|pagename|runs| 04:08:51 INFO - PROCESS | 18630 | |0;ai-astar;106;114;107;114;114;115;116;114;115;114 04:08:51 INFO - PROCESS | 18630 | |1;audio-beat-detection;156;123;156;179;125;153;157;125;191;122 04:08:51 INFO - PROCESS | 18630 | |2;audio-dft;164;164;165;166;177;167;164;164;163;164 04:08:51 INFO - PROCESS | 18630 | |3;audio-fft;76;77;76;154;78;76;76;75;163;77 04:08:51 INFO - PROCESS | 18630 | |4;audio-oscillator;86;85;146;87;87;86;139;88;86;133 04:08:51 INFO - PROCESS | 18630 | |5;imaging-gaussian-blur;117;117;118;118;117;117;118;118;118;120 04:08:51 INFO - PROCESS | 18630 | |6;imaging-darkroom;148;148;146;147;147;148;147;148;147;148 04:08:51 INFO - PROCESS | 18630 | |7;imaging-desaturate;95;95;95;96;95;96;96;96;96;95 04:08:51 INFO - PROCESS | 18630 | |8;json-parse-financial;63;63;64;63;63;62;62;63;61;61 04:08:51 INFO - PROCESS | 18630 | |9;json-stringify-tinderbox;66;66;65;66;66;64;66;66;72;66 04:08:51 INFO - PROCESS | 18630 | |10;stanford-crypto-aes;78;79;79;80;81;79;80;79;83;79 04:08:51 INFO - PROCESS | 18630 | |11;stanford-crypto-ccm;134;128;132;141;130;131;137;134;168;155 04:08:51 INFO - PROCESS | 18630 | |12;stanford-crypto-pbkdf2;172;165;176;168;163;165;178;172;174;172 04:08:51 INFO - PROCESS | 18630 | |13;stanford-crypto-sha256-iterative;79;72;71;72;67;66;68;66;68;72 04:08:51 INFO - PROCESS | 18630 | __end_tp_report 04:08:51 INFO - PROCESS | 18630 | __start_cc_report 04:08:51 INFO - PROCESS | 18630 | _x_x_mozilla_cycle_collect,1007 04:08:51 INFO - PROCESS | 18630 | __end_cc_report 04:08:51 INFO - PROCESS | 18630 | __startTimestamp1469012931472__endTimestamp 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | ------- Summary: start ------- 04:08:51 INFO - PROCESS | 18630 | Number of tests: 14 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.45 (3.0%) stddev-sans-first:2.60 04:08:51 INFO - PROCESS | 18630 | Values: 106.0 114.0 107.0 114.0 114.0 115.0 116.0 114.0 115.0 114.0 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:156.00 stddev:24.49 (15.7%) stddev-sans-first:25.83 04:08:51 INFO - PROCESS | 18630 | Values: 156.0 123.0 156.0 179.0 125.0 153.0 157.0 125.0 191.0 122.0 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | [#2] audio-dft Cycles:10 Average:165.80 Median:164.50 stddev:4.10 (2.5%) stddev-sans-first:4.30 04:08:51 INFO - PROCESS | 18630 | Values: 164.0 164.0 165.0 166.0 177.0 167.0 164.0 164.0 163.0 164.0 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:34.70 (45.7%) stddev-sans-first:36.27 04:08:51 INFO - PROCESS | 18630 | Values: 76.0 77.0 76.0 154.0 78.0 76.0 76.0 75.0 163.0 77.0 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:86.00 stddev:25.75 (29.9%) stddev-sans-first:26.63 04:08:51 INFO - PROCESS | 18630 | Values: 86.0 85.0 146.0 87.0 87.0 86.0 139.0 88.0 86.0 133.0 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 04:08:51 INFO - PROCESS | 18630 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 120.0 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 04:08:51 INFO - PROCESS | 18630 | Values: 148.0 148.0 146.0 147.0 147.0 148.0 147.0 148.0 147.0 148.0 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:08:51 INFO - PROCESS | 18630 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 04:08:51 INFO - PROCESS | 18630 | Values: 63.0 63.0 64.0 63.0 63.0 62.0 62.0 63.0 61.0 61.0 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:2.11 (3.2%) stddev-sans-first:2.24 04:08:51 INFO - PROCESS | 18630 | Values: 66.0 66.0 65.0 66.0 66.0 64.0 66.0 66.0 72.0 66.0 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:1.42 (1.8%) stddev-sans-first:1.36 04:08:51 INFO - PROCESS | 18630 | Values: 78.0 79.0 79.0 80.0 81.0 79.0 80.0 79.0 83.0 79.0 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:135.50 stddev:12.78 (9.4%) stddev-sans-first:13.43 04:08:51 INFO - PROCESS | 18630 | Values: 134.0 128.0 132.0 141.0 130.0 131.0 137.0 134.0 168.0 155.0 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:172.00 stddev:5.04 (2.9%) stddev-sans-first:5.32 04:08:51 INFO - PROCESS | 18630 | Values: 172.0 165.0 176.0 168.0 163.0 165.0 178.0 172.0 174.0 172.0 04:08:51 INFO - PROCESS | 18630 | 04:08:51 INFO - PROCESS | 18630 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:71.50 stddev:3.98 (5.6%) stddev-sans-first:2.62 04:08:51 INFO - PROCESS | 18630 | Values: 79.0 72.0 71.0 72.0 67.0 66.0 68.0 66.0 68.0 72.0 04:08:51 INFO - PROCESS | 18630 | -------- Summary: end -------- 04:08:51 INFO - PROCESS | 18630 | 04:08:52 INFO - TEST-INFO | 18630: exit 0 04:08:52 INFO - TEST-OK | kraken | took 64262ms 04:08:52 INFO - SUITE-END | took 1181s 04:08:52 INFO - Completed test suite (00:19:41) 04:08:52 INFO - javascript benchmark 04:08:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6399.87472518892, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2551.1198636470417, 2564.4230048239147, 2609.0607381342725, 2610.034287313694, 2614.137334679555, 4619.884502887429, 4691.366665500156, 4799.496052914446, 4827.710337379755, 4856.174450343441, 4694.718316900989, 4775.212090005145, 4792.520747925206, 4815.590674792638, 4877.902441951159, 4429.114177164563, 4458.464984201901, 4583.816647334119, 4585.633149348044, 4599.195140850355, 4239.448871646681, 4529.388532548097, 4554.089182163564, 4581.3128030795315, 4594.678372513926, 4358.389825424443, 4360.760158191299, 4401.295792673157, 4482.103579284156, 4577.0, 4433.800478978422, 4443.822247110112, 4445.73325600465, 4462.419885414875, 4558.452985641744, 4459.888502787424, 4468.955310446887, 4475.820967161309, 4481.887952801173, 4512.593866551993, 4787.042591481718, 4853.587445067174, 4864.075825593126, 4878.024395120954, 4889.3888263967, 5227.059129356714, 5233.895322093536, 5239.633225674204, 5257.053730328539, 5259.132243179871, 5295.4969277918535, 5300.893982120375, 5303.178007408819, 5322.148456246982, 5366.195070739382, 4618.145643056012, 4852.393450818648, 4910.312556242129, 4913.041956818386, 4984.476629953875, 5382.273393091961, 5390.8921821563345, 5390.8921821563345, 5399.055165346127, 5404.189371594292, 5148.665336753099, 5154.5360917516855, 5191.247269146028, 5194.194899790538, 5214.009338225725, 5023.120953833065, 5084.694918304914, 5146.794128234828, 5191.195364718475, 5194.35070616173, 5148.6910785353, 5149.794008239628, 5151.330327057459, 5162.406323272871, 5195.19474481456, 5091.847244582668, 5123.180291153398, 5139.665921715076, 5150.896982060338, 5182.1190397631735, 4196.517400498981, 4288.18524480354, 4319.8488052918, 4322.567743225715, 4326.459192600925, 3776.773393596393, 3786.7159963002887, 3787.962120378816, 3817.9427308590393, 3835.290471262825, 4426.26966550522, 4529.728216307032, 4532.138893610204, 4557.658175636774, 4568.451785785661, 5087.720175390389, 5094.4141423736, 5094.694318340911, 5104.744762761921, 5276.050310943991, 4379.189849877783, 4380.561943805594, 4383.758893260838, 4406.471223453206, 4418.9337159942625, 4530.275155975094, 4530.796114174804, 4547.8635640930825, 4554.931676024862, 4579.6794224403975, 4805.7597120143855, 4827.734474603931, 4883.658143929891, 4891.192953162688, 4930.964497455575, 5197.740112994259, 5217.869553261199, 5218.765155568084, 5226.425093239816, 5252.763625636779, 4942.703437793743, 4956.0, 4958.652894297365, 4959.82640607577, 5010.49895010496, 5031.295618613471, 5056.140456122542, 5077.847664570068, 5087.389513258433, 5174.223866420067, 5151.1243088675765, 5196.350456192976, 5208.140656791587, 5222.973885130702, 5230.424653288212, 5026.698398096126, 5051.747412629427, 5057.064443078042, 5074.492550744896, 5106.7701953412925, 4934.309196712391, 4935.679180853233, 4984.651074424755, 5022.020705962303, 5090.745462726774, 4860.708357498562, 4932.901341973212, 4959.380077490314, 4971.254311853251, 5038.168702164102, 4970.900581988412, 4985.077760614153, 4994.825181118644, 5004.224345226496, 5053.646244762831, 4728.31439441286, 4842.661013729005, 4848.296996935495, 4876.731779752147, 4911.557959783637], "value": 4743.337346980575, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.7510170219998, 555.84714203594, 566.1875209074977, 579.9710014499277, 605.4581149870868, 36874.078148046276, 40065.1986960261, 40309.19381612366, 40318.992025199346, 40335.596644033554, 39522.0, 40169.79915100428, 40222.7988860056, 40240.39639405404, 40339.59660403395, 7748.612569371523, 7913.366930645535, 7918.168592297812, 7923.2869041786225, 7934.523928564276, 7843.764687059369, 7915.050193976702, 7919.326857217144, 7933.722319718811, 7938.126806051329, 7958.4826986246, 7958.721444749435, 7985.800354991114, 7989.081255655587, 7995.320397766197, 7892.250236227578, 7913.0899946506315, 7930.603469826486, 7951.483153594998, 7965.840683186362, 7675.923240767576, 7740.0, 7775.222477752236, 7779.0, 7807.102183248886, 38324.425133623015, 38617.0, 38751.0, 38833.805830970945, 38860.222795544214, 2967.74774144198, 3250.821204833733, 3263.9184020399443, 3654.6162652921594, 3749.456328832331, 29623.450905624377, 29812.254693632614, 29902.850485747433, 30010.549841752392, 30345.393092138034, 3093.597832281789, 3273.6562660920736, 3307.536944827726, 3321.9003429897143, 3429.331280400323, 275588.0, 276226.0, 277789.0, 278568.0, 279231.0, 31230.37539249248, 32217.35565288728, 55549.44450555443, 55734.0, 56066.159007614915, 32753.672463275063, 33019.3396132076, 33071.0, 33247.66752332446, 33255.66744332574, 13319.0, 13399.062065655311, 13461.394237259346, 13560.932195339157, 13593.320333983262, 11333.206675532634, 11436.59971900996, 11470.36912969778, 11496.540138394537, 11522.366269855238, 7963.362930965624, 7964.283214510722, 7986.281234688906, 8107.108218096005, 8112.22933821286, 3126.265327648001, 3150.5904232449634, 3175.237942893689, 3182.156728466958, 3223.903282901517, 892.3575025981283, 910.3354551177678, 919.8758167647281, 927.5501381829807, 1048.1509976918721, 28133.71866281352, 28694.713052869203, 29018.854905725337, 29028.274293142418, 29127.563086553717, 940.431039221275, 968.3947532792005, 1003.934744241622, 1008.2740426892625, 1012.0688966151158, 14754.336054877342, 15452.459163929208, 15602.141882196589, 15618.609534761721, 15847.207639617973, 396975.0, 399091.0, 401114.0, 401364.0, 401897.0, 48575.514244857804, 48855.75572122117, 49115.0, 49152.26271605857, 49315.50684493109, 1200.2816083182922, 1209.1777591238042, 1213.8604060533153, 1216.2398500936915, 1236.097648716442, 27075.0, 27992.160235192976, 28520.14439566816, 28570.857145714137, 28895.5665665011, 43310.0, 43695.0, 43766.0, 43844.0, 43874.78062609667, 336523.0, 337180.0, 339533.0, 340053.0, 340228.0, 25818.35454113662, 26117.216483505526, 26147.869260653573, 26201.34496637523, 26213.606795897696, 43512.78243608762, 44443.66668999935, 44646.77676611726, 47391.0, 48138.5186148134, 35239.82380088083, 35690.0, 36894.446583300734, 37265.441018384205, 37590.812045939594, 36592.817035915716, 37084.81457592803, 37554.0, 37634.059148521505, 38106.0, 35904.64095359117, 39579.60420395874, 40079.39880901847, 40086.79956600198, 40855.38716919308, 35401.468977965866, 37244.0, 37540.2491950154, 39553.406698898965, 40024.599754003255, 28814.423711526073, 31111.377772444877, 31203.84398077995, 31362.372752545278, 31904.521432178073], "value": 16961.004486241443, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.4979403526116, 368.6534657422023, 378.16425699204757, 381.07779174397956, 388.97471664341816, 16019.279132439038, 16846.326146954107, 17259.395921142746, 17361.91319043406, 17395.0, 16197.0, 16951.57621059474, 17150.0, 17212.827871721278, 17248.137593120355, 4753.429588449391, 4971.428285747131, 4985.476524964881, 4987.576056035223, 4992.101421744084, 3793.943090853639, 5225.425203227642, 5931.703414829263, 6178.413050760193, 6187.969060154693, 6219.844503887393, 6282.183316168892, 6282.465990390822, 6292.8741425171465, 6310.779122730705, 6040.184575082351, 6139.0, 6160.691965401712, 6169.074638804171, 6173.382661733835, 4765.594924431428, 5028.899422011576, 5404.5946554008215, 5417.45825417459, 5418.458154184589, 12177.756444871142, 12284.692882677915, 12434.129610927239, 12506.249625022529, 12548.874511254862, 1795.8473529749988, 1811.8641101917408, 1814.7731533558306, 2156.4608847788054, 2421.4430680943483, 9210.815783684357, 9406.38858474197, 10023.799524009552, 10497.685069447929, 13476.326183690875, 1662.384917580503, 1683.7306031035098, 1713.4859542137433, 1721.4921598128583, 1747.1002433746503, 40472.0, 66695.0, 71524.64237678831, 71563.64218178876, 71587.64206178988, 9850.261230407605, 9876.80246395068, 10109.191264698806, 10188.847167292497, 10328.122109620615, 13801.585952421443, 13932.303384830719, 13962.650933726534, 13977.091489053382, 13983.091099078527, 6945.652717364213, 7196.784096477114, 7225.494215404871, 7370.299821517055, 7473.252674732484, 6853.772523929742, 6898.586084834926, 7012.193597736224, 7070.257622949516, 7091.716331346792, 4251.128518653669, 4340.891477713082, 4356.281213599784, 4455.754933478625, 4471.195184866755, 1659.7842280503457, 1714.5199344183648, 1749.9737503937451, 1814.5100822777777, 1820.5063653550947, 813.8413009463217, 831.1439217605875, 850.9829803403898, 904.674317245791, 946.0539460539461, 16761.0, 17204.677368555334, 17266.395676151275, 17692.823071769373, 17697.469075927744, 867.2005588404087, 869.9608517616722, 903.3089686389917, 914.3873604684877, 918.3158546882615, 9522.571484283224, 9760.219182465386, 9780.804383912282, 9892.55483503244, 9968.900310996942, 420502.0, 424868.0, 430822.0, 430900.0, 431844.0, 77745.0, 80868.0, 81274.59362703266, 81519.0, 82974.17025829664, 901.2789768185426, 941.223490620241, 949.9097585729345, 963.2582911158509, 963.5904740485406, 16039.438619648256, 16149.838501614833, 16488.67022659564, 16658.58353541171, 16779.077150756337, 38406.4310674945, 38949.22101558009, 39149.21701565896, 39913.80043099766, 40790.18419631531, 47307.0, 48531.0, 49719.25421118759, 56155.71922140363, 56356.71821641029, 6920.446364290744, 7747.457677962489, 7972.800679983046, 8066.7579972600915, 8083.676652934052, 9943.602255909682, 12373.566925157576, 12608.243505389706, 12648.494060237488, 12985.805212922003, 10345.948270258901, 10691.09125724322, 10969.0, 11210.159238057015, 11351.035162011322, 10563.207759418228, 10581.788364232827, 10816.891831081588, 10850.620228291971, 10859.34843909368, 10270.948645256725, 10463.11063559606, 10667.039966403061, 10677.9466102669, 11287.604933827277, 6739.831504212434, 7043.7534686285735, 7210.567365958059, 7293.708251669874, 7559.130699969354, 10386.428746418716, 10692.411917344309, 10818.188635852186, 11036.11711063097, 11261.774764504828], "value": 8297.030647468579, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.7793952967527, 1423.5373503611327, 1489.3744627256551, 1664.4424117920496, 1737.2790292028808, 7005.8598828023405, 7609.54342739436, 7637.1980942001055, 8174.100848906623, 8185.427020108595, 7748.496347737393, 8046.517208967466, 8062.072861620915, 8092.069412017605, 8108.391870609698, 2257.243823319186, 2280.3387017764912, 2280.350100221437, 2292.896819643112, 2296.1848543766973, 2262.7737226277404, 2284.5088306014204, 2290.9885450572806, 2299.619559247903, 2302.0101356416735, 2235.3629215673536, 2245.820334373246, 2256.9774302256933, 2259.141526220034, 2266.5240299537118, 2151.8278537716947, 2180.9127634894585, 2184.9344519664437, 2190.463336482556, 2192.3422973108163, 2206.746224184223, 2225.221172589597, 2230.0, 2232.821374290053, 2233.0286325448483, 7887.881681774778, 8024.317932975704, 8041.8793718094275, 8043.39674524413, 8066.757997260033, 4674.088552732219, 4797.160496913027, 4804.735739534324, 4805.735684537349, 4822.541858523435, 2796.4546913351905, 2898.4637841999297, 2899.246195989037, 2928.282570770175, 2956.2904902823384, 893.8614514750224, 914.4787471141452, 940.4498368454463, 957.0716405087054, 961.1397798969883, 10765.62320318793, 10795.08241799448, 10870.891291087146, 10890.509927053301, 10921.235513514057, 4021.4369988201674, 4241.936370954438, 4320.870373888788, 4411.669124815588, 4428.468583769968, 9238.769030774285, 9264.39781414206, 9268.165865072042, 9270.490123043297, 9323.207527360115, 4768.546988036131, 4782.282657601318, 4782.832600858953, 4787.138315103245, 4803.567678908915, 3754.0614846288427, 4209.0, 4317.0, 4349.934750978738, 4389.407429996973, 3627.5646922369483, 3642.162302670348, 3767.7174211934216, 3785.242951409729, 3823.770573765583, 1184.088252045937, 1205.4394706461537, 1223.424990254579, 1223.8347823043775, 1240.4418011894684, 778.0352363069753, 807.4428644235459, 810.5947026486757, 819.713100414862, 829.2371018662844, 5062.4684408137355, 5103.055934652101, 5149.691018538825, 5172.767225474862, 5312.946870531323, 406.09035759898205, 420.6760794188458, 425.5064125614273, 425.8275398463627, 427.01998912495895, 3592.3174596827043, 3643.617420170897, 3648.543932008499, 3671.7980511072146, 3744.5319335083113, 8557.914420855712, 8891.066438024043, 8916.197542221102, 8918.910810891937, 9026.413283136575, 8812.779680508038, 8843.292536597057, 8853.468791872509, 8979.46123232608, 8999.415038022507, 6871.175458944958, 6961.199462061826, 6962.025316455701, 6978.371946524736, 6987.790366289019, 4693.530646935279, 4745.881352966204, 4780.259059845729, 4928.852134435972, 4996.900061998813, 8150.510969341858, 8240.587970601566, 8283.337333013465, 8328.875066873881, 8436.367272454714, 8277.130901255523, 8287.171282871665, 8379.120192379713, 8434.451760635538, 8457.661693532189, 6239.0, 6508.0, 6508.284088750139, 6734.865302693821, 6907.6891539879825, 7612.048493938258, 7720.3051725344985, 7721.189275126031, 7728.806779830549, 7731.0, 6819.863602727818, 6895.55178913369, 6927.89608155868, 6933.5493192942295, 7129.679164437509, 6790.490713196431, 6811.489138314745, 6819.079424277659, 6855.4172895304455, 6876.862462750817, 5944.970275148597, 6176.258848938156, 6226.750929962751, 6236.438720515175, 6264.68676566179, 4483.484399294123, 4508.1659892919915, 4556.726596404226, 4651.3023046543285, 4672.836450724209, 4438.889027774331, 4530.478994915627, 4554.111948170207, 4582.106489234568, 4593.28804035375], "value": 4059.973447786759, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.0855730122021, 301.8988638806, 306.98158110513356, 308.36169129901106, 308.86255616250764, 4888.31563581098, 4933.720918617081, 4997.575206107481, 5091.15995860683, 5102.0, 4959.900801983958, 4980.203167493201, 4983.729149066983, 5005.199168133099, 5007.22388029855, 3965.662918651918, 3975.4633124528254, 3975.7415767975135, 3992.7205095643317, 3998.400239964014, 3898.1813819098024, 3946.842126314944, 3976.284268831609, 3983.3825757007567, 4000.4399384086105, 3923.431102490137, 3927.252372694152, 3944.408338749182, 3949.111449923773, 3952.980235098835, 3968.285708572456, 3969.761814291152, 3971.702122340807, 3971.9007024824323, 3980.1840622672285, 3478.808665523395, 3502.7548071634997, 3517.8944631661093, 3535.3207226567433, 3538.9646103538894, 4822.734749588772, 4922.581580565657, 4929.134957760243, 4955.182394904837, 4999.750112449412, 4513.616342610882, 4515.977420112911, 4516.887077823048, 4525.932111018337, 4545.499995000548, 5306.575473962073, 5309.495597918191, 5319.840404787863, 5329.626926115174, 5343.358796944352, 3738.6448287412654, 3775.8867233983024, 3820.7707537547835, 3827.2585973382043, 3842.5965273646143, 5473.31583552056, 5486.231927530149, 5521.282233309644, 5527.53015993641, 5527.618095476131, 3870.8838734838, 3896.759363366076, 3903.6877049835944, 3903.980480097581, 3924.7841368724994, 3612.4039533477207, 3971.900702482461, 3975.582563830756, 3981.6814654827544, 3997.320455522568, 4386.320120381346, 4404.515503294635, 4410.3825464435, 4413.183561041217, 4421.336799480039, 5306.0, 5325.949509438894, 5329.866753331198, 5331.626786125012, 5353.839384818461, 1259.8677138900466, 1301.73965206959, 1322.3784821134052, 1326.9914864702896, 1328.4221363706818, 877.9692710755221, 889.1464194373474, 906.5059542549326, 910.822389634015, 913.2328843771131, 4541.568550987651, 4571.337156112345, 4592.311153327028, 4594.540545945446, 4597.931031034537, 5379.220013098157, 5386.326709161355, 5395.244665746799, 5402.594805389612, 5415.566754659618, 4471.977640111779, 4568.406107206042, 4579.0, 4591.1965406053805, 4595.747233902101, 2551.234629611109, 2554.93612659685, 2574.7811436027773, 2575.660656458631, 2592.844429334246, 4530.61489773373, 4551.837877008461, 4570.88572785683, 4594.782382668595, 4606.677532572755, 4667.562289932259, 4885.679302331364, 4887.458521568764, 4899.0, 4916.877078073006, 4499.775011249424, 4577.22187228172, 4606.236258245026, 4616.838410655611, 4627.444706635225, 4752.857414277577, 4768.3085952537385, 4777.163996300703, 4794.376731024944, 4811.687240329367, 4516.367708520876, 4714.457837348748, 4717.834875779331, 4737.076270127292, 4743.810247590058, 4563.566461186182, 4580.519045500175, 4587.7017993830295, 4593.402857628487, 4599.379083823641, 3476.634953329864, 3480.512728218102, 3506.070891213881, 3510.982445087758, 3519.947200791939, 4767.761611919321, 4770.260609605517, 4806.625970366949, 4811.27830825379, 5188.922166167586, 5016.899662006813, 5282.788688452419, 5289.444608316071, 5293.030227329503, 5315.681059136464, 5260.473952604709, 5261.3686357637325, 5261.763220655003, 5261.789528418821, 5266.920996184984, 5042.319286896369, 5182.663126896739, 5198.16829307309, 5202.765875535686, 5204.34945631796, 5226.398964119175, 5236.816711415082, 5268.315119034501, 5269.1832765921345, 5271.551918087006, 5135.998480296306, 5154.175331946871, 5164.767585458739, 5174.586033117266, 5184.055979007872], "value": 3865.1056452637954, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.8485963368793, 659.6899457255091, 660.0561197487593, 691.5297597633607, 745.1765798792336, 12769.361531923401, 13695.589132326022, 13744.175349479014, 13761.655958601028, 13799.034067615272, 12978.22130672158, 13326.400311985959, 13527.526536571222, 13948.163110213394, 13986.440542378292, 780.1418439716323, 798.0901771979918, 799.6481548118809, 800.4676889868259, 801.4149670740363, 623.5354660777705, 774.4733581164805, 794.4597673581991, 797.8643630582786, 800.9559474228915, 840.9117042710519, 843.2200214801314, 844.877492763549, 845.8562044452427, 849.3035710717214, 842.6882053640193, 843.9071702112763, 844.0377969115214, 844.0841686769862, 845.9957700211521, 613.3621034124506, 617.3826173826174, 617.4257940115691, 617.6263360666821, 617.8270084376381, 13918.652033699138, 13931.30343482832, 13938.094023888414, 13948.372323245378, 13966.022378433514, 12672.873271267354, 13087.214767114003, 13128.606141815666, 13179.472821087145, 13272.800907986388, 10043.0, 10101.898981010168, 10617.522211500424, 10677.092447142002, 10768.676939691823, 3249.2039450334582, 3273.9508907366408, 3330.184104894292, 3345.7825241359233, 3423.760336776427, 65053.349466505206, 66755.0, 67374.0, 67852.0, 69372.65313673399, 10335.328203666737, 10419.218558608134, 10435.478226088817, 10475.94762026185, 10566.313189642802, 16619.169041547873, 16642.833571664127, 16658.916705416395, 16751.664966700842, 17869.0, 6498.5126115541525, 6698.66506674674, 6766.18805743314, 6776.966115169393, 7121.89317160243, 3595.442706380515, 3819.732618716663, 3911.2177564487215, 3925.3523168676847, 4001.4998125234347, 2837.7446029857, 2980.418818330405, 3004.023692300011, 3029.2275469755073, 3049.374878149974, 527.0407857698951, 530.6285600079959, 531.7607076815449, 553.5543887170786, 554.0498045851384, 519.366373024909, 533.1922137960992, 582.9941700583024, 605.6063558686889, 609.2719200555293, 7952.721654742057, 8036.959815200887, 8096.149904260085, 8241.670333186605, 8348.499090054494, 517.6816258001302, 542.0189457082693, 548.0655482402494, 555.8276934150426, 562.412279168262, 3718.2563487302646, 3736.458213559073, 3738.6635202831876, 3764.4541541476333, 3863.111484358557, 93092.0, 93697.0, 95983.0, 97106.0, 100769.0, 69513.3048669517, 71741.64129179425, 84245.0, 85754.57122714346, 87242.56378718065, 66167.33832661709, 71540.64229678818, 73506.63246683733, 73661.0, 74346.25653743393, 8521.616527256412, 9003.549822508718, 9039.819203616022, 9251.398659087406, 9411.85882211781, 29891.0, 40354.79822600868, 40794.388084178165, 43328.0, 46906.0, 36719.63280367162, 36952.26095478129, 37496.43755343727, 53575.0, 66830.0, 11621.535138594361, 11717.238379505305, 11717.941410292893, 11795.469203885674, 12092.576759813364, 12256.142070055368, 12450.190737602026, 13144.342782860627, 13159.342032898508, 13195.0, 11433.771324573296, 11955.76088478243, 11993.82009269879, 11995.40022998864, 12749.617511474671, 12010.0, 12337.444814983168, 12494.250344978967, 12531.248125112523, 13095.69624302121, 12532.937335313265, 12574.559890403792, 12785.744285114431, 12933.224006559636, 13368.0, 9489.593657086223, 9851.753706157404, 9981.750456238653, 10061.647842325483, 10400.479976001321, 8661.566921653766, 9151.359404841598, 9739.805203895741, 9750.658726944806, 9830.262730295113], "value": 6559.007369884525, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 107.0, 114.0, 114.0, 115.0, 116.0, 114.0, 115.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 156.0, 179.0, 125.0, 153.0, 157.0, 125.0, 191.0, 122.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 166.0, 177.0, 167.0, 164.0, 164.0, 163.0, 164.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 154.0, 78.0, 76.0, 76.0, 75.0, 163.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 146.0, 87.0, 87.0, 86.0, 139.0, 88.0, 86.0, 133.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 120.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 63.0, 62.0, 62.0, 63.0, 61.0, 61.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 66.0, 64.0, 66.0, 66.0, 72.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 80.0, 81.0, 79.0, 80.0, 79.0, 83.0, 79.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 128.0, 132.0, 141.0, 130.0, 131.0, 137.0, 134.0, 168.0, 155.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 165.0, 176.0, 168.0, 163.0, 165.0, 178.0, 172.0, 174.0, 172.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 72.0, 71.0, 72.0, 67.0, 66.0, 68.0, 66.0, 68.0, 72.0], "value": 70.1, "unit": "score"}]}]} 04:08:52 INFO - Return code: 0 04:08:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:08:52 ERROR - # TBPL SUCCESS # 04:08:52 INFO - Running post-action listener: _resource_record_post_action 04:08:52 INFO - [mozharness: 2016-07-20 11:08:52.752597Z] Finished run-tests step (success) 04:08:52 INFO - Running post-run listener: _resource_record_post_run 04:08:52 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536563712; Read time: 16; Write time: 416924 04:08:52 INFO - TinderboxPrint: CPU usage
13.4% 04:08:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:08:52 INFO - TinderboxPrint: I/O write bytes / time
536,563,712 / 416,924 04:08:52 INFO - TinderboxPrint: CPU idle
8,279.9 (86.6%) 04:08:52 INFO - TinderboxPrint: CPU user
1,222.0 (12.8%) 04:08:52 INFO - TinderboxPrint: Swap in / out
0 / 0 04:08:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247123968; Read time: 0; Write time: 194680 04:08:52 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288673792; Read time: 16; Write time: 222204 04:08:53 INFO - Running post-run listener: _upload_blobber_files 04:08:53 INFO - Blob upload gear active. 04:08:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04: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 04: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:08:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:08:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:08:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:08:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:55 INFO - (blobuploader) - INFO - Done attempting. 04:08:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:08:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:09:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:08 INFO - (blobuploader) - INFO - Done attempting. 04:09:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:09:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:09:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:09 INFO - (blobuploader) - INFO - Done attempting. 04:09:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:09:09 INFO - Return code: 0 04:09:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:09:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:09:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d26656b2783e0bcf8e4530dd2259bb3ccf86e89ede04aa1dec14a83503391832ad9f8f761bc9090dfcc679ddc3a71817fdeff097e46de684602d94d82713b3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4a4d661c4c548f22d33bb417d09e8c9e15c4df489301d0c6e2a9359b3d0808e260c9ec6d026140652422332b286f6dbb8a827569e8ef6b108e5843579d40f42e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e201c48bc3ec6786b0d2e0518cc7457133bbf62ed493d3711293267ff7cc3abb038bee46ac62c11fd569ccce8f7d74e8579d25c10d50db3839de525737a3499d"} 04:09:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:09:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:09:09 INFO - Contents: 04:09:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d26656b2783e0bcf8e4530dd2259bb3ccf86e89ede04aa1dec14a83503391832ad9f8f761bc9090dfcc679ddc3a71817fdeff097e46de684602d94d82713b3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4a4d661c4c548f22d33bb417d09e8c9e15c4df489301d0c6e2a9359b3d0808e260c9ec6d026140652422332b286f6dbb8a827569e8ef6b108e5843579d40f42e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e201c48bc3ec6786b0d2e0518cc7457133bbf62ed493d3711293267ff7cc3abb038bee46ac62c11fd569ccce8f7d74e8579d25c10d50db3839de525737a3499d"} 04:09:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:09:09 INFO - Copying logs to upload dir... 04:09:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:09:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.795473 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-20 04:09:08.788217) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 04:09:08.791755) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d26656b2783e0bcf8e4530dd2259bb3ccf86e89ede04aa1dec14a83503391832ad9f8f761bc9090dfcc679ddc3a71817fdeff097e46de684602d94d82713b3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4a4d661c4c548f22d33bb417d09e8c9e15c4df489301d0c6e2a9359b3d0808e260c9ec6d026140652422332b286f6dbb8a827569e8ef6b108e5843579d40f42e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e201c48bc3ec6786b0d2e0518cc7457133bbf62ed493d3711293267ff7cc3abb038bee46ac62c11fd569ccce8f7d74e8579d25c10d50db3839de525737a3499d"} build_url:https://queue.taskcluster.net/v1/task/B17JYcUmRqek5J51Aulq3g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011465 build_url: 'https://queue.taskcluster.net/v1/task/B17JYcUmRqek5J51Aulq3g/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-Non-PGO/sha512/5d26656b2783e0bcf8e4530dd2259bb3ccf86e89ede04aa1dec14a83503391832ad9f8f761bc9090dfcc679ddc3a71817fdeff097e46de684602d94d82713b3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4a4d661c4c548f22d33bb417d09e8c9e15c4df489301d0c6e2a9359b3d0808e260c9ec6d026140652422332b286f6dbb8a827569e8ef6b108e5843579d40f42e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e201c48bc3ec6786b0d2e0518cc7457133bbf62ed493d3711293267ff7cc3abb038bee46ac62c11fd569ccce8f7d74e8579d25c10d50db3839de525737a3499d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 04:09:08.817139) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:09:08.817481) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469011697.700245-1074965452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:09:08.901901) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 04:09:08.902223) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 04:09:08.902498) ========= ========= Total master_lag: 0.17 =========