builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-069 starttime: 1468859714.63 results: success (0) buildid: 20160718080853 builduid: e8d7db434dfb4e04a16936b3b1a2a1a1 revision: cde56ead650fd302be1d440507485b9abf7c163a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 09:35:14.632012) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 09:35:14.632439) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 09:35:14.632750) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 09:35:14.661900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 09:35:14.662199) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 09:35:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.5M=0s 2016-07-18 09:35:16 (70.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101414 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 09:35:14.777682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 09:35:14.778007) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014230 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 09:35:14.830264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 09:35:14.830660) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cde56ead650fd302be1d440507485b9abf7c163a --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 cde56ead650fd302be1d440507485b9abf7c163a --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=05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 09:35:16,585 truncating revision to first 12 chars 2016-07-18 09:35:16,585 Setting DEBUG logging. 2016-07-18 09:35:16,585 attempt 1/10 2016-07-18 09:35:16,585 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cde56ead650f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 09:35:16,879 unpacking tar archive at: mozilla-central-cde56ead650f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628673 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 09:35:15.473403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 09:35:15.473741) ========= script_repo_revision: cde56ead650fd302be1d440507485b9abf7c163a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 09:35:15.474201) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 09:35:15.474528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 09:35:15.488731) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-18 09:35:15.489075) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:35:17 INFO - MultiFileLogger online at 20160718 09:35:17 in /builds/slave/test 09:35:17 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 09:35:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:35:17 INFO - {'append_to_log': False, 09:35:17 INFO - 'base_work_dir': '/builds/slave/test', 09:35:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:35:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:35:17 INFO - 'branch': 'Firefox-Non-PGO', 09:35:17 INFO - 'buildbot_json_path': 'buildprops.json', 09:35:17 INFO - 'config_files': ('talos/linux_config.py',), 09:35:17 INFO - 'default_actions': ('clobber', 09:35:17 INFO - 'read-buildbot-config', 09:35:17 INFO - 'download-and-extract', 09:35:17 INFO - 'populate-webroot', 09:35:17 INFO - 'create-virtualenv', 09:35:17 INFO - 'install', 09:35:17 INFO - 'run-tests'), 09:35:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:35:17 INFO - 'download_minidump_stackwalk': True, 09:35:17 INFO - 'download_symbols': 'ondemand', 09:35:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:35:17 INFO - 'tooltool.py': '/tools/tooltool.py', 09:35:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:35:17 INFO - '/tools/misc-python/virtualenv.py')}, 09:35:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:35:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:35:17 INFO - 'installer_path': 'installer.exe', 09:35:17 INFO - 'log_level': 'info', 09:35:17 INFO - 'log_name': 'talos', 09:35:17 INFO - 'log_to_console': True, 09:35:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:35:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:35:17 INFO - 'opt_config_files': (), 09:35:17 INFO - 'pip_index': False, 09:35:17 INFO - 'sps_profile': False, 09:35:17 INFO - 'sps_profile_interval': 0, 09:35:17 INFO - 'suite': 'dromaeojs-e10s', 09:35:17 INFO - 'system_bits': '32', 09:35:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:35:17 INFO - 'title': 'talos-linux64-ix-069', 09:35:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:35:17 INFO - 'use_talos_json': True, 09:35:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:35:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:35:17 INFO - 'work_dir': 'build'} 09:35:17 INFO - ##### 09:35:17 INFO - ##### Running clobber step. 09:35:17 INFO - ##### 09:35:17 INFO - Running pre-action listener: _resource_record_pre_action 09:35:17 INFO - Running main action method: clobber 09:35:17 INFO - rmtree: /builds/slave/test/build 09:35:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:35:17 INFO - Running post-action listener: _resource_record_post_action 09:35:17 INFO - ##### 09:35:17 INFO - ##### Finished clobber step (success) 09:35:17 INFO - ##### 09:35:17 INFO - ##### 09:35:17 INFO - ##### Running read-buildbot-config step. 09:35:17 INFO - ##### 09:35:17 INFO - Running pre-action listener: _resource_record_pre_action 09:35:17 INFO - Running main action method: read_buildbot_config 09:35:17 INFO - Using buildbot properties: 09:35:17 INFO - { 09:35:17 INFO - "project": "", 09:35:17 INFO - "product": "firefox", 09:35:17 INFO - "script_repo_revision": "production", 09:35:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:35:17 INFO - "repository": "", 09:35:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:35:17 INFO - "buildid": "20160718080853", 09:35:17 INFO - "pgo_build": "False", 09:35:17 INFO - "basedir": "/builds/slave/test", 09:35:17 INFO - "buildnumber": 132, 09:35:17 INFO - "slavename": "talos-linux64-ix-069", 09:35:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:35:17 INFO - "platform": "ubuntu64_hw", 09:35:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:35:17 INFO - "branch": "mozilla-central", 09:35:17 INFO - "repo_path": "mozilla-central", 09:35:17 INFO - "revision": "cde56ead650fd302be1d440507485b9abf7c163a", 09:35:17 INFO - "stage_platform": "linux64", 09:35:17 INFO - "builduid": "e8d7db434dfb4e04a16936b3b1a2a1a1", 09:35:17 INFO - "slavebuilddir": "test" 09:35:17 INFO - } 09:35:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:35:17 INFO - Running post-action listener: _resource_record_post_action 09:35:17 INFO - ##### 09:35:17 INFO - ##### Finished read-buildbot-config step (success) 09:35:17 INFO - ##### 09:35:17 INFO - ##### 09:35:17 INFO - ##### Running download-and-extract step. 09:35:17 INFO - ##### 09:35:17 INFO - Running pre-action listener: _resource_record_pre_action 09:35:17 INFO - Running main action method: download_and_extract 09:35:17 INFO - mkdir: /builds/slave/test/build/tests 09:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:17 INFO - https://queue.taskcluster.net/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:35:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:35:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:35:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/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 09:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/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 09:35:21 INFO - Downloaded 1361 bytes. 09:35:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:35:22 INFO - Using the following test package requirements: 09:35:22 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:35:22 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:35:22 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:35:22 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:22 INFO - u'jsshell-linux-x86_64.zip'], 09:35:22 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:35:22 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:35:22 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:35:22 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:35:22 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:35:22 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:35:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:35: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')]} 09:35:22 INFO - https://queue.taskcluster.net/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:35:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:35:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:35:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/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 09:35:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/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 09:35:23 INFO - Downloaded 22763283 bytes. 09:35: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'] 09:35: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 09:35:24 INFO - Return code: 0 09:35:24 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 09:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:24 INFO - https://queue.taskcluster.net/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:35:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:35:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:35:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/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 09:35:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/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 09:35:28 INFO - Downloaded 22763283 bytes. 09:35:28 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'] 09:35:28 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 09:35:30 INFO - Return code: 0 09:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:30 INFO - https://queue.taskcluster.net/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:35:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:35:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:35:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/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 09:35:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/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 09:35:31 INFO - Downloaded 14403317 bytes. 09:35:31 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'] 09:35:31 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 09:35:32 INFO - Return code: 0 09:35: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')]} 09:35:32 INFO - https://queue.taskcluster.net/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:35:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:35:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:35:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/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 09:35:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLtqST64Q-C6nfqom2D68g/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 09:35:34 INFO - Downloaded 57128403 bytes. 09:35:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:35:34 INFO - mkdir: /builds/slave/test/properties 09:35:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:35:34 INFO - Writing to file /builds/slave/test/properties/build_url 09:35:34 INFO - Contents: 09:35:34 INFO - build_url:https://queue.taskcluster.net/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:35:35 INFO - Running post-action listener: _resource_record_post_action 09:35:35 INFO - Running post-action listener: set_extra_try_arguments 09:35:35 INFO - ##### 09:35:35 INFO - ##### Finished download-and-extract step (success) 09:35:35 INFO - ##### 09:35:35 INFO - ##### 09:35:35 INFO - ##### Running populate-webroot step. 09:35:35 INFO - ##### 09:35:35 INFO - Running pre-action listener: _resource_record_pre_action 09:35:35 INFO - Running main action method: populate_webroot 09:35:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:35:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:35:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:35:35 INFO - '--tppagecycles', 09:35:35 INFO - '7'], 09:35:35 INFO - 'tests': ['tsvgm']}}, 09:35:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:35:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:35:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:35:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:35:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:35:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:35:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:35 INFO - 'talos_options': ['--disable-e10s'], 09:35:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:35 INFO - 'talos_options': ['--disable-e10s'], 09:35:35 INFO - 'tests': ['damp', 'tps']}, 09:35:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:35 INFO - 'tests': ['damp', 'tps']}, 09:35:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:35:35 INFO - 'tests': ['dromaeo_dom']}, 09:35:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:35:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:35:35 INFO - 'tests': ['basic_compositor_video']}, 09:35:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:35:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:35:35 INFO - 'tests': ['a11yr', 09:35:35 INFO - 'ts_paint', 09:35:35 INFO - 'tpaint', 09:35:35 INFO - 'sessionrestore', 09:35:35 INFO - 'sessionrestore_no_auto_restore', 09:35:35 INFO - 'tabpaint']}, 09:35:35 INFO - 'other-e10s': {'tests': ['a11yr', 09:35:35 INFO - 'ts_paint', 09:35:35 INFO - 'tpaint', 09:35:35 INFO - 'sessionrestore', 09:35:35 INFO - 'sessionrestore_no_auto_restore', 09:35:35 INFO - 'tabpaint']}, 09:35:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:35:35 INFO - 'ts_paint', 09:35:35 INFO - 'tpaint', 09:35:35 INFO - 'sessionrestore', 09:35:35 INFO - 'sessionrestore_no_auto_restore', 09:35:35 INFO - 'tabpaint']}, 09:35:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:35:35 INFO - 'ts_paint', 09:35:35 INFO - 'tpaint', 09:35:35 INFO - 'sessionrestore', 09:35:35 INFO - 'sessionrestore_no_auto_restore', 09:35:35 INFO - 'tabpaint']}, 09:35:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:35:35 INFO - 'tests': ['a11yr', 09:35:35 INFO - 'ts_paint', 09:35:35 INFO - 'tpaint', 09:35:35 INFO - 'sessionrestore', 09:35:35 INFO - 'sessionrestore_no_auto_restore', 09:35:35 INFO - 'tabpaint']}, 09:35:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:35:35 INFO - 'tests': ['a11yr', 09:35:35 INFO - 'ts_paint', 09:35:35 INFO - 'tpaint', 09:35:35 INFO - 'sessionrestore', 09:35:35 INFO - 'sessionrestore_no_auto_restore', 09:35:35 INFO - 'tabpaint']}, 09:35:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:35:35 INFO - 'tests': ['tsvgx', 09:35:35 INFO - 'tsvgr_opacity', 09:35:35 INFO - 'tart', 09:35:35 INFO - 'tscrollx', 09:35:35 INFO - 'cart']}, 09:35:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:35:35 INFO - 'tsvgr_opacity', 09:35:35 INFO - 'tart', 09:35:35 INFO - 'tscrollx', 09:35:35 INFO - 'cart']}, 09:35:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:35 INFO - 'talos_options': ['--disable-e10s'], 09:35:35 INFO - 'tests': ['tp5o']}, 09:35:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:35 INFO - 'tests': ['tp5o']}, 09:35:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:35 INFO - 'talos_options': ['--disable-e10s', 09:35:35 INFO - '--xperf_path', 09:35:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:35 INFO - 'tests': ['tp5n']}, 09:35:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:35 INFO - 'talos_options': ['--xperf_path', 09:35:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:35 INFO - 'tests': ['tp5n']}}, 09:35:35 INFO - 'talos.zip': {'path': '', 09:35:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:35:35 INFO - Running post-action listener: _resource_record_post_action 09:35:35 INFO - ##### 09:35:35 INFO - ##### Finished populate-webroot step (success) 09:35:35 INFO - ##### 09:35:35 INFO - ##### 09:35:35 INFO - ##### Running create-virtualenv step. 09:35:35 INFO - ##### 09:35:35 INFO - Running pre-action listener: _resource_record_pre_action 09:35:35 INFO - Running main action method: create_virtualenv 09:35:35 INFO - Creating virtualenv /builds/slave/test/build/venv 09:35:35 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 09:35:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:35:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:35:35 INFO - Using real prefix '/usr' 09:35:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:35:35 INFO - Installing distribute.............................................................................................................................................................................................done. 09:35:37 INFO - Installing pip.................done. 09:35:37 INFO - Return code: 0 09:35:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:35: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')]} 09:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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')]} 09:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f570>, '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 0x2970470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', '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 09:35: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', 'pip>=1.5'] in /builds/slave/test/build 09:35: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 pip>=1.5 09:35:37 INFO - Using env: {'DISPLAY': ':0', 09:35:37 INFO - 'HOME': '/home/cltbld', 09:35:37 INFO - 'LANG': 'en_US.UTF-8', 09:35:37 INFO - 'LANGUAGE': 'en_US:en', 09:35:37 INFO - 'LOGNAME': 'cltbld', 09:35:37 INFO - 'MAIL': '/var/mail/cltbld', 09:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:37 INFO - 'MOZ_NO_REMOTE': '1', 09:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:37 INFO - 'NO_EM_RESTART': '1', 09:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:37 INFO - 'PWD': '/builds/slave/test', 09:35:37 INFO - 'SHELL': '/bin/bash', 09:35:37 INFO - 'SHLVL': '1', 09:35:37 INFO - 'TERM': 'linux', 09:35:37 INFO - 'TMOUT': '86400', 09:35:37 INFO - 'USER': 'cltbld', 09:35:37 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', 09:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:37 INFO - '_': '/tools/buildbot/bin/python'} 09:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:38 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 09:35:38 INFO - Cleaning up... 09:35:38 INFO - Return code: 0 09:35:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f570>, '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 0x2970470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', '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 09:35:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:35:38 INFO - Using env: {'DISPLAY': ':0', 09:35:38 INFO - 'HOME': '/home/cltbld', 09:35:38 INFO - 'LANG': 'en_US.UTF-8', 09:35:38 INFO - 'LANGUAGE': 'en_US:en', 09:35:38 INFO - 'LOGNAME': 'cltbld', 09:35:38 INFO - 'MAIL': '/var/mail/cltbld', 09:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:38 INFO - 'MOZ_NO_REMOTE': '1', 09:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:38 INFO - 'NO_EM_RESTART': '1', 09:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:38 INFO - 'PWD': '/builds/slave/test', 09:35:38 INFO - 'SHELL': '/bin/bash', 09:35:38 INFO - 'SHLVL': '1', 09:35:38 INFO - 'TERM': 'linux', 09:35:38 INFO - 'TMOUT': '86400', 09:35:38 INFO - 'USER': 'cltbld', 09:35:38 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', 09:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:38 INFO - '_': '/tools/buildbot/bin/python'} 09:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:38 INFO - Downloading/unpacking psutil>=3.1.1 09:35: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 09:35: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 09:35: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 09:35: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 09:35: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 09:35: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 09:35:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:35:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:40 INFO - Installing collected packages: psutil 09:35:40 INFO - Running setup.py install for psutil 09:35:40 INFO - building 'psutil._psutil_linux' extension 09:35:40 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 09:35:40 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 09:35:40 INFO - building 'psutil._psutil_posix' extension 09:35:40 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 09:35:40 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 09:35:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:40 INFO - Successfully installed psutil 09:35:40 INFO - Cleaning up... 09:35:40 INFO - Return code: 0 09:35:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f570>, '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 0x2970470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', '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 09:35:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:35:40 INFO - Using env: {'DISPLAY': ':0', 09:35:40 INFO - 'HOME': '/home/cltbld', 09:35:40 INFO - 'LANG': 'en_US.UTF-8', 09:35:40 INFO - 'LANGUAGE': 'en_US:en', 09:35:40 INFO - 'LOGNAME': 'cltbld', 09:35:40 INFO - 'MAIL': '/var/mail/cltbld', 09:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:40 INFO - 'MOZ_NO_REMOTE': '1', 09:35:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:40 INFO - 'NO_EM_RESTART': '1', 09:35:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:40 INFO - 'PWD': '/builds/slave/test', 09:35:40 INFO - 'SHELL': '/bin/bash', 09:35:40 INFO - 'SHLVL': '1', 09:35:40 INFO - 'TERM': 'linux', 09:35:40 INFO - 'TMOUT': '86400', 09:35:40 INFO - 'USER': 'cltbld', 09:35:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', 09:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:40 INFO - '_': '/tools/buildbot/bin/python'} 09:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:35: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 09:35: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 09:35: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 09:35: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 09:35: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 09:35: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 09:35:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:35:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:35:43 INFO - Installing collected packages: mozsystemmonitor 09:35:43 INFO - Running setup.py install for mozsystemmonitor 09:35:43 INFO - Successfully installed mozsystemmonitor 09:35:43 INFO - Cleaning up... 09:35:43 INFO - Return code: 0 09:35:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:35:43 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')]} 09:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:43 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')]} 09:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:43 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 0x26b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f570>, '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 0x2970470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', '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 09:35:43 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 09:35:43 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 09:35:43 INFO - Using env: {'DISPLAY': ':0', 09:35:43 INFO - 'HOME': '/home/cltbld', 09:35:43 INFO - 'LANG': 'en_US.UTF-8', 09:35:43 INFO - 'LANGUAGE': 'en_US:en', 09:35:43 INFO - 'LOGNAME': 'cltbld', 09:35:43 INFO - 'MAIL': '/var/mail/cltbld', 09:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:43 INFO - 'MOZ_NO_REMOTE': '1', 09:35:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:43 INFO - 'NO_EM_RESTART': '1', 09:35:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:43 INFO - 'PWD': '/builds/slave/test', 09:35:43 INFO - 'SHELL': '/bin/bash', 09:35:43 INFO - 'SHLVL': '1', 09:35:43 INFO - 'TERM': 'linux', 09:35:43 INFO - 'TMOUT': '86400', 09:35:43 INFO - 'USER': 'cltbld', 09:35:43 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', 09:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:43 INFO - '_': '/tools/buildbot/bin/python'} 09:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:43 INFO - Downloading/unpacking jsonschema==2.5.1 09:35:43 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 09:35:43 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 09:35:43 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 09:35:43 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 09:35:43 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 09:35:43 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 09:35:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:35:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:45 INFO - Downloading functools32-3.2.3-2.tar.gz 09:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:35:45 INFO - warning: no files found matching '*.txt' 09:35:45 INFO - no previously-included directories found matching 'build' 09:35:45 INFO - no previously-included directories found matching 'dist' 09:35:45 INFO - no previously-included directories found matching '.git*' 09:35:45 INFO - Installing collected packages: jsonschema, functools32 09:35:45 INFO - Running setup.py install for functools32 09:35:45 INFO - warning: no files found matching '*.txt' 09:35:45 INFO - no previously-included directories found matching 'build' 09:35:45 INFO - no previously-included directories found matching 'dist' 09:35:45 INFO - no previously-included directories found matching '.git*' 09:35:45 INFO - Successfully installed jsonschema functools32 09:35:45 INFO - Cleaning up... 09:35:45 INFO - Return code: 0 09:35:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:35: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')]} 09:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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')]} 09:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:45 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 0x26b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f570>, '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 0x2970470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', '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 09:35:45 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 09:35:45 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 09:35:45 INFO - Using env: {'DISPLAY': ':0', 09:35:45 INFO - 'HOME': '/home/cltbld', 09:35:45 INFO - 'LANG': 'en_US.UTF-8', 09:35:45 INFO - 'LANGUAGE': 'en_US:en', 09:35:45 INFO - 'LOGNAME': 'cltbld', 09:35:45 INFO - 'MAIL': '/var/mail/cltbld', 09:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:45 INFO - 'MOZ_NO_REMOTE': '1', 09:35:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:45 INFO - 'NO_EM_RESTART': '1', 09:35:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:45 INFO - 'PWD': '/builds/slave/test', 09:35:45 INFO - 'SHELL': '/bin/bash', 09:35:45 INFO - 'SHLVL': '1', 09:35:45 INFO - 'TERM': 'linux', 09:35:45 INFO - 'TMOUT': '86400', 09:35:45 INFO - 'USER': 'cltbld', 09:35:45 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', 09:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:45 INFO - '_': '/tools/buildbot/bin/python'} 09:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:45 INFO - Downloading/unpacking blobuploader==1.2.4 09:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:47 INFO - Downloading blobuploader-1.2.4.tar.gz 09:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:35:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:35:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:35:48 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 09:35:48 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 09:35:48 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 09:35:48 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 09:35:48 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 09:35:48 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 09:35:48 INFO - Downloading docopt-0.6.1.tar.gz 09:35:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:35:48 INFO - Installing collected packages: blobuploader, requests, docopt 09:35:48 INFO - Running setup.py install for blobuploader 09:35:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:35:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:35:48 INFO - Running setup.py install for requests 09:35:49 INFO - Running setup.py install for docopt 09:35:49 INFO - Successfully installed blobuploader requests docopt 09:35:49 INFO - Cleaning up... 09:35:49 INFO - Return code: 0 09:35:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:49 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 0x26b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f570>, '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 0x2970470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', '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 09:35:49 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 09:35:49 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 09:35:49 INFO - Using env: {'DISPLAY': ':0', 09:35:49 INFO - 'HOME': '/home/cltbld', 09:35:49 INFO - 'LANG': 'en_US.UTF-8', 09:35:49 INFO - 'LANGUAGE': 'en_US:en', 09:35:49 INFO - 'LOGNAME': 'cltbld', 09:35:49 INFO - 'MAIL': '/var/mail/cltbld', 09:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:49 INFO - 'MOZ_NO_REMOTE': '1', 09:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:49 INFO - 'NO_EM_RESTART': '1', 09:35:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:49 INFO - 'PWD': '/builds/slave/test', 09:35:49 INFO - 'SHELL': '/bin/bash', 09:35:49 INFO - 'SHLVL': '1', 09:35:49 INFO - 'TERM': 'linux', 09:35:49 INFO - 'TMOUT': '86400', 09:35:49 INFO - 'USER': 'cltbld', 09:35:49 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', 09:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:49 INFO - '_': '/tools/buildbot/bin/python'} 09:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:35:49 INFO - Running setup.py (path:/tmp/pip-ZxVTpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:35:49 INFO - Running setup.py (path:/tmp/pip-WDzAnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:35:49 INFO - Running setup.py (path:/tmp/pip-hZ1hPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:35:49 INFO - Running setup.py (path:/tmp/pip-wiwhdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:35:49 INFO - Running setup.py (path:/tmp/pip-bD4fl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:35:49 INFO - Running setup.py (path:/tmp/pip-mwseEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:35:49 INFO - Running setup.py (path:/tmp/pip-9Ep6va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:35:49 INFO - Running setup.py (path:/tmp/pip-vS9MBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:35:49 INFO - Running setup.py (path:/tmp/pip-N233Gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:35:50 INFO - Running setup.py (path:/tmp/pip-chOmIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:35:50 INFO - Running setup.py (path:/tmp/pip-FB1KnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:35:50 INFO - Running setup.py (path:/tmp/pip-x055a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:35:50 INFO - Running setup.py (path:/tmp/pip-iq7m0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:35:50 INFO - Running setup.py (path:/tmp/pip-T_OvuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:50 INFO - Running setup.py (path:/tmp/pip-4VRhol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:35:50 INFO - Running setup.py (path:/tmp/pip-VGZ8vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:35:50 INFO - Running setup.py (path:/tmp/pip-6QzFAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:35:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:35:50 INFO - Running setup.py install for manifestparser 09:35:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:35:50 INFO - Running setup.py install for mozcrash 09:35:50 INFO - Running setup.py install for mozdebug 09:35:50 INFO - Running setup.py install for mozdevice 09:35:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:35:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:35:51 INFO - Running setup.py install for mozfile 09:35:51 INFO - Running setup.py install for mozhttpd 09:35:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:35:51 INFO - Running setup.py install for mozinfo 09:35:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:35:51 INFO - Running setup.py install for mozInstall 09:35:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:35:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:35:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:35:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:35:51 INFO - Running setup.py install for mozleak 09:35:51 INFO - Running setup.py install for mozlog 09:35:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:35:51 INFO - Running setup.py install for moznetwork 09:35:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:35:51 INFO - Running setup.py install for mozprocess 09:35:51 INFO - Running setup.py install for mozprofile 09:35:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:35:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:35:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:35:51 INFO - Running setup.py install for mozrunner 09:35:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:35:52 INFO - Running setup.py install for mozscreenshot 09:35:52 INFO - Running setup.py install for moztest 09:35:52 INFO - Running setup.py install for mozversion 09:35:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:35:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:35:52 INFO - Cleaning up... 09:35:52 INFO - Return code: 0 09:35:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35: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')]} 09:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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')]} 09:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:52 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 0x26b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f570>, '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 0x2970470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', '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 09:35:52 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 09:35:52 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 09:35:52 INFO - Using env: {'DISPLAY': ':0', 09:35:52 INFO - 'HOME': '/home/cltbld', 09:35:52 INFO - 'LANG': 'en_US.UTF-8', 09:35:52 INFO - 'LANGUAGE': 'en_US:en', 09:35:52 INFO - 'LOGNAME': 'cltbld', 09:35:52 INFO - 'MAIL': '/var/mail/cltbld', 09:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:52 INFO - 'MOZ_NO_REMOTE': '1', 09:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:52 INFO - 'NO_EM_RESTART': '1', 09:35:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:52 INFO - 'PWD': '/builds/slave/test', 09:35:52 INFO - 'SHELL': '/bin/bash', 09:35:52 INFO - 'SHLVL': '1', 09:35:52 INFO - 'TERM': 'linux', 09:35:52 INFO - 'TMOUT': '86400', 09:35:52 INFO - 'USER': 'cltbld', 09:35:52 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', 09:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:52 INFO - '_': '/tools/buildbot/bin/python'} 09:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:35:52 INFO - Running setup.py (path:/tmp/pip-hOg2LT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:35:52 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)) 09:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:35:52 INFO - Running setup.py (path:/tmp/pip-np3oKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:35:52 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)) 09:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:35:52 INFO - Running setup.py (path:/tmp/pip-XtV5JJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:35:52 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)) 09:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:35:52 INFO - Running setup.py (path:/tmp/pip-LDUH7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:35:52 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)) 09:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:35:52 INFO - Running setup.py (path:/tmp/pip-b4zCIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:35:53 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)) 09:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:35:53 INFO - Running setup.py (path:/tmp/pip-FD5Oyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:35:53 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)) 09:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:35:53 INFO - Running setup.py (path:/tmp/pip-tns9Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:35:53 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)) 09:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:35:53 INFO - Running setup.py (path:/tmp/pip-p9cQw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:35:53 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)) 09:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:35:53 INFO - Running setup.py (path:/tmp/pip-Ir3x5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:35:53 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)) 09:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:35:53 INFO - Running setup.py (path:/tmp/pip-5bTfid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:35:53 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)) 09:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:35:53 INFO - Running setup.py (path:/tmp/pip-Di8nwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:35:53 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)) 09:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:35:53 INFO - Running setup.py (path:/tmp/pip-4knDQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:35:53 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)) 09:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:35:53 INFO - Running setup.py (path:/tmp/pip-fBYJJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:35:53 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)) 09:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:35:53 INFO - Running setup.py (path:/tmp/pip-r7jwUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:35:53 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)) 09:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:53 INFO - Running setup.py (path:/tmp/pip-Jh6dq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:53 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)) 09:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:35:53 INFO - Running setup.py (path:/tmp/pip-rM4ie7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:35:53 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)) 09:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:35:53 INFO - Running setup.py (path:/tmp/pip-HuZKgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:35:53 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)) 09:35:53 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)) 09:35:53 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)) 09:35:53 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)) 09:35:53 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)) 09:35:53 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)) 09:35:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:35:53 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 09:35:53 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 09:35:53 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 09:35:53 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 09:35:53 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 09:35:53 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 09:35:55 INFO - Downloading blessings-1.6.tar.gz 09:35:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:35:55 INFO - Installing collected packages: blessings 09:35:55 INFO - Running setup.py install for blessings 09:35:55 INFO - Successfully installed blessings 09:35:55 INFO - Cleaning up... 09:35:56 INFO - Return code: 0 09:35:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:35:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:35:56 INFO - Reading from file tmpfile_stdout 09:35:56 INFO - Current package versions: 09:35:56 INFO - argparse == 1.2.1 09:35:56 INFO - blessings == 1.6 09:35:56 INFO - blobuploader == 1.2.4 09:35:56 INFO - docopt == 0.6.1 09:35:56 INFO - functools32 == 3.2.3-2 09:35:56 INFO - jsonschema == 2.5.1 09:35:56 INFO - manifestparser == 1.1 09:35:56 INFO - mozInstall == 1.12 09:35:56 INFO - mozcrash == 0.17 09:35:56 INFO - mozdebug == 0.1 09:35:56 INFO - mozdevice == 0.48 09:35:56 INFO - mozfile == 1.2 09:35:56 INFO - mozhttpd == 0.7 09:35:56 INFO - mozinfo == 0.9 09:35:56 INFO - mozleak == 0.1 09:35:56 INFO - mozlog == 3.2 09:35:56 INFO - moznetwork == 0.27 09:35:56 INFO - mozprocess == 0.23 09:35:56 INFO - mozprofile == 0.28 09:35:56 INFO - mozrunner == 6.12 09:35:56 INFO - mozscreenshot == 0.1 09:35:56 INFO - mozsystemmonitor == 0.3 09:35:56 INFO - moztest == 0.7 09:35:56 INFO - mozversion == 1.4 09:35:56 INFO - psutil == 3.1.1 09:35:56 INFO - requests == 1.2.3 09:35:56 INFO - wsgiref == 0.1.2 09:35:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:56 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 0x26b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f570>, '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 0x2970470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', '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 09:35:56 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 09:35:56 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 09:35:56 INFO - Using env: {'DISPLAY': ':0', 09:35:56 INFO - 'HOME': '/home/cltbld', 09:35:56 INFO - 'LANG': 'en_US.UTF-8', 09:35:56 INFO - 'LANGUAGE': 'en_US:en', 09:35:56 INFO - 'LOGNAME': 'cltbld', 09:35:56 INFO - 'MAIL': '/var/mail/cltbld', 09:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:56 INFO - 'MOZ_NO_REMOTE': '1', 09:35:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:56 INFO - 'NO_EM_RESTART': '1', 09:35:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:56 INFO - 'PWD': '/builds/slave/test', 09:35:56 INFO - 'SHELL': '/bin/bash', 09:35:56 INFO - 'SHLVL': '1', 09:35:56 INFO - 'TERM': 'linux', 09:35:56 INFO - 'TMOUT': '86400', 09:35:56 INFO - 'USER': 'cltbld', 09:35:56 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', 09:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:56 INFO - '_': '/tools/buildbot/bin/python'} 09:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:56 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)) 09:35:56 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)) 09:35:56 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)) 09:35:56 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)) 09:35:56 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)) 09:35:56 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)) 09:35:56 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)) 09:35:56 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)) 09:35:56 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)) 09:35:56 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)) 09:35:56 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)) 09:35:56 INFO - Cleaning up... 09:35:56 INFO - Return code: 0 09:35:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:56 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 0x26b1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296f570>, '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 0x2970470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', '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 09:35:56 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 09:35:56 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 09:35:56 INFO - Using env: {'DISPLAY': ':0', 09:35:56 INFO - 'HOME': '/home/cltbld', 09:35:56 INFO - 'LANG': 'en_US.UTF-8', 09:35:56 INFO - 'LANGUAGE': 'en_US:en', 09:35:56 INFO - 'LOGNAME': 'cltbld', 09:35:56 INFO - 'MAIL': '/var/mail/cltbld', 09:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:56 INFO - 'MOZ_NO_REMOTE': '1', 09:35:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:56 INFO - 'NO_EM_RESTART': '1', 09:35:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:56 INFO - 'PWD': '/builds/slave/test', 09:35:56 INFO - 'SHELL': '/bin/bash', 09:35:56 INFO - 'SHLVL': '1', 09:35:56 INFO - 'TERM': 'linux', 09:35:56 INFO - 'TMOUT': '86400', 09:35:56 INFO - 'USER': 'cltbld', 09:35:56 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', 09:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:56 INFO - '_': '/tools/buildbot/bin/python'} 09:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:35:56 INFO - Cleaning up... 09:35:56 INFO - Return code: 0 09:35:56 INFO - Running post-action listener: _resource_record_post_action 09:35:56 INFO - Running post-action listener: _start_resource_monitoring 09:35:56 INFO - Starting resource monitoring. 09:35:56 INFO - ##### 09:35:56 INFO - ##### Finished create-virtualenv step (success) 09:35:56 INFO - ##### 09:35:56 INFO - ##### 09:35:56 INFO - ##### Running install step. 09:35:56 INFO - ##### 09:35:56 INFO - Running pre-action listener: _resource_record_pre_action 09:35:56 INFO - Running main action method: install 09:35:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:35:56 INFO - Reading from file tmpfile_stdout 09:35:56 INFO - Detecting whether we're running mozinstall >=1.0... 09:35:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:35:56 INFO - Reading from file tmpfile_stdout 09:35:56 INFO - Output received: 09:35:56 INFO - Usage: mozinstall [options] installer 09:35:56 INFO - Options: 09:35:56 INFO - -h, --help show this help message and exit 09:35:56 INFO - -d DEST, --destination=DEST 09:35:56 INFO - Directory to install application into. [default: 09:35:56 INFO - "/builds/slave/test"] 09:35:57 INFO - --app=APP Application being installed. [default: firefox] 09:35:57 INFO - mkdir: /builds/slave/test/build/application 09:35:57 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'] 09:35:57 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 09:36:13 INFO - Reading from file tmpfile_stdout 09:36:13 INFO - Output received: 09:36:13 INFO - /builds/slave/test/build/application/firefox/firefox 09:36:13 INFO - Running post-action listener: _resource_record_post_action 09:36:13 INFO - ##### 09:36:13 INFO - ##### Finished install step (success) 09:36:13 INFO - ##### 09:36:13 INFO - ##### 09:36:13 INFO - ##### Running run-tests step. 09:36:13 INFO - ##### 09:36:13 INFO - Running pre-action listener: _resource_record_pre_action 09:36:13 INFO - Running main action method: run_tests 09:36:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:36:13 INFO - Python 2.7.3 09:36:13 INFO - Return code: 0 09:36:13 INFO - grabbing minidump binary from tooltool 09:36:13 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')]} 09:36:13 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 0x296f570>, '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 0x2970470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2970900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:36:13 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 09:36:13 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 09:36:13 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 09:36:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:36:13 INFO - Return code: 0 09:36:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:36:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:36:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:36:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:36:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:36:13 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/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 09:36:13 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/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 09:36:13 INFO - Using env: {'DISPLAY': ':0', 09:36:13 INFO - 'HOME': '/home/cltbld', 09:36:13 INFO - 'LANG': 'en_US.UTF-8', 09:36:13 INFO - 'LANGUAGE': 'en_US:en', 09:36:13 INFO - 'LOGNAME': 'cltbld', 09:36:13 INFO - 'MAIL': '/var/mail/cltbld', 09:36:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:36:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:13 INFO - 'MOZ_NO_REMOTE': '1', 09:36:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:13 INFO - 'NO_EM_RESTART': '1', 09:36:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:13 INFO - 'PWD': '/builds/slave/test', 09:36:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:36:13 INFO - 'SHELL': '/bin/bash', 09:36:13 INFO - 'SHLVL': '1', 09:36:13 INFO - 'TERM': 'linux', 09:36:13 INFO - 'TMOUT': '86400', 09:36:13 INFO - 'USER': 'cltbld', 09:36:13 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290', 09:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:13 INFO - '_': '/tools/buildbot/bin/python'} 09:36:13 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/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 09:36:13 INFO - mozversion application_buildid: 20160718080853 09:36:13 INFO - mozversion application_changeset: cde56ead650fd302be1d440507485b9abf7c163a 09:36:13 INFO - mozversion application_display_name: Nightly 09:36:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:36:13 INFO - mozversion application_name: Firefox 09:36:13 INFO - mozversion application_remotingname: firefox 09:36:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:36:13 INFO - mozversion application_vendor: Mozilla 09:36:13 INFO - mozversion application_version: 50.0a1 09:36:13 INFO - mozversion platform_buildid: 20160718080853 09:36:13 INFO - mozversion platform_changeset: cde56ead650fd302be1d440507485b9abf7c163a 09:36:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:36:13 INFO - mozversion platform_version: 50.0a1 09:36:13 INFO - using testdate: 1468859773 09:36:13 INFO - actual date: 1468859773 09:36:13 INFO - starting webserver on 'localhost:33862' 09:36:13 INFO - SUITE-START | Running 2 tests 09:36:13 INFO - TEST-START | dromaeo_css 09:36:13 INFO - operating with platform_type : linux_ 09:36:13 INFO - Initialising browser for dromaeo_css test... 09:36:13 INFO - TEST-INFO | started process 11942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9QwRnp/profile http://localhost:33862/getInfo.html) 09:36:18 INFO - PROCESS | 11942 | __metrics Screen width/height:1600/1200 09:36:18 INFO - PROCESS | 11942 | colorDepth:24 09:36:18 INFO - PROCESS | 11942 | Browser inner width/height: 1024/697 09:36:18 INFO - PROCESS | 11942 | __metrics 09:36:19 ERROR - PROCESS | 11942 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:36:20 INFO - TEST-INFO | 11942: exit 0 09:36:20 INFO - Browser initialized. 09:36:20 INFO - Running cycle 1/1 for dromaeo_css test... 09:36:20 INFO - TEST-INFO | started process 12063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9QwRnp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:32 INFO - PROCESS | 12063 | RSS: Main: 168873984 09:36:32 INFO - PROCESS | 12063 | 09:37:21 INFO - PROCESS | 12063 | 1468859841863 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] 09:39:35 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:33862/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33862/tests/dromaeo/cssquery-ext.html) 09:39:36 INFO - PROCESS | 12063 | RSS: Main: 170229760 09:39:36 INFO - PROCESS | 12063 | 09:42:38 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:33862/tests/dromaeo/cssquery-ext.html (next: http://localhost:33862/tests/dromaeo/cssquery-jquery.html) 09:42:39 INFO - PROCESS | 12063 | RSS: Main: 168022016 09:42:39 INFO - PROCESS | 12063 | 09:45:41 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:33862/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33862/tests/dromaeo/cssquery-mootools.html) 09:45:41 INFO - PROCESS | 12063 | RSS: Main: 172417024 09:45:41 INFO - PROCESS | 12063 | 09:48:43 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:33862/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33862/tests/dromaeo/cssquery-prototype.html) 09:48:44 INFO - PROCESS | 12063 | RSS: Main: 167043072 09:48:44 INFO - PROCESS | 12063 | 09:51:47 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:33862/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33862/tests/dromaeo/cssquery-yui.html) 09:51:47 INFO - PROCESS | 12063 | RSS: Main: 169115648 09:51:47 INFO - PROCESS | 12063 | 09:54:50 INFO - PROCESS | 12063 | Cycle 1(1): loaded http://localhost:33862/tests/dromaeo/cssquery-yui.html (next: http://localhost:33862/tests/dromaeo/cssquery-dojo.html) 09:54:50 INFO - PROCESS | 12063 | RSS: Main: 171061248 09:54:50 INFO - PROCESS | 12063 | 09:54:50 INFO - PROCESS | 12063 | __start_tp_report 09:54:50 INFO - PROCESS | 12063 | _x_x_mozilla_page_load 09:54:50 INFO - PROCESS | 12063 | _x_x_mozilla_page_load_details 09:54:50 INFO - PROCESS | 12063 | |i|pagename|runs| 09:54:50 INFO - PROCESS | 12063 | |0;dojo.html;2625.1074634624224;2643.5902435122557;2655.229983304842;2681.4905168018063;2682.4635072985384;4774.355462012627;4848.345473361095;4851.199552073908;4908.8281910133155;4946.812764936416;4650.44194696636;4769.379980602525;4781.784819683114;4809.591184749301;4816;4377.299632058871;4392.868213953587;4496.348029535716;4530.252508336137;4546.136234115507;4416.80124394403;4440.55594440555;4458.308962110894;4514.097180563884;4563.087382523492;4274.764887931163;4347.5652434756585;4365.628921541673;4396.846110386153;4467.24056910326;4357.978210108961;4401.779911004437;4473.217186992263;4474.9776251118865;4502;4452.910941781146;4458.08609235106;4460.264056430685;4465.754383508905;4500.437445319335;4785.401824771903;4842.055799119174;4844.854654360375;4880.707157570557;4885.193942999401;5183.3002544656365;5195.870103247411;5203.895922081575;5218.191180367049;5246.265522826808;5036.7733451994745;5123.564497017758;5248.291480650101;5248.501392367719;5250.6324557281005;4787.6409269304595;4829.13075646387;4847.418309802846;4850.393700787402;4854.271859221074;5282.339707536558;5294.49702278283;5297.17893726473;5305.151175811851;5313.07021271276;4831;4947.901041979212;4984.925226121611;5016.147254966664;5074.4671809460215;4934.827281045218;5101.132807422747;5110.4634013428795;5142.61430392722;5168.405633352213;4936.975315123402;4993.725345106054;5048.646594738333;5070.898582028339;5079.796808127633;5043.067032598908;5106.617003724736;5111.97444012785;5117.002184573972;5162.664426812245;4216.009237829107;4295.892602684958;4315.870523884289;4320.589543993316;4413.801378937956;3759.0978165240144;3766.8304926278383;3771.453139294787;3805.8477660893254;3815.256025075084;4282.828686852553;4345.391645169679;4353.3469979503325;4354.281543545343;4390.1000294940095;5016.54851063406;5049.495050494921;5081.390233172043;5097.337346144977;5102.515261050195;4312.180685669713;4353.390525326457;4354.934675979863;4365.781710914442;4402.141582391467;4454.153710794939;4615.446146462446;4618.445786505641;4622.214223581999;4659.114768194032;4801.303810947463;4832.468428472795;4852.344933434082;4872.707637541759;4885.462599114166;5199.818006369759;5204.37547494288;5219.739013049409;5238.738063096906;5250.816221432385;4763.380760501252;4792.544708252711;4841;4857.697509269709;4862.6839255448285;5061.114304996685;5097.464766199496;5100.413452453015;5104.336436263262;5139.794408223779;5170.819021334235;5172.069027574922;5172.431032586488;5213;5223.7910483580235;4908.386451693538;4958.2810492477665;4981.402231732215;5005.299258103795;5027.396712394536;4854.2233242681;4925.16272233714;4939.950600493949;5003.124453220745;5033.924491132562;4874.098291816025;4875.902481950412;4904.239842824368;4931.3096166536;4943.382077240345;5025.597952163891;5038.244263360525;5040.34475518195;5048.671836330626;5099.515546023122;4808.942032752789;4884.438289596742;4918;4935.259711043373;4982.62630302736 09:54:50 INFO - PROCESS | 12063 | |1;ext.html;564.4637594285429;566.5552541255115;567.5601408908095;574.7413663851265;593.2169536212197;35129.47305790412;39624.20751584967;39634.2073158537;39688.80155599225;39719.40420893689;39391;39517.40723889137;39552.60447395525;39592.60407395925;39686.60313396865;7757.379409647228;7877.921220787776;7880.64537095832;7894;7923.247291507327;7761.844763104735;7847.64685589147;7853.999999999972;7861.606919653995;7882.960585197066;7827.3346765525;7862.174471680477;7909.564973926432;7914.40641951853;7934.801629959239;7808;7840.960795195988;7851.293383595504;7882.448228623999;7884.842303153905;7678.078630564312;7754.457187996843;7774.65014074368;7816.72641457552;7836.177201393885;37936.241275174616;38155.61844381548;38194.61805381939;38207.235855282735;38293;2630.973690263111;2933.3839893622367;3044.9543256851166;3088.1044497095813;3131.671174526665;25539.23382298534;26544.60183097255;27345.86327068352;27389.31526711848;27646.447071058465;3347.196672798511;3396.1679388549715;3412.4710669846213;3420.863165473403;3422.418188907867;237118;237944;238085;238820.80589597113;239553;31190.22024449407;31521.52717709236;31907.840460798012;31929.36141277208;31938;31741.523877141863;33074.17314567155;33142.502862457084;33156.17109572232;33238.66761332404;13676.179429234278;14059.507917222849;14086.013979021574;14100.435982560788;14132.081414708216;11504.25222360544;11711.063114950783;11726.648200553997;11765.705857353463;11782.528698852122;7613;7692.7692169235015;7743.264389882952;7757.68969241224;7776.844463110706;2968.9703102969124;3076.35396566719;3086.861091250899;3109.657937626859;3158;909.231699214163;920.7790130368663;990.5493000684816;1012.2559918459926;1013.6553571785628;27394.5890811638;28571.428571428456;28629;28932.42135157327;29056.564151537743;895.3777124898133;962.4898803634085;987.4766373821886;1000.554753134848;1006.7734759679014;14302.642433939234;14439.205843678488;14640.707185856223;14899.627509312353;14994.100353978796;396637;402362;403158;404134;404909;48147;48323.27515087206;48500.27249591259;48578.27132592943;48920.75539622279;1164.6040346282305;1200.5557943560939;1217.0385395537426;1221.8717034711406;1236.1285293867982;26274.4745105093;27215.86392068027;27422.72577274202;27458.862705687145;27584.448311033266;42282.78858605687;42354.152916942105;42691.57308426876;43012.78493607512;43146.568534314254;295425;295782;296675;297261;297755;24459;24574.754252457962;24735.505289893743;24769.380765481008;24900.750992489844;40347;40579.79710101431;40775.59224407718;40921;41090.79454602708;35846.28307433889;36307.45538816867;36345;36436.45345319769;36750.26499470049;35734.4639830408;35912;36067.81966090153;36551;36717.44923826091;29408.55887161737;34137.31725365429;34197.487037694955;35093.29813403769;35221.29557408786;30688.84655576708;32175.67824321727;32263.838680806446;32643;32702.509462357608;24867.502649947262;25191.37021574475;25503;25543.23370298894;27402.177934661195 09:54:50 INFO - PROCESS | 12063 | |2;jquery.html;370.4517314374725;374.9793761343126;375.53621277722027;380.3951716770335;389.4722650808155;16378.590535236624;16668.499945001655;17375.391861284857;17919.462416127506;17933.013684247362;17492.56268593286;18166;18348.816511834877;18416.447506574823;19453.416397508063;5906.409359064091;6067.514598832105;6127.111568822518;6142.201513803199;6155.446009859112;5831.387704291052;5974.820755377345;6006.21919150512;6034.5172386209215;6044.274687037561;5978.521718262528;5994.97002514989;6010.278766547998;6025.668588227646;6039.094135879609;6393.648349340784;6757.425618822406;6763.053172555846;6833.863322733518;6835.58986460814;6502.089707440962;6561.606303621798;6605.042268871035;6852.588844669286;7049.083619129532;23649.645255321186;24408.755912440825;25069.749302506923;25352.873235633888;25375.492490150278;1975.3185151122839;2084.291340944086;2577.87110644467;2668.919932402031;2699.20373489821;14878.181700006495;15068.397264109532;15247.085174889431;15468.22658867052;15624.687506249926;1785.7053586158397;1857.136431559318;1870.5510677437317;1873.5503479165038;1885.4532185666278;70607;81948.59025704893;87020.56489717575;88075;88224.5588772052;16492.752608710878;16892.550580166055;16922.91538542324;17023;17106.230219640147;29957.40085198284;30281.394372112434;30303.848480757457;30306.84846575753;30369.696303036686;8668.219860212612;9180.8622870657;9242.81514369709;9253.629854805868;9322.487263200454;7478.663460144197;7494.100707915085;7560.773176804704;7672.194419585975;7672.61636918163;8230.917690823015;8305.961754780652;8466.534340611326;8585.656573737106;8634.740957771277;3031.5604237385455;3263.3450535400502;3284.490903909898;3415.9316813664086;3448.793072415663;801.5230937592123;886.8581027035773;918.2103391083663;977.1205914676706;983.8475036369374;17251.703128358058;18102.5474363142;18193.727094093334;18210.180541875383;18459.72310415318;850.2008112374348;861.2765277167084;870.8214815962713;874.9431286966327;942.4580866002076;9654.613815447303;10018;10057;10096.747581310527;10193.592256309665;417826.7716535433;420054;420179;423289;423496;57358.42641573615;70439.77361358335;73135.26864731284;85008;85576;909.7581800841804;921.8478950973015;931.7763736703278;934.8504239321676;938.2915898496591;16044.67910641804;16078.919605401898;16221.837781622506;16484.587885302484;16756.497305080866;35520.46719299264;37208.62791372051;37306.88079357624;37495.81252093722;38235;50592.241116382545;53801.19298210452;54491.182632259755;54577;54889;7543.849123017619;7562.0925488941675;7646.808829779077;7741.380689544711;7806.531608103532;11471.139664525028;11728.882711172779;11769.941150294193;12097.395130243629;12429.689257768629;10612.681619551426;10803.297785643908;10825.512851921525;10910.618128365786;11130;10368.637097701545;10479.738006549896;10746.785064298827;10764.677059688222;10856.480092786858;10437.425941573287;10575.841362379724;11035.503402346752;11284.830727538929;11318.207725459139;7496.4002879768395;7534.698612055676;7650.6174691264105;7653.617319134132;7987.40094492927;8533.615987280711;8808.603612837309;10833.620823271463;10926.726831829268;11084.944575277072 09:54:50 INFO - PROCESS | 12063 | |3;mootools.html;1376.2499437806398;1409.1615488784173;1487;1716.2362748576888;1735.2278236184886;6569.146011018573;7326.670299836507;7402.814929626762;7864.056313242412;7886.093099293583;7507;7638.503497272687;7711.267429594193;7749.186335434769;7776.533407995525;2168.544605632815;2195.209724499179;2198.5712786006734;2199.846010779246;2204.7684993075736;2155.461134716321;2164.5021645021657;2219.9001044953015;2220.3006053093304;2220.85564438311;2190.167736260219;2192.8355373346985;2200.0869639099756;2201.2625770366867;2204.019211450905;2080.365488525999;2095.308548179097;2096.612126756555;2098.9580208395823;2100.2859027930576;2088.404804630673;2155.385715071197;2158.6546152615506;2160.7947245011856;2162.9891850540803;7747;7755.612219389008;7802.33680137189;7822.452428330019;7850.607469626496;4606.124836281129;4720.103180395714;4742.620590352763;4749.715017098985;4752.310914917352;2820.1539538138477;2883.942321153565;2926.5756465312625;2930.7069293070736;2970.970290297091;918.6417297254076;923.8983711791698;924.3021518753366;953.9332246742731;956.7703751099685;10440.68677939663;10484.842727359095;10509.159267258678;10516.47417629123;10548.94725526375;4087.448194493705;4161.3549899765585;4299.290617048215;4343.913121737548;4350.695451318377;8984.05667404913;9029.864552031724;9049.366544341965;9060.320475964329;9072.04743501936;4785.449673287547;4791.856244312677;4800.639952003614;4804.8318308859025;4806.303086052503;3545.450455179451;4192.329227323614;4354.760488173181;4358.738475691469;4374.212641724456;3709.9072523187137;3718.2935242303874;3820.2168555446065;3830.6552410283207;3837.9040523986564;1212.5271144253747;1214.678110300771;1223.424990254579;1230.1081715756006;1242.3043095866344;742.6992068212382;822.5393779483509;847.6863560482661;865.6191275838611;892.3441270666056;5363.651362661414;5463;5470.398256191816;5493.642913210629;5513.724313784375;398.4998826472758;398.6890225624018;399.26933711308817;404.0988595432144;408.98159582818846;3836.5971572984995;3859.591249194024;3872.690184785267;3934.252492026506;3961.1087505311075;9292.95353523228;9493.240540756722;9671.951640241754;9716.31985761004;9734.951325243328;9551;9559.474228917476;9643.807123857623;9691.854622180674;9732;7275.199728029913;7299.270072992765;7312.268773122645;7339.522931009467;7354.3748781353115;5242.606804489602;5317.548008419328;5395.622306438511;5407.648502847303;5530.05988981866;9003.14470125337;9036.412633178823;9061.68284110053;9072.183503484453;9127.908720912972;8293.295069919124;8571.95714021426;8620.094890036708;8895.599698013735;9095.49974751395;6058.303295121117;6689.899651505134;6881.208661003849;6909.516333856783;6992.2308546058875;7621.771346859603;7659.961700191687;7675.462717609714;7696.230376962483;7740.148583655906;6688.966555167193;6744.831379215362;6923.688434020582;6935.375816176366;7040.929590704028;6923.82690432723;6936.549124306904;6974.825629359307;6998.475114366341;7010.614416206953;6270.184875966278;6308.179936608211;6342.587731797418;6383.744650214126;6473.676316184266;4735.076660051257;4742.241241401359;4794.976025119852;4828.589569886599;4858.611311095033;4867.245576935581;4869.732164730974;4888.804447822047;4901.14230009754;4918.385201849769 09:54:50 INFO - PROCESS | 12063 | |4;prototype.html;303.54165210532096;307.66157227050235;310.40402427339507;310.9860056297469;313.6831799882119;5041.571466425354;5061.721605311711;5067.442581316052;5070.011347787183;5070.138076526985;4974.228994505848;4995.500449955002;4995.650304478688;5006.173981293082;5021.673591216569;3718.4236443351188;3845.365514690087;3902.4926759521363;3916.2167566486673;3922.431247469115;3931.5427857589007;3948.6643635291034;3955.7626542407547;3962.544307404642;3966.5636779954325;3938.350172221594;3945.230680017398;3960.7623542587394;3965.385365268374;3976.369688427745;3810.3209477974206;3909.9218015639813;3942.960570394288;3946.9210615787665;3964.0288129408336;3444.293919746446;3463.7229021678204;3465.4108801503803;3473.7221022318154;3482.4428091505238;4808.639352048575;4810.326554282403;4822.9758851205515;4833.613310935117;4898.118338699069;4392.78036098197;4475.433598240622;4480.731156130642;4481.865544033684;4552.157850797613;5213.556847667915;5226.477352264781;5236.502532259429;5244.056069907415;5274.894502109936;3808.5810560838563;3810;3820.9617903820886;3822.120912190212;3828.846846126152;5451.291332126838;5456.017916774979;5465.754041068161;5492.615516913817;5498.422665620133;3562.5012498250267;3755.4366844972924;3762.5484941806612;3765.284595926765;3768.2086761780333;3818.3508803503473;3824.78963656996;3829.463875057494;3837.1174629835295;3849.1531862990096;4402.965303153756;4404.581564751344;4410.779461026936;4422.624076953495;4434.11317736454;5171.4052883918075;5227.895442091137;5279.630425870229;5315.28243687105;5329.120695085345;1308.913601710578;1326.5821266301084;1332.9000324975666;1335.6927906581345;1338.772408690525;824.5588610093571;825.224289168192;841.1966571923798;855.9771073567152;859.6819176904586;4438.667099967515;4560.635149188057;4565.56627120423;4582.243929751554;4599.724016559017;5411.431799661058;5416.756245968941;5418.103663717746;5433.8369848904595;5440.782368705287;4414.27164517851;4566.70316429431;4580.541945805459;4591.586757191802;4630.32860235264;2887.985560072186;2890.8265504069823;2900.1589539033444;2903.912882613525;2917.197770613056;5062.430646499597;5074.594032477393;5084.796608135707;5085.567726743268;5088.338515992898;5423.823655785102;5455.427180146107;5503.532199763065;5510.448955104457;5541.390447050821;5020.974895125574;5033.345665063592;5037.697738135724;5039.941612261467;5049.469805670426;5398.730063496888;5413.431589683027;5414.269073675161;5424.810131645373;5456.980917060713;5000.449950505515;5285.841424757264;5295.7616907240035;5299.735013249399;5301.443348448512;4976.850694479172;4981.153203955264;5013.774380152829;5029.371328583927;5029.698218106925;3740.8690695825517;3756.441076953034;3759.6240375962184;3761.1725420407465;3771.717121215865;5166.509181627739;5393.029254734185;5424;5425.321834770653;5462.371827239918;5301.920471193012;5307.734613269244;5314.97342513285;5315.3090098286975;5332.30680011596;5264.210368444611;5271.604629652715;5323.946760532345;5354.46455354477;5364.919526207188;5151.330327057459;5213.713245771367;5226.947730522646;5250.264962905273;5251.973740131275;5072.391313042459;5177.430482646982;5271.420143784104;5302.496262855023;5303.893922121613;5177.275181474522;5193.662411943212;5210.47895210476;5214.687118772886;5223.216517522402 09:54:50 INFO - PROCESS | 12063 | |5;yui.html;622.5766478794418;627.244170774217;646.7057488842574;712.319734653406;727.83987522745;12092.939535302323;12883.80674289884;12926.09517333787;12954.870451295485;12959.222446653208;12262.202956807801;12272.32502212378;12302.200356976813;13391.464341426332;13941.372638231278;605.5276884030463;756.9810754731135;776.6932061835572;777.7666699990009;779.2052106851008;753.4386881773087;777.9494332868373;778.0080397493185;778.2373274191295;781.6912319633741;812.743985644523;817.3012074676155;819.5041999590252;819.9959000205021;821.0311832038193;811.6307080278459;812.3379445751693;812.7196117339538;813.1868131868132;814.1004190369615;598.3119412675458;598.9131575921467;599.1671576508656;599.6042611876185;600.4205941266698;13842.723145537033;13880.375383107785;13888;13914;13921.373538190806;12496.500139994389;12639;12679.619611411672;12840.1011929165;12868.742625147539;10215;10442.425666588335;10498.055175034207;10592.735181620445;10656.147508199325;3251.8048917065053;3282.5404443377706;3306.156929982839;3308.7022168004996;3376.5948086229564;60194.699026505026;60472.69763651198;60715.39284607186;60775.392246077856;61021.999999999556;9864.210863130933;10035.849462258071;10203.489825508696;10266.486675666187;10331;16776.748348774778;17041.82958170427;17170.656586868194;17183.484495465156;17232.052237126827;6647.069410282565;6802.727890884309;6990.405815505637;6999.825004374829;7005.334493223136;3691.2248427830455;3778.301014312361;3785.5078839750654;3793.2223894101644;3826.732128750961;2724.972750272472;2850.9572356414255;2853.9429211415654;2856.7857410694282;2862.084133077437;509.06586413930853;510.7701534309576;553.090166675816;574.8993926062923;598.4135547163804;566.2016556655179;601.6209787833724;613.1201725523888;619.2043224456552;628.205320269859;8123.6750529978135;8151;8275.337972962148;8367.95816020916;8534.402591818638;577.3562477837265;577.982660520185;580.0601837187173;591.7100620695828;597.3220394851875;4141.81361838718;4171.165766846643;4191.245575796325;4250.3199488081755;4294.312909934395;97147;105863;108215.45892270489;108287.45856270668;109091;95634.52182739042;95643.52178239204;96013;96028.51985740027;96724.51637741766;50387;50428.24357634639;50720.492795072314;79160.20839791643;79194.20805791984;7733.651985660546;7878.448508604342;8022.679092836222;8039.437239393186;8268.37987150954;49827.50172498373;49842.75078624584;50702.49297506978;51421.48578514167;53050.4694953061;66851;72198;72293.63853180701;73324;73741;10276.486175691334;10310.226732994905;10364.222683298933;10416.270861039655;10760.784784304427;11635.185537012328;11780.764384712087;11861.525538978343;11892.940535297268;11967.401629918644;10501.684949451528;10711.08955738771;11023.173262005543;11249.212555121063;11754;9905.752356191153;10065.396076235449;10084.14284785772;10218.489075546044;10485.21360897951;9792;9919.801603968024;10161.847572286273;10333.276670632984;10496.790064198825;7957.562334071682;8255.876161857457;8402.663893444194;8421;8614.741557753277;8784.253338466046;8896.955515222382;8998.325125615474;9122.954385228031;9174.128457796498 09:54:50 INFO - PROCESS | 12063 | __end_tp_report 09:54:50 INFO - PROCESS | 12063 | __start_cc_report 09:54:50 INFO - PROCESS | 12063 | _x_x_mozilla_cycle_collect,395 09:54:50 INFO - PROCESS | 12063 | __end_cc_report 09:54:50 INFO - PROCESS | 12063 | __startTimestamp1468860890755__endTimestamp 09:54:50 INFO - PROCESS | 12063 | 09:54:50 INFO - PROCESS | 12063 | ------- Summary: start ------- 09:54:50 INFO - PROCESS | 12063 | Number of tests: 6 09:54:50 INFO - PROCESS | 12063 | 09:54:50 INFO - PROCESS | 12063 | [#0] dojo.html Cycles:165 Average:4743.08 Median:4872.71 stddev:505.44 (10.4%) stddev-sans-first:478.90 09:54:50 INFO - PROCESS | 12063 | Values: 2625.1 2643.6 2655.2 2681.5 2682.5 4774.4 4848.3 4851.2 4908.8 4946.8 4650.4 4769.4 4781.8 4809.6 4816.0 4377.3 4392.9 4496.3 4530.3 4546.1 4416.8 4440.6 4458.3 4514.1 4563.1 4274.8 4347.6 4365.6 4396.8 4467.2 4358.0 4401.8 4473.2 4475.0 4502.0 4452.9 4458.1 4460.3 4465.8 4500.4 4785.4 4842.1 4844.9 4880.7 4885.2 5183.3 5195.9 5203.9 5218.2 5246.3 5036.8 5123.6 5248.3 5248.5 5250.6 4787.6 4829.1 4847.4 4850.4 4854.3 5282.3 5294.5 5297.2 5305.2 5313.1 4831.0 4947.9 4984.9 5016.1 5074.5 4934.8 5101.1 5110.5 5142.6 5168.4 4937.0 4993.7 5048.6 5070.9 5079.8 5043.1 5106.6 5112.0 5117.0 5162.7 4216.0 4295.9 4315.9 4320.6 4413.8 3759.1 3766.8 3771.5 3805.8 3815.3 4282.8 4345.4 4353.3 4354.3 4390.1 5016.5 5049.5 5081.4 5097.3 5102.5 4312.2 4353.4 4354.9 4365.8 4402.1 4454.2 4615.4 4618.4 4622.2 4659.1 4801.3 4832.5 4852.3 4872.7 4885.5 5199.8 5204.4 5219.7 5238.7 5250.8 4763.4 4792.5 4841.0 4857.7 4862.7 5061.1 5097.5 5100.4 5104.3 5139.8 5170.8 5172.1 5172.4 5213.0 5223.8 4908.4 4958.3 4981.4 5005.3 5027.4 4854.2 4925.2 4940.0 5003.1 5033.9 4874.1 4875.9 4904.2 4931.3 4943.4 5025.6 5038.2 5040.3 5048.7 5099.5 4808.9 4884.4 4918.0 4935.3 4982.6 09:54:50 INFO - PROCESS | 12063 | 09:54:50 INFO - PROCESS | 12063 | [#1] ext.html Cycles:180 Average:45049.79 Median:3421.64 stddev:84435.80 (2467.7%) stddev-sans-first:84606.60 09:54:50 INFO - PROCESS | 12063 | Values: 564.5 566.6 567.6 574.7 593.2 35129.5 39624.2 39634.2 39688.8 39719.4 39391.0 39517.4 39552.6 39592.6 39686.6 7757.4 7877.9 7880.6 7894.0 7923.2 7761.8 7847.6 7854.0 7861.6 7883.0 7827.3 7862.2 7909.6 7914.4 7934.8 7808.0 7841.0 7851.3 7882.4 7884.8 7678.1 7754.5 7774.7 7816.7 7836.2 37936.2 38155.6 38194.6 38207.2 38293.0 2631.0 2933.4 3045.0 3088.1 3131.7 25539.2 26544.6 27345.9 27389.3 27646.4 3347.2 3396.2 3412.5 3420.9 3422.4 237118.0 237944.0 238085.0 238820.8 239553.0 31190.2 31521.5 31907.8 31929.4 31938.0 31741.5 33074.2 33142.5 33156.2 33238.7 13676.2 14059.5 14086.0 14100.4 14132.1 11504.3 11711.1 11726.6 11765.7 11782.5 7613.0 7692.8 7743.3 7757.7 7776.8 2969.0 3076.4 3086.9 3109.7 3158.0 909.2 920.8 990.5 1012.3 1013.7 27394.6 28571.4 28629.0 28932.4 29056.6 895.4 962.5 987.5 1000.6 1006.8 14302.6 14439.2 14640.7 14899.6 14994.1 396637.0 402362.0 403158.0 404134.0 404909.0 48147.0 48323.3 48500.3 48578.3 48920.8 1164.6 1200.6 1217.0 1221.9 1236.1 26274.5 27215.9 27422.7 27458.9 27584.4 42282.8 42354.2 42691.6 43012.8 43146.6 295425.0 295782.0 296675.0 297261.0 297755.0 24459.0 24574.8 24735.5 24769.4 24900.8 40347.0 40579.8 40775.6 40921.0 41090.8 35846.3 36307.5 36345.0 36436.5 36750.3 35734.5 35912.0 36067.8 36551.0 36717.4 29408.6 34137.3 34197.5 35093.3 35221.3 30688.8 32175.7 32263.8 32643.0 32702.5 24867.5 25191.4 25503.0 25543.2 27402.2 09:54:50 INFO - PROCESS | 12063 | 09:54:50 INFO - PROCESS | 12063 | [#2] jquery.html Cycles:180 Average:27039.27 Median:19312.24 stddev:69370.15 (359.2%) stddev-sans-first:69535.85 09:54:50 INFO - PROCESS | 12063 | Values: 370.5 375.0 375.5 380.4 389.5 16378.6 16668.5 17375.4 17919.5 17933.0 17492.6 18166.0 18348.8 18416.4 19453.4 5906.4 6067.5 6127.1 6142.2 6155.4 5831.4 5974.8 6006.2 6034.5 6044.3 5978.5 5995.0 6010.3 6025.7 6039.1 6393.6 6757.4 6763.1 6833.9 6835.6 6502.1 6561.6 6605.0 6852.6 7049.1 23649.6 24408.8 25069.7 25352.9 25375.5 1975.3 2084.3 2577.9 2668.9 2699.2 14878.2 15068.4 15247.1 15468.2 15624.7 1785.7 1857.1 1870.6 1873.6 1885.5 70607.0 81948.6 87020.6 88075.0 88224.6 16492.8 16892.6 16922.9 17023.0 17106.2 29957.4 30281.4 30303.8 30306.8 30369.7 8668.2 9180.9 9242.8 9253.6 9322.5 7478.7 7494.1 7560.8 7672.2 7672.6 8230.9 8306.0 8466.5 8585.7 8634.7 3031.6 3263.3 3284.5 3415.9 3448.8 801.5 886.9 918.2 977.1 983.8 17251.7 18102.5 18193.7 18210.2 18459.7 850.2 861.3 870.8 874.9 942.5 9654.6 10018.0 10057.0 10096.7 10193.6 417826.8 420054.0 420179.0 423289.0 423496.0 57358.4 70439.8 73135.3 85008.0 85576.0 909.8 921.8 931.8 934.9 938.3 16044.7 16078.9 16221.8 16484.6 16756.5 35520.5 37208.6 37306.9 37495.8 38235.0 50592.2 53801.2 54491.2 54577.0 54889.0 7543.8 7562.1 7646.8 7741.4 7806.5 11471.1 11728.9 11769.9 12097.4 12429.7 10612.7 10803.3 10825.5 10910.6 11130.0 10368.6 10479.7 10746.8 10764.7 10856.5 10437.4 10575.8 11035.5 11284.8 11318.2 7496.4 7534.7 7650.6 7653.6 7987.4 8533.6 8808.6 10833.6 10926.7 11084.9 09:54:50 INFO - PROCESS | 12063 | 09:54:50 INFO - PROCESS | 12063 | [#3] mootools.html Cycles:180 Average:5168.98 Median:5280.08 stddev:2868.31 (54.3%) stddev-sans-first:2862.19 09:54:50 INFO - PROCESS | 12063 | Values: 1376.2 1409.2 1487.0 1716.2 1735.2 6569.1 7326.7 7402.8 7864.1 7886.1 7507.0 7638.5 7711.3 7749.2 7776.5 2168.5 2195.2 2198.6 2199.8 2204.8 2155.5 2164.5 2219.9 2220.3 2220.9 2190.2 2192.8 2200.1 2201.3 2204.0 2080.4 2095.3 2096.6 2099.0 2100.3 2088.4 2155.4 2158.7 2160.8 2163.0 7747.0 7755.6 7802.3 7822.5 7850.6 4606.1 4720.1 4742.6 4749.7 4752.3 2820.2 2883.9 2926.6 2930.7 2971.0 918.6 923.9 924.3 953.9 956.8 10440.7 10484.8 10509.2 10516.5 10548.9 4087.4 4161.4 4299.3 4343.9 4350.7 8984.1 9029.9 9049.4 9060.3 9072.0 4785.4 4791.9 4800.6 4804.8 4806.3 3545.5 4192.3 4354.8 4358.7 4374.2 3709.9 3718.3 3820.2 3830.7 3837.9 1212.5 1214.7 1223.4 1230.1 1242.3 742.7 822.5 847.7 865.6 892.3 5363.7 5463.0 5470.4 5493.6 5513.7 398.5 398.7 399.3 404.1 409.0 3836.6 3859.6 3872.7 3934.3 3961.1 9293.0 9493.2 9672.0 9716.3 9735.0 9551.0 9559.5 9643.8 9691.9 9732.0 7275.2 7299.3 7312.3 7339.5 7354.4 5242.6 5317.5 5395.6 5407.6 5530.1 9003.1 9036.4 9061.7 9072.2 9127.9 8293.3 8572.0 8620.1 8895.6 9095.5 6058.3 6689.9 6881.2 6909.5 6992.2 7621.8 7660.0 7675.5 7696.2 7740.1 6689.0 6744.8 6923.7 6935.4 7040.9 6923.8 6936.5 6974.8 6998.5 7010.6 6270.2 6308.2 6342.6 6383.7 6473.7 4735.1 4742.2 4795.0 4828.6 4858.6 4867.2 4869.7 4888.8 4901.1 4918.4 09:54:50 INFO - PROCESS | 12063 | 09:54:50 INFO - PROCESS | 12063 | [#4] prototype.html Cycles:180 Average:4357.65 Median:5003.31 stddev:1271.61 (25.4%) stddev-sans-first:1238.24 09:54:50 INFO - PROCESS | 12063 | Values: 303.5 307.7 310.4 311.0 313.7 5041.6 5061.7 5067.4 5070.0 5070.1 4974.2 4995.5 4995.7 5006.2 5021.7 3718.4 3845.4 3902.5 3916.2 3922.4 3931.5 3948.7 3955.8 3962.5 3966.6 3938.4 3945.2 3960.8 3965.4 3976.4 3810.3 3909.9 3943.0 3946.9 3964.0 3444.3 3463.7 3465.4 3473.7 3482.4 4808.6 4810.3 4823.0 4833.6 4898.1 4392.8 4475.4 4480.7 4481.9 4552.2 5213.6 5226.5 5236.5 5244.1 5274.9 3808.6 3810.0 3821.0 3822.1 3828.8 5451.3 5456.0 5465.8 5492.6 5498.4 3562.5 3755.4 3762.5 3765.3 3768.2 3818.4 3824.8 3829.5 3837.1 3849.2 4403.0 4404.6 4410.8 4422.6 4434.1 5171.4 5227.9 5279.6 5315.3 5329.1 1308.9 1326.6 1332.9 1335.7 1338.8 824.6 825.2 841.2 856.0 859.7 4438.7 4560.6 4565.6 4582.2 4599.7 5411.4 5416.8 5418.1 5433.8 5440.8 4414.3 4566.7 4580.5 4591.6 4630.3 2888.0 2890.8 2900.2 2903.9 2917.2 5062.4 5074.6 5084.8 5085.6 5088.3 5423.8 5455.4 5503.5 5510.4 5541.4 5021.0 5033.3 5037.7 5039.9 5049.5 5398.7 5413.4 5414.3 5424.8 5457.0 5000.4 5285.8 5295.8 5299.7 5301.4 4976.9 4981.2 5013.8 5029.4 5029.7 3740.9 3756.4 3759.6 3761.2 3771.7 5166.5 5393.0 5424.0 5425.3 5462.4 5301.9 5307.7 5315.0 5315.3 5332.3 5264.2 5271.6 5323.9 5354.5 5364.9 5151.3 5213.7 5226.9 5250.3 5252.0 5072.4 5177.4 5271.4 5302.5 5303.9 5177.3 5193.7 5210.5 5214.7 5223.2 09:54:50 INFO - PROCESS | 12063 | 09:54:50 INFO - PROCESS | 12063 | [#5] yui.html Cycles:180 Average:18090.14 Median:559.65 stddev:27074.17 (4837.7%) stddev-sans-first:27118.35 09:54:50 INFO - PROCESS | 12063 | Values: 622.6 627.2 646.7 712.3 727.8 12092.9 12883.8 12926.1 12954.9 12959.2 12262.2 12272.3 12302.2 13391.5 13941.4 605.5 757.0 776.7 777.8 779.2 753.4 777.9 778.0 778.2 781.7 812.7 817.3 819.5 820.0 821.0 811.6 812.3 812.7 813.2 814.1 598.3 598.9 599.2 599.6 600.4 13842.7 13880.4 13888.0 13914.0 13921.4 12496.5 12639.0 12679.6 12840.1 12868.7 10215.0 10442.4 10498.1 10592.7 10656.1 3251.8 3282.5 3306.2 3308.7 3376.6 60194.7 60472.7 60715.4 60775.4 61022.0 9864.2 10035.8 10203.5 10266.5 10331.0 16776.7 17041.8 17170.7 17183.5 17232.1 6647.1 6802.7 6990.4 6999.8 7005.3 3691.2 3778.3 3785.5 3793.2 3826.7 2725.0 2851.0 2853.9 2856.8 2862.1 509.1 510.8 553.1 574.9 598.4 566.2 601.6 613.1 619.2 628.2 8123.7 8151.0 8275.3 8368.0 8534.4 577.4 578.0 580.1 591.7 597.3 4141.8 4171.2 4191.2 4250.3 4294.3 97147.0 105863.0 108215.5 108287.5 109091.0 95634.5 95643.5 96013.0 96028.5 96724.5 50387.0 50428.2 50720.5 79160.2 79194.2 7733.7 7878.4 8022.7 8039.4 8268.4 49827.5 49842.8 50702.5 51421.5 53050.5 66851.0 72198.0 72293.6 73324.0 73741.0 10276.5 10310.2 10364.2 10416.3 10760.8 11635.2 11780.8 11861.5 11892.9 11967.4 10501.7 10711.1 11023.2 11249.2 11754.0 9905.8 10065.4 10084.1 10218.5 10485.2 9792.0 9919.8 10161.8 10333.3 10496.8 7957.6 8255.9 8402.7 8421.0 8614.7 8784.3 8897.0 8998.3 9123.0 9174.1 09:54:50 INFO - PROCESS | 12063 | -------- Summary: end -------- 09:54:50 INFO - PROCESS | 12063 | 09:54:51 INFO - TEST-INFO | 12063: exit 0 09:54:51 INFO - TEST-OK | dromaeo_css | took 1117940ms 09:54:51 INFO - TEST-START | kraken 09:54:51 INFO - operating with platform_type : linux_ 09:54:51 INFO - Initialising browser for kraken test... 09:54:51 INFO - TEST-INFO | started process 12309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUZBZBs/profile http://localhost:33862/getInfo.html) 09:54:56 INFO - PROCESS | 12309 | __metrics Screen width/height:1600/1200 09:54:56 INFO - PROCESS | 12309 | colorDepth:24 09:54:56 INFO - PROCESS | 12309 | Browser inner width/height: 1024/697 09:54:56 INFO - PROCESS | 12309 | __metrics 09:54:57 ERROR - PROCESS | 12309 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:54:58 INFO - TEST-INFO | 12309: exit 0 09:54:58 INFO - Browser initialized. 09:54:58 INFO - Running cycle 1/1 for kraken test... 09:54:58 INFO - TEST-INFO | started process 12434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUZBZBs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:10 INFO - PROCESS | 12434 | RSS: Main: 169287680 09:55:10 INFO - PROCESS | 12434 | 09:55:12 INFO - PROCESS | 12434 | Cycle 1(1): loaded http://localhost:33862/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33862/tests/kraken/driver.html?testName=audio-beat-detection) 09:55:13 INFO - PROCESS | 12434 | RSS: Main: 173510656 09:55:13 INFO - PROCESS | 12434 | 09:55:16 INFO - PROCESS | 12434 | Cycle 1(1): loaded http://localhost:33862/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33862/tests/kraken/driver.html?testName=audio-dft) 09:55:17 INFO - PROCESS | 12434 | RSS: Main: 173522944 09:55:17 INFO - PROCESS | 12434 | 09:55:20 INFO - PROCESS | 12434 | Cycle 1(1): loaded http://localhost:33862/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33862/tests/kraken/driver.html?testName=audio-fft) 09:55:20 INFO - PROCESS | 12434 | RSS: Main: 168771584 09:55:20 INFO - PROCESS | 12434 | 09:55:23 INFO - PROCESS | 12434 | Cycle 1(1): loaded http://localhost:33862/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33862/tests/kraken/driver.html?testName=audio-oscillator) 09:55:23 INFO - PROCESS | 12434 | RSS: Main: 169086976 09:55:23 INFO - PROCESS | 12434 | 09:55:26 INFO - PROCESS | 12434 | Cycle 1(1): loaded http://localhost:33862/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33862/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:55:26 INFO - PROCESS | 12434 | RSS: Main: 169299968 09:55:26 INFO - PROCESS | 12434 | 09:55:29 INFO - PROCESS | 12434 | Cycle 1(1): loaded http://localhost:33862/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33862/tests/kraken/driver.html?testName=imaging-darkroom) 09:55:30 INFO - PROCESS | 12434 | RSS: Main: 169512960 09:55:30 INFO - PROCESS | 12434 | 09:55:33 INFO - PROCESS | 12434 | Cycle 1(1): loaded http://localhost:33862/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33862/tests/kraken/driver.html?testName=imaging-desaturate) 09:55:34 INFO - PROCESS | 12434 | RSS: Main: 167469056 09:55:34 INFO - PROCESS | 12434 | 09:55:37 INFO - PROCESS | 12434 | Cycle 1(1): loaded http://localhost:33862/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33862/tests/kraken/driver.html?testName=json-parse-financial) 09:55:38 INFO - PROCESS | 12434 | RSS: Main: 168689664 09:55:38 INFO - PROCESS | 12434 | 09:55:39 INFO - PROCESS | 12434 | Cycle 1(1): loaded http://localhost:33862/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33862/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:55:40 INFO - PROCESS | 12434 | RSS: Main: 169148416 09:55:40 INFO - PROCESS | 12434 | 09:55:42 INFO - PROCESS | 12434 | Cycle 1(1): loaded http://localhost:33862/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33862/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:55:43 INFO - PROCESS | 12434 | RSS: Main: 169447424 09:55:43 INFO - PROCESS | 12434 | 09:55:45 INFO - PROCESS | 12434 | Cycle 1(1): loaded http://localhost:33862/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33862/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:55:46 INFO - PROCESS | 12434 | RSS: Main: 169844736 09:55:46 INFO - PROCESS | 12434 | 09:55:48 INFO - PROCESS | 12434 | Cycle 1(1): loaded http://localhost:33862/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33862/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:55:49 INFO - PROCESS | 12434 | RSS: Main: 170008576 09:55:49 INFO - PROCESS | 12434 | 09:55:52 INFO - PROCESS | 12434 | Cycle 1(1): loaded http://localhost:33862/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33862/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:55:52 INFO - PROCESS | 12434 | RSS: Main: 170442752 09:55:52 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | Cycle 1(1): loaded http://localhost:33862/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33862/tests/kraken/driver.html?testName=ai-astar) 09:55:54 INFO - PROCESS | 12434 | RSS: Main: 170917888 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | __start_tp_report 09:55:54 INFO - PROCESS | 12434 | _x_x_mozilla_page_load 09:55:54 INFO - PROCESS | 12434 | _x_x_mozilla_page_load_details 09:55:54 INFO - PROCESS | 12434 | |i|pagename|runs| 09:55:54 INFO - PROCESS | 12434 | |0;ai-astar;104;115;110;117;114;118;116;115;116;115 09:55:54 INFO - PROCESS | 12434 | |1;audio-beat-detection;159;128;153;178;125;151;156;127;184;126 09:55:54 INFO - PROCESS | 12434 | |2;audio-dft;162;164;167;174;165;164;163;164;165;164 09:55:54 INFO - PROCESS | 12434 | |3;audio-fft;75;77;77;152;79;77;76;79;169;77 09:55:54 INFO - PROCESS | 12434 | |4;audio-oscillator;86;85;139;87;86;86;129;86;85;139 09:55:54 INFO - PROCESS | 12434 | |5;imaging-gaussian-blur;118;118;118;118;122;118;118;118;119;118 09:55:54 INFO - PROCESS | 12434 | |6;imaging-darkroom;149;148;148;147;149;149;148;147;149;148 09:55:54 INFO - PROCESS | 12434 | |7;imaging-desaturate;96;96;96;96;96;96;95;96;95;95 09:55:54 INFO - PROCESS | 12434 | |8;json-parse-financial;63;65;64;65;67;64;64;65;65;64 09:55:54 INFO - PROCESS | 12434 | |9;json-stringify-tinderbox;67;66;65;66;66;66;66;66;67;74 09:55:54 INFO - PROCESS | 12434 | |10;stanford-crypto-aes;81;80;79;81;83;85;80;79;87;79 09:55:54 INFO - PROCESS | 12434 | |11;stanford-crypto-ccm;143;132;138;131;138;138;153;133;180;132 09:55:54 INFO - PROCESS | 12434 | |12;stanford-crypto-pbkdf2;166;167;170;170;167;167;169;165;172;172 09:55:54 INFO - PROCESS | 12434 | |13;stanford-crypto-sha256-iterative;67;69;68;69;73;67;66;67;67;66 09:55:54 INFO - PROCESS | 12434 | __end_tp_report 09:55:54 INFO - PROCESS | 12434 | __start_cc_report 09:55:54 INFO - PROCESS | 12434 | _x_x_mozilla_cycle_collect,1024 09:55:54 INFO - PROCESS | 12434 | __end_cc_report 09:55:54 INFO - PROCESS | 12434 | __startTimestamp1468860954954__endTimestamp 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | ------- Summary: start ------- 09:55:54 INFO - PROCESS | 12434 | Number of tests: 14 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.50 stddev:4.11 (3.6%) stddev-sans-first:2.26 09:55:54 INFO - PROCESS | 12434 | Values: 104.0 115.0 110.0 117.0 114.0 118.0 116.0 115.0 116.0 115.0 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:154.50 stddev:21.77 (14.1%) stddev-sans-first:22.77 09:55:54 INFO - PROCESS | 12434 | Values: 159.0 128.0 153.0 178.0 125.0 151.0 156.0 127.0 184.0 126.0 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:3.36 (2.0%) stddev-sans-first:3.36 09:55:54 INFO - PROCESS | 12434 | Values: 162.0 164.0 167.0 174.0 165.0 164.0 163.0 164.0 165.0 164.0 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | [#3] audio-fft Cycles:10 Average:93.80 Median:77.00 stddev:35.40 (46.0%) stddev-sans-first:36.89 09:55:54 INFO - PROCESS | 12434 | Values: 75.0 77.0 77.0 152.0 79.0 77.0 76.0 79.0 169.0 77.0 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:86.00 stddev:24.22 (28.2%) stddev-sans-first:25.09 09:55:54 INFO - PROCESS | 12434 | Values: 86.0 85.0 139.0 87.0 86.0 86.0 129.0 86.0 85.0 139.0 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.00 stddev:1.27 (1.1%) stddev-sans-first:1.33 09:55:54 INFO - PROCESS | 12434 | Values: 118.0 118.0 118.0 118.0 122.0 118.0 118.0 118.0 119.0 118.0 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 09:55:54 INFO - PROCESS | 12434 | Values: 149.0 148.0 148.0 147.0 149.0 149.0 148.0 147.0 149.0 148.0 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:55:54 INFO - PROCESS | 12434 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:1.07 (1.7%) stddev-sans-first:0.97 09:55:54 INFO - PROCESS | 12434 | Values: 63.0 65.0 64.0 65.0 67.0 64.0 64.0 65.0 65.0 64.0 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:66.00 stddev:2.56 (3.9%) stddev-sans-first:2.71 09:55:54 INFO - PROCESS | 12434 | Values: 67.0 66.0 65.0 66.0 66.0 66.0 66.0 66.0 67.0 74.0 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:2.76 (3.4%) stddev-sans-first:2.92 09:55:54 INFO - PROCESS | 12434 | Values: 81.0 80.0 79.0 81.0 83.0 85.0 80.0 79.0 87.0 79.0 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | [#11] stanford-crypto-ccm Cycles:10 Average:141.80 Median:138.00 stddev:14.97 (10.8%) stddev-sans-first:15.87 09:55:54 INFO - PROCESS | 12434 | Values: 143.0 132.0 138.0 131.0 138.0 138.0 153.0 133.0 180.0 132.0 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:169.50 stddev:2.46 (1.5%) stddev-sans-first:2.44 09:55:54 INFO - PROCESS | 12434 | Values: 166.0 167.0 170.0 170.0 167.0 167.0 169.0 165.0 172.0 172.0 09:55:54 INFO - PROCESS | 12434 | 09:55:54 INFO - PROCESS | 12434 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:2.08 (3.1%) stddev-sans-first:2.18 09:55:54 INFO - PROCESS | 12434 | Values: 67.0 69.0 68.0 69.0 73.0 67.0 66.0 67.0 67.0 66.0 09:55:54 INFO - PROCESS | 12434 | -------- Summary: end -------- 09:55:54 INFO - PROCESS | 12434 | 09:55:55 INFO - TEST-INFO | 12434: exit 0 09:55:56 INFO - TEST-OK | kraken | took 64418ms 09:55:56 INFO - SUITE-END | took 1182s 09:55:56 INFO - Completed test suite (00:19:42) 09:55:56 INFO - javascript benchmark 09:55:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6511.1941197023225, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2625.1074634624224, 2643.5902435122557, 2655.229983304842, 2681.4905168018063, 2682.4635072985384, 4774.355462012627, 4848.345473361095, 4851.199552073908, 4908.8281910133155, 4946.812764936416, 4650.44194696636, 4769.379980602525, 4781.784819683114, 4809.591184749301, 4816.0, 4377.299632058871, 4392.868213953587, 4496.348029535716, 4530.252508336137, 4546.136234115507, 4416.80124394403, 4440.55594440555, 4458.308962110894, 4514.097180563884, 4563.087382523492, 4274.764887931163, 4347.5652434756585, 4365.628921541673, 4396.846110386153, 4467.24056910326, 4357.978210108961, 4401.779911004437, 4473.217186992263, 4474.9776251118865, 4502.0, 4452.910941781146, 4458.08609235106, 4460.264056430685, 4465.754383508905, 4500.437445319335, 4785.401824771903, 4842.055799119174, 4844.854654360375, 4880.707157570557, 4885.193942999401, 5183.3002544656365, 5195.870103247411, 5203.895922081575, 5218.191180367049, 5246.265522826808, 5036.7733451994745, 5123.564497017758, 5248.291480650101, 5248.501392367719, 5250.6324557281005, 4787.6409269304595, 4829.13075646387, 4847.418309802846, 4850.393700787402, 4854.271859221074, 5282.339707536558, 5294.49702278283, 5297.17893726473, 5305.151175811851, 5313.07021271276, 4831.0, 4947.901041979212, 4984.925226121611, 5016.147254966664, 5074.4671809460215, 4934.827281045218, 5101.132807422747, 5110.4634013428795, 5142.61430392722, 5168.405633352213, 4936.975315123402, 4993.725345106054, 5048.646594738333, 5070.898582028339, 5079.796808127633, 5043.067032598908, 5106.617003724736, 5111.97444012785, 5117.002184573972, 5162.664426812245, 4216.009237829107, 4295.892602684958, 4315.870523884289, 4320.589543993316, 4413.801378937956, 3759.0978165240144, 3766.8304926278383, 3771.453139294787, 3805.8477660893254, 3815.256025075084, 4282.828686852553, 4345.391645169679, 4353.3469979503325, 4354.281543545343, 4390.1000294940095, 5016.54851063406, 5049.495050494921, 5081.390233172043, 5097.337346144977, 5102.515261050195, 4312.180685669713, 4353.390525326457, 4354.934675979863, 4365.781710914442, 4402.141582391467, 4454.153710794939, 4615.446146462446, 4618.445786505641, 4622.214223581999, 4659.114768194032, 4801.303810947463, 4832.468428472795, 4852.344933434082, 4872.707637541759, 4885.462599114166, 5199.818006369759, 5204.37547494288, 5219.739013049409, 5238.738063096906, 5250.816221432385, 4763.380760501252, 4792.544708252711, 4841.0, 4857.697509269709, 4862.6839255448285, 5061.114304996685, 5097.464766199496, 5100.413452453015, 5104.336436263262, 5139.794408223779, 5170.819021334235, 5172.069027574922, 5172.431032586488, 5213.0, 5223.7910483580235, 4908.386451693538, 4958.2810492477665, 4981.402231732215, 5005.299258103795, 5027.396712394536, 4854.2233242681, 4925.16272233714, 4939.950600493949, 5003.124453220745, 5033.924491132562, 4874.098291816025, 4875.902481950412, 4904.239842824368, 4931.3096166536, 4943.382077240345, 5025.597952163891, 5038.244263360525, 5040.34475518195, 5048.671836330626, 5099.515546023122, 4808.942032752789, 4884.438289596742, 4918.0, 4935.259711043373, 4982.62630302736], "value": 4710.226390508051, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.4637594285429, 566.5552541255115, 567.5601408908095, 574.7413663851265, 593.2169536212197, 35129.47305790412, 39624.20751584967, 39634.2073158537, 39688.80155599225, 39719.40420893689, 39391.0, 39517.40723889137, 39552.60447395525, 39592.60407395925, 39686.60313396865, 7757.379409647228, 7877.921220787776, 7880.64537095832, 7894.0, 7923.247291507327, 7761.844763104735, 7847.64685589147, 7853.999999999972, 7861.606919653995, 7882.960585197066, 7827.3346765525, 7862.174471680477, 7909.564973926432, 7914.40641951853, 7934.801629959239, 7808.0, 7840.960795195988, 7851.293383595504, 7882.448228623999, 7884.842303153905, 7678.078630564312, 7754.457187996843, 7774.65014074368, 7816.72641457552, 7836.177201393885, 37936.241275174616, 38155.61844381548, 38194.61805381939, 38207.235855282735, 38293.0, 2630.973690263111, 2933.3839893622367, 3044.9543256851166, 3088.1044497095813, 3131.671174526665, 25539.23382298534, 26544.60183097255, 27345.86327068352, 27389.31526711848, 27646.447071058465, 3347.196672798511, 3396.1679388549715, 3412.4710669846213, 3420.863165473403, 3422.418188907867, 237118.0, 237944.0, 238085.0, 238820.80589597113, 239553.0, 31190.22024449407, 31521.52717709236, 31907.840460798012, 31929.36141277208, 31938.0, 31741.523877141863, 33074.17314567155, 33142.502862457084, 33156.17109572232, 33238.66761332404, 13676.179429234278, 14059.507917222849, 14086.013979021574, 14100.435982560788, 14132.081414708216, 11504.25222360544, 11711.063114950783, 11726.648200553997, 11765.705857353463, 11782.528698852122, 7613.0, 7692.7692169235015, 7743.264389882952, 7757.68969241224, 7776.844463110706, 2968.9703102969124, 3076.35396566719, 3086.861091250899, 3109.657937626859, 3158.0, 909.231699214163, 920.7790130368663, 990.5493000684816, 1012.2559918459926, 1013.6553571785628, 27394.5890811638, 28571.428571428456, 28629.0, 28932.42135157327, 29056.564151537743, 895.3777124898133, 962.4898803634085, 987.4766373821886, 1000.554753134848, 1006.7734759679014, 14302.642433939234, 14439.205843678488, 14640.707185856223, 14899.627509312353, 14994.100353978796, 396637.0, 402362.0, 403158.0, 404134.0, 404909.0, 48147.0, 48323.27515087206, 48500.27249591259, 48578.27132592943, 48920.75539622279, 1164.6040346282305, 1200.5557943560939, 1217.0385395537426, 1221.8717034711406, 1236.1285293867982, 26274.4745105093, 27215.86392068027, 27422.72577274202, 27458.862705687145, 27584.448311033266, 42282.78858605687, 42354.152916942105, 42691.57308426876, 43012.78493607512, 43146.568534314254, 295425.0, 295782.0, 296675.0, 297261.0, 297755.0, 24459.0, 24574.754252457962, 24735.505289893743, 24769.380765481008, 24900.750992489844, 40347.0, 40579.79710101431, 40775.59224407718, 40921.0, 41090.79454602708, 35846.28307433889, 36307.45538816867, 36345.0, 36436.45345319769, 36750.26499470049, 35734.4639830408, 35912.0, 36067.81966090153, 36551.0, 36717.44923826091, 29408.55887161737, 34137.31725365429, 34197.487037694955, 35093.29813403769, 35221.29557408786, 30688.84655576708, 32175.67824321727, 32263.838680806446, 32643.0, 32702.509462357608, 24867.502649947262, 25191.37021574475, 25503.0, 25543.23370298894, 27402.177934661195], "value": 16142.980591934753, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.4517314374725, 374.9793761343126, 375.53621277722027, 380.3951716770335, 389.4722650808155, 16378.590535236624, 16668.499945001655, 17375.391861284857, 17919.462416127506, 17933.013684247362, 17492.56268593286, 18166.0, 18348.816511834877, 18416.447506574823, 19453.416397508063, 5906.409359064091, 6067.514598832105, 6127.111568822518, 6142.201513803199, 6155.446009859112, 5831.387704291052, 5974.820755377345, 6006.21919150512, 6034.5172386209215, 6044.274687037561, 5978.521718262528, 5994.97002514989, 6010.278766547998, 6025.668588227646, 6039.094135879609, 6393.648349340784, 6757.425618822406, 6763.053172555846, 6833.863322733518, 6835.58986460814, 6502.089707440962, 6561.606303621798, 6605.042268871035, 6852.588844669286, 7049.083619129532, 23649.645255321186, 24408.755912440825, 25069.749302506923, 25352.873235633888, 25375.492490150278, 1975.3185151122839, 2084.291340944086, 2577.87110644467, 2668.919932402031, 2699.20373489821, 14878.181700006495, 15068.397264109532, 15247.085174889431, 15468.22658867052, 15624.687506249926, 1785.7053586158397, 1857.136431559318, 1870.5510677437317, 1873.5503479165038, 1885.4532185666278, 70607.0, 81948.59025704893, 87020.56489717575, 88075.0, 88224.5588772052, 16492.752608710878, 16892.550580166055, 16922.91538542324, 17023.0, 17106.230219640147, 29957.40085198284, 30281.394372112434, 30303.848480757457, 30306.84846575753, 30369.696303036686, 8668.219860212612, 9180.8622870657, 9242.81514369709, 9253.629854805868, 9322.487263200454, 7478.663460144197, 7494.100707915085, 7560.773176804704, 7672.194419585975, 7672.61636918163, 8230.917690823015, 8305.961754780652, 8466.534340611326, 8585.656573737106, 8634.740957771277, 3031.5604237385455, 3263.3450535400502, 3284.490903909898, 3415.9316813664086, 3448.793072415663, 801.5230937592123, 886.8581027035773, 918.2103391083663, 977.1205914676706, 983.8475036369374, 17251.703128358058, 18102.5474363142, 18193.727094093334, 18210.180541875383, 18459.72310415318, 850.2008112374348, 861.2765277167084, 870.8214815962713, 874.9431286966327, 942.4580866002076, 9654.613815447303, 10018.0, 10057.0, 10096.747581310527, 10193.592256309665, 417826.7716535433, 420054.0, 420179.0, 423289.0, 423496.0, 57358.42641573615, 70439.77361358335, 73135.26864731284, 85008.0, 85576.0, 909.7581800841804, 921.8478950973015, 931.7763736703278, 934.8504239321676, 938.2915898496591, 16044.67910641804, 16078.919605401898, 16221.837781622506, 16484.587885302484, 16756.497305080866, 35520.46719299264, 37208.62791372051, 37306.88079357624, 37495.81252093722, 38235.0, 50592.241116382545, 53801.19298210452, 54491.182632259755, 54577.0, 54889.0, 7543.849123017619, 7562.0925488941675, 7646.808829779077, 7741.380689544711, 7806.531608103532, 11471.139664525028, 11728.882711172779, 11769.941150294193, 12097.395130243629, 12429.689257768629, 10612.681619551426, 10803.297785643908, 10825.512851921525, 10910.618128365786, 11130.0, 10368.637097701545, 10479.738006549896, 10746.785064298827, 10764.677059688222, 10856.480092786858, 10437.425941573287, 10575.841362379724, 11035.503402346752, 11284.830727538929, 11318.207725459139, 7496.4002879768395, 7534.698612055676, 7650.6174691264105, 7653.617319134132, 7987.40094492927, 8533.615987280711, 8808.603612837309, 10833.620823271463, 10926.726831829268, 11084.944575277072], "value": 9560.075106583543, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.2499437806398, 1409.1615488784173, 1487.0, 1716.2362748576888, 1735.2278236184886, 6569.146011018573, 7326.670299836507, 7402.814929626762, 7864.056313242412, 7886.093099293583, 7507.0, 7638.503497272687, 7711.267429594193, 7749.186335434769, 7776.533407995525, 2168.544605632815, 2195.209724499179, 2198.5712786006734, 2199.846010779246, 2204.7684993075736, 2155.461134716321, 2164.5021645021657, 2219.9001044953015, 2220.3006053093304, 2220.85564438311, 2190.167736260219, 2192.8355373346985, 2200.0869639099756, 2201.2625770366867, 2204.019211450905, 2080.365488525999, 2095.308548179097, 2096.612126756555, 2098.9580208395823, 2100.2859027930576, 2088.404804630673, 2155.385715071197, 2158.6546152615506, 2160.7947245011856, 2162.9891850540803, 7747.0, 7755.612219389008, 7802.33680137189, 7822.452428330019, 7850.607469626496, 4606.124836281129, 4720.103180395714, 4742.620590352763, 4749.715017098985, 4752.310914917352, 2820.1539538138477, 2883.942321153565, 2926.5756465312625, 2930.7069293070736, 2970.970290297091, 918.6417297254076, 923.8983711791698, 924.3021518753366, 953.9332246742731, 956.7703751099685, 10440.68677939663, 10484.842727359095, 10509.159267258678, 10516.47417629123, 10548.94725526375, 4087.448194493705, 4161.3549899765585, 4299.290617048215, 4343.913121737548, 4350.695451318377, 8984.05667404913, 9029.864552031724, 9049.366544341965, 9060.320475964329, 9072.04743501936, 4785.449673287547, 4791.856244312677, 4800.639952003614, 4804.8318308859025, 4806.303086052503, 3545.450455179451, 4192.329227323614, 4354.760488173181, 4358.738475691469, 4374.212641724456, 3709.9072523187137, 3718.2935242303874, 3820.2168555446065, 3830.6552410283207, 3837.9040523986564, 1212.5271144253747, 1214.678110300771, 1223.424990254579, 1230.1081715756006, 1242.3043095866344, 742.6992068212382, 822.5393779483509, 847.6863560482661, 865.6191275838611, 892.3441270666056, 5363.651362661414, 5463.0, 5470.398256191816, 5493.642913210629, 5513.724313784375, 398.4998826472758, 398.6890225624018, 399.26933711308817, 404.0988595432144, 408.98159582818846, 3836.5971572984995, 3859.591249194024, 3872.690184785267, 3934.252492026506, 3961.1087505311075, 9292.95353523228, 9493.240540756722, 9671.951640241754, 9716.31985761004, 9734.951325243328, 9551.0, 9559.474228917476, 9643.807123857623, 9691.854622180674, 9732.0, 7275.199728029913, 7299.270072992765, 7312.268773122645, 7339.522931009467, 7354.3748781353115, 5242.606804489602, 5317.548008419328, 5395.622306438511, 5407.648502847303, 5530.05988981866, 9003.14470125337, 9036.412633178823, 9061.68284110053, 9072.183503484453, 9127.908720912972, 8293.295069919124, 8571.95714021426, 8620.094890036708, 8895.599698013735, 9095.49974751395, 6058.303295121117, 6689.899651505134, 6881.208661003849, 6909.516333856783, 6992.2308546058875, 7621.771346859603, 7659.961700191687, 7675.462717609714, 7696.230376962483, 7740.148583655906, 6688.966555167193, 6744.831379215362, 6923.688434020582, 6935.375816176366, 7040.929590704028, 6923.82690432723, 6936.549124306904, 6974.825629359307, 6998.475114366341, 7010.614416206953, 6270.184875966278, 6308.179936608211, 6342.587731797418, 6383.744650214126, 6473.676316184266, 4735.076660051257, 4742.241241401359, 4794.976025119852, 4828.589569886599, 4858.611311095033, 4867.245576935581, 4869.732164730974, 4888.804447822047, 4901.14230009754, 4918.385201849769], "value": 4102.276769747734, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.54165210532096, 307.66157227050235, 310.40402427339507, 310.9860056297469, 313.6831799882119, 5041.571466425354, 5061.721605311711, 5067.442581316052, 5070.011347787183, 5070.138076526985, 4974.228994505848, 4995.500449955002, 4995.650304478688, 5006.173981293082, 5021.673591216569, 3718.4236443351188, 3845.365514690087, 3902.4926759521363, 3916.2167566486673, 3922.431247469115, 3931.5427857589007, 3948.6643635291034, 3955.7626542407547, 3962.544307404642, 3966.5636779954325, 3938.350172221594, 3945.230680017398, 3960.7623542587394, 3965.385365268374, 3976.369688427745, 3810.3209477974206, 3909.9218015639813, 3942.960570394288, 3946.9210615787665, 3964.0288129408336, 3444.293919746446, 3463.7229021678204, 3465.4108801503803, 3473.7221022318154, 3482.4428091505238, 4808.639352048575, 4810.326554282403, 4822.9758851205515, 4833.613310935117, 4898.118338699069, 4392.78036098197, 4475.433598240622, 4480.731156130642, 4481.865544033684, 4552.157850797613, 5213.556847667915, 5226.477352264781, 5236.502532259429, 5244.056069907415, 5274.894502109936, 3808.5810560838563, 3810.0, 3820.9617903820886, 3822.120912190212, 3828.846846126152, 5451.291332126838, 5456.017916774979, 5465.754041068161, 5492.615516913817, 5498.422665620133, 3562.5012498250267, 3755.4366844972924, 3762.5484941806612, 3765.284595926765, 3768.2086761780333, 3818.3508803503473, 3824.78963656996, 3829.463875057494, 3837.1174629835295, 3849.1531862990096, 4402.965303153756, 4404.581564751344, 4410.779461026936, 4422.624076953495, 4434.11317736454, 5171.4052883918075, 5227.895442091137, 5279.630425870229, 5315.28243687105, 5329.120695085345, 1308.913601710578, 1326.5821266301084, 1332.9000324975666, 1335.6927906581345, 1338.772408690525, 824.5588610093571, 825.224289168192, 841.1966571923798, 855.9771073567152, 859.6819176904586, 4438.667099967515, 4560.635149188057, 4565.56627120423, 4582.243929751554, 4599.724016559017, 5411.431799661058, 5416.756245968941, 5418.103663717746, 5433.8369848904595, 5440.782368705287, 4414.27164517851, 4566.70316429431, 4580.541945805459, 4591.586757191802, 4630.32860235264, 2887.985560072186, 2890.8265504069823, 2900.1589539033444, 2903.912882613525, 2917.197770613056, 5062.430646499597, 5074.594032477393, 5084.796608135707, 5085.567726743268, 5088.338515992898, 5423.823655785102, 5455.427180146107, 5503.532199763065, 5510.448955104457, 5541.390447050821, 5020.974895125574, 5033.345665063592, 5037.697738135724, 5039.941612261467, 5049.469805670426, 5398.730063496888, 5413.431589683027, 5414.269073675161, 5424.810131645373, 5456.980917060713, 5000.449950505515, 5285.841424757264, 5295.7616907240035, 5299.735013249399, 5301.443348448512, 4976.850694479172, 4981.153203955264, 5013.774380152829, 5029.371328583927, 5029.698218106925, 3740.8690695825517, 3756.441076953034, 3759.6240375962184, 3761.1725420407465, 3771.717121215865, 5166.509181627739, 5393.029254734185, 5424.0, 5425.321834770653, 5462.371827239918, 5301.920471193012, 5307.734613269244, 5314.97342513285, 5315.3090098286975, 5332.30680011596, 5264.210368444611, 5271.604629652715, 5323.946760532345, 5354.46455354477, 5364.919526207188, 5151.330327057459, 5213.713245771367, 5226.947730522646, 5250.264962905273, 5251.973740131275, 5072.391313042459, 5177.430482646982, 5271.420143784104, 5302.496262855023, 5303.893922121613, 5177.275181474522, 5193.662411943212, 5210.47895210476, 5214.687118772886, 5223.216517522402], "value": 3949.023293431392, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.5766478794418, 627.244170774217, 646.7057488842574, 712.319734653406, 727.83987522745, 12092.939535302323, 12883.80674289884, 12926.09517333787, 12954.870451295485, 12959.222446653208, 12262.202956807801, 12272.32502212378, 12302.200356976813, 13391.464341426332, 13941.372638231278, 605.5276884030463, 756.9810754731135, 776.6932061835572, 777.7666699990009, 779.2052106851008, 753.4386881773087, 777.9494332868373, 778.0080397493185, 778.2373274191295, 781.6912319633741, 812.743985644523, 817.3012074676155, 819.5041999590252, 819.9959000205021, 821.0311832038193, 811.6307080278459, 812.3379445751693, 812.7196117339538, 813.1868131868132, 814.1004190369615, 598.3119412675458, 598.9131575921467, 599.1671576508656, 599.6042611876185, 600.4205941266698, 13842.723145537033, 13880.375383107785, 13888.0, 13914.0, 13921.373538190806, 12496.500139994389, 12639.0, 12679.619611411672, 12840.1011929165, 12868.742625147539, 10215.0, 10442.425666588335, 10498.055175034207, 10592.735181620445, 10656.147508199325, 3251.8048917065053, 3282.5404443377706, 3306.156929982839, 3308.7022168004996, 3376.5948086229564, 60194.699026505026, 60472.69763651198, 60715.39284607186, 60775.392246077856, 61021.999999999556, 9864.210863130933, 10035.849462258071, 10203.489825508696, 10266.486675666187, 10331.0, 16776.748348774778, 17041.82958170427, 17170.656586868194, 17183.484495465156, 17232.052237126827, 6647.069410282565, 6802.727890884309, 6990.405815505637, 6999.825004374829, 7005.334493223136, 3691.2248427830455, 3778.301014312361, 3785.5078839750654, 3793.2223894101644, 3826.732128750961, 2724.972750272472, 2850.9572356414255, 2853.9429211415654, 2856.7857410694282, 2862.084133077437, 509.06586413930853, 510.7701534309576, 553.090166675816, 574.8993926062923, 598.4135547163804, 566.2016556655179, 601.6209787833724, 613.1201725523888, 619.2043224456552, 628.205320269859, 8123.6750529978135, 8151.0, 8275.337972962148, 8367.95816020916, 8534.402591818638, 577.3562477837265, 577.982660520185, 580.0601837187173, 591.7100620695828, 597.3220394851875, 4141.81361838718, 4171.165766846643, 4191.245575796325, 4250.3199488081755, 4294.312909934395, 97147.0, 105863.0, 108215.45892270489, 108287.45856270668, 109091.0, 95634.52182739042, 95643.52178239204, 96013.0, 96028.51985740027, 96724.51637741766, 50387.0, 50428.24357634639, 50720.492795072314, 79160.20839791643, 79194.20805791984, 7733.651985660546, 7878.448508604342, 8022.679092836222, 8039.437239393186, 8268.37987150954, 49827.50172498373, 49842.75078624584, 50702.49297506978, 51421.48578514167, 53050.4694953061, 66851.0, 72198.0, 72293.63853180701, 73324.0, 73741.0, 10276.486175691334, 10310.226732994905, 10364.222683298933, 10416.270861039655, 10760.784784304427, 11635.185537012328, 11780.764384712087, 11861.525538978343, 11892.940535297268, 11967.401629918644, 10501.684949451528, 10711.08955738771, 11023.173262005543, 11249.212555121063, 11754.0, 9905.752356191153, 10065.396076235449, 10084.14284785772, 10218.489075546044, 10485.21360897951, 9792.0, 9919.801603968024, 10161.847572286273, 10333.276670632984, 10496.790064198825, 7957.562334071682, 8255.876161857457, 8402.663893444194, 8421.0, 8614.741557753277, 8784.253338466046, 8896.955515222382, 8998.325125615474, 9122.954385228031, 9174.128457796498], "value": 6470.161341963862, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 110.0, 117.0, 114.0, 118.0, 116.0, 115.0, 116.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 128.0, 153.0, 178.0, 125.0, 151.0, 156.0, 127.0, 184.0, 126.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 167.0, 174.0, 165.0, 164.0, 163.0, 164.0, 165.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 152.0, 79.0, 77.0, 76.0, 79.0, 169.0, 77.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 139.0, 87.0, 86.0, 86.0, 129.0, 86.0, 85.0, 139.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 122.0, 118.0, 118.0, 118.0, 119.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 147.0, 149.0, 149.0, 148.0, 147.0, 149.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 65.0, 67.0, 64.0, 64.0, 65.0, 65.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 74.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 81.0, 83.0, 85.0, 80.0, 79.0, 87.0, 79.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 132.0, 138.0, 131.0, 138.0, 138.0, 153.0, 133.0, 180.0, 132.0], "value": 141.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 170.0, 170.0, 167.0, 167.0, 169.0, 165.0, 172.0, 172.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 69.0, 73.0, 67.0, 66.0, 67.0, 67.0, 66.0], "value": 67.9, "unit": "score"}]}]} 09:55:56 INFO - Return code: 0 09:55:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:55:56 ERROR - # TBPL SUCCESS # 09:55:56 INFO - Running post-action listener: _resource_record_post_action 09:55:56 INFO - ##### 09:55:56 INFO - ##### Finished run-tests step (success) 09:55:56 INFO - ##### 09:55:56 INFO - Running post-run listener: _resource_record_post_run 09:55:56 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 548077568; Read time: 0; Write time: 666272 09:55:56 INFO - TinderboxPrint: CPU usage
13.3% 09:55:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:55:56 INFO - TinderboxPrint: I/O write bytes / time
548,077,568 / 666,272 09:55:56 INFO - TinderboxPrint: CPU idle
8,290.7 (86.6%) 09:55:56 INFO - TinderboxPrint: CPU user
1,223.0 (12.8%) 09:55:56 INFO - TinderboxPrint: Swap in / out
0 / 0 09:55:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246677504; Read time: 0; Write time: 401004 09:55:56 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 300785664; Read time: 0; Write time: 265268 09:55:56 INFO - Running post-run listener: _upload_blobber_files 09:55:56 INFO - Blob upload gear active. 09:55:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:55:56 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 09:55:56 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'] 09:55:56 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 09:55:57 INFO - (blobuploader) - INFO - Open directory for files ... 09:55:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:55:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:55:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:58 INFO - (blobuploader) - INFO - Done attempting. 09:55:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:55:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:56:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:03 INFO - (blobuploader) - INFO - Done attempting. 09:56:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:56:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:56:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:04 INFO - (blobuploader) - INFO - Done attempting. 09:56:04 INFO - (blobuploader) - INFO - Iteration through files over. 09:56:04 INFO - Return code: 0 09:56:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:56:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:56:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac1e603d0bb741d4604148e55c38f91f4d12f4a4d07825df8d0e29fd4fd50231c650d65d6edae69cb168f5c0d2e76bc1471211bc5b45d52bfc06ae9410c18d76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/445300ca6df15d9b1e0acdadcd17bac7c69be4059cbaf49c6edb4839efe34ab368f883b5893794b09753e21540d1a7c514dda19aa82fd7e9cbdb246b3ce3bf53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5b6c40fe1e3a030c49156de2e90dcf987ecb56c16773dbde7ecaa261c0380708511358a231ffcc74a0840d2b4f894a7eaec83e88509f75cee3cc2c4aa736d1a"} 09:56:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:56:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:56:04 INFO - Contents: 09:56:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac1e603d0bb741d4604148e55c38f91f4d12f4a4d07825df8d0e29fd4fd50231c650d65d6edae69cb168f5c0d2e76bc1471211bc5b45d52bfc06ae9410c18d76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/445300ca6df15d9b1e0acdadcd17bac7c69be4059cbaf49c6edb4839efe34ab368f883b5893794b09753e21540d1a7c514dda19aa82fd7e9cbdb246b3ce3bf53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5b6c40fe1e3a030c49156de2e90dcf987ecb56c16773dbde7ecaa261c0380708511358a231ffcc74a0840d2b4f894a7eaec83e88509f75cee3cc2c4aa736d1a"} 09:56:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:56:04 INFO - Copying logs to upload dir... 09:56:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:56:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.549394 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-18 09:56:03.039556) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 09:56:03.043342) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290 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/ac1e603d0bb741d4604148e55c38f91f4d12f4a4d07825df8d0e29fd4fd50231c650d65d6edae69cb168f5c0d2e76bc1471211bc5b45d52bfc06ae9410c18d76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/445300ca6df15d9b1e0acdadcd17bac7c69be4059cbaf49c6edb4839efe34ab368f883b5893794b09753e21540d1a7c514dda19aa82fd7e9cbdb246b3ce3bf53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5b6c40fe1e3a030c49156de2e90dcf987ecb56c16773dbde7ecaa261c0380708511358a231ffcc74a0840d2b4f894a7eaec83e88509f75cee3cc2c4aa736d1a"} build_url:https://queue.taskcluster.net/v1/task/cLtqST64Q-C6nfqom2D68g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/cLtqST64Q-C6nfqom2D68g/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/ac1e603d0bb741d4604148e55c38f91f4d12f4a4d07825df8d0e29fd4fd50231c650d65d6edae69cb168f5c0d2e76bc1471211bc5b45d52bfc06ae9410c18d76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/445300ca6df15d9b1e0acdadcd17bac7c69be4059cbaf49c6edb4839efe34ab368f883b5893794b09753e21540d1a7c514dda19aa82fd7e9cbdb246b3ce3bf53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5b6c40fe1e3a030c49156de2e90dcf987ecb56c16773dbde7ecaa261c0380708511358a231ffcc74a0840d2b4f894a7eaec83e88509f75cee3cc2c4aa736d1a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 09:56:03.068942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 09:56:03.069256) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468859525.543562-2020613290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 09:56:03.153125) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 09:56:03.153597) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 09:56:03.154029) ========= ========= Total master_lag: 0.16 =========