builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1468494137.38 results: success (0) buildid: 20160714024642 builduid: 612e797e353f43d18a53ee170858e551 revision: 08f8a5aacd8308a73f6040fe522be7ba38497561 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 04:02:17.380156) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 04:02:17.380646) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 04:02:17.380938) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 04:02:17.403200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 04:02:17.403561) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 04:02:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-07-14 04:02:17 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135532 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 04:02:17.553164) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 04:02:17.553475) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017159 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 04:02:17.602198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 04:02:17.602551) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 08f8a5aacd8308a73f6040fe522be7ba38497561 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 08f8a5aacd8308a73f6040fe522be7ba38497561 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 04:02:17,675 truncating revision to first 12 chars 2016-07-14 04:02:17,675 Setting DEBUG logging. 2016-07-14 04:02:17,675 attempt 1/10 2016-07-14 04:02:17,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/08f8a5aacd83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 04:02:18,770 unpacking tar archive at: mozilla-central-08f8a5aacd83/testing/mozharness/ program finished with exit code 0 elapsedTime=1.459707 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 04:02:19.076116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 04:02:19.076536) ========= script_repo_revision: 08f8a5aacd8308a73f6040fe522be7ba38497561 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 04:02:19.076982) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 04:02:19.077296) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 04:02:19.088352) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-14 04:02:19.088648) ========= /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=5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:02:19 INFO - MultiFileLogger online at 20160714 04:02:19 in /builds/slave/test 04:02: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 04:02:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:02:19 INFO - {'append_to_log': False, 04:02:19 INFO - 'base_work_dir': '/builds/slave/test', 04:02:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:02:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:02:19 INFO - 'branch': 'Firefox-Non-PGO', 04:02:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:02:19 INFO - 'config_files': ('talos/linux_config.py',), 04:02:19 INFO - 'default_actions': ('clobber', 04:02:19 INFO - 'read-buildbot-config', 04:02:19 INFO - 'download-and-extract', 04:02:19 INFO - 'populate-webroot', 04:02:19 INFO - 'create-virtualenv', 04:02:19 INFO - 'install', 04:02:19 INFO - 'run-tests'), 04:02:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:02:19 INFO - 'download_minidump_stackwalk': True, 04:02:19 INFO - 'download_symbols': 'ondemand', 04:02:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:02:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:02:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:02:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:02:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:02:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:02:19 INFO - 'installer_path': 'installer.exe', 04:02:19 INFO - 'log_level': 'info', 04:02:19 INFO - 'log_name': 'talos', 04:02:19 INFO - 'log_to_console': True, 04:02:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:02:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:02:19 INFO - 'opt_config_files': (), 04:02:19 INFO - 'pip_index': False, 04:02:19 INFO - 'sps_profile': False, 04:02:19 INFO - 'sps_profile_interval': 0, 04:02:19 INFO - 'suite': 'dromaeojs-e10s', 04:02:19 INFO - 'system_bits': '32', 04:02:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:02:19 INFO - 'title': 'talos-linux64-ix-039', 04:02:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:02:19 INFO - 'use_talos_json': True, 04:02:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:02:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:02:19 INFO - 'work_dir': 'build'} 04:02:19 INFO - ##### 04:02:19 INFO - ##### Running clobber step. 04:02:19 INFO - ##### 04:02:19 INFO - Running pre-action listener: _resource_record_pre_action 04:02:19 INFO - Running main action method: clobber 04:02:19 INFO - rmtree: /builds/slave/test/build 04:02:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:02:19 INFO - Running post-action listener: _resource_record_post_action 04:02:19 INFO - ##### 04:02:19 INFO - ##### Finished clobber step (success) 04:02:19 INFO - ##### 04:02:19 INFO - ##### 04:02:19 INFO - ##### Running read-buildbot-config step. 04:02:19 INFO - ##### 04:02:19 INFO - Running pre-action listener: _resource_record_pre_action 04:02:19 INFO - Running main action method: read_buildbot_config 04:02:19 INFO - Using buildbot properties: 04:02:19 INFO - { 04:02:19 INFO - "project": "", 04:02:19 INFO - "product": "firefox", 04:02:19 INFO - "script_repo_revision": "production", 04:02:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:02:19 INFO - "repository": "", 04:02:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:02:19 INFO - "buildid": "20160714024642", 04:02:19 INFO - "pgo_build": "False", 04:02:19 INFO - "basedir": "/builds/slave/test", 04:02:19 INFO - "buildnumber": 380, 04:02:19 INFO - "slavename": "talos-linux64-ix-039", 04:02:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:02:19 INFO - "platform": "ubuntu64_hw", 04:02:19 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:02:19 INFO - "branch": "mozilla-central", 04:02:19 INFO - "repo_path": "mozilla-central", 04:02:19 INFO - "revision": "08f8a5aacd8308a73f6040fe522be7ba38497561", 04:02:19 INFO - "stage_platform": "linux64", 04:02:19 INFO - "builduid": "612e797e353f43d18a53ee170858e551", 04:02:19 INFO - "slavebuilddir": "test" 04:02:19 INFO - } 04:02:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:02:19 INFO - Running post-action listener: _resource_record_post_action 04:02:19 INFO - ##### 04:02:19 INFO - ##### Finished read-buildbot-config step (success) 04:02:19 INFO - ##### 04:02:19 INFO - ##### 04:02:19 INFO - ##### Running download-and-extract step. 04:02:19 INFO - ##### 04:02:19 INFO - Running pre-action listener: _resource_record_pre_action 04:02:19 INFO - Running main action method: download_and_extract 04:02:19 INFO - mkdir: /builds/slave/test/build/tests 04:02:19 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')]} 04:02:19 INFO - https://queue.taskcluster.net/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:02:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:02:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:02:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/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 04:02:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/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 04:02:20 INFO - Downloaded 1361 bytes. 04:02:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:02:20 INFO - Using the following test package requirements: 04:02:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:02:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:02:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:02:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:20 INFO - u'jsshell-linux-x86_64.zip'], 04:02:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:02:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:02:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:02:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:02:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:02:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:02:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:02: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')]} 04:02:20 INFO - https://queue.taskcluster.net/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:02:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/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 04:02:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/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 04:02:21 INFO - Downloaded 22756012 bytes. 04:02: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'] 04:02: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 04:02:22 INFO - Return code: 0 04:02: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 04:02: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')]} 04:02:22 INFO - https://queue.taskcluster.net/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:02:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/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 04:02:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/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 04:02:23 INFO - Downloaded 22756012 bytes. 04:02: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'] 04:02: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 04:02:25 INFO - Return code: 0 04:02: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')]} 04:02:25 INFO - https://queue.taskcluster.net/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:02:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:02:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:02:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/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 04:02:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/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 04:02:26 INFO - Downloaded 14403317 bytes. 04:02: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'] 04:02: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 04:02:26 INFO - Return code: 0 04:02: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')]} 04:02:26 INFO - https://queue.taskcluster.net/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:02:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:02:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:02:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/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 04:02:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nh1DOghQRVa7p-oozJwavg/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 04:02:28 INFO - Downloaded 57045556 bytes. 04:02:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:02:28 INFO - mkdir: /builds/slave/test/properties 04:02:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:02:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:02:28 INFO - Contents: 04:02:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:02:28 INFO - Running post-action listener: _resource_record_post_action 04:02:28 INFO - Running post-action listener: set_extra_try_arguments 04:02:28 INFO - ##### 04:02:28 INFO - ##### Finished download-and-extract step (success) 04:02:28 INFO - ##### 04:02:28 INFO - ##### 04:02:28 INFO - ##### Running populate-webroot step. 04:02:28 INFO - ##### 04:02:28 INFO - Running pre-action listener: _resource_record_pre_action 04:02:28 INFO - Running main action method: populate_webroot 04:02:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:02:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:02:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:02:29 INFO - '--tppagecycles', 04:02:29 INFO - '7'], 04:02:29 INFO - 'tests': ['tsvgm']}}, 04:02:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:02:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:02:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:02:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:02:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:02:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:02:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:29 INFO - 'talos_options': ['--disable-e10s'], 04:02:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:02:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:02:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:29 INFO - 'talos_options': ['--disable-e10s'], 04:02:29 INFO - 'tests': ['damp', 'tps']}, 04:02:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:29 INFO - 'tests': ['damp', 'tps']}, 04:02:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:02:29 INFO - 'tests': ['dromaeo_dom']}, 04:02:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:02:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:02:29 INFO - 'tests': ['basic_compositor_video']}, 04:02:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:02:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:02:29 INFO - 'tests': ['a11yr', 04:02:29 INFO - 'ts_paint', 04:02:29 INFO - 'tpaint', 04:02:29 INFO - 'sessionrestore', 04:02:29 INFO - 'sessionrestore_no_auto_restore', 04:02:29 INFO - 'tabpaint']}, 04:02:29 INFO - 'other-e10s': {'tests': ['a11yr', 04:02:29 INFO - 'ts_paint', 04:02:29 INFO - 'tpaint', 04:02:29 INFO - 'sessionrestore', 04:02:29 INFO - 'sessionrestore_no_auto_restore', 04:02:29 INFO - 'tabpaint']}, 04:02:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:02:29 INFO - 'ts_paint', 04:02:29 INFO - 'tpaint', 04:02:29 INFO - 'sessionrestore', 04:02:29 INFO - 'sessionrestore_no_auto_restore', 04:02:29 INFO - 'tabpaint']}, 04:02:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:02:29 INFO - 'ts_paint', 04:02:29 INFO - 'tpaint', 04:02:29 INFO - 'sessionrestore', 04:02:29 INFO - 'sessionrestore_no_auto_restore', 04:02:29 INFO - 'tabpaint']}, 04:02:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:02:29 INFO - 'tests': ['a11yr', 04:02:29 INFO - 'ts_paint', 04:02:29 INFO - 'tpaint', 04:02:29 INFO - 'sessionrestore', 04:02:29 INFO - 'sessionrestore_no_auto_restore', 04:02:29 INFO - 'tabpaint']}, 04:02:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:02:29 INFO - 'tests': ['a11yr', 04:02:29 INFO - 'ts_paint', 04:02:29 INFO - 'tpaint', 04:02:29 INFO - 'sessionrestore', 04:02:29 INFO - 'sessionrestore_no_auto_restore', 04:02:29 INFO - 'tabpaint']}, 04:02:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:02:29 INFO - 'tests': ['tsvgx', 04:02:29 INFO - 'tsvgr_opacity', 04:02:29 INFO - 'tart', 04:02:29 INFO - 'tscrollx', 04:02:29 INFO - 'cart']}, 04:02:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:02:29 INFO - 'tsvgr_opacity', 04:02:29 INFO - 'tart', 04:02:29 INFO - 'tscrollx', 04:02:29 INFO - 'cart']}, 04:02:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:29 INFO - 'talos_options': ['--disable-e10s'], 04:02:29 INFO - 'tests': ['tp5o']}, 04:02:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:29 INFO - 'tests': ['tp5o']}, 04:02:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:29 INFO - 'talos_options': ['--disable-e10s', 04:02:29 INFO - '--xperf_path', 04:02:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:02:29 INFO - 'tests': ['tp5n']}, 04:02:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:29 INFO - 'talos_options': ['--xperf_path', 04:02:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:02:29 INFO - 'tests': ['tp5n']}}, 04:02:29 INFO - 'talos.zip': {'path': '', 04:02:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:02:29 INFO - Running post-action listener: _resource_record_post_action 04:02:29 INFO - ##### 04:02:29 INFO - ##### Finished populate-webroot step (success) 04:02:29 INFO - ##### 04:02:29 INFO - ##### 04:02:29 INFO - ##### Running create-virtualenv step. 04:02:29 INFO - ##### 04:02:29 INFO - Running pre-action listener: _resource_record_pre_action 04:02:29 INFO - Running main action method: create_virtualenv 04:02:29 INFO - Creating virtualenv /builds/slave/test/build/venv 04:02: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 04:02:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:02:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:02:29 INFO - Using real prefix '/usr' 04:02:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:02:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:02:31 INFO - Installing pip.................done. 04:02:32 INFO - Return code: 0 04:02:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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 0x248e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c570>, '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 0x274d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', '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 04:02: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 04:02: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 04:02:32 INFO - Using env: {'DISPLAY': ':0', 04:02:32 INFO - 'HOME': '/home/cltbld', 04:02:32 INFO - 'LANG': 'en_US.UTF-8', 04:02:32 INFO - 'LANGUAGE': 'en_US:en', 04:02:32 INFO - 'LOGNAME': 'cltbld', 04:02:32 INFO - 'MAIL': '/var/mail/cltbld', 04:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:32 INFO - 'MOZ_NO_REMOTE': '1', 04:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:32 INFO - 'NO_EM_RESTART': '1', 04:02:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:32 INFO - 'PWD': '/builds/slave/test', 04:02:32 INFO - 'SHELL': '/bin/bash', 04:02:32 INFO - 'SHLVL': '1', 04:02:32 INFO - 'TERM': 'linux', 04:02:32 INFO - 'TMOUT': '86400', 04:02:32 INFO - 'USER': 'cltbld', 04:02:32 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', 04:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:32 INFO - '_': '/tools/buildbot/bin/python'} 04:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02: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 04:02:32 INFO - Cleaning up... 04:02:32 INFO - Return code: 0 04:02:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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 0x248e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c570>, '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 0x274d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', '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 04:02: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 04:02: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 04:02:32 INFO - Using env: {'DISPLAY': ':0', 04:02:32 INFO - 'HOME': '/home/cltbld', 04:02:32 INFO - 'LANG': 'en_US.UTF-8', 04:02:32 INFO - 'LANGUAGE': 'en_US:en', 04:02:32 INFO - 'LOGNAME': 'cltbld', 04:02:32 INFO - 'MAIL': '/var/mail/cltbld', 04:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:32 INFO - 'MOZ_NO_REMOTE': '1', 04:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:32 INFO - 'NO_EM_RESTART': '1', 04:02:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:32 INFO - 'PWD': '/builds/slave/test', 04:02:32 INFO - 'SHELL': '/bin/bash', 04:02:32 INFO - 'SHLVL': '1', 04:02:32 INFO - 'TERM': 'linux', 04:02:32 INFO - 'TMOUT': '86400', 04:02:32 INFO - 'USER': 'cltbld', 04:02:32 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', 04:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:32 INFO - '_': '/tools/buildbot/bin/python'} 04:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:32 INFO - Downloading/unpacking psutil>=3.1.1 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:02:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:34 INFO - Installing collected packages: psutil 04:02:34 INFO - Running setup.py install for psutil 04:02:34 INFO - building 'psutil._psutil_linux' extension 04:02:34 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 04:02:34 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 04:02:34 INFO - building 'psutil._psutil_posix' extension 04:02:34 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 04:02:34 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 04:02:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:35 INFO - Successfully installed psutil 04:02:35 INFO - Cleaning up... 04:02:35 INFO - Return code: 0 04:02:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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 0x248e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c570>, '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 0x274d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', '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 04:02: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 04:02: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 04:02:35 INFO - Using env: {'DISPLAY': ':0', 04:02:35 INFO - 'HOME': '/home/cltbld', 04:02:35 INFO - 'LANG': 'en_US.UTF-8', 04:02:35 INFO - 'LANGUAGE': 'en_US:en', 04:02:35 INFO - 'LOGNAME': 'cltbld', 04:02:35 INFO - 'MAIL': '/var/mail/cltbld', 04:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:35 INFO - 'MOZ_NO_REMOTE': '1', 04:02:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:35 INFO - 'NO_EM_RESTART': '1', 04:02:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:35 INFO - 'PWD': '/builds/slave/test', 04:02:35 INFO - 'SHELL': '/bin/bash', 04:02:35 INFO - 'SHLVL': '1', 04:02:35 INFO - 'TERM': 'linux', 04:02:35 INFO - 'TMOUT': '86400', 04:02:35 INFO - 'USER': 'cltbld', 04:02:35 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', 04:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:35 INFO - '_': '/tools/buildbot/bin/python'} 04:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:02:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:02:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:02:37 INFO - Installing collected packages: mozsystemmonitor 04:02:37 INFO - Running setup.py install for mozsystemmonitor 04:02:37 INFO - Successfully installed mozsystemmonitor 04:02:37 INFO - Cleaning up... 04:02:37 INFO - Return code: 0 04:02:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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 0x248e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c570>, '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 0x274d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', '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 04:02: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 04:02: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 04:02:37 INFO - Using env: {'DISPLAY': ':0', 04:02:37 INFO - 'HOME': '/home/cltbld', 04:02:37 INFO - 'LANG': 'en_US.UTF-8', 04:02:37 INFO - 'LANGUAGE': 'en_US:en', 04:02:37 INFO - 'LOGNAME': 'cltbld', 04:02:37 INFO - 'MAIL': '/var/mail/cltbld', 04:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:37 INFO - 'MOZ_NO_REMOTE': '1', 04:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:37 INFO - 'NO_EM_RESTART': '1', 04:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:37 INFO - 'PWD': '/builds/slave/test', 04:02:37 INFO - 'SHELL': '/bin/bash', 04:02:37 INFO - 'SHLVL': '1', 04:02:37 INFO - 'TERM': 'linux', 04:02:37 INFO - 'TMOUT': '86400', 04:02:37 INFO - 'USER': 'cltbld', 04:02:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', 04:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:37 INFO - '_': '/tools/buildbot/bin/python'} 04:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:38 INFO - Downloading/unpacking jsonschema==2.5.1 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:02:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:41 INFO - Downloading functools32-3.2.3-2.tar.gz 04:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:02:41 INFO - warning: no files found matching '*.txt' 04:02:41 INFO - no previously-included directories found matching 'build' 04:02:41 INFO - no previously-included directories found matching 'dist' 04:02:41 INFO - no previously-included directories found matching '.git*' 04:02:41 INFO - Installing collected packages: jsonschema, functools32 04:02:41 INFO - Running setup.py install for functools32 04:02:41 INFO - warning: no files found matching '*.txt' 04:02:41 INFO - no previously-included directories found matching 'build' 04:02:41 INFO - no previously-included directories found matching 'dist' 04:02:41 INFO - no previously-included directories found matching '.git*' 04:02:41 INFO - Successfully installed jsonschema functools32 04:02:41 INFO - Cleaning up... 04:02:41 INFO - Return code: 0 04:02:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x248e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c570>, '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 0x274d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', '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 04:02:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:02:41 INFO - Using env: {'DISPLAY': ':0', 04:02:41 INFO - 'HOME': '/home/cltbld', 04:02:41 INFO - 'LANG': 'en_US.UTF-8', 04:02:41 INFO - 'LANGUAGE': 'en_US:en', 04:02:41 INFO - 'LOGNAME': 'cltbld', 04:02:41 INFO - 'MAIL': '/var/mail/cltbld', 04:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:41 INFO - 'MOZ_NO_REMOTE': '1', 04:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:41 INFO - 'NO_EM_RESTART': '1', 04:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:41 INFO - 'PWD': '/builds/slave/test', 04:02:41 INFO - 'SHELL': '/bin/bash', 04:02:41 INFO - 'SHLVL': '1', 04:02:41 INFO - 'TERM': 'linux', 04:02:41 INFO - 'TMOUT': '86400', 04:02:41 INFO - 'USER': 'cltbld', 04:02:41 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', 04:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:41 INFO - '_': '/tools/buildbot/bin/python'} 04:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:44 INFO - Downloading blobuploader-1.2.4.tar.gz 04:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:02:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:02:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02:44 INFO - Downloading docopt-0.6.1.tar.gz 04:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:02:44 INFO - Installing collected packages: blobuploader, requests, docopt 04:02:44 INFO - Running setup.py install for blobuploader 04:02:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:02:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:02:44 INFO - Running setup.py install for requests 04:02:45 INFO - Running setup.py install for docopt 04:02:45 INFO - Successfully installed blobuploader requests docopt 04:02:45 INFO - Cleaning up... 04:02:45 INFO - Return code: 0 04:02:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:45 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 0x248e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c570>, '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 0x274d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', '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 04:02:45 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 04:02:45 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 04:02:45 INFO - Using env: {'DISPLAY': ':0', 04:02:45 INFO - 'HOME': '/home/cltbld', 04:02:45 INFO - 'LANG': 'en_US.UTF-8', 04:02:45 INFO - 'LANGUAGE': 'en_US:en', 04:02:45 INFO - 'LOGNAME': 'cltbld', 04:02:45 INFO - 'MAIL': '/var/mail/cltbld', 04:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:45 INFO - 'MOZ_NO_REMOTE': '1', 04:02:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:45 INFO - 'NO_EM_RESTART': '1', 04:02:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:45 INFO - 'PWD': '/builds/slave/test', 04:02:45 INFO - 'SHELL': '/bin/bash', 04:02:45 INFO - 'SHLVL': '1', 04:02:45 INFO - 'TERM': 'linux', 04:02:45 INFO - 'TMOUT': '86400', 04:02:45 INFO - 'USER': 'cltbld', 04:02:45 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', 04:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:45 INFO - '_': '/tools/buildbot/bin/python'} 04:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:45 INFO - Running setup.py (path:/tmp/pip-IThn1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:45 INFO - Running setup.py (path:/tmp/pip-Un8DsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:45 INFO - Running setup.py (path:/tmp/pip-bEwc3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:45 INFO - Running setup.py (path:/tmp/pip-diKXrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:45 INFO - Running setup.py (path:/tmp/pip-McPFvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:46 INFO - Running setup.py (path:/tmp/pip-uaLsqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:46 INFO - Running setup.py (path:/tmp/pip-xGfmW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:46 INFO - Running setup.py (path:/tmp/pip-aUO2FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:46 INFO - Running setup.py (path:/tmp/pip-uWw1PJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:46 INFO - Running setup.py (path:/tmp/pip-Zk6Pka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:46 INFO - Running setup.py (path:/tmp/pip-yJbqko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:46 INFO - Running setup.py (path:/tmp/pip-ghVcyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:46 INFO - Running setup.py (path:/tmp/pip-sQ3SuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:46 INFO - Running setup.py (path:/tmp/pip-4S95Nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:46 INFO - Running setup.py (path:/tmp/pip-7eYUde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:46 INFO - Running setup.py (path:/tmp/pip-is62n6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:46 INFO - Running setup.py (path:/tmp/pip-Vg_jl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:02:46 INFO - Running setup.py install for manifestparser 04:02:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:02:46 INFO - Running setup.py install for mozcrash 04:02:47 INFO - Running setup.py install for mozdebug 04:02:47 INFO - Running setup.py install for mozdevice 04:02:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:02:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:02:47 INFO - Running setup.py install for mozfile 04:02:47 INFO - Running setup.py install for mozhttpd 04:02:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:02:47 INFO - Running setup.py install for mozinfo 04:02:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:02:47 INFO - Running setup.py install for mozInstall 04:02:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:02:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:02:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:02:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:02:47 INFO - Running setup.py install for mozleak 04:02:47 INFO - Running setup.py install for mozlog 04:02:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:02:47 INFO - Running setup.py install for moznetwork 04:02:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:02:48 INFO - Running setup.py install for mozprocess 04:02:48 INFO - Running setup.py install for mozprofile 04:02:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:02:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:02:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:02:48 INFO - Running setup.py install for mozrunner 04:02:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:02:48 INFO - Running setup.py install for mozscreenshot 04:02:48 INFO - Running setup.py install for moztest 04:02:48 INFO - Running setup.py install for mozversion 04:02:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:02:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:02:48 INFO - Cleaning up... 04:02:48 INFO - Return code: 0 04:02:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:48 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 0x248e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c570>, '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 0x274d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', '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 04:02:48 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 04:02:48 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 04:02:48 INFO - Using env: {'DISPLAY': ':0', 04:02:48 INFO - 'HOME': '/home/cltbld', 04:02:48 INFO - 'LANG': 'en_US.UTF-8', 04:02:48 INFO - 'LANGUAGE': 'en_US:en', 04:02:48 INFO - 'LOGNAME': 'cltbld', 04:02:48 INFO - 'MAIL': '/var/mail/cltbld', 04:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:48 INFO - 'MOZ_NO_REMOTE': '1', 04:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:48 INFO - 'NO_EM_RESTART': '1', 04:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:48 INFO - 'PWD': '/builds/slave/test', 04:02:48 INFO - 'SHELL': '/bin/bash', 04:02:48 INFO - 'SHLVL': '1', 04:02:48 INFO - 'TERM': 'linux', 04:02:48 INFO - 'TMOUT': '86400', 04:02:48 INFO - 'USER': 'cltbld', 04:02:48 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', 04:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:48 INFO - '_': '/tools/buildbot/bin/python'} 04:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:48 INFO - Running setup.py (path:/tmp/pip-YL1p1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:48 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)) 04:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:48 INFO - Running setup.py (path:/tmp/pip-P90JhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02: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)) 04:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:49 INFO - Running setup.py (path:/tmp/pip-yr6_8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02: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)) 04:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:49 INFO - Running setup.py (path:/tmp/pip-eyfub0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02: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)) 04:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:49 INFO - Running setup.py (path:/tmp/pip-Cd9uhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02: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)) 04:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:49 INFO - Running setup.py (path:/tmp/pip-wWra4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:49 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)) 04:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:49 INFO - Running setup.py (path:/tmp/pip-EjYyOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:49 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)) 04:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:49 INFO - Running setup.py (path:/tmp/pip-mnDpv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:49 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)) 04:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:49 INFO - Running setup.py (path:/tmp/pip-X7xU9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:49 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)) 04:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:49 INFO - Running setup.py (path:/tmp/pip-HnS73P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:49 INFO - Running setup.py (path:/tmp/pip-6Fe6AY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:49 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)) 04:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:49 INFO - Running setup.py (path:/tmp/pip-Gp_2G2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:49 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)) 04:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:49 INFO - Running setup.py (path:/tmp/pip-fZ5ZM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:49 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)) 04:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:49 INFO - Running setup.py (path:/tmp/pip-dCO5FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:49 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)) 04:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:49 INFO - Running setup.py (path:/tmp/pip-Z36DX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:49 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)) 04:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:49 INFO - Running setup.py (path:/tmp/pip-Ha3gKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02: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)) 04:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:50 INFO - Running setup.py (path:/tmp/pip-bOdC_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02: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)) 04:02: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)) 04:02: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)) 04:02: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)) 04:02: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)) 04:02: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)) 04:02:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02:52 INFO - Downloading blessings-1.6.tar.gz 04:02:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:02:52 INFO - Installing collected packages: blessings 04:02:52 INFO - Running setup.py install for blessings 04:02:52 INFO - Successfully installed blessings 04:02:52 INFO - Cleaning up... 04:02:52 INFO - Return code: 0 04:02:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:02:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:52 INFO - Reading from file tmpfile_stdout 04:02:52 INFO - Current package versions: 04:02:52 INFO - argparse == 1.2.1 04:02:52 INFO - blessings == 1.6 04:02:52 INFO - blobuploader == 1.2.4 04:02:52 INFO - docopt == 0.6.1 04:02:52 INFO - functools32 == 3.2.3-2 04:02:52 INFO - jsonschema == 2.5.1 04:02:52 INFO - manifestparser == 1.1 04:02:52 INFO - mozInstall == 1.12 04:02:52 INFO - mozcrash == 0.17 04:02:52 INFO - mozdebug == 0.1 04:02:52 INFO - mozdevice == 0.48 04:02:52 INFO - mozfile == 1.2 04:02:52 INFO - mozhttpd == 0.7 04:02:52 INFO - mozinfo == 0.9 04:02:52 INFO - mozleak == 0.1 04:02:52 INFO - mozlog == 3.2 04:02:52 INFO - moznetwork == 0.27 04:02:52 INFO - mozprocess == 0.23 04:02:52 INFO - mozprofile == 0.28 04:02:52 INFO - mozrunner == 6.12 04:02:52 INFO - mozscreenshot == 0.1 04:02:52 INFO - mozsystemmonitor == 0.3 04:02:52 INFO - moztest == 0.7 04:02:52 INFO - mozversion == 1.4 04:02:52 INFO - psutil == 3.1.1 04:02:52 INFO - requests == 1.2.3 04:02:52 INFO - wsgiref == 0.1.2 04:02:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:52 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')]} 04:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:52 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')]} 04:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:52 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 0x248e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c570>, '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 0x274d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', '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 04:02:52 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 04:02:52 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 04:02:52 INFO - Using env: {'DISPLAY': ':0', 04:02:52 INFO - 'HOME': '/home/cltbld', 04:02:52 INFO - 'LANG': 'en_US.UTF-8', 04:02:52 INFO - 'LANGUAGE': 'en_US:en', 04:02:52 INFO - 'LOGNAME': 'cltbld', 04:02:52 INFO - 'MAIL': '/var/mail/cltbld', 04:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:52 INFO - 'MOZ_NO_REMOTE': '1', 04:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:52 INFO - 'NO_EM_RESTART': '1', 04:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:52 INFO - 'PWD': '/builds/slave/test', 04:02:52 INFO - 'SHELL': '/bin/bash', 04:02:52 INFO - 'SHLVL': '1', 04:02:52 INFO - 'TERM': 'linux', 04:02:52 INFO - 'TMOUT': '86400', 04:02:52 INFO - 'USER': 'cltbld', 04:02:52 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', 04:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:52 INFO - '_': '/tools/buildbot/bin/python'} 04:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:52 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)) 04:02:52 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)) 04:02:52 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)) 04:02:52 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)) 04:02:52 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)) 04:02:52 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)) 04:02:52 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)) 04:02:52 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)) 04:02:52 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)) 04:02:52 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)) 04:02:52 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)) 04:02:52 INFO - Cleaning up... 04:02:52 INFO - Return code: 0 04:02:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:02:52 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')]} 04:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:52 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')]} 04:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:52 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 0x248e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26bd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274c570>, '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 0x274d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', '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 04:02:52 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 04:02:52 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 04:02:52 INFO - Using env: {'DISPLAY': ':0', 04:02:52 INFO - 'HOME': '/home/cltbld', 04:02:52 INFO - 'LANG': 'en_US.UTF-8', 04:02:52 INFO - 'LANGUAGE': 'en_US:en', 04:02:52 INFO - 'LOGNAME': 'cltbld', 04:02:52 INFO - 'MAIL': '/var/mail/cltbld', 04:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:52 INFO - 'MOZ_NO_REMOTE': '1', 04:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:52 INFO - 'NO_EM_RESTART': '1', 04:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:52 INFO - 'PWD': '/builds/slave/test', 04:02:52 INFO - 'SHELL': '/bin/bash', 04:02:52 INFO - 'SHLVL': '1', 04:02:52 INFO - 'TERM': 'linux', 04:02:52 INFO - 'TMOUT': '86400', 04:02:52 INFO - 'USER': 'cltbld', 04:02:52 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', 04:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:52 INFO - '_': '/tools/buildbot/bin/python'} 04:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:02:52 INFO - Cleaning up... 04:02:52 INFO - Return code: 0 04:02:52 INFO - Running post-action listener: _resource_record_post_action 04:02:52 INFO - Running post-action listener: _start_resource_monitoring 04:02:52 INFO - Starting resource monitoring. 04:02:52 INFO - ##### 04:02:52 INFO - ##### Finished create-virtualenv step (success) 04:02:52 INFO - ##### 04:02:52 INFO - ##### 04:02:52 INFO - ##### Running install step. 04:02:52 INFO - ##### 04:02:52 INFO - Running pre-action listener: _resource_record_pre_action 04:02:52 INFO - Running main action method: install 04:02:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:53 INFO - Reading from file tmpfile_stdout 04:02:53 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:53 INFO - Reading from file tmpfile_stdout 04:02:53 INFO - Output received: 04:02:53 INFO - Usage: mozinstall [options] installer 04:02:53 INFO - Options: 04:02:53 INFO - -h, --help show this help message and exit 04:02:53 INFO - -d DEST, --destination=DEST 04:02:53 INFO - Directory to install application into. [default: 04:02:53 INFO - "/builds/slave/test"] 04:02:53 INFO - --app=APP Application being installed. [default: firefox] 04:02:53 INFO - mkdir: /builds/slave/test/build/application 04:02:53 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'] 04:02:53 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 04:03:09 INFO - Reading from file tmpfile_stdout 04:03:09 INFO - Output received: 04:03:09 INFO - /builds/slave/test/build/application/firefox/firefox 04:03:09 INFO - Running post-action listener: _resource_record_post_action 04:03:09 INFO - ##### 04:03:09 INFO - ##### Finished install step (success) 04:03:09 INFO - ##### 04:03:09 INFO - ##### 04:03:09 INFO - ##### Running run-tests step. 04:03:09 INFO - ##### 04:03:09 INFO - Running pre-action listener: _resource_record_pre_action 04:03:09 INFO - Running main action method: run_tests 04:03:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:03:09 INFO - Python 2.7.3 04:03:09 INFO - Return code: 0 04:03:09 INFO - grabbing minidump binary from tooltool 04:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:09 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 0x274c570>, '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 0x274d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:03:09 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 04:03:09 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 04:03:09 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 04:03:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:03:09 INFO - Return code: 0 04:03:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:03:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:03:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:03:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:03:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:03:09 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/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 04:03:09 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/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 04:03:09 INFO - Using env: {'DISPLAY': ':0', 04:03:09 INFO - 'HOME': '/home/cltbld', 04:03:09 INFO - 'LANG': 'en_US.UTF-8', 04:03:09 INFO - 'LANGUAGE': 'en_US:en', 04:03:09 INFO - 'LOGNAME': 'cltbld', 04:03:09 INFO - 'MAIL': '/var/mail/cltbld', 04:03:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:03:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:09 INFO - 'MOZ_NO_REMOTE': '1', 04:03:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:09 INFO - 'NO_EM_RESTART': '1', 04:03:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:09 INFO - 'PWD': '/builds/slave/test', 04:03:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:03:09 INFO - 'SHELL': '/bin/bash', 04:03:09 INFO - 'SHLVL': '1', 04:03:09 INFO - 'TERM': 'linux', 04:03:09 INFO - 'TMOUT': '86400', 04:03:09 INFO - 'USER': 'cltbld', 04:03:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696', 04:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:09 INFO - '_': '/tools/buildbot/bin/python'} 04:03:09 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/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 04:03:09 INFO - mozversion application_buildid: 20160714024642 04:03:09 INFO - mozversion application_changeset: 08f8a5aacd8308a73f6040fe522be7ba38497561 04:03:09 INFO - mozversion application_display_name: Nightly 04:03:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:03:09 INFO - mozversion application_name: Firefox 04:03:09 INFO - mozversion application_remotingname: firefox 04:03:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:03:09 INFO - mozversion application_vendor: Mozilla 04:03:09 INFO - mozversion application_version: 50.0a1 04:03:09 INFO - mozversion platform_buildid: 20160714024642 04:03:09 INFO - mozversion platform_changeset: 08f8a5aacd8308a73f6040fe522be7ba38497561 04:03:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:03:09 INFO - mozversion platform_version: 50.0a1 04:03:09 INFO - using testdate: 1468494189 04:03:09 INFO - actual date: 1468494189 04:03:09 INFO - starting webserver on 'localhost:33443' 04:03:09 INFO - SUITE-START | Running 2 tests 04:03:09 INFO - TEST-START | dromaeo_css 04:03:09 INFO - operating with platform_type : linux_ 04:03:09 INFO - Initialising browser for dromaeo_css test... 04:03:09 INFO - TEST-INFO | started process 5042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH4vI_B/profile http://localhost:33443/getInfo.html) 04:03:15 INFO - PROCESS | 5042 | __metrics Screen width/height:1600/1200 04:03:15 INFO - PROCESS | 5042 | colorDepth:24 04:03:15 INFO - PROCESS | 5042 | Browser inner width/height: 1024/697 04:03:15 INFO - PROCESS | 5042 | __metrics 04:03:15 ERROR - PROCESS | 5042 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 04:03:16 INFO - TEST-INFO | 5042: exit 0 04:03:16 INFO - Browser initialized. 04:03:16 INFO - Running cycle 1/1 for dromaeo_css test... 04:03:16 INFO - TEST-INFO | started process 5162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH4vI_B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:28 INFO - PROCESS | 5162 | RSS: Main: 169398272 04:03:28 INFO - PROCESS | 5162 | 04:04:18 INFO - PROCESS | 5162 | 1468494258355 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] 04:06:30 INFO - PROCESS | 5162 | Cycle 1(1): loaded http://localhost:33443/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33443/tests/dromaeo/cssquery-ext.html) 04:06:31 INFO - PROCESS | 5162 | RSS: Main: 169259008 04:06:31 INFO - PROCESS | 5162 | 04:09:33 INFO - PROCESS | 5162 | Cycle 1(1): loaded http://localhost:33443/tests/dromaeo/cssquery-ext.html (next: http://localhost:33443/tests/dromaeo/cssquery-jquery.html) 04:09:34 INFO - PROCESS | 5162 | RSS: Main: 168738816 04:09:34 INFO - PROCESS | 5162 | 04:12:36 INFO - PROCESS | 5162 | Cycle 1(1): loaded http://localhost:33443/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33443/tests/dromaeo/cssquery-mootools.html) 04:12:37 INFO - PROCESS | 5162 | RSS: Main: 172183552 04:12:37 INFO - PROCESS | 5162 | 04:15:38 INFO - PROCESS | 5162 | Cycle 1(1): loaded http://localhost:33443/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33443/tests/dromaeo/cssquery-prototype.html) 04:15:39 INFO - PROCESS | 5162 | RSS: Main: 168443904 04:15:39 INFO - PROCESS | 5162 | 04:18:42 INFO - PROCESS | 5162 | Cycle 1(1): loaded http://localhost:33443/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33443/tests/dromaeo/cssquery-yui.html) 04:18:43 INFO - PROCESS | 5162 | RSS: Main: 169263104 04:18:43 INFO - PROCESS | 5162 | 04:21:45 INFO - PROCESS | 5162 | Cycle 1(1): loaded http://localhost:33443/tests/dromaeo/cssquery-yui.html (next: http://localhost:33443/tests/dromaeo/cssquery-dojo.html) 04:21:45 INFO - PROCESS | 5162 | RSS: Main: 170868736 04:21:45 INFO - PROCESS | 5162 | 04:21:45 INFO - PROCESS | 5162 | __start_tp_report 04:21:45 INFO - PROCESS | 5162 | _x_x_mozilla_page_load 04:21:45 INFO - PROCESS | 5162 | _x_x_mozilla_page_load_details 04:21:45 INFO - PROCESS | 5162 | |i|pagename|runs| 04:21:45 INFO - PROCESS | 5162 | |0;dojo.html;2607.8174527783053;2662.334416395901;2681.343070947617;2684.087410280504;2689.6503454550893;4739.597134243589;4761.309610106537;4794;4816.109019831325;4903.534164254399;4607.331936869152;4802.303665968432;4805.1831188697915;4823.155947709146;4834.178189707749;4349.804258808361;4402.889927751816;4443.688941774077;4481.551844815525;4519.0961807638605;606.2197727277857;4309.4397728295435;4309.978450107745;4335.978320108395;4445.02209513908;4315.50371707253;4348.326009468537;4353.978230108829;4363.1273745250755;4377.890552736175;4340.110277393127;4366.19225443294;4379.496357918848;4383.3863259143745;4419.911601767979;4304.182205380999;4337.761423121727;4378.43080399546;4398.582134697199;4424.446944131983;4751.619870410394;4787.2101103318255;4811.446683631392;4812.326274321563;4901.313816065754;5204.557612602934;5214.713190774506;5215.348081489814;5218.243354713583;5267;5025.572826309768;5069.721165335905;5095.694258344512;5095.79616815327;5112.105381558213;4835.057163853015;4864.975675121602;4876.951230487721;4885.5358740919555;4926.113299606105;5093.745312734349;5277.23480095384;5343.225232341289;5347.919781203285;5352.464753524617;5105.15764898795;5112.36095488064;5141.742912854343;5145.845624631267;5190.92213616796;5227.111391063529;5229.686218826882;5230.529252367305;5232.581393488512;5305.734713264398;4940.308356830046;5087.87280317995;5148.304978827885;5165.66423182492;5175.094358487325;5122.282880396748;5153.252778347193;5155.484451554889;5158.200478925773;5196.038732834438;4314.80583373749;4320.071184695305;4321.632661223831;4354.303311470213;4370.994671225572;3716.108134047809;3720.776753394751;3747.8126093695205;3779.433085037266;3793.791341476245;4405.964598319392;4466.129104824593;4483.641308695296;4502.729836209838;4556.498785133633;5219.869503262373;5227.712475813867;5229.189475631283;5237.816676416307;5270.130428479258;4318.1363727254675;4393.077453734688;4398.406215160976;4398.626116780109;4561.726296422159;4507.459104907432;4523.977380113144;4529.8641040768825;4572.7942242599165;4574;4785.408687250058;4802.991371811959;4808.711477311373;4813.278008298783;4853.684510506806;5057.519535644108;5093.388793344822;5097.541221290102;5150.845474635767;5152.149895267239;4898.559129678203;4910.705357678551;4915.975420122876;4917.385326834145;4962.057209130254;5103.081445339726;5128.640995130305;5136.30659860929;5146.099432599205;5194.558462530727;5135;5151.7166555839785;5190.429052804113;5210.374755029269;5234.738263086754;5037.219231019198;5037.823676171316;5041.899162016813;5061.898762024813;5109.540141387293;5029.748512574283;5071.92392114126;5081.7713202905215;5090.516400941905;5107.974460127675;4851.417829860439;4883.8290659826735;4891.828785992473;4900.191468407673;4913.459519452786;5020.42265139499;5026.52248036436;5037.546620803999;5039.143345631325;5087.669301495539;4828.179209534317;4914.778834952507;4926.5073492650445;4937.901241975069;4956.677815941952 04:21:45 INFO - PROCESS | 5162 | |1;ext.html;535.3655917737481;545.7216819422093;548.8984537860496;550.9999999999998;579.8608333999841;35896.820515897416;40170.79914600423;40195.79902100489;40270.39594406086;40295.39556906649;39831.80084099583;40159.39760903581;40174.19651606966;40404.59595404045;40421.595784042154;7727.150013498511;7844.4901081429525;7867.606619669023;7872.937153484292;7885.053793544783;7832.21677832215;7851.2933835954755;7888.2506161914525;7926.405519586054;7935.365170786324;7886.447948643598;7914.485558438711;7930.405219608552;7931.484453510503;7964.60176991151;7822.647980840876;7840.960795196016;7874.448788584801;7909.564973926432;7916.445848790587;7887.684492620288;7910.564918929456;7943.4836735612;7961.681532738684;7970.681172753083;37732.81133594342;38016.61983380186;38355.808220958716;38469.23061538753;38573.614263857286;2386.3556839653197;2746;2782.1375373634237;2855.914322570326;2869.5121829288864;26128.86935565329;27503.587446188325;28207.71792282092;28720.856395718096;28954;3114.1280441476197;3126.937461250762;3163.5254711793186;3179.491281394966;3186.9857296180026;229642;229958;230173;231127.8443607788;231718;31901.20246993844;32398.514022289684;32688;32769;32886.67113328884;34030.319393611986;34052.14869628279;34085.31829363448;34092.14769630729;34286.31427371489;13110.737785244242;13296;13305.201687898758;13326.200427974352;13385;11201;11334.773304533863;11404.714882128013;11446.828297575543;11658.76682466363;7888.211178882066;7949.682012719427;7951.5626640534165;7977.282044616012;8056.234657707509;3033.9696603034126;3097.504399296102;3103.5189545620465;3103.7672174586546;3108.3006323577015;871.6208449324438;884.6594061286451;920.6685593186447;985.5663508056432;1019.6227395863579;27640.58539121915;28076;28728.569071463946;29008.12975610735;29023;946.5125460387906;1001.8146642871092;1003.6236411345745;1050.1283934334638;1063.9361638301727;14786.63033424173;14999.2500374983;15164.772528412082;15450.459233926758;15640.4525841595;293622;397626;400745;402695;404481;51542.22686659703;51732.74133629383;51766.48233517692;51968;52182.47817521852;1190.7975644140517;1210.442683297386;1213.2659740856832;1230.7600017996406;1254.0782524844233;27803.721962780113;29891.850540747157;29976;30201.697983019887;30684.84657576698;43274;43303.566964331214;43765.562344377424;43970.560294396644;44185;357728;359388;364476;366434;366952;25200;25510.107146250535;25584.616230756925;25854;25887.870560647076;42812;42936.78531607447;43351.78324108359;43610;43885.56114438815;37230.627693722716;37261;37493.81253093717;37780.81109594544;38594.2281154381;37501.62498374981;37548;37729.62270377371;37767;37982.81008594939;31723.682763172073;36104.27791444209;36579.634203657624;36619.267614647026;37005.444918326786;32257.677423226407;33868.70216796901;34141.829290853384;34606.30787384289;34872.47691284683;26099.73900260973;26114.86942565275;26235.21294361172;26313.868430657723;26817.195484135507 04:21:45 INFO - PROCESS | 5162 | |2;jquery.html;369.51224383813377;377.1852797956414;381.8415357626585;388.7511992324911;393.2901113490151;16459.588510287234;16857.662846743075;17681.911590442047;17705.380311689092;18179.45461636153;10058;10393.48032598369;10427.270091093607;10489.895101048987;10527.68416947491;4671.509491503386;4757.357756702852;4822.324874517571;4826.348442960208;4860.441049279325;4703.6237101032;4707.646926480511;4712.481627021025;4746.715197088186;4823.42118945727;4803.78382972767;4813.422389313288;4819.51804819517;4945.9258111128365;5200.661956972804;5026.97486512567;5135.691858488484;5136.948630513684;5154.664946778485;5177.275181474596;4537.659675524349;4595.793189306489;4633.49031606523;4638.095571363586;4646.86059418218;20449.591008179752;20654.07056682453;21172;21260.574788504142;21541.78458215429;1823.534998575368;1954.6872500399868;1982.137770070024;2234.173355858343;2273.238465114189;9114.58984345706;9123.498207598579;9241.815163696756;10213.540390682363;12610.243385396814;1707.5474999125242;1711.9486415407432;1726.8100508944005;1741.3731056819536;1778.310006736015;70668.6466567669;72398.63800680963;73234;73392.2660773396;73768.26231737668;9878.259130565093;10001.34991225568;10053.648122315684;10248.436336001592;10513.789724205473;13661.521846735317;13837.792433113511;13869.445222191202;13927.303634818218;13957.511487097903;7486.700531978769;7499.962500187464;7614.961925190339;7620.809479762939;7633.770986870402;7229.783106506813;7245.601491917995;7411.370033547209;7460.179380268275;7507.361874240751;4193.748375097504;4313.374560688682;4316.805743741539;4418.403515525427;4484.327350897326;1674.7641898066217;1745.9388921387945;1765.7792775903013;1769.4514700442646;1778.2442461953617;824.0358780227149;863.4128792421088;882.911708829112;913.5706218077493;940.5579377692474;17075.658486830194;17288.308467661405;17350.219240134225;17634.735478967825;17718.557036074202;817.6729308276618;870.9085546017703;888.2139306713605;890.4034297021011;941.6892425499568;9439.150476457015;9449.055094490495;9693.41839489633;9710.611575537041;9761.609535618496;372935;383936;384502;385336;401822;82409.58795205985;82499;82609.58695206486;83230.16769832224;83767.5811620938;907.2469850024464;926.0600490502146;942.3591957468986;948.3172116076414;954.4893481986965;15733.685326293182;15946.521604351889;16005.279762410486;16122.596935076717;16154.353825846834;39449.40825887671;39495;40141.1971760569;40506.79746601248;41581.58418415898;54836.451635483136;56604;57537.42462575321;58576.12135817881;59577.10634340575;7266.7093316266755;7824.84350313002;7890.84218315619;8134.552599606842;8160.000799804086;11140.944295278472;12235.571754988889;12296.262224266573;12463.750724985268;12652.304123273309;9871.901280987098;10060.49697515136;10269.127124194229;10853.728656783644;10883.619073332395;10055.446950417798;10321.174306055347;10368.170546356123;10537.57849686004;10540.209484288556;10117.291789574954;10825.945870270598;10839.13286937059;11018.669439916495;11189.608363707557;7458.627068646654;7556.055493063367;7580.658870350958;7640.617969101634;7738.806529836799;8792.956035219782;9499.335046546676;9991.700248992542;10197.13324367437;10371.170306375321 04:21:45 INFO - PROCESS | 5162 | |3;mootools.html;1408.4014293925081;1438.2089850582179;1466.633341664584;1560.8985415947955;1562.281350578733;6942.895856562156;7713.884291735621;7782.066152061746;8220.054693710224;8246.051704054029;7837.098733645633;8045.235702608257;8128.715494957678;8132.105468398487;8138.959305203481;2208.7791220877903;2231.2971414004537;2231.475603233239;2242.3497185816095;2247.3033359658475;2177.7168968034134;2179.6621523663857;2258.6950761647213;2281.1103669568884;2284.463151159476;2165.65349544073;2168.251953076186;2170.6852506386645;2206.6028114939304;2246.618074927258;2196.143504033428;2199.285232299501;2210.7568167501563;2213.9815684785017;2215.7341119065654;2157.6871353653787;2166.2418153646254;2166.7833216678364;2179.814715749163;2179.9891000545053;8106;8116.35069194463;8188.631511581993;8191;8217.876731849026;4692.577668009862;4828.49300823412;4831.130396528623;4842.564169224786;4846.151923413388;2837.917344421316;2976;2986.656534498539;2991.925201869949;2998.3553535989868;893.8837951066384;918.4810582021137;931;936;947.8578213267996;10874.836877446845;10948.671539853816;10954.068904143158;10981.725456863642;10990.780184396268;4094.63148316647;4318.892027699269;4319.265724826787;4379.4525684289465;4386.363977223348;9328.533573321307;9334.346595738232;9395.624175032923;9417.246620270362;9458.85811712825;4827.662063655511;4831.541003604652;4843.07981483517;4849.927251091236;4862.294967229732;3842.135519508144;4201.516825565038;4343.782810859444;4421.115776844644;4430.379746835446;3736.439534069911;3789.450529673182;3824;3846.9807650962125;3887.552931412867;1221.4259298129864;1257.3775980889518;1283.5700040486354;1297.5523444411663;1299.4737131461773;790.1742678900563;811.7321283976273;832.317499650281;834.7662654456761;866.8179682266668;5402.567794576425;5429.294191755047;5484.890302193934;5542.501174894279;5581.246531718247;411.6624368018256;412.8885200995774;416.73953778888193;422.391755871544;430.7372502773306;3650.963490365062;3690.2988432197794;3700.611435799256;3707.796071216109;3740.1023754299317;9700.466474343837;9992.700218993441;9995.80008399828;10050.949745251228;10052.095311421861;9884.406935583887;9922.553485093189;9940.80118397628;9987.60049598008;9998.550065247082;7514.4364172687265;7520.1351844537485;7555.055618047744;7559.677056515088;7577.886331705029;5564.1931919870585;5574.108142697149;5724.79963201286;5779.595428320145;5790.747500396742;8914.910850891409;9027.4132181408;9041.276697864287;9106.772330691521;9134.634614615341;8842.91157088421;9188.632454701738;9264.39781414206;9281.02549232321;9301.162895339452;6056.454919057306;6756.662166891538;6942.791716248521;6952.652367381509;7116.395106416013;7881.527108373287;7897.605119743875;7898.486598371088;7944.801379965547;7947.483413578099;6733;6956.513044086865;6979;7014.614196219053;7033.648317583998;6964.4080253179045;7052.576845389293;7079.29207079288;7165.928340716526;7191.748288809867;6555.3772391622715;6605.702743376656;6660.766873159416;6688;6717.496187786033;4782.593479554277;4875.293082503088;4881.682690625098;4885.462599114024;4939.975300123477;4797.016611594685;4805.975970120127;4888.877778055577;4940.086084074458;4987.625928055338 04:21:45 INFO - PROCESS | 5162 | |4;prototype.html;299.0520051436945;304.50517908398854;308.48483033334327;313.1435523842292;315.08624987536143;4980.526849949258;4987.226979818125;5131.794728210872;5180.326557547518;5205.427402985673;5021.347224860763;5024.623153263502;5038.7984480620735;5040.269160971657;5047.64666473347;3989.481367422231;3993.341098718708;4002.75983440993;4003.359462486003;4016.4577781999496;3945.664618507416;4011.418344340069;4014.2974979378637;4018.4775979122674;4041.898952526181;3908.9804550977206;3964.9008774780573;3965.9801700991597;3969.6625786808154;3985.322495175827;3943.7239393242485;3944.5660977292473;3955.3671412573995;3981.3828856527284;3989.1024519482885;3535.1515636247113;3535.6287589803214;3538.115471132217;3541.982290088533;3565.3047655707146;4912.929419113055;4981.160738379125;5017.34774479319;5020.899582008376;5083.974580127076;4509.489321077443;4552.180607490651;4572.565606267399;4579.519150489217;4585.541445855421;5361.410244873061;5367.651102678314;5373.775734559273;5380.973095134538;5404.729763511848;3744.9812750936344;3830.865919692825;3832.559255685604;3836.9232615347537;3868.916703323046;5542.528885044776;5555.972220138914;5603.579731520153;5623.8594035149035;5648.265725455705;3938.1729836734035;3954.60453954608;3955.110100227483;3958.8218530166214;3960.386140148282;3816.38937769961;4007.238624661305;4018.2566225248424;4019.8995025124605;4026.4362989181536;4517.277235642281;4527.3435351873795;4537.705049171794;4540.659450541222;4560.293154561048;5320.973395133077;5334.1732031535175;5367.570594352443;5391.32608423947;5402.676344295594;1286.350393051503;1349.5546469664987;1374.4639590559689;1376.6351916742071;1379.5516457151266;930.3394589841289;951.6526467839188;956.8947415784259;960.1358777100526;965.9903400966041;4610.74640894754;4681.344611754357;4683.227267500824;4692.976535117303;4710.905781884343;5424.810131645373;5430.51125398716;5449.427810079885;5506.449355064461;5507.127576623887;4495.955040449554;4648.2562789953445;4666.160091183551;4668.97665511677;4680.134175177603;2903.941921161565;2924.8683809228637;2933.120063980797;2941.6175897133235;2943.2641839540115;5109.540141387293;5191.428942816287;5212.635115541952;5214.32213812202;5214.947850521522;5423.755930983115;5613.372122084631;5632.8313599264575;5647.830565083054;5650.180723795027;5176.7411629418375;5182;5197.8440646780655;5208.348956380452;5249.370075590801;5519.806806761744;5538.501534861882;5542.2795036644975;5542.944570554243;5574.86062848432;5266.657667251617;5397.190421436659;5401.405845356929;5405.972970135282;5417.322834645669;5178.922316165336;5181.896362072813;5193.428722840409;5200.5438477226435;5249.921251181159;3868.96131038686;3894.1822217334675;3895.8636447724193;3899.337112690906;3908.785016824102;5202.167653175474;5319.175527793198;5346.823698786261;5436.852443284959;5462.754176062166;5312.282841816305;5317.8404647860625;5358.651687640291;5360.8742164144405;5381.67709937405;5300.628955973045;5345.144776835843;5349.893002140013;5363.490468405495;5381.381141168816;5178.611604129781;5256.421793602624;5256.710880901587;5257.185136303879;5276.208568714724;5343.9732801337295;5406.324209473816;5422.529581068198;5437.40188579248;5444.727763611724;5311.41574426805;5316.521513063843;5322.760475778522;5346.224797404277;5349.652272602269 04:21:45 INFO - PROCESS | 5162 | |5;yui.html;627.9309275979645;635.7298148286977;639.2233436374804;725.9981225908246;732.6666366803105;10718.624848130317;11752.001079908217;11752.588659396923;11756.7648647027;11782.646520604396;13028.544000959968;13772.586822395344;14400.71198576028;14476.348564314605;15227.086374817518;612.2958597612759;751.7556794041931;764.2281295891162;774.4269240761823;778.8169780101672;776.848514539665;793.6904607203167;794.3962588432804;796.4783067091035;796.625585974591;834.870595057767;835.6824406725436;836.3225787112428;836.6695155413609;837.6063250272392;826.9297109745679;828.4076885027174;828.7430896422098;829.1004260377498;829.3613917283687;604.8276241271217;607.1378642327905;607.8996965500687;608.2609629300421;609.7347653770624;13623.795643065361;13635.590932272047;13772;13775.173489590657;13831.654208644864;13224.86775132246;13395.531156409479;13632.863671363259;13646;13688.178709277476;9278.907210927871;9315.487648179347;9433;9500.23998080152;9563.713088607354;3190.218396492851;3259.9022029339158;3280.2455435249785;3280.5243239730344;3282.983585082083;67696;68503.31496685019;68714.31285687129;69503.30496695019;70329.2967070333;9913.206943444507;10353.4305613192;10493.52779124926;10594.523246453928;10666.839997400046;18756.437306880816;18920.33778817735;18921.337753178846;19109.23563057462;19168.520786980436;7073.61095139762;7114;7121.537100088478;7129.821754456077;7177.461690373243;3558.1638314995957;3570.3751843427294;3572.1248294167576;3724.7578907370935;3879.2047630235734;2689.9731002690114;2827.5720761015555;2830.5754136879223;2831.66020077592;2833.5324671429394;444.16718652526515;445.43652279865995;450.4706969311112;479.6115146731159;481.4992407895749;459.60244388603616;460.1234647995574;530.3953493017963;530.4456842599493;562.8030189433665;7488.213737557587;7573.2805383488485;7673.424493163036;7943.404244681672;8008.119106898236;496.50845662794296;523.0611053159588;527.9768166570756;541.7155993103652;565.7143142712904;3592.9820350898076;3770.434434834797;3801.2777572261184;3803.2013277212095;3887.61123887609;93720;93740.53129734307;95071.52464237635;97272.51363743277;97935;47532.28701569479;59478;79746;82453.58773206096;84949.15050849535;73565.63217183879;74829.6258518704;75042.24957750461;77376;77954.61022694963;7171.1753148386515;7195.892061618975;7197;7488.925110748823;7519.060117485315;45044.32433513434;45161.87095322643;45615;46567.534324657674;47051.52948470471;57584.42415575791;65051.67474162599;65230.347696522425;66817.33182668306;67703.32296677167;9311.76720581991;9436.150746432853;9545.570449329658;9635.084666956627;9849.162821159995;9955.50222488887;10510.632127875488;10954.616588419367;11185.384803835866;11217.332725723863;8785.824283514166;8854.424462409923;8901.243394311556;8981.775455613662;9110.817783644157;9272.72181834546;9377.249820014518;9430.056994300516;9465.526723663652;9510.61957521719;9139.588718507815;9163.26693864476;9294.953525232331;9338.766530836783;9697;8342.207490288412;8605.311575073854;8643.956780216058;8702.47785132894;8807.119288071142;8663.176998185163;8890.151175421535;8912.598933048159;8938.68714594986;8943.821123577362 04:21:45 INFO - PROCESS | 5162 | __end_tp_report 04:21:45 INFO - PROCESS | 5162 | __start_cc_report 04:21:45 INFO - PROCESS | 5162 | _x_x_mozilla_cycle_collect,418 04:21:45 INFO - PROCESS | 5162 | __end_cc_report 04:21:45 INFO - PROCESS | 5162 | __startTimestamp1468495305794__endTimestamp 04:21:45 INFO - PROCESS | 5162 | 04:21:45 INFO - PROCESS | 5162 | ------- Summary: start ------- 04:21:45 INFO - PROCESS | 5162 | Number of tests: 6 04:21:45 INFO - PROCESS | 5162 | 04:21:45 INFO - PROCESS | 5162 | [#0] dojo.html Cycles:165 Average:4733.77 Median:4901.31 stddev:612.44 (12.5%) stddev-sans-first:591.17 04:21:45 INFO - PROCESS | 5162 | Values: 2607.8 2662.3 2681.3 2684.1 2689.7 4739.6 4761.3 4794.0 4816.1 4903.5 4607.3 4802.3 4805.2 4823.2 4834.2 4349.8 4402.9 4443.7 4481.6 4519.1 606.2 4309.4 4310.0 4336.0 4445.0 4315.5 4348.3 4354.0 4363.1 4377.9 4340.1 4366.2 4379.5 4383.4 4419.9 4304.2 4337.8 4378.4 4398.6 4424.4 4751.6 4787.2 4811.4 4812.3 4901.3 5204.6 5214.7 5215.3 5218.2 5267.0 5025.6 5069.7 5095.7 5095.8 5112.1 4835.1 4865.0 4877.0 4885.5 4926.1 5093.7 5277.2 5343.2 5347.9 5352.5 5105.2 5112.4 5141.7 5145.8 5190.9 5227.1 5229.7 5230.5 5232.6 5305.7 4940.3 5087.9 5148.3 5165.7 5175.1 5122.3 5153.3 5155.5 5158.2 5196.0 4314.8 4320.1 4321.6 4354.3 4371.0 3716.1 3720.8 3747.8 3779.4 3793.8 4406.0 4466.1 4483.6 4502.7 4556.5 5219.9 5227.7 5229.2 5237.8 5270.1 4318.1 4393.1 4398.4 4398.6 4561.7 4507.5 4524.0 4529.9 4572.8 4574.0 4785.4 4803.0 4808.7 4813.3 4853.7 5057.5 5093.4 5097.5 5150.8 5152.1 4898.6 4910.7 4916.0 4917.4 4962.1 5103.1 5128.6 5136.3 5146.1 5194.6 5135.0 5151.7 5190.4 5210.4 5234.7 5037.2 5037.8 5041.9 5061.9 5109.5 5029.7 5071.9 5081.8 5090.5 5108.0 4851.4 4883.8 4891.8 4900.2 4913.5 5020.4 5026.5 5037.5 5039.1 5087.7 4828.2 4914.8 4926.5 4937.9 4956.7 04:21:45 INFO - PROCESS | 5162 | 04:21:45 INFO - PROCESS | 5162 | [#1] ext.html Cycles:180 Average:46656.35 Median:200290.14 stddev:87812.17 (43.8%) stddev-sans-first:87990.23 04:21:45 INFO - PROCESS | 5162 | Values: 535.4 545.7 548.9 551.0 579.9 35896.8 40170.8 40195.8 40270.4 40295.4 39831.8 40159.4 40174.2 40404.6 40421.6 7727.2 7844.5 7867.6 7872.9 7885.1 7832.2 7851.3 7888.3 7926.4 7935.4 7886.4 7914.5 7930.4 7931.5 7964.6 7822.6 7841.0 7874.4 7909.6 7916.4 7887.7 7910.6 7943.5 7961.7 7970.7 37732.8 38016.6 38355.8 38469.2 38573.6 2386.4 2746.0 2782.1 2855.9 2869.5 26128.9 27503.6 28207.7 28720.9 28954.0 3114.1 3126.9 3163.5 3179.5 3187.0 229642.0 229958.0 230173.0 231127.8 231718.0 31901.2 32398.5 32688.0 32769.0 32886.7 34030.3 34052.1 34085.3 34092.1 34286.3 13110.7 13296.0 13305.2 13326.2 13385.0 11201.0 11334.8 11404.7 11446.8 11658.8 7888.2 7949.7 7951.6 7977.3 8056.2 3034.0 3097.5 3103.5 3103.8 3108.3 871.6 884.7 920.7 985.6 1019.6 27640.6 28076.0 28728.6 29008.1 29023.0 946.5 1001.8 1003.6 1050.1 1063.9 14786.6 14999.3 15164.8 15450.5 15640.5 293622.0 397626.0 400745.0 402695.0 404481.0 51542.2 51732.7 51766.5 51968.0 52182.5 1190.8 1210.4 1213.3 1230.8 1254.1 27803.7 29891.9 29976.0 30201.7 30684.8 43274.0 43303.6 43765.6 43970.6 44185.0 357728.0 359388.0 364476.0 366434.0 366952.0 25200.0 25510.1 25584.6 25854.0 25887.9 42812.0 42936.8 43351.8 43610.0 43885.6 37230.6 37261.0 37493.8 37780.8 38594.2 37501.6 37548.0 37729.6 37767.0 37982.8 31723.7 36104.3 36579.6 36619.3 37005.4 32257.7 33868.7 34141.8 34606.3 34872.5 26099.7 26114.9 26235.2 26313.9 26817.2 04:21:45 INFO - PROCESS | 5162 | 04:21:45 INFO - PROCESS | 5162 | [#2] jquery.html Cycles:180 Average:24606.00 Median:4451.37 stddev:64077.95 (1439.5%) stddev-sans-first:64231.86 04:21:45 INFO - PROCESS | 5162 | Values: 369.5 377.2 381.8 388.8 393.3 16459.6 16857.7 17681.9 17705.4 18179.5 10058.0 10393.5 10427.3 10489.9 10527.7 4671.5 4757.4 4822.3 4826.3 4860.4 4703.6 4707.6 4712.5 4746.7 4823.4 4803.8 4813.4 4819.5 4945.9 5200.7 5027.0 5135.7 5136.9 5154.7 5177.3 4537.7 4595.8 4633.5 4638.1 4646.9 20449.6 20654.1 21172.0 21260.6 21541.8 1823.5 1954.7 1982.1 2234.2 2273.2 9114.6 9123.5 9241.8 10213.5 12610.2 1707.5 1711.9 1726.8 1741.4 1778.3 70668.6 72398.6 73234.0 73392.3 73768.3 9878.3 10001.3 10053.6 10248.4 10513.8 13661.5 13837.8 13869.4 13927.3 13957.5 7486.7 7500.0 7615.0 7620.8 7633.8 7229.8 7245.6 7411.4 7460.2 7507.4 4193.7 4313.4 4316.8 4418.4 4484.3 1674.8 1745.9 1765.8 1769.5 1778.2 824.0 863.4 882.9 913.6 940.6 17075.7 17288.3 17350.2 17634.7 17718.6 817.7 870.9 888.2 890.4 941.7 9439.2 9449.1 9693.4 9710.6 9761.6 372935.0 383936.0 384502.0 385336.0 401822.0 82409.6 82499.0 82609.6 83230.2 83767.6 907.2 926.1 942.4 948.3 954.5 15733.7 15946.5 16005.3 16122.6 16154.4 39449.4 39495.0 40141.2 40506.8 41581.6 54836.5 56604.0 57537.4 58576.1 59577.1 7266.7 7824.8 7890.8 8134.6 8160.0 11140.9 12235.6 12296.3 12463.8 12652.3 9871.9 10060.5 10269.1 10853.7 10883.6 10055.4 10321.2 10368.2 10537.6 10540.2 10117.3 10825.9 10839.1 11018.7 11189.6 7458.6 7556.1 7580.7 7640.6 7738.8 8793.0 9499.3 9991.7 10197.1 10371.2 04:21:45 INFO - PROCESS | 5162 | 04:21:45 INFO - PROCESS | 5162 | [#3] mootools.html Cycles:180 Average:5303.88 Median:4963.86 stddev:2990.30 (60.2%) stddev-sans-first:2984.36 04:21:45 INFO - PROCESS | 5162 | Values: 1408.4 1438.2 1466.6 1560.9 1562.3 6942.9 7713.9 7782.1 8220.1 8246.1 7837.1 8045.2 8128.7 8132.1 8139.0 2208.8 2231.3 2231.5 2242.3 2247.3 2177.7 2179.7 2258.7 2281.1 2284.5 2165.7 2168.3 2170.7 2206.6 2246.6 2196.1 2199.3 2210.8 2214.0 2215.7 2157.7 2166.2 2166.8 2179.8 2180.0 8106.0 8116.4 8188.6 8191.0 8217.9 4692.6 4828.5 4831.1 4842.6 4846.2 2837.9 2976.0 2986.7 2991.9 2998.4 893.9 918.5 931.0 936.0 947.9 10874.8 10948.7 10954.1 10981.7 10990.8 4094.6 4318.9 4319.3 4379.5 4386.4 9328.5 9334.3 9395.6 9417.2 9458.9 4827.7 4831.5 4843.1 4849.9 4862.3 3842.1 4201.5 4343.8 4421.1 4430.4 3736.4 3789.5 3824.0 3847.0 3887.6 1221.4 1257.4 1283.6 1297.6 1299.5 790.2 811.7 832.3 834.8 866.8 5402.6 5429.3 5484.9 5542.5 5581.2 411.7 412.9 416.7 422.4 430.7 3651.0 3690.3 3700.6 3707.8 3740.1 9700.5 9992.7 9995.8 10050.9 10052.1 9884.4 9922.6 9940.8 9987.6 9998.6 7514.4 7520.1 7555.1 7559.7 7577.9 5564.2 5574.1 5724.8 5779.6 5790.7 8914.9 9027.4 9041.3 9106.8 9134.6 8842.9 9188.6 9264.4 9281.0 9301.2 6056.5 6756.7 6942.8 6952.7 7116.4 7881.5 7897.6 7898.5 7944.8 7947.5 6733.0 6956.5 6979.0 7014.6 7033.6 6964.4 7052.6 7079.3 7165.9 7191.7 6555.4 6605.7 6660.8 6688.0 6717.5 4782.6 4875.3 4881.7 4885.5 4940.0 4797.0 4806.0 4888.9 4940.1 4987.6 04:21:45 INFO - PROCESS | 5162 | 04:21:45 INFO - PROCESS | 5162 | [#4] prototype.html Cycles:180 Average:4448.41 Median:5065.81 stddev:1286.15 (25.4%) stddev-sans-first:1251.48 04:21:45 INFO - PROCESS | 5162 | Values: 299.1 304.5 308.5 313.1 315.1 4980.5 4987.2 5131.8 5180.3 5205.4 5021.3 5024.6 5038.8 5040.3 5047.6 3989.5 3993.3 4002.8 4003.4 4016.5 3945.7 4011.4 4014.3 4018.5 4041.9 3909.0 3964.9 3966.0 3969.7 3985.3 3943.7 3944.6 3955.4 3981.4 3989.1 3535.2 3535.6 3538.1 3542.0 3565.3 4912.9 4981.2 5017.3 5020.9 5084.0 4509.5 4552.2 4572.6 4579.5 4585.5 5361.4 5367.7 5373.8 5381.0 5404.7 3745.0 3830.9 3832.6 3836.9 3868.9 5542.5 5556.0 5603.6 5623.9 5648.3 3938.2 3954.6 3955.1 3958.8 3960.4 3816.4 4007.2 4018.3 4019.9 4026.4 4517.3 4527.3 4537.7 4540.7 4560.3 5321.0 5334.2 5367.6 5391.3 5402.7 1286.4 1349.6 1374.5 1376.6 1379.6 930.3 951.7 956.9 960.1 966.0 4610.7 4681.3 4683.2 4693.0 4710.9 5424.8 5430.5 5449.4 5506.4 5507.1 4496.0 4648.3 4666.2 4669.0 4680.1 2903.9 2924.9 2933.1 2941.6 2943.3 5109.5 5191.4 5212.6 5214.3 5214.9 5423.8 5613.4 5632.8 5647.8 5650.2 5176.7 5182.0 5197.8 5208.3 5249.4 5519.8 5538.5 5542.3 5542.9 5574.9 5266.7 5397.2 5401.4 5406.0 5417.3 5178.9 5181.9 5193.4 5200.5 5249.9 3869.0 3894.2 3895.9 3899.3 3908.8 5202.2 5319.2 5346.8 5436.9 5462.8 5312.3 5317.8 5358.7 5360.9 5381.7 5300.6 5345.1 5349.9 5363.5 5381.4 5178.6 5256.4 5256.7 5257.2 5276.2 5344.0 5406.3 5422.5 5437.4 5444.7 5311.4 5316.5 5322.8 5346.2 5349.7 04:21:45 INFO - PROCESS | 5162 | 04:21:45 INFO - PROCESS | 5162 | [#5] yui.html Cycles:180 Average:17231.68 Median:68608.81 stddev:25094.10 (36.6%) stddev-sans-first:25133.53 04:21:45 INFO - PROCESS | 5162 | Values: 627.9 635.7 639.2 726.0 732.7 10718.6 11752.0 11752.6 11756.8 11782.6 13028.5 13772.6 14400.7 14476.3 15227.1 612.3 751.8 764.2 774.4 778.8 776.8 793.7 794.4 796.5 796.6 834.9 835.7 836.3 836.7 837.6 826.9 828.4 828.7 829.1 829.4 604.8 607.1 607.9 608.3 609.7 13623.8 13635.6 13772.0 13775.2 13831.7 13224.9 13395.5 13632.9 13646.0 13688.2 9278.9 9315.5 9433.0 9500.2 9563.7 3190.2 3259.9 3280.2 3280.5 3283.0 67696.0 68503.3 68714.3 69503.3 70329.3 9913.2 10353.4 10493.5 10594.5 10666.8 18756.4 18920.3 18921.3 19109.2 19168.5 7073.6 7114.0 7121.5 7129.8 7177.5 3558.2 3570.4 3572.1 3724.8 3879.2 2690.0 2827.6 2830.6 2831.7 2833.5 444.2 445.4 450.5 479.6 481.5 459.6 460.1 530.4 530.4 562.8 7488.2 7573.3 7673.4 7943.4 8008.1 496.5 523.1 528.0 541.7 565.7 3593.0 3770.4 3801.3 3803.2 3887.6 93720.0 93740.5 95071.5 97272.5 97935.0 47532.3 59478.0 79746.0 82453.6 84949.2 73565.6 74829.6 75042.2 77376.0 77954.6 7171.2 7195.9 7197.0 7488.9 7519.1 45044.3 45161.9 45615.0 46567.5 47051.5 57584.4 65051.7 65230.3 66817.3 67703.3 9311.8 9436.2 9545.6 9635.1 9849.2 9955.5 10510.6 10954.6 11185.4 11217.3 8785.8 8854.4 8901.2 8981.8 9110.8 9272.7 9377.2 9430.1 9465.5 9510.6 9139.6 9163.3 9295.0 9338.8 9697.0 8342.2 8605.3 8644.0 8702.5 8807.1 8663.2 8890.2 8912.6 8938.7 8943.8 04:21:45 INFO - PROCESS | 5162 | -------- Summary: end -------- 04:21:45 INFO - PROCESS | 5162 | 04:21:46 INFO - TEST-INFO | 5162: exit 0 04:21:46 INFO - TEST-OK | dromaeo_css | took 1116691ms 04:21:46 INFO - TEST-START | kraken 04:21:46 INFO - operating with platform_type : linux_ 04:21:46 INFO - Initialising browser for kraken test... 04:21:46 INFO - TEST-INFO | started process 5408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7q1etv/profile http://localhost:33443/getInfo.html) 04:21:51 INFO - PROCESS | 5408 | __metrics Screen width/height:1600/1200 04:21:51 INFO - PROCESS | 5408 | colorDepth:24 04:21:51 INFO - PROCESS | 5408 | Browser inner width/height: 1024/697 04:21:51 INFO - PROCESS | 5408 | __metrics 04:21:52 ERROR - PROCESS | 5408 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 04:21:53 INFO - TEST-INFO | 5408: exit 0 04:21:53 INFO - Browser initialized. 04:21:53 INFO - Running cycle 1/1 for kraken test... 04:21:53 INFO - TEST-INFO | started process 5531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7q1etv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:05 INFO - PROCESS | 5531 | RSS: Main: 168939520 04:22:05 INFO - PROCESS | 5531 | 04:22:07 INFO - PROCESS | 5531 | Cycle 1(1): loaded http://localhost:33443/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33443/tests/kraken/driver.html?testName=audio-beat-detection) 04:22:08 INFO - PROCESS | 5531 | RSS: Main: 174264320 04:22:08 INFO - PROCESS | 5531 | 04:22:11 INFO - PROCESS | 5531 | Cycle 1(1): loaded http://localhost:33443/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33443/tests/kraken/driver.html?testName=audio-dft) 04:22:12 INFO - PROCESS | 5531 | RSS: Main: 173887488 04:22:12 INFO - PROCESS | 5531 | 04:22:15 INFO - PROCESS | 5531 | Cycle 1(1): loaded http://localhost:33443/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33443/tests/kraken/driver.html?testName=audio-fft) 04:22:15 INFO - PROCESS | 5531 | RSS: Main: 168800256 04:22:15 INFO - PROCESS | 5531 | 04:22:17 INFO - PROCESS | 5531 | Cycle 1(1): loaded http://localhost:33443/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33443/tests/kraken/driver.html?testName=audio-oscillator) 04:22:18 INFO - PROCESS | 5531 | RSS: Main: 169062400 04:22:18 INFO - PROCESS | 5531 | 04:22:20 INFO - PROCESS | 5531 | Cycle 1(1): loaded http://localhost:33443/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33443/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:22:21 INFO - PROCESS | 5531 | RSS: Main: 169697280 04:22:21 INFO - PROCESS | 5531 | 04:22:24 INFO - PROCESS | 5531 | Cycle 1(1): loaded http://localhost:33443/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33443/tests/kraken/driver.html?testName=imaging-darkroom) 04:22:25 INFO - PROCESS | 5531 | RSS: Main: 170098688 04:22:25 INFO - PROCESS | 5531 | 04:22:28 INFO - PROCESS | 5531 | Cycle 1(1): loaded http://localhost:33443/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33443/tests/kraken/driver.html?testName=imaging-desaturate) 04:22:29 INFO - PROCESS | 5531 | RSS: Main: 167391232 04:22:29 INFO - PROCESS | 5531 | 04:22:32 INFO - PROCESS | 5531 | Cycle 1(1): loaded http://localhost:33443/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33443/tests/kraken/driver.html?testName=json-parse-financial) 04:22:32 INFO - PROCESS | 5531 | RSS: Main: 168976384 04:22:32 INFO - PROCESS | 5531 | 04:22:34 INFO - PROCESS | 5531 | Cycle 1(1): loaded http://localhost:33443/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33443/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:22:35 INFO - PROCESS | 5531 | RSS: Main: 169209856 04:22:35 INFO - PROCESS | 5531 | 04:22:37 INFO - PROCESS | 5531 | Cycle 1(1): loaded http://localhost:33443/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33443/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:22:37 INFO - PROCESS | 5531 | RSS: Main: 169676800 04:22:37 INFO - PROCESS | 5531 | 04:22:39 INFO - PROCESS | 5531 | Cycle 1(1): loaded http://localhost:33443/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33443/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:22:40 INFO - PROCESS | 5531 | RSS: Main: 170172416 04:22:40 INFO - PROCESS | 5531 | 04:22:43 INFO - PROCESS | 5531 | Cycle 1(1): loaded http://localhost:33443/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:22:44 INFO - PROCESS | 5531 | RSS: Main: 170160128 04:22:44 INFO - PROCESS | 5531 | 04:22:47 INFO - PROCESS | 5531 | Cycle 1(1): loaded http://localhost:33443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:22:47 INFO - PROCESS | 5531 | RSS: Main: 169504768 04:22:47 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | Cycle 1(1): loaded http://localhost:33443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33443/tests/kraken/driver.html?testName=ai-astar) 04:22:49 INFO - PROCESS | 5531 | RSS: Main: 170651648 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | __start_tp_report 04:22:49 INFO - PROCESS | 5531 | _x_x_mozilla_page_load 04:22:49 INFO - PROCESS | 5531 | _x_x_mozilla_page_load_details 04:22:49 INFO - PROCESS | 5531 | |i|pagename|runs| 04:22:49 INFO - PROCESS | 5531 | |0;ai-astar;106;116;107;113;112;115;114;113;115;114 04:22:49 INFO - PROCESS | 5531 | |1;audio-beat-detection;156;122;155;181;129;160;152;125;181;122 04:22:49 INFO - PROCESS | 5531 | |2;audio-dft;162;161;162;164;173;164;160;164;163;164 04:22:49 INFO - PROCESS | 5531 | |3;audio-fft;77;76;77;168;77;77;76;75;178;75 04:22:49 INFO - PROCESS | 5531 | |4;audio-oscillator;86;85;136;86;86;85;135;84;85;143 04:22:49 INFO - PROCESS | 5531 | |5;imaging-gaussian-blur;118;118;117;118;117;117;117;117;119;118 04:22:49 INFO - PROCESS | 5531 | |6;imaging-darkroom;148;149;148;149;149;150;147;148;148;148 04:22:49 INFO - PROCESS | 5531 | |7;imaging-desaturate;96;95;95;96;96;96;95;95;96;96 04:22:49 INFO - PROCESS | 5531 | |8;json-parse-financial;65;66;66;66;67;66;67;66;65;66 04:22:49 INFO - PROCESS | 5531 | |9;json-stringify-tinderbox;66;67;65;66;67;66;66;65;66;65 04:22:49 INFO - PROCESS | 5531 | |10;stanford-crypto-aes;79;89;81;81;78;78;79;85;84;79 04:22:49 INFO - PROCESS | 5531 | |11;stanford-crypto-ccm;132;129;133;138;133;146;131;140;171;129 04:22:49 INFO - PROCESS | 5531 | |12;stanford-crypto-pbkdf2;167;171;170;174;164;174;168;176;164;167 04:22:49 INFO - PROCESS | 5531 | |13;stanford-crypto-sha256-iterative;70;69;68;68;68;67;66;67;67;68 04:22:49 INFO - PROCESS | 5531 | __end_tp_report 04:22:49 INFO - PROCESS | 5531 | __start_cc_report 04:22:49 INFO - PROCESS | 5531 | _x_x_mozilla_cycle_collect,1010 04:22:49 INFO - PROCESS | 5531 | __end_cc_report 04:22:49 INFO - PROCESS | 5531 | __startTimestamp1468495369661__endTimestamp 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | ------- Summary: start ------- 04:22:49 INFO - PROCESS | 5531 | Number of tests: 14 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:3.37 (3.0%) stddev-sans-first:2.64 04:22:49 INFO - PROCESS | 5531 | Values: 106.0 116.0 107.0 113.0 112.0 115.0 114.0 113.0 115.0 114.0 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:155.50 stddev:22.83 (14.7%) stddev-sans-first:24.05 04:22:49 INFO - PROCESS | 5531 | Values: 156.0 122.0 155.0 181.0 129.0 160.0 152.0 125.0 181.0 122.0 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:3.56 (2.2%) stddev-sans-first:3.72 04:22:49 INFO - PROCESS | 5531 | Values: 162.0 161.0 162.0 164.0 173.0 164.0 160.0 164.0 163.0 164.0 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.50 stddev:40.87 (53.4%) stddev-sans-first:42.79 04:22:49 INFO - PROCESS | 5531 | Values: 77.0 76.0 77.0 168.0 77.0 77.0 76.0 75.0 178.0 75.0 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | [#4] audio-oscillator Cycles:10 Average:101.10 Median:85.00 stddev:25.55 (30.1%) stddev-sans-first:26.51 04:22:49 INFO - PROCESS | 5531 | Values: 86.0 85.0 136.0 86.0 86.0 85.0 135.0 84.0 85.0 143.0 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 04:22:49 INFO - PROCESS | 5531 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 119.0 118.0 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 04:22:49 INFO - PROCESS | 5531 | Values: 148.0 149.0 148.0 149.0 149.0 150.0 147.0 148.0 148.0 148.0 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:22:49 INFO - PROCESS | 5531 | Values: 96.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 04:22:49 INFO - PROCESS | 5531 | Values: 65.0 66.0 66.0 66.0 67.0 66.0 67.0 66.0 65.0 66.0 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 04:22:49 INFO - PROCESS | 5531 | Values: 66.0 67.0 65.0 66.0 67.0 66.0 66.0 65.0 66.0 65.0 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:3.62 (4.5%) stddev-sans-first:3.75 04:22:49 INFO - PROCESS | 5531 | Values: 79.0 89.0 81.0 81.0 78.0 78.0 79.0 85.0 84.0 79.0 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:135.50 stddev:12.71 (9.4%) stddev-sans-first:13.28 04:22:49 INFO - PROCESS | 5531 | Values: 132.0 129.0 133.0 138.0 133.0 146.0 131.0 140.0 171.0 129.0 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:170.50 stddev:4.22 (2.5%) stddev-sans-first:4.38 04:22:49 INFO - PROCESS | 5531 | Values: 167.0 171.0 170.0 174.0 164.0 174.0 168.0 176.0 164.0 167.0 04:22:49 INFO - PROCESS | 5531 | 04:22:49 INFO - PROCESS | 5531 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.14 (1.7%) stddev-sans-first:0.88 04:22:49 INFO - PROCESS | 5531 | Values: 70.0 69.0 68.0 68.0 68.0 67.0 66.0 67.0 67.0 68.0 04:22:49 INFO - PROCESS | 5531 | -------- Summary: end -------- 04:22:49 INFO - PROCESS | 5531 | 04:22:50 INFO - TEST-INFO | 5531: exit 0 04:22:50 INFO - TEST-OK | kraken | took 64191ms 04:22:50 INFO - SUITE-END | took 1180s 04:22:50 INFO - Completed test suite (00:19:40) 04:22:50 INFO - javascript benchmark 04:22:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6360.98430443748, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2607.8174527783053, 2662.334416395901, 2681.343070947617, 2684.087410280504, 2689.6503454550893, 4739.597134243589, 4761.309610106537, 4794.0, 4816.109019831325, 4903.534164254399, 4607.331936869152, 4802.303665968432, 4805.1831188697915, 4823.155947709146, 4834.178189707749, 4349.804258808361, 4402.889927751816, 4443.688941774077, 4481.551844815525, 4519.0961807638605, 606.2197727277857, 4309.4397728295435, 4309.978450107745, 4335.978320108395, 4445.02209513908, 4315.50371707253, 4348.326009468537, 4353.978230108829, 4363.1273745250755, 4377.890552736175, 4340.110277393127, 4366.19225443294, 4379.496357918848, 4383.3863259143745, 4419.911601767979, 4304.182205380999, 4337.761423121727, 4378.43080399546, 4398.582134697199, 4424.446944131983, 4751.619870410394, 4787.2101103318255, 4811.446683631392, 4812.326274321563, 4901.313816065754, 5204.557612602934, 5214.713190774506, 5215.348081489814, 5218.243354713583, 5267.0, 5025.572826309768, 5069.721165335905, 5095.694258344512, 5095.79616815327, 5112.105381558213, 4835.057163853015, 4864.975675121602, 4876.951230487721, 4885.5358740919555, 4926.113299606105, 5093.745312734349, 5277.23480095384, 5343.225232341289, 5347.919781203285, 5352.464753524617, 5105.15764898795, 5112.36095488064, 5141.742912854343, 5145.845624631267, 5190.92213616796, 5227.111391063529, 5229.686218826882, 5230.529252367305, 5232.581393488512, 5305.734713264398, 4940.308356830046, 5087.87280317995, 5148.304978827885, 5165.66423182492, 5175.094358487325, 5122.282880396748, 5153.252778347193, 5155.484451554889, 5158.200478925773, 5196.038732834438, 4314.80583373749, 4320.071184695305, 4321.632661223831, 4354.303311470213, 4370.994671225572, 3716.108134047809, 3720.776753394751, 3747.8126093695205, 3779.433085037266, 3793.791341476245, 4405.964598319392, 4466.129104824593, 4483.641308695296, 4502.729836209838, 4556.498785133633, 5219.869503262373, 5227.712475813867, 5229.189475631283, 5237.816676416307, 5270.130428479258, 4318.1363727254675, 4393.077453734688, 4398.406215160976, 4398.626116780109, 4561.726296422159, 4507.459104907432, 4523.977380113144, 4529.8641040768825, 4572.7942242599165, 4574.0, 4785.408687250058, 4802.991371811959, 4808.711477311373, 4813.278008298783, 4853.684510506806, 5057.519535644108, 5093.388793344822, 5097.541221290102, 5150.845474635767, 5152.149895267239, 4898.559129678203, 4910.705357678551, 4915.975420122876, 4917.385326834145, 4962.057209130254, 5103.081445339726, 5128.640995130305, 5136.30659860929, 5146.099432599205, 5194.558462530727, 5135.0, 5151.7166555839785, 5190.429052804113, 5210.374755029269, 5234.738263086754, 5037.219231019198, 5037.823676171316, 5041.899162016813, 5061.898762024813, 5109.540141387293, 5029.748512574283, 5071.92392114126, 5081.7713202905215, 5090.516400941905, 5107.974460127675, 4851.417829860439, 4883.8290659826735, 4891.828785992473, 4900.191468407673, 4913.459519452786, 5020.42265139499, 5026.52248036436, 5037.546620803999, 5039.143345631325, 5087.669301495539, 4828.179209534317, 4914.778834952507, 4926.5073492650445, 4937.901241975069, 4956.677815941952], "value": 4694.947007262365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.3655917737481, 545.7216819422093, 548.8984537860496, 550.9999999999998, 579.8608333999841, 35896.820515897416, 40170.79914600423, 40195.79902100489, 40270.39594406086, 40295.39556906649, 39831.80084099583, 40159.39760903581, 40174.19651606966, 40404.59595404045, 40421.595784042154, 7727.150013498511, 7844.4901081429525, 7867.606619669023, 7872.937153484292, 7885.053793544783, 7832.21677832215, 7851.2933835954755, 7888.2506161914525, 7926.405519586054, 7935.365170786324, 7886.447948643598, 7914.485558438711, 7930.405219608552, 7931.484453510503, 7964.60176991151, 7822.647980840876, 7840.960795196016, 7874.448788584801, 7909.564973926432, 7916.445848790587, 7887.684492620288, 7910.564918929456, 7943.4836735612, 7961.681532738684, 7970.681172753083, 37732.81133594342, 38016.61983380186, 38355.808220958716, 38469.23061538753, 38573.614263857286, 2386.3556839653197, 2746.0, 2782.1375373634237, 2855.914322570326, 2869.5121829288864, 26128.86935565329, 27503.587446188325, 28207.71792282092, 28720.856395718096, 28954.0, 3114.1280441476197, 3126.937461250762, 3163.5254711793186, 3179.491281394966, 3186.9857296180026, 229642.0, 229958.0, 230173.0, 231127.8443607788, 231718.0, 31901.20246993844, 32398.514022289684, 32688.0, 32769.0, 32886.67113328884, 34030.319393611986, 34052.14869628279, 34085.31829363448, 34092.14769630729, 34286.31427371489, 13110.737785244242, 13296.0, 13305.201687898758, 13326.200427974352, 13385.0, 11201.0, 11334.773304533863, 11404.714882128013, 11446.828297575543, 11658.76682466363, 7888.211178882066, 7949.682012719427, 7951.5626640534165, 7977.282044616012, 8056.234657707509, 3033.9696603034126, 3097.504399296102, 3103.5189545620465, 3103.7672174586546, 3108.3006323577015, 871.6208449324438, 884.6594061286451, 920.6685593186447, 985.5663508056432, 1019.6227395863579, 27640.58539121915, 28076.0, 28728.569071463946, 29008.12975610735, 29023.0, 946.5125460387906, 1001.8146642871092, 1003.6236411345745, 1050.1283934334638, 1063.9361638301727, 14786.63033424173, 14999.2500374983, 15164.772528412082, 15450.459233926758, 15640.4525841595, 293622.0, 397626.0, 400745.0, 402695.0, 404481.0, 51542.22686659703, 51732.74133629383, 51766.48233517692, 51968.0, 52182.47817521852, 1190.7975644140517, 1210.442683297386, 1213.2659740856832, 1230.7600017996406, 1254.0782524844233, 27803.721962780113, 29891.850540747157, 29976.0, 30201.697983019887, 30684.84657576698, 43274.0, 43303.566964331214, 43765.562344377424, 43970.560294396644, 44185.0, 357728.0, 359388.0, 364476.0, 366434.0, 366952.0, 25200.0, 25510.107146250535, 25584.616230756925, 25854.0, 25887.870560647076, 42812.0, 42936.78531607447, 43351.78324108359, 43610.0, 43885.56114438815, 37230.627693722716, 37261.0, 37493.81253093717, 37780.81109594544, 38594.2281154381, 37501.62498374981, 37548.0, 37729.62270377371, 37767.0, 37982.81008594939, 31723.682763172073, 36104.27791444209, 36579.634203657624, 36619.267614647026, 37005.444918326786, 32257.677423226407, 33868.70216796901, 34141.829290853384, 34606.30787384289, 34872.47691284683, 26099.73900260973, 26114.86942565275, 26235.21294361172, 26313.868430657723, 26817.195484135507], "value": 16405.549395302354, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.51224383813377, 377.1852797956414, 381.8415357626585, 388.7511992324911, 393.2901113490151, 16459.588510287234, 16857.662846743075, 17681.911590442047, 17705.380311689092, 18179.45461636153, 10058.0, 10393.48032598369, 10427.270091093607, 10489.895101048987, 10527.68416947491, 4671.509491503386, 4757.357756702852, 4822.324874517571, 4826.348442960208, 4860.441049279325, 4703.6237101032, 4707.646926480511, 4712.481627021025, 4746.715197088186, 4823.42118945727, 4803.78382972767, 4813.422389313288, 4819.51804819517, 4945.9258111128365, 5200.661956972804, 5026.97486512567, 5135.691858488484, 5136.948630513684, 5154.664946778485, 5177.275181474596, 4537.659675524349, 4595.793189306489, 4633.49031606523, 4638.095571363586, 4646.86059418218, 20449.591008179752, 20654.07056682453, 21172.0, 21260.574788504142, 21541.78458215429, 1823.534998575368, 1954.6872500399868, 1982.137770070024, 2234.173355858343, 2273.238465114189, 9114.58984345706, 9123.498207598579, 9241.815163696756, 10213.540390682363, 12610.243385396814, 1707.5474999125242, 1711.9486415407432, 1726.8100508944005, 1741.3731056819536, 1778.310006736015, 70668.6466567669, 72398.63800680963, 73234.0, 73392.2660773396, 73768.26231737668, 9878.259130565093, 10001.34991225568, 10053.648122315684, 10248.436336001592, 10513.789724205473, 13661.521846735317, 13837.792433113511, 13869.445222191202, 13927.303634818218, 13957.511487097903, 7486.700531978769, 7499.962500187464, 7614.961925190339, 7620.809479762939, 7633.770986870402, 7229.783106506813, 7245.601491917995, 7411.370033547209, 7460.179380268275, 7507.361874240751, 4193.748375097504, 4313.374560688682, 4316.805743741539, 4418.403515525427, 4484.327350897326, 1674.7641898066217, 1745.9388921387945, 1765.7792775903013, 1769.4514700442646, 1778.2442461953617, 824.0358780227149, 863.4128792421088, 882.911708829112, 913.5706218077493, 940.5579377692474, 17075.658486830194, 17288.308467661405, 17350.219240134225, 17634.735478967825, 17718.557036074202, 817.6729308276618, 870.9085546017703, 888.2139306713605, 890.4034297021011, 941.6892425499568, 9439.150476457015, 9449.055094490495, 9693.41839489633, 9710.611575537041, 9761.609535618496, 372935.0, 383936.0, 384502.0, 385336.0, 401822.0, 82409.58795205985, 82499.0, 82609.58695206486, 83230.16769832224, 83767.5811620938, 907.2469850024464, 926.0600490502146, 942.3591957468986, 948.3172116076414, 954.4893481986965, 15733.685326293182, 15946.521604351889, 16005.279762410486, 16122.596935076717, 16154.353825846834, 39449.40825887671, 39495.0, 40141.1971760569, 40506.79746601248, 41581.58418415898, 54836.451635483136, 56604.0, 57537.42462575321, 58576.12135817881, 59577.10634340575, 7266.7093316266755, 7824.84350313002, 7890.84218315619, 8134.552599606842, 8160.000799804086, 11140.944295278472, 12235.571754988889, 12296.262224266573, 12463.750724985268, 12652.304123273309, 9871.901280987098, 10060.49697515136, 10269.127124194229, 10853.728656783644, 10883.619073332395, 10055.446950417798, 10321.174306055347, 10368.170546356123, 10537.57849686004, 10540.209484288556, 10117.291789574954, 10825.945870270598, 10839.13286937059, 11018.669439916495, 11189.608363707557, 7458.627068646654, 7556.055493063367, 7580.658870350958, 7640.617969101634, 7738.806529836799, 8792.956035219782, 9499.335046546676, 9991.700248992542, 10197.13324367437, 10371.170306375321], "value": 8175.14520685507, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.4014293925081, 1438.2089850582179, 1466.633341664584, 1560.8985415947955, 1562.281350578733, 6942.895856562156, 7713.884291735621, 7782.066152061746, 8220.054693710224, 8246.051704054029, 7837.098733645633, 8045.235702608257, 8128.715494957678, 8132.105468398487, 8138.959305203481, 2208.7791220877903, 2231.2971414004537, 2231.475603233239, 2242.3497185816095, 2247.3033359658475, 2177.7168968034134, 2179.6621523663857, 2258.6950761647213, 2281.1103669568884, 2284.463151159476, 2165.65349544073, 2168.251953076186, 2170.6852506386645, 2206.6028114939304, 2246.618074927258, 2196.143504033428, 2199.285232299501, 2210.7568167501563, 2213.9815684785017, 2215.7341119065654, 2157.6871353653787, 2166.2418153646254, 2166.7833216678364, 2179.814715749163, 2179.9891000545053, 8106.0, 8116.35069194463, 8188.631511581993, 8191.0, 8217.876731849026, 4692.577668009862, 4828.49300823412, 4831.130396528623, 4842.564169224786, 4846.151923413388, 2837.917344421316, 2976.0, 2986.656534498539, 2991.925201869949, 2998.3553535989868, 893.8837951066384, 918.4810582021137, 931.0, 936.0, 947.8578213267996, 10874.836877446845, 10948.671539853816, 10954.068904143158, 10981.725456863642, 10990.780184396268, 4094.63148316647, 4318.892027699269, 4319.265724826787, 4379.4525684289465, 4386.363977223348, 9328.533573321307, 9334.346595738232, 9395.624175032923, 9417.246620270362, 9458.85811712825, 4827.662063655511, 4831.541003604652, 4843.07981483517, 4849.927251091236, 4862.294967229732, 3842.135519508144, 4201.516825565038, 4343.782810859444, 4421.115776844644, 4430.379746835446, 3736.439534069911, 3789.450529673182, 3824.0, 3846.9807650962125, 3887.552931412867, 1221.4259298129864, 1257.3775980889518, 1283.5700040486354, 1297.5523444411663, 1299.4737131461773, 790.1742678900563, 811.7321283976273, 832.317499650281, 834.7662654456761, 866.8179682266668, 5402.567794576425, 5429.294191755047, 5484.890302193934, 5542.501174894279, 5581.246531718247, 411.6624368018256, 412.8885200995774, 416.73953778888193, 422.391755871544, 430.7372502773306, 3650.963490365062, 3690.2988432197794, 3700.611435799256, 3707.796071216109, 3740.1023754299317, 9700.466474343837, 9992.700218993441, 9995.80008399828, 10050.949745251228, 10052.095311421861, 9884.406935583887, 9922.553485093189, 9940.80118397628, 9987.60049598008, 9998.550065247082, 7514.4364172687265, 7520.1351844537485, 7555.055618047744, 7559.677056515088, 7577.886331705029, 5564.1931919870585, 5574.108142697149, 5724.79963201286, 5779.595428320145, 5790.747500396742, 8914.910850891409, 9027.4132181408, 9041.276697864287, 9106.772330691521, 9134.634614615341, 8842.91157088421, 9188.632454701738, 9264.39781414206, 9281.02549232321, 9301.162895339452, 6056.454919057306, 6756.662166891538, 6942.791716248521, 6952.652367381509, 7116.395106416013, 7881.527108373287, 7897.605119743875, 7898.486598371088, 7944.801379965547, 7947.483413578099, 6733.0, 6956.513044086865, 6979.0, 7014.614196219053, 7033.648317583998, 6964.4080253179045, 7052.576845389293, 7079.29207079288, 7165.928340716526, 7191.748288809867, 6555.3772391622715, 6605.702743376656, 6660.766873159416, 6688.0, 6717.496187786033, 4782.593479554277, 4875.293082503088, 4881.682690625098, 4885.462599114024, 4939.975300123477, 4797.016611594685, 4805.975970120127, 4888.877778055577, 4940.086084074458, 4987.625928055338], "value": 4185.077320265377, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.0520051436945, 304.50517908398854, 308.48483033334327, 313.1435523842292, 315.08624987536143, 4980.526849949258, 4987.226979818125, 5131.794728210872, 5180.326557547518, 5205.427402985673, 5021.347224860763, 5024.623153263502, 5038.7984480620735, 5040.269160971657, 5047.64666473347, 3989.481367422231, 3993.341098718708, 4002.75983440993, 4003.359462486003, 4016.4577781999496, 3945.664618507416, 4011.418344340069, 4014.2974979378637, 4018.4775979122674, 4041.898952526181, 3908.9804550977206, 3964.9008774780573, 3965.9801700991597, 3969.6625786808154, 3985.322495175827, 3943.7239393242485, 3944.5660977292473, 3955.3671412573995, 3981.3828856527284, 3989.1024519482885, 3535.1515636247113, 3535.6287589803214, 3538.115471132217, 3541.982290088533, 3565.3047655707146, 4912.929419113055, 4981.160738379125, 5017.34774479319, 5020.899582008376, 5083.974580127076, 4509.489321077443, 4552.180607490651, 4572.565606267399, 4579.519150489217, 4585.541445855421, 5361.410244873061, 5367.651102678314, 5373.775734559273, 5380.973095134538, 5404.729763511848, 3744.9812750936344, 3830.865919692825, 3832.559255685604, 3836.9232615347537, 3868.916703323046, 5542.528885044776, 5555.972220138914, 5603.579731520153, 5623.8594035149035, 5648.265725455705, 3938.1729836734035, 3954.60453954608, 3955.110100227483, 3958.8218530166214, 3960.386140148282, 3816.38937769961, 4007.238624661305, 4018.2566225248424, 4019.8995025124605, 4026.4362989181536, 4517.277235642281, 4527.3435351873795, 4537.705049171794, 4540.659450541222, 4560.293154561048, 5320.973395133077, 5334.1732031535175, 5367.570594352443, 5391.32608423947, 5402.676344295594, 1286.350393051503, 1349.5546469664987, 1374.4639590559689, 1376.6351916742071, 1379.5516457151266, 930.3394589841289, 951.6526467839188, 956.8947415784259, 960.1358777100526, 965.9903400966041, 4610.74640894754, 4681.344611754357, 4683.227267500824, 4692.976535117303, 4710.905781884343, 5424.810131645373, 5430.51125398716, 5449.427810079885, 5506.449355064461, 5507.127576623887, 4495.955040449554, 4648.2562789953445, 4666.160091183551, 4668.97665511677, 4680.134175177603, 2903.941921161565, 2924.8683809228637, 2933.120063980797, 2941.6175897133235, 2943.2641839540115, 5109.540141387293, 5191.428942816287, 5212.635115541952, 5214.32213812202, 5214.947850521522, 5423.755930983115, 5613.372122084631, 5632.8313599264575, 5647.830565083054, 5650.180723795027, 5176.7411629418375, 5182.0, 5197.8440646780655, 5208.348956380452, 5249.370075590801, 5519.806806761744, 5538.501534861882, 5542.2795036644975, 5542.944570554243, 5574.86062848432, 5266.657667251617, 5397.190421436659, 5401.405845356929, 5405.972970135282, 5417.322834645669, 5178.922316165336, 5181.896362072813, 5193.428722840409, 5200.5438477226435, 5249.921251181159, 3868.96131038686, 3894.1822217334675, 3895.8636447724193, 3899.337112690906, 3908.785016824102, 5202.167653175474, 5319.175527793198, 5346.823698786261, 5436.852443284959, 5462.754176062166, 5312.282841816305, 5317.8404647860625, 5358.651687640291, 5360.8742164144405, 5381.67709937405, 5300.628955973045, 5345.144776835843, 5349.893002140013, 5363.490468405495, 5381.381141168816, 5178.611604129781, 5256.421793602624, 5256.710880901587, 5257.185136303879, 5276.208568714724, 5343.9732801337295, 5406.324209473816, 5422.529581068198, 5437.40188579248, 5444.727763611724, 5311.41574426805, 5316.521513063843, 5322.760475778522, 5346.224797404277, 5349.652272602269], "value": 4038.9613436444374, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.9309275979645, 635.7298148286977, 639.2233436374804, 725.9981225908246, 732.6666366803105, 10718.624848130317, 11752.001079908217, 11752.588659396923, 11756.7648647027, 11782.646520604396, 13028.544000959968, 13772.586822395344, 14400.71198576028, 14476.348564314605, 15227.086374817518, 612.2958597612759, 751.7556794041931, 764.2281295891162, 774.4269240761823, 778.8169780101672, 776.848514539665, 793.6904607203167, 794.3962588432804, 796.4783067091035, 796.625585974591, 834.870595057767, 835.6824406725436, 836.3225787112428, 836.6695155413609, 837.6063250272392, 826.9297109745679, 828.4076885027174, 828.7430896422098, 829.1004260377498, 829.3613917283687, 604.8276241271217, 607.1378642327905, 607.8996965500687, 608.2609629300421, 609.7347653770624, 13623.795643065361, 13635.590932272047, 13772.0, 13775.173489590657, 13831.654208644864, 13224.86775132246, 13395.531156409479, 13632.863671363259, 13646.0, 13688.178709277476, 9278.907210927871, 9315.487648179347, 9433.0, 9500.23998080152, 9563.713088607354, 3190.218396492851, 3259.9022029339158, 3280.2455435249785, 3280.5243239730344, 3282.983585082083, 67696.0, 68503.31496685019, 68714.31285687129, 69503.30496695019, 70329.2967070333, 9913.206943444507, 10353.4305613192, 10493.52779124926, 10594.523246453928, 10666.839997400046, 18756.437306880816, 18920.33778817735, 18921.337753178846, 19109.23563057462, 19168.520786980436, 7073.61095139762, 7114.0, 7121.537100088478, 7129.821754456077, 7177.461690373243, 3558.1638314995957, 3570.3751843427294, 3572.1248294167576, 3724.7578907370935, 3879.2047630235734, 2689.9731002690114, 2827.5720761015555, 2830.5754136879223, 2831.66020077592, 2833.5324671429394, 444.16718652526515, 445.43652279865995, 450.4706969311112, 479.6115146731159, 481.4992407895749, 459.60244388603616, 460.1234647995574, 530.3953493017963, 530.4456842599493, 562.8030189433665, 7488.213737557587, 7573.2805383488485, 7673.424493163036, 7943.404244681672, 8008.119106898236, 496.50845662794296, 523.0611053159588, 527.9768166570756, 541.7155993103652, 565.7143142712904, 3592.9820350898076, 3770.434434834797, 3801.2777572261184, 3803.2013277212095, 3887.61123887609, 93720.0, 93740.53129734307, 95071.52464237635, 97272.51363743277, 97935.0, 47532.28701569479, 59478.0, 79746.0, 82453.58773206096, 84949.15050849535, 73565.63217183879, 74829.6258518704, 75042.24957750461, 77376.0, 77954.61022694963, 7171.1753148386515, 7195.892061618975, 7197.0, 7488.925110748823, 7519.060117485315, 45044.32433513434, 45161.87095322643, 45615.0, 46567.534324657674, 47051.52948470471, 57584.42415575791, 65051.67474162599, 65230.347696522425, 66817.33182668306, 67703.32296677167, 9311.76720581991, 9436.150746432853, 9545.570449329658, 9635.084666956627, 9849.162821159995, 9955.50222488887, 10510.632127875488, 10954.616588419367, 11185.384803835866, 11217.332725723863, 8785.824283514166, 8854.424462409923, 8901.243394311556, 8981.775455613662, 9110.817783644157, 9272.72181834546, 9377.249820014518, 9430.056994300516, 9465.526723663652, 9510.61957521719, 9139.588718507815, 9163.26693864476, 9294.953525232331, 9338.766530836783, 9697.0, 8342.207490288412, 8605.311575073854, 8643.956780216058, 8702.47785132894, 8807.119288071142, 8663.176998185163, 8890.151175421535, 8912.598933048159, 8938.68714594986, 8943.821123577362], "value": 6223.178957059125, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 107.0, 113.0, 112.0, 115.0, 114.0, 113.0, 115.0, 114.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 122.0, 155.0, 181.0, 129.0, 160.0, 152.0, 125.0, 181.0, 122.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 164.0, 173.0, 164.0, 160.0, 164.0, 163.0, 164.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 168.0, 77.0, 77.0, 76.0, 75.0, 178.0, 75.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 136.0, 86.0, 86.0, 85.0, 135.0, 84.0, 85.0, 143.0], "value": 101.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 119.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 149.0, 149.0, 150.0, 147.0, 148.0, 148.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 65.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 67.0, 66.0, 66.0, 65.0, 66.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 89.0, 81.0, 81.0, 78.0, 78.0, 79.0, 85.0, 84.0, 79.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 129.0, 133.0, 138.0, 133.0, 146.0, 131.0, 140.0, 171.0, 129.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 170.0, 174.0, 164.0, 174.0, 168.0, 176.0, 164.0, 167.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 68.0, 68.0, 67.0, 66.0, 67.0, 67.0, 68.0], "value": 67.8, "unit": "score"}]}]} 04:22:50 INFO - Return code: 0 04:22:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:22:50 ERROR - # TBPL SUCCESS # 04:22:50 INFO - Running post-action listener: _resource_record_post_action 04:22:50 INFO - ##### 04:22:50 INFO - ##### Finished run-tests step (success) 04:22:50 INFO - ##### 04:22:50 INFO - Running post-run listener: _resource_record_post_run 04:22:51 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 671744; Write bytes: 286433280; Read time: 236; Write time: 224456 04:22:51 INFO - TinderboxPrint: CPU usage
13.3% 04:22:51 INFO - TinderboxPrint: I/O read bytes / time
671,744 / 236 04:22:51 INFO - TinderboxPrint: I/O write bytes / time
286,433,280 / 224,456 04:22:51 INFO - TinderboxPrint: CPU idle
8,280.0 (86.7%) 04:22:51 INFO - TinderboxPrint: CPU user
1,218.7 (12.8%) 04:22:51 INFO - TinderboxPrint: Swap in / out
0 / 0 04:22:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1363968; Read time: 0; Write time: 84 04:22:51 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 667648; Write bytes: 285069312; Read time: 216; Write time: 224372 04:22:51 INFO - Running post-run listener: _upload_blobber_files 04:22:51 INFO - Blob upload gear active. 04:22:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:22:51 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:22:51 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:22:51 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:22:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:22:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:22:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:22:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:56 INFO - (blobuploader) - INFO - Done attempting. 04:22:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:22:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:22:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:56 INFO - (blobuploader) - INFO - Done attempting. 04:22:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:22:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:22:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:57 INFO - (blobuploader) - INFO - Done attempting. 04:22:57 INFO - (blobuploader) - INFO - Iteration through files over. 04:22:57 INFO - Return code: 0 04:22:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:22:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:22:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5fc1bb32d3b8e32207b3829afe302361afcbc8a2b12c4fa7c925b2730554c9c70f3607a99198b0ccaff4af562b172f646a28293e342e9e12df4eab74a7f22f90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81df50c57ea9dbd27b32ad7027756df88f2ea285c318330ded9842b0896eee12ee90640daca8804d5432d9292af9b3a92e10e121443981bc2f6a3ca3fe2ef229", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6a08008d19dc25709a093918613de2a685ce1e43c25877e92d3684a2c53eaf3056d70672378faa5c73a5dbfc2ad4ccdb6288f378b690b81bf31c161a7c6e317"} 04:22:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:22:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:22:57 INFO - Contents: 04:22:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5fc1bb32d3b8e32207b3829afe302361afcbc8a2b12c4fa7c925b2730554c9c70f3607a99198b0ccaff4af562b172f646a28293e342e9e12df4eab74a7f22f90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81df50c57ea9dbd27b32ad7027756df88f2ea285c318330ded9842b0896eee12ee90640daca8804d5432d9292af9b3a92e10e121443981bc2f6a3ca3fe2ef229", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6a08008d19dc25709a093918613de2a685ce1e43c25877e92d3684a2c53eaf3056d70672378faa5c73a5dbfc2ad4ccdb6288f378b690b81bf31c161a7c6e317"} 04:22:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:22:57 INFO - Copying logs to upload dir... 04:22:57 INFO - mkdir: /builds/slave/test/build/upload/logs 04:22:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.522182 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-14 04:22:57.630491) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 04:22:57.634161) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696 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/5fc1bb32d3b8e32207b3829afe302361afcbc8a2b12c4fa7c925b2730554c9c70f3607a99198b0ccaff4af562b172f646a28293e342e9e12df4eab74a7f22f90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81df50c57ea9dbd27b32ad7027756df88f2ea285c318330ded9842b0896eee12ee90640daca8804d5432d9292af9b3a92e10e121443981bc2f6a3ca3fe2ef229", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6a08008d19dc25709a093918613de2a685ce1e43c25877e92d3684a2c53eaf3056d70672378faa5c73a5dbfc2ad4ccdb6288f378b690b81bf31c161a7c6e317"} build_url:https://queue.taskcluster.net/v1/task/Nh1DOghQRVa7p-oozJwavg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/Nh1DOghQRVa7p-oozJwavg/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/5fc1bb32d3b8e32207b3829afe302361afcbc8a2b12c4fa7c925b2730554c9c70f3607a99198b0ccaff4af562b172f646a28293e342e9e12df4eab74a7f22f90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81df50c57ea9dbd27b32ad7027756df88f2ea285c318330ded9842b0896eee12ee90640daca8804d5432d9292af9b3a92e10e121443981bc2f6a3ca3fe2ef229", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6a08008d19dc25709a093918613de2a685ce1e43c25877e92d3684a2c53eaf3056d70672378faa5c73a5dbfc2ad4ccdb6288f378b690b81bf31c161a7c6e317"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 04:22:57.662341) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 04:22:57.662844) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468494136.553743-1220797696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 04:22:57.743672) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 04:22:57.744004) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 04:22:57.744340) ========= ========= Total master_lag: 0.17 =========