builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1467867707.62 results: success (0) buildid: 20160706212122 builduid: 68a26aaddb1640da99369ab1290ad97e revision: e178424c2e2a702ff2c7738e639c59bbed5a17cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 22:01:47.620536) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 22:01:47.621039) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 22:01:47.621329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 22:01:47.638455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:01:47.638863) ========= 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=d2a8c569965ab8367867b893000001a1-1467867707.199368-22513771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 22:01:48-- 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% 111M=0s 2016-07-06 22:01:48 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097232 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:01:47.750500) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:01:47.750858) ========= 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=d2a8c569965ab8367867b893000001a1-1467867707.199368-22513771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017581 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:01:47.801544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 22:01:47.801926) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e178424c2e2a702ff2c7738e639c59bbed5a17cf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e178424c2e2a702ff2c7738e639c59bbed5a17cf --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=d2a8c569965ab8367867b893000001a1-1467867707.199368-22513771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 22:01:48,265 truncating revision to first 12 chars 2016-07-06 22:01:48,265 Setting DEBUG logging. 2016-07-06 22:01:48,265 attempt 1/10 2016-07-06 22:01:48,265 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e178424c2e2a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 22:01:49,044 unpacking tar archive at: fx-team-e178424c2e2a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.201586 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 22:01:49.017521) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 22:01:49.017897) ========= script_repo_revision: e178424c2e2a702ff2c7738e639c59bbed5a17cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 22:01:49.018330) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 22:01:49.018638) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 22:01:49.027593) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 20 secs) (at 2016-07-06 22:01:49.027996) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=d2a8c569965ab8367867b893000001a1-1467867707.199368-22513771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:01:49 INFO - MultiFileLogger online at 20160706 22:01:49 in /builds/slave/test 22:01:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:01:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:01:49 INFO - {'append_to_log': False, 22:01:49 INFO - 'base_work_dir': '/builds/slave/test', 22:01:49 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:01:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:01:49 INFO - 'branch': 'Fx-Team-Non-PGO', 22:01:49 INFO - 'buildbot_json_path': 'buildprops.json', 22:01:49 INFO - 'config_files': ('talos/linux_config.py',), 22:01:49 INFO - 'default_actions': ('clobber', 22:01:49 INFO - 'read-buildbot-config', 22:01:49 INFO - 'download-and-extract', 22:01:49 INFO - 'populate-webroot', 22:01:49 INFO - 'create-virtualenv', 22:01:49 INFO - 'install', 22:01:49 INFO - 'run-tests'), 22:01:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:01:49 INFO - 'download_minidump_stackwalk': True, 22:01:49 INFO - 'download_symbols': 'ondemand', 22:01:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:01:49 INFO - 'tooltool.py': '/tools/tooltool.py', 22:01:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:01:49 INFO - '/tools/misc-python/virtualenv.py')}, 22:01:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:01:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:01:49 INFO - 'installer_path': 'installer.exe', 22:01:49 INFO - 'log_level': 'info', 22:01:49 INFO - 'log_name': 'talos', 22:01:49 INFO - 'log_to_console': True, 22:01:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:01:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:01:49 INFO - 'opt_config_files': (), 22:01:49 INFO - 'pip_index': False, 22:01:49 INFO - 'sps_profile': False, 22:01:49 INFO - 'sps_profile_interval': 0, 22:01:49 INFO - 'suite': 'dromaeojs-e10s', 22:01:49 INFO - 'system_bits': '32', 22:01:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:01:49 INFO - 'title': 'talos-linux64-ix-043', 22:01:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:01:49 INFO - 'use_talos_json': True, 22:01:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:01:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:01:49 INFO - 'work_dir': 'build'} 22:01:49 INFO - ##### 22:01:49 INFO - ##### Running clobber step. 22:01:49 INFO - ##### 22:01:49 INFO - Running pre-action listener: _resource_record_pre_action 22:01:49 INFO - Running main action method: clobber 22:01:49 INFO - rmtree: /builds/slave/test/build 22:01:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:01:50 INFO - Running post-action listener: _resource_record_post_action 22:01:50 INFO - ##### 22:01:50 INFO - ##### Finished clobber step (success) 22:01:50 INFO - ##### 22:01:50 INFO - ##### 22:01:50 INFO - ##### Running read-buildbot-config step. 22:01:50 INFO - ##### 22:01:50 INFO - Running pre-action listener: _resource_record_pre_action 22:01:50 INFO - Running main action method: read_buildbot_config 22:01:50 INFO - Using buildbot properties: 22:01:50 INFO - { 22:01:50 INFO - "project": "", 22:01:50 INFO - "product": "firefox", 22:01:50 INFO - "script_repo_revision": "production", 22:01:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:01:50 INFO - "repository": "", 22:01:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:01:50 INFO - "buildid": "20160706212122", 22:01:50 INFO - "pgo_build": "False", 22:01:50 INFO - "basedir": "/builds/slave/test", 22:01:50 INFO - "buildnumber": 1421, 22:01:50 INFO - "slavename": "talos-linux64-ix-043", 22:01:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:01:50 INFO - "platform": "ubuntu64_hw", 22:01:50 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:01:50 INFO - "branch": "fx-team", 22:01:50 INFO - "repo_path": "integration/fx-team", 22:01:50 INFO - "revision": "e178424c2e2a702ff2c7738e639c59bbed5a17cf", 22:01:50 INFO - "stage_platform": "linux64", 22:01:50 INFO - "builduid": "68a26aaddb1640da99369ab1290ad97e", 22:01:50 INFO - "slavebuilddir": "test" 22:01:50 INFO - } 22:01:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:01:50 INFO - Running post-action listener: _resource_record_post_action 22:01:50 INFO - ##### 22:01:50 INFO - ##### Finished read-buildbot-config step (success) 22:01:50 INFO - ##### 22:01:50 INFO - ##### 22:01:50 INFO - ##### Running download-and-extract step. 22:01:50 INFO - ##### 22:01:50 INFO - Running pre-action listener: _resource_record_pre_action 22:01:50 INFO - Running main action method: download_and_extract 22:01:50 INFO - mkdir: /builds/slave/test/build/tests 22:01:50 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')]} 22:01:50 INFO - https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:01:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:01:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:01:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:01:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:01:51 INFO - Downloaded 1361 bytes. 22:01:51 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:01:51 INFO - Using the following test package requirements: 22:01:51 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:51 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:01:51 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:01:51 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:51 INFO - u'jsshell-linux-x86_64.zip'], 22:01:51 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:01:51 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:51 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:01:51 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:01:51 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:01:51 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:01:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:01:51 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')]} 22:01:51 INFO - https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:01:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:01:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:01:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:01:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:01:52 INFO - Downloaded 22733087 bytes. 22:01:52 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'] 22:01:52 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 22:01:53 INFO - Return code: 0 22:01:53 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 22:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:53 INFO - https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:01:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:01:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:01:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:01:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:01:54 INFO - Downloaded 22733087 bytes. 22:01:54 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'] 22:01:54 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 22:01:56 INFO - Return code: 0 22:01: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')]} 22:01:56 INFO - https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:01:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:01:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:01:57 INFO - Downloaded 14403333 bytes. 22:01:57 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'] 22:01:57 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 22:01:57 INFO - Return code: 0 22:01:57 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')]} 22:01:57 INFO - https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:01:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:01:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:01:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:01:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:01:58 INFO - Downloaded 56585515 bytes. 22:01:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:01:58 INFO - mkdir: /builds/slave/test/properties 22:01:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:01:58 INFO - Writing to file /builds/slave/test/properties/build_url 22:01:58 INFO - Contents: 22:01:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:01:59 INFO - Running post-action listener: _resource_record_post_action 22:01:59 INFO - Running post-action listener: set_extra_try_arguments 22:01:59 INFO - ##### 22:01:59 INFO - ##### Finished download-and-extract step (success) 22:01:59 INFO - ##### 22:01:59 INFO - ##### 22:01:59 INFO - ##### Running populate-webroot step. 22:01:59 INFO - ##### 22:01:59 INFO - Running pre-action listener: _resource_record_pre_action 22:01:59 INFO - Running main action method: populate_webroot 22:01:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:01:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:01:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:01:59 INFO - '--tppagecycles', 22:01:59 INFO - '7'], 22:01:59 INFO - 'tests': ['tsvgm']}}, 22:01:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:01:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:01:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:01:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:01:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:01:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:01:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:59 INFO - 'talos_options': ['--disable-e10s'], 22:01:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:59 INFO - 'talos_options': ['--disable-e10s'], 22:01:59 INFO - 'tests': ['damp', 'tps']}, 22:01:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:59 INFO - 'tests': ['damp', 'tps']}, 22:01:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:01:59 INFO - 'tests': ['dromaeo_dom']}, 22:01:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:01:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:01:59 INFO - 'tests': ['basic_compositor_video']}, 22:01:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:01:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:01:59 INFO - 'tests': ['a11yr', 22:01:59 INFO - 'ts_paint', 22:01:59 INFO - 'tpaint', 22:01:59 INFO - 'sessionrestore', 22:01:59 INFO - 'sessionrestore_no_auto_restore', 22:01:59 INFO - 'tabpaint']}, 22:01:59 INFO - 'other-e10s': {'tests': ['a11yr', 22:01:59 INFO - 'ts_paint', 22:01:59 INFO - 'tpaint', 22:01:59 INFO - 'sessionrestore', 22:01:59 INFO - 'sessionrestore_no_auto_restore', 22:01:59 INFO - 'tabpaint']}, 22:01:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:01:59 INFO - 'ts_paint', 22:01:59 INFO - 'tpaint', 22:01:59 INFO - 'sessionrestore', 22:01:59 INFO - 'sessionrestore_no_auto_restore', 22:01:59 INFO - 'tabpaint']}, 22:01:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:01:59 INFO - 'ts_paint', 22:01:59 INFO - 'tpaint', 22:01:59 INFO - 'sessionrestore', 22:01:59 INFO - 'sessionrestore_no_auto_restore', 22:01:59 INFO - 'tabpaint']}, 22:01:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:01:59 INFO - 'tests': ['a11yr', 22:01:59 INFO - 'ts_paint', 22:01:59 INFO - 'tpaint', 22:01:59 INFO - 'sessionrestore', 22:01:59 INFO - 'sessionrestore_no_auto_restore', 22:01:59 INFO - 'tabpaint']}, 22:01:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:01:59 INFO - 'tests': ['a11yr', 22:01:59 INFO - 'ts_paint', 22:01:59 INFO - 'tpaint', 22:01:59 INFO - 'sessionrestore', 22:01:59 INFO - 'sessionrestore_no_auto_restore', 22:01:59 INFO - 'tabpaint']}, 22:01:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:01:59 INFO - 'tests': ['tsvgx', 22:01:59 INFO - 'tsvgr_opacity', 22:01:59 INFO - 'tart', 22:01:59 INFO - 'tscrollx', 22:01:59 INFO - 'cart']}, 22:01:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:01:59 INFO - 'tsvgr_opacity', 22:01:59 INFO - 'tart', 22:01:59 INFO - 'tscrollx', 22:01:59 INFO - 'cart']}, 22:01:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:59 INFO - 'talos_options': ['--disable-e10s'], 22:01:59 INFO - 'tests': ['tp5o']}, 22:01:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:59 INFO - 'tests': ['tp5o']}, 22:01:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:59 INFO - 'talos_options': ['--disable-e10s', 22:01:59 INFO - '--xperf_path', 22:01:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:59 INFO - 'tests': ['tp5n']}, 22:01:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:59 INFO - 'talos_options': ['--xperf_path', 22:01:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:59 INFO - 'tests': ['tp5n']}}, 22:01:59 INFO - 'talos.zip': {'path': '', 22:01:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:01:59 INFO - Running post-action listener: _resource_record_post_action 22:01:59 INFO - ##### 22:01:59 INFO - ##### Finished populate-webroot step (success) 22:01:59 INFO - ##### 22:01:59 INFO - ##### 22:01:59 INFO - ##### Running create-virtualenv step. 22:01:59 INFO - ##### 22:01:59 INFO - Running pre-action listener: _resource_record_pre_action 22:01:59 INFO - Running main action method: create_virtualenv 22:01:59 INFO - Creating virtualenv /builds/slave/test/build/venv 22:01:59 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 22:01:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:01:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:01:59 INFO - Using real prefix '/usr' 22:01:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:02:00 INFO - Installing distribute.............................................................................................................................................................................................done. 22:02:02 INFO - Installing pip.................done. 22:02:02 INFO - Return code: 0 22:02:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:02:02 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')]} 22:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:02 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')]} 22:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:02 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 0x1a4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09570>, '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 0x1d0a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a900>, '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': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', '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 22:02:02 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 22:02:02 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 22:02:02 INFO - Using env: {'DISPLAY': ':0', 22:02:02 INFO - 'HOME': '/home/cltbld', 22:02:02 INFO - 'LANG': 'en_US.UTF-8', 22:02:02 INFO - 'LANGUAGE': 'en_US:en', 22:02:02 INFO - 'LOGNAME': 'cltbld', 22:02:02 INFO - 'MAIL': '/var/mail/cltbld', 22:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:02 INFO - 'MOZ_NO_REMOTE': '1', 22:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:02 INFO - 'NO_EM_RESTART': '1', 22:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:02 INFO - 'PWD': '/builds/slave/test', 22:02:02 INFO - 'SHELL': '/bin/bash', 22:02:02 INFO - 'SHLVL': '1', 22:02:02 INFO - 'TERM': 'linux', 22:02:02 INFO - 'TMOUT': '86400', 22:02:02 INFO - 'USER': 'cltbld', 22:02:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', 22:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:02 INFO - '_': '/tools/buildbot/bin/python'} 22:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:02 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 22:02:02 INFO - Cleaning up... 22:02:02 INFO - Return code: 0 22:02:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:02:02 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')]} 22:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:02 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')]} 22:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:02 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 0x1a4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09570>, '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 0x1d0a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a900>, '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': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', '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 22:02:02 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 22:02:02 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 22:02:02 INFO - Using env: {'DISPLAY': ':0', 22:02:02 INFO - 'HOME': '/home/cltbld', 22:02:02 INFO - 'LANG': 'en_US.UTF-8', 22:02:02 INFO - 'LANGUAGE': 'en_US:en', 22:02:02 INFO - 'LOGNAME': 'cltbld', 22:02:02 INFO - 'MAIL': '/var/mail/cltbld', 22:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:02 INFO - 'MOZ_NO_REMOTE': '1', 22:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:02 INFO - 'NO_EM_RESTART': '1', 22:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:02 INFO - 'PWD': '/builds/slave/test', 22:02:02 INFO - 'SHELL': '/bin/bash', 22:02:02 INFO - 'SHLVL': '1', 22:02:02 INFO - 'TERM': 'linux', 22:02:02 INFO - 'TMOUT': '86400', 22:02:02 INFO - 'USER': 'cltbld', 22:02:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', 22:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:02 INFO - '_': '/tools/buildbot/bin/python'} 22:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:02 INFO - Downloading/unpacking psutil>=3.1.1 22:02:02 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 22:02:02 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 22:02:02 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 22:02:02 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 22:02:02 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 22:02:02 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 22:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:02:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:02:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:02:04 INFO - Installing collected packages: psutil 22:02:04 INFO - Running setup.py install for psutil 22:02:04 INFO - building 'psutil._psutil_linux' extension 22:02:04 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 22:02:04 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 22:02:04 INFO - building 'psutil._psutil_posix' extension 22:02:04 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 22:02:05 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 22:02:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:02:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:02:05 INFO - Successfully installed psutil 22:02:05 INFO - Cleaning up... 22:02:05 INFO - Return code: 0 22:02:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:02:05 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')]} 22:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:05 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')]} 22:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:05 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 0x1a4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09570>, '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 0x1d0a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a900>, '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': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', '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 22:02:05 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 22:02:05 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 22:02:05 INFO - Using env: {'DISPLAY': ':0', 22:02:05 INFO - 'HOME': '/home/cltbld', 22:02:05 INFO - 'LANG': 'en_US.UTF-8', 22:02:05 INFO - 'LANGUAGE': 'en_US:en', 22:02:05 INFO - 'LOGNAME': 'cltbld', 22:02:05 INFO - 'MAIL': '/var/mail/cltbld', 22:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:05 INFO - 'MOZ_NO_REMOTE': '1', 22:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:05 INFO - 'NO_EM_RESTART': '1', 22:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:05 INFO - 'PWD': '/builds/slave/test', 22:02:05 INFO - 'SHELL': '/bin/bash', 22:02:05 INFO - 'SHLVL': '1', 22:02:05 INFO - 'TERM': 'linux', 22:02:05 INFO - 'TMOUT': '86400', 22:02:05 INFO - 'USER': 'cltbld', 22:02:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', 22:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:05 INFO - '_': '/tools/buildbot/bin/python'} 22:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:02:05 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 22:02:05 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 22:02:05 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 22:02:05 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 22:02:05 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 22:02:05 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 22:02:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:02:07 INFO - Installing collected packages: mozsystemmonitor 22:02:07 INFO - Running setup.py install for mozsystemmonitor 22:02:07 INFO - Successfully installed mozsystemmonitor 22:02:07 INFO - Cleaning up... 22:02:07 INFO - Return code: 0 22:02:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:07 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 0x1a4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09570>, '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 0x1d0a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a900>, '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': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', '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 22:02:07 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 22:02:07 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 22:02:07 INFO - Using env: {'DISPLAY': ':0', 22:02:07 INFO - 'HOME': '/home/cltbld', 22:02:07 INFO - 'LANG': 'en_US.UTF-8', 22:02:07 INFO - 'LANGUAGE': 'en_US:en', 22:02:07 INFO - 'LOGNAME': 'cltbld', 22:02:07 INFO - 'MAIL': '/var/mail/cltbld', 22:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:07 INFO - 'MOZ_NO_REMOTE': '1', 22:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:07 INFO - 'NO_EM_RESTART': '1', 22:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:07 INFO - 'PWD': '/builds/slave/test', 22:02:07 INFO - 'SHELL': '/bin/bash', 22:02:07 INFO - 'SHLVL': '1', 22:02:07 INFO - 'TERM': 'linux', 22:02:07 INFO - 'TMOUT': '86400', 22:02:07 INFO - 'USER': 'cltbld', 22:02:07 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', 22:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:07 INFO - '_': '/tools/buildbot/bin/python'} 22:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:07 INFO - Downloading/unpacking jsonschema==2.5.1 22:02:07 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 22:02:07 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 22:02:07 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 22:02:07 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 22:02:07 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 22:02:07 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 22:02:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:02:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:02:09 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 22:02:09 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 22:02:09 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 22:02:09 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 22:02:09 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 22:02:09 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 22:02:10 INFO - Downloading functools32-3.2.3-2.tar.gz 22:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:02:10 INFO - warning: no files found matching '*.txt' 22:02:10 INFO - no previously-included directories found matching 'build' 22:02:10 INFO - no previously-included directories found matching 'dist' 22:02:10 INFO - no previously-included directories found matching '.git*' 22:02:10 INFO - Installing collected packages: jsonschema, functools32 22:02:10 INFO - Running setup.py install for functools32 22:02:10 INFO - warning: no files found matching '*.txt' 22:02:10 INFO - no previously-included directories found matching 'build' 22:02:10 INFO - no previously-included directories found matching 'dist' 22:02:10 INFO - no previously-included directories found matching '.git*' 22:02:10 INFO - Successfully installed jsonschema functools32 22:02:10 INFO - Cleaning up... 22:02:10 INFO - Return code: 0 22:02:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:10 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 0x1a4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09570>, '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 0x1d0a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a900>, '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': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', '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 22:02:10 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 22:02:10 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 22:02:10 INFO - Using env: {'DISPLAY': ':0', 22:02:10 INFO - 'HOME': '/home/cltbld', 22:02:10 INFO - 'LANG': 'en_US.UTF-8', 22:02:10 INFO - 'LANGUAGE': 'en_US:en', 22:02:10 INFO - 'LOGNAME': 'cltbld', 22:02:10 INFO - 'MAIL': '/var/mail/cltbld', 22:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:10 INFO - 'MOZ_NO_REMOTE': '1', 22:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:10 INFO - 'NO_EM_RESTART': '1', 22:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:10 INFO - 'PWD': '/builds/slave/test', 22:02:10 INFO - 'SHELL': '/bin/bash', 22:02:10 INFO - 'SHLVL': '1', 22:02:10 INFO - 'TERM': 'linux', 22:02:10 INFO - 'TMOUT': '86400', 22:02:10 INFO - 'USER': 'cltbld', 22:02:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', 22:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:10 INFO - '_': '/tools/buildbot/bin/python'} 22:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:10 INFO - Downloading/unpacking blobuploader==1.2.4 22:02:10 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 22:02:10 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 22:02:10 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 22:02:10 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 22:02:10 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 22:02:10 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 22:02:12 INFO - Downloading blobuploader-1.2.4.tar.gz 22:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:02:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:02:12 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 22:02:12 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 22:02:12 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 22:02:12 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 22:02:12 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 22:02:12 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 22:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:02:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:02:12 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 22:02:12 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 22:02:12 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 22:02:12 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 22:02:12 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 22:02:12 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 22:02:13 INFO - Downloading docopt-0.6.1.tar.gz 22:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:02:13 INFO - Installing collected packages: blobuploader, requests, docopt 22:02:13 INFO - Running setup.py install for blobuploader 22:02:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:02:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:02:13 INFO - Running setup.py install for requests 22:02:13 INFO - Running setup.py install for docopt 22:02:13 INFO - Successfully installed blobuploader requests docopt 22:02:13 INFO - Cleaning up... 22:02:13 INFO - Return code: 0 22:02:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:02: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')]} 22:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02: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')]} 22:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:13 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 0x1a4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09570>, '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 0x1d0a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a900>, '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': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', '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 22:02:13 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 22:02:13 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 22:02:13 INFO - Using env: {'DISPLAY': ':0', 22:02:13 INFO - 'HOME': '/home/cltbld', 22:02:13 INFO - 'LANG': 'en_US.UTF-8', 22:02:13 INFO - 'LANGUAGE': 'en_US:en', 22:02:13 INFO - 'LOGNAME': 'cltbld', 22:02:13 INFO - 'MAIL': '/var/mail/cltbld', 22:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:13 INFO - 'MOZ_NO_REMOTE': '1', 22:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:13 INFO - 'NO_EM_RESTART': '1', 22:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:13 INFO - 'PWD': '/builds/slave/test', 22:02:13 INFO - 'SHELL': '/bin/bash', 22:02:13 INFO - 'SHLVL': '1', 22:02:13 INFO - 'TERM': 'linux', 22:02:13 INFO - 'TMOUT': '86400', 22:02:13 INFO - 'USER': 'cltbld', 22:02:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', 22:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:13 INFO - '_': '/tools/buildbot/bin/python'} 22:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:02:13 INFO - Running setup.py (path:/tmp/pip-A91a8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:02:14 INFO - Running setup.py (path:/tmp/pip-eHXF0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:02:14 INFO - Running setup.py (path:/tmp/pip-DTe7kP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:02:14 INFO - Running setup.py (path:/tmp/pip-pF5w_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:02:14 INFO - Running setup.py (path:/tmp/pip-6Z6GOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:02:14 INFO - Running setup.py (path:/tmp/pip-WDKZOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:02:14 INFO - Running setup.py (path:/tmp/pip-OHg4GF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:02:14 INFO - Running setup.py (path:/tmp/pip-243_EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:02:14 INFO - Running setup.py (path:/tmp/pip-kRen9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:02:14 INFO - Running setup.py (path:/tmp/pip-H_B5bJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:02:14 INFO - Running setup.py (path:/tmp/pip-MgRqLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:02:14 INFO - Running setup.py (path:/tmp/pip-2iWv81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:02:14 INFO - Running setup.py (path:/tmp/pip-kfHk_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:02:14 INFO - Running setup.py (path:/tmp/pip-Pvlh7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:02:14 INFO - Running setup.py (path:/tmp/pip-RNdLDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:02:15 INFO - Running setup.py (path:/tmp/pip-vDa0xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:02:15 INFO - Running setup.py (path:/tmp/pip-WI9Ehw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:02:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:02:15 INFO - Running setup.py install for manifestparser 22:02:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:02:15 INFO - Running setup.py install for mozcrash 22:02:15 INFO - Running setup.py install for mozdebug 22:02:15 INFO - Running setup.py install for mozdevice 22:02:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:02:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:02:15 INFO - Running setup.py install for mozfile 22:02:15 INFO - Running setup.py install for mozhttpd 22:02:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:02:15 INFO - Running setup.py install for mozinfo 22:02:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:02:15 INFO - Running setup.py install for mozInstall 22:02:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:02:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:02:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:02:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:02:16 INFO - Running setup.py install for mozleak 22:02:16 INFO - Running setup.py install for mozlog 22:02:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:02:16 INFO - Running setup.py install for moznetwork 22:02:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:02:16 INFO - Running setup.py install for mozprocess 22:02:16 INFO - Running setup.py install for mozprofile 22:02:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:02:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:02:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:02:16 INFO - Running setup.py install for mozrunner 22:02:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:02:16 INFO - Running setup.py install for mozscreenshot 22:02:16 INFO - Running setup.py install for moztest 22:02:16 INFO - Running setup.py install for mozversion 22:02:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:02:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:02:16 INFO - Cleaning up... 22:02:16 INFO - Return code: 0 22:02:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:02:16 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')]} 22:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:16 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')]} 22:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:16 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 0x1a4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09570>, '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 0x1d0a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a900>, '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': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', '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 22:02:16 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 22:02:16 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 22:02:16 INFO - Using env: {'DISPLAY': ':0', 22:02:16 INFO - 'HOME': '/home/cltbld', 22:02:16 INFO - 'LANG': 'en_US.UTF-8', 22:02:16 INFO - 'LANGUAGE': 'en_US:en', 22:02:16 INFO - 'LOGNAME': 'cltbld', 22:02:16 INFO - 'MAIL': '/var/mail/cltbld', 22:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:16 INFO - 'MOZ_NO_REMOTE': '1', 22:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:16 INFO - 'NO_EM_RESTART': '1', 22:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:16 INFO - 'PWD': '/builds/slave/test', 22:02:16 INFO - 'SHELL': '/bin/bash', 22:02:16 INFO - 'SHLVL': '1', 22:02:16 INFO - 'TERM': 'linux', 22:02:16 INFO - 'TMOUT': '86400', 22:02:16 INFO - 'USER': 'cltbld', 22:02:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', 22:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:16 INFO - '_': '/tools/buildbot/bin/python'} 22:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:02:17 INFO - Running setup.py (path:/tmp/pip-yi2dCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:02:17 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)) 22:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:02:17 INFO - Running setup.py (path:/tmp/pip-04Xt_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:02:17 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)) 22:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:02:17 INFO - Running setup.py (path:/tmp/pip-LdmODw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:02:17 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)) 22:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:02:17 INFO - Running setup.py (path:/tmp/pip-u__w1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:02:17 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)) 22:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:02:17 INFO - Running setup.py (path:/tmp/pip-VMNbHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:02:17 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)) 22:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:02:17 INFO - Running setup.py (path:/tmp/pip-fQzvsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:02:17 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)) 22:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:02:17 INFO - Running setup.py (path:/tmp/pip-76jIgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:02:17 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)) 22:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:02:17 INFO - Running setup.py (path:/tmp/pip-27RWoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:02:17 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)) 22:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:02:17 INFO - Running setup.py (path:/tmp/pip-jpt8cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:02:17 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)) 22:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:02:17 INFO - Running setup.py (path:/tmp/pip-7ARoGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:02:17 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)) 22:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:02:17 INFO - Running setup.py (path:/tmp/pip-rujPVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:02:18 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)) 22:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:02:18 INFO - Running setup.py (path:/tmp/pip-LQu9ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:02:18 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)) 22:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:02:18 INFO - Running setup.py (path:/tmp/pip-gZo6_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:02:18 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)) 22:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:02:18 INFO - Running setup.py (path:/tmp/pip-dW13W5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:02:18 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)) 22:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:02:18 INFO - Running setup.py (path:/tmp/pip-P0sVbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:02:18 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)) 22:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:02:18 INFO - Running setup.py (path:/tmp/pip-kscU0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:02:18 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)) 22:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:02:18 INFO - Running setup.py (path:/tmp/pip-UimJe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:02:18 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)) 22:02:18 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)) 22:02:18 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)) 22:02:18 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)) 22:02:18 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)) 22:02:18 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)) 22:02:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:02:18 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 22:02:18 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 22:02:18 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 22:02:18 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 22:02:18 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 22:02:18 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 22:02:20 INFO - Downloading blessings-1.6.tar.gz 22:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:02:20 INFO - Installing collected packages: blessings 22:02:20 INFO - Running setup.py install for blessings 22:02:20 INFO - Successfully installed blessings 22:02:20 INFO - Cleaning up... 22:02:20 INFO - Return code: 0 22:02:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:02:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:02:20 INFO - Reading from file tmpfile_stdout 22:02:20 INFO - Current package versions: 22:02:20 INFO - argparse == 1.2.1 22:02:20 INFO - blessings == 1.6 22:02:20 INFO - blobuploader == 1.2.4 22:02:20 INFO - docopt == 0.6.1 22:02:20 INFO - functools32 == 3.2.3-2 22:02:20 INFO - jsonschema == 2.5.1 22:02:20 INFO - manifestparser == 1.1 22:02:20 INFO - mozInstall == 1.12 22:02:20 INFO - mozcrash == 0.17 22:02:20 INFO - mozdebug == 0.1 22:02:20 INFO - mozdevice == 0.48 22:02:20 INFO - mozfile == 1.2 22:02:20 INFO - mozhttpd == 0.7 22:02:20 INFO - mozinfo == 0.9 22:02:20 INFO - mozleak == 0.1 22:02:20 INFO - mozlog == 3.2 22:02:20 INFO - moznetwork == 0.27 22:02:20 INFO - mozprocess == 0.23 22:02:20 INFO - mozprofile == 0.28 22:02:20 INFO - mozrunner == 6.12 22:02:20 INFO - mozscreenshot == 0.1 22:02:20 INFO - mozsystemmonitor == 0.3 22:02:20 INFO - moztest == 0.7 22:02:20 INFO - mozversion == 1.4 22:02:20 INFO - psutil == 3.1.1 22:02:20 INFO - requests == 1.2.3 22:02:20 INFO - wsgiref == 0.1.2 22:02:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:20 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 0x1a4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09570>, '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 0x1d0a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a900>, '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': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', '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 22:02:20 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 22:02:20 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 22:02:20 INFO - Using env: {'DISPLAY': ':0', 22:02:20 INFO - 'HOME': '/home/cltbld', 22:02:20 INFO - 'LANG': 'en_US.UTF-8', 22:02:20 INFO - 'LANGUAGE': 'en_US:en', 22:02:20 INFO - 'LOGNAME': 'cltbld', 22:02:20 INFO - 'MAIL': '/var/mail/cltbld', 22:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:20 INFO - 'MOZ_NO_REMOTE': '1', 22:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:20 INFO - 'NO_EM_RESTART': '1', 22:02:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:20 INFO - 'PWD': '/builds/slave/test', 22:02:20 INFO - 'SHELL': '/bin/bash', 22:02:20 INFO - 'SHLVL': '1', 22:02:20 INFO - 'TERM': 'linux', 22:02:20 INFO - 'TMOUT': '86400', 22:02:20 INFO - 'USER': 'cltbld', 22:02:20 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', 22:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:20 INFO - '_': '/tools/buildbot/bin/python'} 22:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:21 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)) 22:02:21 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)) 22:02:21 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)) 22:02:21 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)) 22:02:21 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)) 22:02:21 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)) 22:02:21 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)) 22:02:21 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)) 22:02:21 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)) 22:02:21 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)) 22:02:21 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)) 22:02:21 INFO - Cleaning up... 22:02:21 INFO - Return code: 0 22:02:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:02:21 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')]} 22:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:21 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')]} 22:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:21 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 0x1a4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09570>, '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 0x1d0a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a900>, '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': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', '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 22:02:21 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 22:02:21 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 22:02:21 INFO - Using env: {'DISPLAY': ':0', 22:02:21 INFO - 'HOME': '/home/cltbld', 22:02:21 INFO - 'LANG': 'en_US.UTF-8', 22:02:21 INFO - 'LANGUAGE': 'en_US:en', 22:02:21 INFO - 'LOGNAME': 'cltbld', 22:02:21 INFO - 'MAIL': '/var/mail/cltbld', 22:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:21 INFO - 'MOZ_NO_REMOTE': '1', 22:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:21 INFO - 'NO_EM_RESTART': '1', 22:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:21 INFO - 'PWD': '/builds/slave/test', 22:02:21 INFO - 'SHELL': '/bin/bash', 22:02:21 INFO - 'SHLVL': '1', 22:02:21 INFO - 'TERM': 'linux', 22:02:21 INFO - 'TMOUT': '86400', 22:02:21 INFO - 'USER': 'cltbld', 22:02:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', 22:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:21 INFO - '_': '/tools/buildbot/bin/python'} 22:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:02:21 INFO - Cleaning up... 22:02:21 INFO - Return code: 0 22:02:21 INFO - Running post-action listener: _resource_record_post_action 22:02:21 INFO - Running post-action listener: _start_resource_monitoring 22:02:21 INFO - Starting resource monitoring. 22:02:21 INFO - ##### 22:02:21 INFO - ##### Finished create-virtualenv step (success) 22:02:21 INFO - ##### 22:02:21 INFO - ##### 22:02:21 INFO - ##### Running install step. 22:02:21 INFO - ##### 22:02:21 INFO - Running pre-action listener: _resource_record_pre_action 22:02:21 INFO - Running main action method: install 22:02:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:02:21 INFO - Reading from file tmpfile_stdout 22:02:21 INFO - Detecting whether we're running mozinstall >=1.0... 22:02:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:02:21 INFO - Reading from file tmpfile_stdout 22:02:21 INFO - Output received: 22:02:21 INFO - Usage: mozinstall [options] installer 22:02:21 INFO - Options: 22:02:21 INFO - -h, --help show this help message and exit 22:02:21 INFO - -d DEST, --destination=DEST 22:02:21 INFO - Directory to install application into. [default: 22:02:21 INFO - "/builds/slave/test"] 22:02:21 INFO - --app=APP Application being installed. [default: firefox] 22:02:21 INFO - mkdir: /builds/slave/test/build/application 22:02:21 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'] 22:02:21 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 22:02:37 INFO - Reading from file tmpfile_stdout 22:02:37 INFO - Output received: 22:02:37 INFO - /builds/slave/test/build/application/firefox/firefox 22:02:37 INFO - Running post-action listener: _resource_record_post_action 22:02:37 INFO - ##### 22:02:37 INFO - ##### Finished install step (success) 22:02:37 INFO - ##### 22:02:37 INFO - ##### 22:02:37 INFO - ##### Running run-tests step. 22:02:37 INFO - ##### 22:02:37 INFO - Running pre-action listener: _resource_record_pre_action 22:02:37 INFO - Running main action method: run_tests 22:02:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:02:37 INFO - Python 2.7.3 22:02:37 INFO - Return code: 0 22:02:37 INFO - grabbing minidump binary from tooltool 22:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:37 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 0x1d09570>, '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 0x1d0a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:02:37 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 22:02:37 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 22:02:37 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 22:02:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:02:37 INFO - Return code: 0 22:02:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:02:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:02:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:02:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:02:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:02:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 22:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 22:02:37 INFO - Using env: {'DISPLAY': ':0', 22:02:37 INFO - 'HOME': '/home/cltbld', 22:02:37 INFO - 'LANG': 'en_US.UTF-8', 22:02:37 INFO - 'LANGUAGE': 'en_US:en', 22:02:37 INFO - 'LOGNAME': 'cltbld', 22:02:37 INFO - 'MAIL': '/var/mail/cltbld', 22:02:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:02:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:37 INFO - 'MOZ_NO_REMOTE': '1', 22:02:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:37 INFO - 'NO_EM_RESTART': '1', 22:02:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:37 INFO - 'PWD': '/builds/slave/test', 22:02:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:02:37 INFO - 'SHELL': '/bin/bash', 22:02:37 INFO - 'SHLVL': '1', 22:02:37 INFO - 'TERM': 'linux', 22:02:37 INFO - 'TMOUT': '86400', 22:02:37 INFO - 'USER': 'cltbld', 22:02:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467867707.199368-22513771', 22:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:37 INFO - '_': '/tools/buildbot/bin/python'} 22:02:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 22:02:38 INFO - mozversion application_buildid: 20160706212122 22:02:38 INFO - mozversion application_changeset: e178424c2e2a702ff2c7738e639c59bbed5a17cf 22:02:38 INFO - mozversion application_display_name: Nightly 22:02:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:02:38 INFO - mozversion application_name: Firefox 22:02:38 INFO - mozversion application_remotingname: firefox 22:02:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:02:38 INFO - mozversion application_vendor: Mozilla 22:02:38 INFO - mozversion application_version: 50.0a1 22:02:38 INFO - mozversion platform_buildid: 20160706212122 22:02:38 INFO - mozversion platform_changeset: e178424c2e2a702ff2c7738e639c59bbed5a17cf 22:02:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:02:38 INFO - mozversion platform_version: 50.0a1 22:02:38 INFO - using testdate: 1467867758 22:02:38 INFO - actual date: 1467867758 22:02:38 INFO - starting webserver on 'localhost:46965' 22:02:38 INFO - SUITE-START | Running 2 tests 22:02:38 INFO - TEST-START | dromaeo_css 22:02:38 INFO - operating with platform_type : linux_ 22:02:38 INFO - Initialising browser for dromaeo_css test... 22:02:38 INFO - TEST-INFO | started process 23913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0oDAd2/profile http://localhost:46965/getInfo.html) 22:02:43 INFO - PROCESS | 23913 | __metrics Screen width/height:1600/1200 22:02:43 INFO - PROCESS | 23913 | colorDepth:24 22:02:43 INFO - PROCESS | 23913 | Browser inner width/height: 1024/697 22:02:43 INFO - PROCESS | 23913 | __metrics 22:02:44 ERROR - PROCESS | 23913 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 22:02:45 INFO - TEST-INFO | 23913: exit 0 22:02:45 INFO - Browser initialized. 22:02:45 INFO - Running cycle 1/1 for dromaeo_css test... 22:02:45 INFO - TEST-INFO | started process 24032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0oDAd2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:02:57 INFO - PROCESS | 24032 | RSS: Main: 169197568 22:02:57 INFO - PROCESS | 24032 | 22:03:47 INFO - PROCESS | 24032 | 1467867827002 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] 22:05:59 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:46965/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46965/tests/dromaeo/cssquery-ext.html) 22:06:00 INFO - PROCESS | 24032 | RSS: Main: 172113920 22:06:00 INFO - PROCESS | 24032 | 22:09:03 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:46965/tests/dromaeo/cssquery-ext.html (next: http://localhost:46965/tests/dromaeo/cssquery-jquery.html) 22:09:03 INFO - PROCESS | 24032 | RSS: Main: 169402368 22:09:03 INFO - PROCESS | 24032 | 22:12:05 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:46965/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46965/tests/dromaeo/cssquery-mootools.html) 22:12:06 INFO - PROCESS | 24032 | RSS: Main: 171958272 22:12:06 INFO - PROCESS | 24032 | 22:15:08 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:46965/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46965/tests/dromaeo/cssquery-prototype.html) 22:15:09 INFO - PROCESS | 24032 | RSS: Main: 167641088 22:15:09 INFO - PROCESS | 24032 | 22:18:11 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:46965/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46965/tests/dromaeo/cssquery-yui.html) 22:18:12 INFO - PROCESS | 24032 | RSS: Main: 169361408 22:18:12 INFO - PROCESS | 24032 | 22:21:15 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:46965/tests/dromaeo/cssquery-yui.html (next: http://localhost:46965/tests/dromaeo/cssquery-dojo.html) 22:21:15 INFO - PROCESS | 24032 | RSS: Main: 170618880 22:21:15 INFO - PROCESS | 24032 | 22:21:15 INFO - PROCESS | 24032 | __start_tp_report 22:21:15 INFO - PROCESS | 24032 | _x_x_mozilla_page_load 22:21:15 INFO - PROCESS | 24032 | _x_x_mozilla_page_load_details 22:21:15 INFO - PROCESS | 24032 | |i|pagename|runs| 22:21:15 INFO - PROCESS | 24032 | |0;dojo.html;2693.703692593814;2739.0960982875654;2744.341358074062;2754.242583289595;2762.0332883490782;4799.208130658441;4897.04507621014;4939.827106051289;4989.101961646902;5029.723365214912;4803.3995750531185;4863.19757240055;4890.364252647159;4950.207966725325;4961.355023846904;4491.393661855656;4523.932141017887;4559.863204103882;4570.542945705436;4576.519465456129;4555.635549156076;4568.748718820463;4587.0825834833;4607.769611519428;4686.43762748469;4546.863594092182;4632.290786136927;4632.397788287535;4642.094791515656;4685.601723853477;4436.955630443719;4593.425821772278;4610.423697037871;4634;4673.626109911199;4447.688661793676;4454.443194600675;4465.129299786543;4492.7528985905765;4500.549945005506;4823.2282834746275;4864.270359446112;4872.9512704873205;4874.8537543873745;4917.532834380764;5155.587552995751;5218.66078704883;5240.8689782755355;5278.736063196863;5299.099153143975;5326.227696983954;5349.679019258857;5354.437784032699;5384.973075134639;5416.566674666017;4976.129177393942;4976.626752993468;4991.700497970133;5002.74986250686;5030.748462576893;5282.788688452496;5415.810446634349;5424.105022671215;5445.891082178414;5489.286392768914;5138.332016837787;5164.638475306692;5170.379554453414;5232.502912223333;5248.134057880483;5332.5467335276935;5335.253064570963;5342.599305052059;5342.786288548492;5379.193121031876;5181.5077567631015;5214.713190774544;5243.344581927259;5267.288915996368;5276.234945932818;5164.354455693038;5212.687238765686;5237.685738855681;5239.711815850089;5274.182501712241;4349.608535231844;4398.934015989763;4417.182821178092;4427.778611069433;4465.4864690561;3798.5061941947924;3816.1222918728295;3825.2923209206388;3826.7512611680154;3950.0322421007036;4504.054148628759;4522.66080043998;4529.343245229489;4566.748828814447;4584.129015487047;5368.543673787772;5385.3268341457315;5392.622516423813;5397.8110766123;5442.428545002717;4472.904138486092;4545;4565.543445655474;4583.587477127075;4588.082383523309;4721.220998535203;4724.43306803179;4728;4744.264638980894;4820.25286080658;4971.154903666457;5011.1481048221885;5038.697678139323;5044.672096313728;5077.289179514797;5197.532222099878;5249.501297376743;5294.391145018218;5324.920126198188;5357.089294819968;5016.197408414636;5026.773795179299;5038.2190760432195;5041.924371134509;5090.898182036412;5192.922106168486;5207.817726379559;5209.53114219722;5216.895662086813;5227.790888364575;5111.667741596784;5290.206469029677;5309.38942021657;5317.229001794795;5367.4364191759305;5174.689518628894;5184.559312458483;5193.143131383279;5197.428282888804;5247.449017853223;4953.380827396575;5198.090334191577;5222.399424066281;5232.450592687713;5238.764255608583;4982.177940639899;4999.600031997359;5000.174971129868;5043.2687260347775;5052.646314757932;5172.431032586488;5174.094533456705;5184.040952423814;5186.559142472932;5236.266922630911;4875.585575226146;4988.700677959334;5051.646384753032;5053.772580233825;5055.51972562606 22:21:15 INFO - PROCESS | 24032 | |1;ext.html;546.327057954965;577.5004621002834;581.0325807530461;593.7803012885232;595.6545203781807;35794;39599.604003959954;39609.99999999993;39938;39942.60057399425;39787.80106099473;40334.39498407526;40522.39216411756;40681.796591017;40708.18583628333;7815.374770018385;7836.921630783676;7898;7914.28771410573;7917.406194535404;7840.255175758322;7964;7968.561729104897;7981.720639777609;7983.0420349558135;7947.324477419426;7978.202179782004;7986.361091112697;7995.880061799048;8016.959915200416;7975.322097621709;7990.161033091529;7998.600069996477;8005.919940800576;8011.359091272742;7948.801279967989;7991.20087991202;8003.9199608003755;8009.159038301011;8022.237887400687;37934.62065379338;38242;38512.22975540502;38604.22791544154;38643.420348694795;2922.3570814421005;2942.7940044196916;3306.2230375861654;3735.458358537997;3838.42423636454;28936.565951510533;29565.113046608636;29735;29759.553606695918;29763.70236297631;3581.5164952731307;3588.2105936693883;3682.5396825396824;3718.888433347004;3746.157114649182;257591;261050;261227;261623;262803;31913;32951;55540.44459555353;55909.44090559124;56250.43749562452;33845;34009.65990340065;34125;34209.48685769716;34353.48469772955;13587.456501740018;13750.724985500234;13809.033367664368;13819.516316928859;13849.961252906072;11057.391843448526;11157.888421115847;11159.218854680095;11168.609098681507;11181.32912025281;7855.567943763148;7876.306594082185;7895.368370530458;7961.800954976056;7984.560849153236;3096.8296743679316;3141.308912039348;3144.119646498984;3147.228928912431;3170.3500782339565;859.5315553023618;918.1140199707181;929.8372784762639;956.2397893674546;971.3880255439028;29154.708452915198;29782.55326170109;29999.05006174592;30026.39947201044;30126.397472050438;990.4156547636928;996.1035068438464;1016.671821528691;1023.526122383765;1034.095166729112;15376.846231537766;15514.301856416263;15600.843991560167;15683.607909802346;15717.214139293219;387219;393326;394115;394398;394567;50177.24734128918;50661.74669126631;51006;51334;51359.74320128375;1188.1089183112665;1190.9464074116686;1190.9745061691601;1200.363807182195;1217.8295038694766;27742.167734967985;28440.288992775346;28876.133715988555;29022.854885725435;29273.7072629271;38360.61639383682;38402;38474.6152538471;43806.780966094964;44329.77835110804;143732;143920;144050.2797486006;144124;144348;22325.995330210506;22748.545029099656;22817.88591057034;22884.4278893029;25766.09818656338;40662.39006414847;43169.13661726811;43853.78073109614;44371.33442998422;44537.55462445334;37023.259534809695;37427.625723743506;38519.80740096282;38622;38891.416628751154;37344.81327593345;37963.810180948916;38667.80666096652;38758.224835502566;38799.22401552009;35674.46488302729;36877;37095.629043710294;37215.813920930224;37367.81316093402;32425.189370264987;34404.82797585996;34619.4807077889;34850.128746781535;34931.301373972885;25881.741182588685;26185.476290473704;26200;26521.60217596699;26725.465490689687 22:21:15 INFO - PROCESS | 24032 | |2;jquery.html;366.785430523144;369.8206369910592;372.76702061211745;380.4825437405129;383.2698708959433;15925.681486370266;17643.558911027216;17813.109344532786;18444.631107377845;18531.44405667832;17550.385736499225;17846.732299015493;18361;18487.352942646976;19190.616187676274;5729.541636669067;5960.940390596082;6025.608335458203;6048.788292409767;6061.878762424749;5769.365369809318;5936.347001829795;5951.375105613892;5970.104484327342;5979.940200598004;5795.71021448928;5825.825225243249;5945.256842894638;5966.820995370124;5972.701364931758;5828.825135245907;5995.550333724967;6004.159417681528;6007.15899774032;6008.068749343859;5780.421957804228;5811.360750317462;5840.269966254218;5888.470037696585;5889.469947704684;22689.773102269097;23461.530769384688;23600.881995590084;23606.64590031151;24449.755502444925;1862.5157459060606;1921.1162865082078;1933.9709904351446;1993.6511110555596;2040.5306779440664;14703.63240918975;14938.253087345589;15172.862035347393;15484.922575387163;16183.757243641356;1832.1480511562054;1847.178005787425;1889.6126294109674;1953.3651563242004;1961.568454939911;82607.5869620648;85512.57243713741;85892.14107858966;88612.11387886103;89804;13487.662808429672;15822.60443488922;17163;17205.042840146838;17215.91392043057;29724.851375743416;29777.10668679943;30344.848275758923;30362.392752144835;30429.543556846664;8914.593059873798;9109.453432794053;9153.496557689257;9192.954035229915;9219.124183202584;7412.332890039815;7478.214787447239;7501.362384197295;7589.58257295854;7639.121501027453;8657.935107961786;8660.393772435995;8682.86975695365;8684.696035638723;8697.652093916298;3438.0604583081604;3450.516927630134;3472.232627599083;3532.911677208039;3660.249648821985;799.5043073294595;804.0833449867039;820.1470470710394;864.6022829498376;898.6495266845935;16747;17622.00558906876;17710.557236068944;17744.37894673706;18044.917304961746;880.295763389286;880.8018195905998;895.7671005538607;906.2704522859161;953.208836665566;9543.618255269712;9619.374740641835;9859.556319965619;9906.60373585063;10349.63776267827;259962;262818;262909;264202;424646;59729.506762331286;71594.64202679058;77156.2284377149;84729.57635211785;86729.56635216784;913.2100732866156;924.653255029364;944.471096186138;949.1647350331664;956.6030097509595;14285.64285892861;14574.198419086628;16006.439774607832;16212;16646.084465354037;38193.61806382012;39189.41215881821;39720.205595888496;40001.399978999754;41499.58500414957;53989.73005134949;55945.44054559402;56065;56165.71917140388;56498.74005039917;7249.202587715453;7309.4152467803515;7357.852842943218;7394.149672787483;7720.343770779322;11762;11933.105017123924;12238.632841014783;12238.877611223774;12348;9669.468179250209;10220.540075696463;10358.482075896025;10720.571177152826;10868.510917008596;6312.6528040956355;10289.9485502575;10608.204384671026;10823.837642435212;10946.014858662758;10415.270931034755;10447.58209671635;10515.106215971728;10522.684319470429;10700;7229.313215244543;7374.188839227573;7378.667959941923;7405.481616286808;7448.5158464699625;10065.144462720751;10188.745281368025;10300.793984120426;10420.905804890377;10648.414337211529 22:21:15 INFO - PROCESS | 24032 | |3;mootools.html;1376.6695992961688;1414.3564678071477;1482.8591283828039;1698.762173295738;1760.1375326090213;7008.544444611097;7624.847503049936;7721.420893432994;8278.91721082789;8290.170982901707;7865.252800983912;8056.315213206884;8127.3091787198155;8135.145809689986;8137.267645911867;2233.2853486884205;2270.704808374909;2274.385915802732;2282.018731945263;2284.132029828663;2177.1617927098023;2223.766504517019;2224.421650370907;2227.6658501224783;2234.0728597631964;2191.638379667353;2212.4468882779306;2215.4793623498463;2230.7657695941934;2263.7396699379533;2159.686845407415;2167.046499540197;2181.0076415231033;2183.7051997980307;2186.693862859201;2191.9452013699624;2199.2082850173924;2217.456723102834;2217.46780772615;2221.1781640792847;8201.876971845428;8252.05101413339;8255.752327430188;8260.29787468066;8264.586770661443;4644.071185762828;4709.175894218498;4725.149473094842;4728.05438912219;4768.2847572864;2766.792490563216;2910.2287893708185;2925.590417341574;2926.839023853687;2942.2350188950813;854.7350321400323;880.4937161132375;883.4919921045424;887.436477836572;890.812929284851;10863.750668673125;10994.615188468446;11007.119430445546;11097.1122310215;11107.500162492708;4180.122174343361;4218.704690671685;4365.126974605028;4382.802773875183;4411.470623525198;9232.723018309462;9282.675106371245;9328.720138395858;9404.153626173676;9423.434593924387;4619.19164146273;4623.722576645412;4645.744484053342;4655.6973796703105;4662.067586482717;3712.1833196696684;4129.256733787947;4212.777225422554;4221.6200541951375;4279.122779830127;3665.2852693725;3745.793981331053;3768.6231376862092;3790.8673196437994;3855.151866589346;1142.2175809570472;1147.4549588945183;1149.8620165580016;1157.0685598093617;1191.5174354386488;725.8439435521389;856.8243510080418;862.8619420892627;875.4090988582681;878.3587980773943;5328.467153284718;5422.15956526739;5423.538999185034;5450.836474905759;5454.53636440899;394.12504240585855;396.3104198694251;399.69623086454504;403.31839191765823;410.17145366359784;3680.208755117609;3798.3163030654746;3819.0643292393543;3835.520559930009;3840.8847734568008;9764.902350976541;10076.647317343857;10085;10204.540795664212;10247.795044099226;9957.800843983225;10042.246831487668;10042.845072816574;10051.698449046395;10162.796744065077;7464.962675186589;7595.962020189974;7616.0860696715645;7661.693532258759;7712.691492340244;5305.416404195458;5352.464753524772;5366.221897824872;5367.302250707383;5418.268533748052;9085.591148398205;9098.454092754457;9116.908830911607;9145.314101442551;9157.496337701225;8673.566321683764;9097.863532047157;9104.544772761203;9220.769480763034;9405.106514881076;6184.690765461619;6701;6762.8647427052165;6902.309769023258;6976.790696279119;7973.043234811859;7977.680892764224;8032.879506807286;8062.39532035088;8071.71748988806;7049.929500705132;7208.098987626547;7263.273672632695;7322.231165727522;7332.890006649798;6819.352161544645;6899.344562266577;6978.47661425385;7061.223265440694;7267.818304542428;6723.226828914738;6785.355391237825;6825.795226143224;6854.897176542256;6884.449244060564;4517.75152366623;4617.238155704271;4631.976840115778;4655.86032419028;4702.318163866289;4675.275332323496;4740.312654665123;4754.0729557737295;4762.119007983534;4793.616510679068 22:21:15 INFO - PROCESS | 24032 | |4;prototype.html;289.43560057887123;293.9147647182317;305.5859310634091;308.44172048592065;311.57936785339797;5162.277281180638;5168.741562921853;5184.688918664882;5197.974010129953;5204.531592156705;5091.159958606825;5091.567216786569;5103.336566246392;5112.3098381718455;5137.820176293831;3773.792441415721;3880.670143037831;3946.1713040261434;3965.266425711253;3973.185496973128;3951.1505026419313;3953.584873588275;3971.9205615887663;4014.5383280922774;4018.718689691723;3983.223271462066;3993.800309984489;4007.9378964574266;4008.5790991945864;4011.3581826907703;3713.1274150574595;3945.704072194568;3967.4643923070303;4002.8191683453306;4010.8796736097966;3406.9949364937156;3441.6042155151977;3451.620321764604;3454.3091381723757;3460.584729832436;4908.77910494025;4970.602351811846;4993.575546078588;5001.599872010231;5005.974970125162;4247.362895565659;4535.387722657432;4565.383673204108;4570.542945705436;4584.426946631671;5267.657602255841;5310.814121505768;5335.039692855324;5350.170723537858;5356.3572371315695;3751.456038874348;3753.817547472565;3767.792771397572;3771.8679846205528;3775.244951009809;5345.385280692732;5589.552835773128;5624.0439125348785;5659.292588426447;5695.430456954313;3849.7882616456363;3869.071422858494;3870.632289932452;3877.728559000899;3891.066144125446;3928.6267804559093;3931.3513270310077;3937.8621748238675;3939.4287828265315;3939.5272567291536;4512.210363186429;4513.390692256569;4518.390017347681;4525.705829121097;4529.8641040768825;5060.862265395404;5277.498637629419;5303.867403314871;5312.707801070978;5407.783688652488;1325.436689406998;1330.401319406271;1331.182935293337;1341.6243451833307;1352.6888815572474;842.3555979675554;848.325581162977;854.7563944275852;863.494855509534;864.4510735682886;4571.862844114682;4614.3388380183105;4615.5845973862515;4616.215243408561;4616.515265897099;5378.7041712705395;5387.272718183073;5392.622516423813;5396.757145928443;5419.945800542023;4400.9119817604105;4555.9772201138785;4596.655250856199;4598.172328980749;4614.792334344963;2910.7338307835735;2938.353562216309;2938.617979662673;2940.8529573521237;2949.601803756508;5099.388073431212;5114.41184263807;5166.302549155891;5167.560757335668;5169.870753231124;5378.650387724785;5577.860553486195;5617.073182924853;5636.436356364413;5642.153676948408;5088.643794934319;5131.717755523482;5144.819931302386;5169.974150129226;5188.898496109006;5409.864753381197;5416.458354164552;5458.727063646881;5473.890522189614;5477.507024367826;5117.309163262912;5286.682799031916;5413.323334583177;5422.267993820784;5434.918476222781;5207.479252074762;5209.895802084013;5232.005918875554;5248.711320877388;5263.578913686973;3796.8101594920695;3811.7712937223855;3816.8549435168784;3819.675327597074;3822.2164456285836;5215.5827533797965;5457.508824205841;5490.231367608458;5520.309961254843;5535.861603459945;5277.340332458442;5299.708516031656;5316.627836051439;5323.228131920927;5331.933613277438;5209.451933690608;5305.1776974569;5330.333708286465;5353.223782551586;5368.1679339702405;5158.226266060121;5176.9741151294;5199.844004679866;5204.609654276021;5272.9736351318;5074.517920797518;5207.895842083213;5322.707251101227;5337.519623233928;5342.545883599938;5153.5361817436615;5160.122779127482;5161.870953226199;5169.508896654812;5202.8959420812125 22:21:15 INFO - PROCESS | 24032 | |5;yui.html;617.4998251416353;648.5946283572767;660.4056349285645;710.6695386645209;716.4590733995832;12982.935085324572;13437.059405841595;13447.663808404795;13676.316184190788;13683.24742139182;13212.735745285088;13307.534236301732;13417.597472075853;13428.865711342884;13435.26106064166;749.254491780679;770.1797585571348;796.040770871099;796.2674339607546;796.9203079692043;791.4064451661254;795.0380040151424;796.1163108949062;801.7234054251275;803.5580430763057;836.4897412578322;837.0290463062848;838.2372041442288;838.4089217101958;842.153635596225;826.669332267098;827.8220182660726;829.9709510167145;834.8789425533264;835.0355339582792;608.2062907905182;609.7439075588263;610.6397225636896;611.1871211288975;611.8562137897591;13629.25039122848;13647;13647.454101836014;13657.726845463134;13659;11810.586629467927;12615.053870959715;12771.262672170125;13264.270465124415;13446.93276533611;11662.76674466506;12046.518139274418;12232.938835305766;12378.195417297848;12475.50097996079;4141.834326626931;4183.644390226835;4193.433886425354;4268.551802060801;4306.913861722779;57474.425255747745;62430.68784656093;63308.366916330706;64056.3594364055;64192.35807641911;10085.647002355028;10396.792064158675;10471.424071675978;10578;10627.84058239127;18635.254589816526;18644.16101275446;18663.533411664816;18693.813061869478;18697;7162.856742865113;7196.10048743907;7271.454640901953;7279.854402911912;7508.2867127622785;3693.963060369416;3767.9434808477895;3780.3384407728536;3780.8865734028022;3846.0961674006585;2985.7462115719973;3099.969000310013;3100.3954228925145;3107.658157602662;3111.9222019449694;540.4082529630049;542.7530473634487;550.1417788250342;558.4973523828587;560.8541779137454;525.7029778175319;561.3151954615363;563.4731526023181;608.1455554945309;630.0580631955256;8197.139300373376;8242.835143297101;8563.529005904611;8791.472511649321;8888.73333799987;580.4195804195804;590.4597293476421;591.2579712460835;591.382005803936;594.2987275015523;4063.5733248009124;4097.1396006838895;4193.370994350872;4197.496300443905;4209.5579964103945;95282.52358738161;96091;97390.5130474343;97556.51221743987;98164.50917745366;68244.6587767068;69815;70933.64533177404;84645;87928.5603571978;74377;75345.62327188329;76481;76763.61618191985;77419.61290193514;8812.559372031244;9204.723858284262;9229.953850230706;9320;9326.114019168168;41809;43837.34243986279;44738.55261447344;46433.66012908424;47361;53897;55365;55369.72315138399;60431.395686042575;60556.69721651363;10860.348379097279;10989.230753847474;11158.10735141203;11384.886151138713;11418.828717569077;13171.93414032962;13357.53248636293;13390.397432115384;13646.522371716943;14239.216843073731;11816.416944596409;12352.505899763908;12384.81422778641;12394.81407778902;12803.219732817994;10540.10409115203;10541.104006159563;10602.575896964036;10661;10663.200259980378;10906.127509799355;11173.441327933733;11208.439578020903;11485.393045824841;11731.120165987755;9790.657326993522;10025.899741002788;10194.133498652698;10400;10564.894351056391;9650.806983860424;10056.698299050748;10057.899421005988;10160.898391015995;10192.439415831905 22:21:15 INFO - PROCESS | 24032 | __end_tp_report 22:21:15 INFO - PROCESS | 24032 | __start_cc_report 22:21:15 INFO - PROCESS | 24032 | _x_x_mozilla_cycle_collect,399 22:21:15 INFO - PROCESS | 24032 | __end_cc_report 22:21:15 INFO - PROCESS | 24032 | __startTimestamp1467868875298__endTimestamp 22:21:15 INFO - PROCESS | 24032 | 22:21:15 INFO - PROCESS | 24032 | ------- Summary: start ------- 22:21:15 INFO - PROCESS | 24032 | Number of tests: 6 22:21:15 INFO - PROCESS | 24032 | 22:21:15 INFO - PROCESS | 24032 | [#0] dojo.html Cycles:165 Average:4884.83 Median:5026.77 stddev:523.54 (10.4%) stddev-sans-first:496.13 22:21:15 INFO - PROCESS | 24032 | Values: 2693.7 2739.1 2744.3 2754.2 2762.0 4799.2 4897.0 4939.8 4989.1 5029.7 4803.4 4863.2 4890.4 4950.2 4961.4 4491.4 4523.9 4559.9 4570.5 4576.5 4555.6 4568.7 4587.1 4607.8 4686.4 4546.9 4632.3 4632.4 4642.1 4685.6 4437.0 4593.4 4610.4 4634.0 4673.6 4447.7 4454.4 4465.1 4492.8 4500.5 4823.2 4864.3 4873.0 4874.9 4917.5 5155.6 5218.7 5240.9 5278.7 5299.1 5326.2 5349.7 5354.4 5385.0 5416.6 4976.1 4976.6 4991.7 5002.7 5030.7 5282.8 5415.8 5424.1 5445.9 5489.3 5138.3 5164.6 5170.4 5232.5 5248.1 5332.5 5335.3 5342.6 5342.8 5379.2 5181.5 5214.7 5243.3 5267.3 5276.2 5164.4 5212.7 5237.7 5239.7 5274.2 4349.6 4398.9 4417.2 4427.8 4465.5 3798.5 3816.1 3825.3 3826.8 3950.0 4504.1 4522.7 4529.3 4566.7 4584.1 5368.5 5385.3 5392.6 5397.8 5442.4 4472.9 4545.0 4565.5 4583.6 4588.1 4721.2 4724.4 4728.0 4744.3 4820.3 4971.2 5011.1 5038.7 5044.7 5077.3 5197.5 5249.5 5294.4 5324.9 5357.1 5016.2 5026.8 5038.2 5041.9 5090.9 5192.9 5207.8 5209.5 5216.9 5227.8 5111.7 5290.2 5309.4 5317.2 5367.4 5174.7 5184.6 5193.1 5197.4 5247.4 4953.4 5198.1 5222.4 5232.5 5238.8 4982.2 4999.6 5000.2 5043.3 5052.6 5172.4 5174.1 5184.0 5186.6 5236.3 4875.6 4988.7 5051.6 5053.8 5055.5 22:21:15 INFO - PROCESS | 24032 | 22:21:15 INFO - PROCESS | 24032 | [#1] ext.html Cycles:180 Average:42170.29 Median:37397.72 stddev:75391.75 (201.6%) stddev-sans-first:75538.47 22:21:15 INFO - PROCESS | 24032 | Values: 546.3 577.5 581.0 593.8 595.7 35794.0 39599.6 39610.0 39938.0 39942.6 39787.8 40334.4 40522.4 40681.8 40708.2 7815.4 7836.9 7898.0 7914.3 7917.4 7840.3 7964.0 7968.6 7981.7 7983.0 7947.3 7978.2 7986.4 7995.9 8017.0 7975.3 7990.2 7998.6 8005.9 8011.4 7948.8 7991.2 8003.9 8009.2 8022.2 37934.6 38242.0 38512.2 38604.2 38643.4 2922.4 2942.8 3306.2 3735.5 3838.4 28936.6 29565.1 29735.0 29759.6 29763.7 3581.5 3588.2 3682.5 3718.9 3746.2 257591.0 261050.0 261227.0 261623.0 262803.0 31913.0 32951.0 55540.4 55909.4 56250.4 33845.0 34009.7 34125.0 34209.5 34353.5 13587.5 13750.7 13809.0 13819.5 13850.0 11057.4 11157.9 11159.2 11168.6 11181.3 7855.6 7876.3 7895.4 7961.8 7984.6 3096.8 3141.3 3144.1 3147.2 3170.4 859.5 918.1 929.8 956.2 971.4 29154.7 29782.6 29999.1 30026.4 30126.4 990.4 996.1 1016.7 1023.5 1034.1 15376.8 15514.3 15600.8 15683.6 15717.2 387219.0 393326.0 394115.0 394398.0 394567.0 50177.2 50661.7 51006.0 51334.0 51359.7 1188.1 1190.9 1191.0 1200.4 1217.8 27742.2 28440.3 28876.1 29022.9 29273.7 38360.6 38402.0 38474.6 43806.8 44329.8 143732.0 143920.0 144050.3 144124.0 144348.0 22326.0 22748.5 22817.9 22884.4 25766.1 40662.4 43169.1 43853.8 44371.3 44537.6 37023.3 37427.6 38519.8 38622.0 38891.4 37344.8 37963.8 38667.8 38758.2 38799.2 35674.5 36877.0 37095.6 37215.8 37367.8 32425.2 34404.8 34619.5 34850.1 34931.3 25881.7 26185.5 26200.0 26521.6 26725.5 22:21:15 INFO - PROCESS | 24032 | 22:21:15 INFO - PROCESS | 24032 | [#2] jquery.html Cycles:180 Average:23615.21 Median:39860.80 stddev:51103.96 (128.2%) stddev-sans-first:51217.51 22:21:15 INFO - PROCESS | 24032 | Values: 366.8 369.8 372.8 380.5 383.3 15925.7 17643.6 17813.1 18444.6 18531.4 17550.4 17846.7 18361.0 18487.4 19190.6 5729.5 5960.9 6025.6 6048.8 6061.9 5769.4 5936.3 5951.4 5970.1 5979.9 5795.7 5825.8 5945.3 5966.8 5972.7 5828.8 5995.6 6004.2 6007.2 6008.1 5780.4 5811.4 5840.3 5888.5 5889.5 22689.8 23461.5 23600.9 23606.6 24449.8 1862.5 1921.1 1934.0 1993.7 2040.5 14703.6 14938.3 15172.9 15484.9 16183.8 1832.1 1847.2 1889.6 1953.4 1961.6 82607.6 85512.6 85892.1 88612.1 89804.0 13487.7 15822.6 17163.0 17205.0 17215.9 29724.9 29777.1 30344.8 30362.4 30429.5 8914.6 9109.5 9153.5 9193.0 9219.1 7412.3 7478.2 7501.4 7589.6 7639.1 8657.9 8660.4 8682.9 8684.7 8697.7 3438.1 3450.5 3472.2 3532.9 3660.2 799.5 804.1 820.1 864.6 898.6 16747.0 17622.0 17710.6 17744.4 18044.9 880.3 880.8 895.8 906.3 953.2 9543.6 9619.4 9859.6 9906.6 10349.6 259962.0 262818.0 262909.0 264202.0 424646.0 59729.5 71594.6 77156.2 84729.6 86729.6 913.2 924.7 944.5 949.2 956.6 14285.6 14574.2 16006.4 16212.0 16646.1 38193.6 39189.4 39720.2 40001.4 41499.6 53989.7 55945.4 56065.0 56165.7 56498.7 7249.2 7309.4 7357.9 7394.1 7720.3 11762.0 11933.1 12238.6 12238.9 12348.0 9669.5 10220.5 10358.5 10720.6 10868.5 6312.7 10289.9 10608.2 10823.8 10946.0 10415.3 10447.6 10515.1 10522.7 10700.0 7229.3 7374.2 7378.7 7405.5 7448.5 10065.1 10188.7 10300.8 10420.9 10648.4 22:21:15 INFO - PROCESS | 24032 | 22:21:15 INFO - PROCESS | 24032 | [#3] mootools.html Cycles:180 Average:5291.30 Median:4717.16 stddev:3020.45 (64.0%) stddev-sans-first:3014.60 22:21:15 INFO - PROCESS | 24032 | Values: 1376.7 1414.4 1482.9 1698.8 1760.1 7008.5 7624.8 7721.4 8278.9 8290.2 7865.3 8056.3 8127.3 8135.1 8137.3 2233.3 2270.7 2274.4 2282.0 2284.1 2177.2 2223.8 2224.4 2227.7 2234.1 2191.6 2212.4 2215.5 2230.8 2263.7 2159.7 2167.0 2181.0 2183.7 2186.7 2191.9 2199.2 2217.5 2217.5 2221.2 8201.9 8252.1 8255.8 8260.3 8264.6 4644.1 4709.2 4725.1 4728.1 4768.3 2766.8 2910.2 2925.6 2926.8 2942.2 854.7 880.5 883.5 887.4 890.8 10863.8 10994.6 11007.1 11097.1 11107.5 4180.1 4218.7 4365.1 4382.8 4411.5 9232.7 9282.7 9328.7 9404.2 9423.4 4619.2 4623.7 4645.7 4655.7 4662.1 3712.2 4129.3 4212.8 4221.6 4279.1 3665.3 3745.8 3768.6 3790.9 3855.2 1142.2 1147.5 1149.9 1157.1 1191.5 725.8 856.8 862.9 875.4 878.4 5328.5 5422.2 5423.5 5450.8 5454.5 394.1 396.3 399.7 403.3 410.2 3680.2 3798.3 3819.1 3835.5 3840.9 9764.9 10076.6 10085.0 10204.5 10247.8 9957.8 10042.2 10042.8 10051.7 10162.8 7465.0 7596.0 7616.1 7661.7 7712.7 5305.4 5352.5 5366.2 5367.3 5418.3 9085.6 9098.5 9116.9 9145.3 9157.5 8673.6 9097.9 9104.5 9220.8 9405.1 6184.7 6701.0 6762.9 6902.3 6976.8 7973.0 7977.7 8032.9 8062.4 8071.7 7049.9 7208.1 7263.3 7322.2 7332.9 6819.4 6899.3 6978.5 7061.2 7267.8 6723.2 6785.4 6825.8 6854.9 6884.4 4517.8 4617.2 4632.0 4655.9 4702.3 4675.3 4740.3 4754.1 4762.1 4793.6 22:21:15 INFO - PROCESS | 24032 | 22:21:15 INFO - PROCESS | 24032 | [#4] prototype.html Cycles:180 Average:4407.39 Median:5101.36 stddev:1287.98 (25.2%) stddev-sans-first:1253.96 22:21:15 INFO - PROCESS | 24032 | Values: 289.4 293.9 305.6 308.4 311.6 5162.3 5168.7 5184.7 5198.0 5204.5 5091.2 5091.6 5103.3 5112.3 5137.8 3773.8 3880.7 3946.2 3965.3 3973.2 3951.2 3953.6 3971.9 4014.5 4018.7 3983.2 3993.8 4007.9 4008.6 4011.4 3713.1 3945.7 3967.5 4002.8 4010.9 3407.0 3441.6 3451.6 3454.3 3460.6 4908.8 4970.6 4993.6 5001.6 5006.0 4247.4 4535.4 4565.4 4570.5 4584.4 5267.7 5310.8 5335.0 5350.2 5356.4 3751.5 3753.8 3767.8 3771.9 3775.2 5345.4 5589.6 5624.0 5659.3 5695.4 3849.8 3869.1 3870.6 3877.7 3891.1 3928.6 3931.4 3937.9 3939.4 3939.5 4512.2 4513.4 4518.4 4525.7 4529.9 5060.9 5277.5 5303.9 5312.7 5407.8 1325.4 1330.4 1331.2 1341.6 1352.7 842.4 848.3 854.8 863.5 864.5 4571.9 4614.3 4615.6 4616.2 4616.5 5378.7 5387.3 5392.6 5396.8 5419.9 4400.9 4556.0 4596.7 4598.2 4614.8 2910.7 2938.4 2938.6 2940.9 2949.6 5099.4 5114.4 5166.3 5167.6 5169.9 5378.7 5577.9 5617.1 5636.4 5642.2 5088.6 5131.7 5144.8 5170.0 5188.9 5409.9 5416.5 5458.7 5473.9 5477.5 5117.3 5286.7 5413.3 5422.3 5434.9 5207.5 5209.9 5232.0 5248.7 5263.6 3796.8 3811.8 3816.9 3819.7 3822.2 5215.6 5457.5 5490.2 5520.3 5535.9 5277.3 5299.7 5316.6 5323.2 5331.9 5209.5 5305.2 5330.3 5353.2 5368.2 5158.2 5177.0 5199.8 5204.6 5273.0 5074.5 5207.9 5322.7 5337.5 5342.5 5153.5 5160.1 5161.9 5169.5 5202.9 22:21:15 INFO - PROCESS | 24032 | 22:21:15 INFO - PROCESS | 24032 | [#5] yui.html Cycles:180 Average:17602.82 Median:45586.11 stddev:24552.85 (53.9%) stddev-sans-first:24588.61 22:21:15 INFO - PROCESS | 24032 | Values: 617.5 648.6 660.4 710.7 716.5 12982.9 13437.1 13447.7 13676.3 13683.2 13212.7 13307.5 13417.6 13428.9 13435.3 749.3 770.2 796.0 796.3 796.9 791.4 795.0 796.1 801.7 803.6 836.5 837.0 838.2 838.4 842.2 826.7 827.8 830.0 834.9 835.0 608.2 609.7 610.6 611.2 611.9 13629.3 13647.0 13647.5 13657.7 13659.0 11810.6 12615.1 12771.3 13264.3 13446.9 11662.8 12046.5 12232.9 12378.2 12475.5 4141.8 4183.6 4193.4 4268.6 4306.9 57474.4 62430.7 63308.4 64056.4 64192.4 10085.6 10396.8 10471.4 10578.0 10627.8 18635.3 18644.2 18663.5 18693.8 18697.0 7162.9 7196.1 7271.5 7279.9 7508.3 3694.0 3767.9 3780.3 3780.9 3846.1 2985.7 3100.0 3100.4 3107.7 3111.9 540.4 542.8 550.1 558.5 560.9 525.7 561.3 563.5 608.1 630.1 8197.1 8242.8 8563.5 8791.5 8888.7 580.4 590.5 591.3 591.4 594.3 4063.6 4097.1 4193.4 4197.5 4209.6 95282.5 96091.0 97390.5 97556.5 98164.5 68244.7 69815.0 70933.6 84645.0 87928.6 74377.0 75345.6 76481.0 76763.6 77419.6 8812.6 9204.7 9230.0 9320.0 9326.1 41809.0 43837.3 44738.6 46433.7 47361.0 53897.0 55365.0 55369.7 60431.4 60556.7 10860.3 10989.2 11158.1 11384.9 11418.8 13171.9 13357.5 13390.4 13646.5 14239.2 11816.4 12352.5 12384.8 12394.8 12803.2 10540.1 10541.1 10602.6 10661.0 10663.2 10906.1 11173.4 11208.4 11485.4 11731.1 9790.7 10025.9 10194.1 10400.0 10564.9 9650.8 10056.7 10057.9 10160.9 10192.4 22:21:15 INFO - PROCESS | 24032 | -------- Summary: end -------- 22:21:15 INFO - PROCESS | 24032 | 22:21:16 INFO - TEST-INFO | 24032: exit 0 22:21:16 INFO - TEST-OK | dromaeo_css | took 1117976ms 22:21:16 INFO - TEST-START | kraken 22:21:16 INFO - operating with platform_type : linux_ 22:21:16 INFO - Initialising browser for kraken test... 22:21:16 INFO - TEST-INFO | started process 24282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4kdeZP/profile http://localhost:46965/getInfo.html) 22:21:21 INFO - PROCESS | 24282 | __metrics Screen width/height:1600/1200 22:21:21 INFO - PROCESS | 24282 | colorDepth:24 22:21:21 INFO - PROCESS | 24282 | Browser inner width/height: 1024/697 22:21:21 INFO - PROCESS | 24282 | __metrics 22:21:22 ERROR - PROCESS | 24282 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 22:21:22 INFO - TEST-INFO | 24282: exit 0 22:21:22 INFO - Browser initialized. 22:21:22 INFO - Running cycle 1/1 for kraken test... 22:21:22 INFO - TEST-INFO | started process 24400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4kdeZP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:21:34 INFO - PROCESS | 24400 | RSS: Main: 169316352 22:21:34 INFO - PROCESS | 24400 | 22:21:37 INFO - PROCESS | 24400 | Cycle 1(1): loaded http://localhost:46965/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46965/tests/kraken/driver.html?testName=audio-beat-detection) 22:21:38 INFO - PROCESS | 24400 | RSS: Main: 174567424 22:21:38 INFO - PROCESS | 24400 | 22:21:41 INFO - PROCESS | 24400 | Cycle 1(1): loaded http://localhost:46965/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46965/tests/kraken/driver.html?testName=audio-dft) 22:21:41 INFO - PROCESS | 24400 | RSS: Main: 173146112 22:21:41 INFO - PROCESS | 24400 | 22:21:44 INFO - PROCESS | 24400 | Cycle 1(1): loaded http://localhost:46965/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46965/tests/kraken/driver.html?testName=audio-fft) 22:21:45 INFO - PROCESS | 24400 | RSS: Main: 168206336 22:21:45 INFO - PROCESS | 24400 | 22:21:47 INFO - PROCESS | 24400 | Cycle 1(1): loaded http://localhost:46965/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46965/tests/kraken/driver.html?testName=audio-oscillator) 22:21:48 INFO - PROCESS | 24400 | RSS: Main: 169041920 22:21:48 INFO - PROCESS | 24400 | 22:21:50 INFO - PROCESS | 24400 | Cycle 1(1): loaded http://localhost:46965/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46965/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:21:51 INFO - PROCESS | 24400 | RSS: Main: 170070016 22:21:51 INFO - PROCESS | 24400 | 22:21:54 INFO - PROCESS | 24400 | Cycle 1(1): loaded http://localhost:46965/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46965/tests/kraken/driver.html?testName=imaging-darkroom) 22:21:54 INFO - PROCESS | 24400 | RSS: Main: 169549824 22:21:54 INFO - PROCESS | 24400 | 22:21:58 INFO - PROCESS | 24400 | Cycle 1(1): loaded http://localhost:46965/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46965/tests/kraken/driver.html?testName=imaging-desaturate) 22:21:59 INFO - PROCESS | 24400 | RSS: Main: 167243776 22:21:59 INFO - PROCESS | 24400 | 22:22:02 INFO - PROCESS | 24400 | Cycle 1(1): loaded http://localhost:46965/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46965/tests/kraken/driver.html?testName=json-parse-financial) 22:22:02 INFO - PROCESS | 24400 | RSS: Main: 168460288 22:22:02 INFO - PROCESS | 24400 | 22:22:04 INFO - PROCESS | 24400 | Cycle 1(1): loaded http://localhost:46965/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46965/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:22:05 INFO - PROCESS | 24400 | RSS: Main: 169185280 22:22:05 INFO - PROCESS | 24400 | 22:22:06 INFO - PROCESS | 24400 | Cycle 1(1): loaded http://localhost:46965/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46965/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:22:07 INFO - PROCESS | 24400 | RSS: Main: 169533440 22:22:07 INFO - PROCESS | 24400 | 22:22:09 INFO - PROCESS | 24400 | Cycle 1(1): loaded http://localhost:46965/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46965/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:22:10 INFO - PROCESS | 24400 | RSS: Main: 169762816 22:22:10 INFO - PROCESS | 24400 | 22:22:13 INFO - PROCESS | 24400 | Cycle 1(1): loaded http://localhost:46965/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46965/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:22:13 INFO - PROCESS | 24400 | RSS: Main: 169889792 22:22:13 INFO - PROCESS | 24400 | 22:22:16 INFO - PROCESS | 24400 | Cycle 1(1): loaded http://localhost:46965/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46965/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:22:17 INFO - PROCESS | 24400 | RSS: Main: 169914368 22:22:17 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | Cycle 1(1): loaded http://localhost:46965/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46965/tests/kraken/driver.html?testName=ai-astar) 22:22:19 INFO - PROCESS | 24400 | RSS: Main: 170586112 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | __start_tp_report 22:22:19 INFO - PROCESS | 24400 | _x_x_mozilla_page_load 22:22:19 INFO - PROCESS | 24400 | _x_x_mozilla_page_load_details 22:22:19 INFO - PROCESS | 24400 | |i|pagename|runs| 22:22:19 INFO - PROCESS | 24400 | |0;ai-astar;104;112;105;112;113;114;114;112;112;113 22:22:19 INFO - PROCESS | 24400 | |1;audio-beat-detection;161;122;153;171;125;149;147;125;182;124 22:22:19 INFO - PROCESS | 24400 | |2;audio-dft;161;163;163;163;176;165;162;164;164;163 22:22:19 INFO - PROCESS | 24400 | |3;audio-fft;76;79;76;162;78;76;76;75;165;77 22:22:19 INFO - PROCESS | 24400 | |4;audio-oscillator;85;86;139;87;86;86;128;85;84;142 22:22:19 INFO - PROCESS | 24400 | |5;imaging-gaussian-blur;118;118;117;117;117;119;118;119;117;118 22:22:19 INFO - PROCESS | 24400 | |6;imaging-darkroom;148;147;148;147;148;149;149;148;148;151 22:22:19 INFO - PROCESS | 24400 | |7;imaging-desaturate;95;96;96;96;96;95;96;96;96;96 22:22:19 INFO - PROCESS | 24400 | |8;json-parse-financial;66;64;67;66;65;69;66;68;65;64 22:22:19 INFO - PROCESS | 24400 | |9;json-stringify-tinderbox;64;66;65;64;72;66;64;65;65;65 22:22:19 INFO - PROCESS | 24400 | |10;stanford-crypto-aes;79;79;78;89;81;80;78;80;83;84 22:22:19 INFO - PROCESS | 24400 | |11;stanford-crypto-ccm;142;130;135;138;129;146;134;139;186;139 22:22:19 INFO - PROCESS | 24400 | |12;stanford-crypto-pbkdf2;168;170;167;163;169;172;168;165;170;166 22:22:19 INFO - PROCESS | 24400 | |13;stanford-crypto-sha256-iterative;67;69;70;67;67;67;67;65;69;69 22:22:19 INFO - PROCESS | 24400 | __end_tp_report 22:22:19 INFO - PROCESS | 24400 | __start_cc_report 22:22:19 INFO - PROCESS | 24400 | _x_x_mozilla_cycle_collect,1023 22:22:19 INFO - PROCESS | 24400 | __end_cc_report 22:22:19 INFO - PROCESS | 24400 | __startTimestamp1467868939410__endTimestamp 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | ------- Summary: start ------- 22:22:19 INFO - PROCESS | 24400 | Number of tests: 14 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.50 stddev:3.57 (3.2%) stddev-sans-first:2.71 22:22:19 INFO - PROCESS | 24400 | Values: 104.0 112.0 105.0 112.0 113.0 114.0 114.0 112.0 112.0 113.0 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:151.00 stddev:21.47 (14.2%) stddev-sans-first:22.06 22:22:19 INFO - PROCESS | 24400 | Values: 161.0 122.0 153.0 171.0 125.0 149.0 147.0 125.0 182.0 124.0 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:4.22 (2.6%) stddev-sans-first:4.29 22:22:19 INFO - PROCESS | 24400 | Values: 161.0 163.0 163.0 163.0 176.0 165.0 162.0 164.0 164.0 163.0 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:36.65 (48.2%) stddev-sans-first:38.29 22:22:19 INFO - PROCESS | 24400 | Values: 76.0 79.0 76.0 162.0 78.0 76.0 76.0 75.0 165.0 77.0 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:85.50 stddev:24.78 (29.0%) stddev-sans-first:25.61 22:22:19 INFO - PROCESS | 24400 | Values: 85.0 86.0 139.0 87.0 86.0 86.0 128.0 85.0 84.0 142.0 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 22:22:19 INFO - PROCESS | 24400 | Values: 118.0 118.0 117.0 117.0 117.0 119.0 118.0 119.0 117.0 118.0 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 22:22:19 INFO - PROCESS | 24400 | Values: 148.0 147.0 148.0 147.0 148.0 149.0 149.0 148.0 148.0 151.0 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:22:19 INFO - PROCESS | 24400 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:1.63 (2.5%) stddev-sans-first:1.73 22:22:19 INFO - PROCESS | 24400 | Values: 66.0 64.0 67.0 66.0 65.0 69.0 66.0 68.0 65.0 64.0 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.00 stddev:2.37 (3.6%) stddev-sans-first:2.44 22:22:19 INFO - PROCESS | 24400 | Values: 64.0 66.0 65.0 64.0 72.0 66.0 64.0 65.0 65.0 65.0 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:80.50 stddev:3.41 (4.2%) stddev-sans-first:3.54 22:22:19 INFO - PROCESS | 24400 | Values: 79.0 79.0 78.0 89.0 81.0 80.0 78.0 80.0 83.0 84.0 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | [#11] stanford-crypto-ccm Cycles:10 Average:141.80 Median:139.00 stddev:16.37 (11.8%) stddev-sans-first:17.36 22:22:19 INFO - PROCESS | 24400 | Values: 142.0 130.0 135.0 138.0 129.0 146.0 134.0 139.0 186.0 139.0 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:168.50 stddev:2.66 (1.6%) stddev-sans-first:2.82 22:22:19 INFO - PROCESS | 24400 | Values: 168.0 170.0 167.0 163.0 169.0 172.0 168.0 165.0 170.0 166.0 22:22:19 INFO - PROCESS | 24400 | 22:22:19 INFO - PROCESS | 24400 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.49 (2.2%) stddev-sans-first:1.56 22:22:19 INFO - PROCESS | 24400 | Values: 67.0 69.0 70.0 67.0 67.0 67.0 67.0 65.0 69.0 69.0 22:22:19 INFO - PROCESS | 24400 | -------- Summary: end -------- 22:22:19 INFO - PROCESS | 24400 | 22:22:20 INFO - TEST-INFO | 24400: exit 0 22:22:20 INFO - TEST-OK | kraken | took 64358ms 22:22:20 INFO - SUITE-END | took 1182s 22:22:20 INFO - Completed test suite (00:19:42) 22:22:20 INFO - javascript benchmark 22:22:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6596.1528121282845, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2693.703692593814, 2739.0960982875654, 2744.341358074062, 2754.242583289595, 2762.0332883490782, 4799.208130658441, 4897.04507621014, 4939.827106051289, 4989.101961646902, 5029.723365214912, 4803.3995750531185, 4863.19757240055, 4890.364252647159, 4950.207966725325, 4961.355023846904, 4491.393661855656, 4523.932141017887, 4559.863204103882, 4570.542945705436, 4576.519465456129, 4555.635549156076, 4568.748718820463, 4587.0825834833, 4607.769611519428, 4686.43762748469, 4546.863594092182, 4632.290786136927, 4632.397788287535, 4642.094791515656, 4685.601723853477, 4436.955630443719, 4593.425821772278, 4610.423697037871, 4634.0, 4673.626109911199, 4447.688661793676, 4454.443194600675, 4465.129299786543, 4492.7528985905765, 4500.549945005506, 4823.2282834746275, 4864.270359446112, 4872.9512704873205, 4874.8537543873745, 4917.532834380764, 5155.587552995751, 5218.66078704883, 5240.8689782755355, 5278.736063196863, 5299.099153143975, 5326.227696983954, 5349.679019258857, 5354.437784032699, 5384.973075134639, 5416.566674666017, 4976.129177393942, 4976.626752993468, 4991.700497970133, 5002.74986250686, 5030.748462576893, 5282.788688452496, 5415.810446634349, 5424.105022671215, 5445.891082178414, 5489.286392768914, 5138.332016837787, 5164.638475306692, 5170.379554453414, 5232.502912223333, 5248.134057880483, 5332.5467335276935, 5335.253064570963, 5342.599305052059, 5342.786288548492, 5379.193121031876, 5181.5077567631015, 5214.713190774544, 5243.344581927259, 5267.288915996368, 5276.234945932818, 5164.354455693038, 5212.687238765686, 5237.685738855681, 5239.711815850089, 5274.182501712241, 4349.608535231844, 4398.934015989763, 4417.182821178092, 4427.778611069433, 4465.4864690561, 3798.5061941947924, 3816.1222918728295, 3825.2923209206388, 3826.7512611680154, 3950.0322421007036, 4504.054148628759, 4522.66080043998, 4529.343245229489, 4566.748828814447, 4584.129015487047, 5368.543673787772, 5385.3268341457315, 5392.622516423813, 5397.8110766123, 5442.428545002717, 4472.904138486092, 4545.0, 4565.543445655474, 4583.587477127075, 4588.082383523309, 4721.220998535203, 4724.43306803179, 4728.0, 4744.264638980894, 4820.25286080658, 4971.154903666457, 5011.1481048221885, 5038.697678139323, 5044.672096313728, 5077.289179514797, 5197.532222099878, 5249.501297376743, 5294.391145018218, 5324.920126198188, 5357.089294819968, 5016.197408414636, 5026.773795179299, 5038.2190760432195, 5041.924371134509, 5090.898182036412, 5192.922106168486, 5207.817726379559, 5209.53114219722, 5216.895662086813, 5227.790888364575, 5111.667741596784, 5290.206469029677, 5309.38942021657, 5317.229001794795, 5367.4364191759305, 5174.689518628894, 5184.559312458483, 5193.143131383279, 5197.428282888804, 5247.449017853223, 4953.380827396575, 5198.090334191577, 5222.399424066281, 5232.450592687713, 5238.764255608583, 4982.177940639899, 4999.600031997359, 5000.174971129868, 5043.2687260347775, 5052.646314757932, 5172.431032586488, 5174.094533456705, 5184.040952423814, 5186.559142472932, 5236.266922630911, 4875.585575226146, 4988.700677959334, 5051.646384753032, 5053.772580233825, 5055.51972562606], "value": 4850.606321712267, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.327057954965, 577.5004621002834, 581.0325807530461, 593.7803012885232, 595.6545203781807, 35794.0, 39599.604003959954, 39609.99999999993, 39938.0, 39942.60057399425, 39787.80106099473, 40334.39498407526, 40522.39216411756, 40681.796591017, 40708.18583628333, 7815.374770018385, 7836.921630783676, 7898.0, 7914.28771410573, 7917.406194535404, 7840.255175758322, 7964.0, 7968.561729104897, 7981.720639777609, 7983.0420349558135, 7947.324477419426, 7978.202179782004, 7986.361091112697, 7995.880061799048, 8016.959915200416, 7975.322097621709, 7990.161033091529, 7998.600069996477, 8005.919940800576, 8011.359091272742, 7948.801279967989, 7991.20087991202, 8003.9199608003755, 8009.159038301011, 8022.237887400687, 37934.62065379338, 38242.0, 38512.22975540502, 38604.22791544154, 38643.420348694795, 2922.3570814421005, 2942.7940044196916, 3306.2230375861654, 3735.458358537997, 3838.42423636454, 28936.565951510533, 29565.113046608636, 29735.0, 29759.553606695918, 29763.70236297631, 3581.5164952731307, 3588.2105936693883, 3682.5396825396824, 3718.888433347004, 3746.157114649182, 257591.0, 261050.0, 261227.0, 261623.0, 262803.0, 31913.0, 32951.0, 55540.44459555353, 55909.44090559124, 56250.43749562452, 33845.0, 34009.65990340065, 34125.0, 34209.48685769716, 34353.48469772955, 13587.456501740018, 13750.724985500234, 13809.033367664368, 13819.516316928859, 13849.961252906072, 11057.391843448526, 11157.888421115847, 11159.218854680095, 11168.609098681507, 11181.32912025281, 7855.567943763148, 7876.306594082185, 7895.368370530458, 7961.800954976056, 7984.560849153236, 3096.8296743679316, 3141.308912039348, 3144.119646498984, 3147.228928912431, 3170.3500782339565, 859.5315553023618, 918.1140199707181, 929.8372784762639, 956.2397893674546, 971.3880255439028, 29154.708452915198, 29782.55326170109, 29999.05006174592, 30026.39947201044, 30126.397472050438, 990.4156547636928, 996.1035068438464, 1016.671821528691, 1023.526122383765, 1034.095166729112, 15376.846231537766, 15514.301856416263, 15600.843991560167, 15683.607909802346, 15717.214139293219, 387219.0, 393326.0, 394115.0, 394398.0, 394567.0, 50177.24734128918, 50661.74669126631, 51006.0, 51334.0, 51359.74320128375, 1188.1089183112665, 1190.9464074116686, 1190.9745061691601, 1200.363807182195, 1217.8295038694766, 27742.167734967985, 28440.288992775346, 28876.133715988555, 29022.854885725435, 29273.7072629271, 38360.61639383682, 38402.0, 38474.6152538471, 43806.780966094964, 44329.77835110804, 143732.0, 143920.0, 144050.2797486006, 144124.0, 144348.0, 22325.995330210506, 22748.545029099656, 22817.88591057034, 22884.4278893029, 25766.09818656338, 40662.39006414847, 43169.13661726811, 43853.78073109614, 44371.33442998422, 44537.55462445334, 37023.259534809695, 37427.625723743506, 38519.80740096282, 38622.0, 38891.416628751154, 37344.81327593345, 37963.810180948916, 38667.80666096652, 38758.224835502566, 38799.22401552009, 35674.46488302729, 36877.0, 37095.629043710294, 37215.813920930224, 37367.81316093402, 32425.189370264987, 34404.82797585996, 34619.4807077889, 34850.128746781535, 34931.301373972885, 25881.741182588685, 26185.476290473704, 26200.0, 26521.60217596699, 26725.465490689687], "value": 16407.152095740912, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.785430523144, 369.8206369910592, 372.76702061211745, 380.4825437405129, 383.2698708959433, 15925.681486370266, 17643.558911027216, 17813.109344532786, 18444.631107377845, 18531.44405667832, 17550.385736499225, 17846.732299015493, 18361.0, 18487.352942646976, 19190.616187676274, 5729.541636669067, 5960.940390596082, 6025.608335458203, 6048.788292409767, 6061.878762424749, 5769.365369809318, 5936.347001829795, 5951.375105613892, 5970.104484327342, 5979.940200598004, 5795.71021448928, 5825.825225243249, 5945.256842894638, 5966.820995370124, 5972.701364931758, 5828.825135245907, 5995.550333724967, 6004.159417681528, 6007.15899774032, 6008.068749343859, 5780.421957804228, 5811.360750317462, 5840.269966254218, 5888.470037696585, 5889.469947704684, 22689.773102269097, 23461.530769384688, 23600.881995590084, 23606.64590031151, 24449.755502444925, 1862.5157459060606, 1921.1162865082078, 1933.9709904351446, 1993.6511110555596, 2040.5306779440664, 14703.63240918975, 14938.253087345589, 15172.862035347393, 15484.922575387163, 16183.757243641356, 1832.1480511562054, 1847.178005787425, 1889.6126294109674, 1953.3651563242004, 1961.568454939911, 82607.5869620648, 85512.57243713741, 85892.14107858966, 88612.11387886103, 89804.0, 13487.662808429672, 15822.60443488922, 17163.0, 17205.042840146838, 17215.91392043057, 29724.851375743416, 29777.10668679943, 30344.848275758923, 30362.392752144835, 30429.543556846664, 8914.593059873798, 9109.453432794053, 9153.496557689257, 9192.954035229915, 9219.124183202584, 7412.332890039815, 7478.214787447239, 7501.362384197295, 7589.58257295854, 7639.121501027453, 8657.935107961786, 8660.393772435995, 8682.86975695365, 8684.696035638723, 8697.652093916298, 3438.0604583081604, 3450.516927630134, 3472.232627599083, 3532.911677208039, 3660.249648821985, 799.5043073294595, 804.0833449867039, 820.1470470710394, 864.6022829498376, 898.6495266845935, 16747.0, 17622.00558906876, 17710.557236068944, 17744.37894673706, 18044.917304961746, 880.295763389286, 880.8018195905998, 895.7671005538607, 906.2704522859161, 953.208836665566, 9543.618255269712, 9619.374740641835, 9859.556319965619, 9906.60373585063, 10349.63776267827, 259962.0, 262818.0, 262909.0, 264202.0, 424646.0, 59729.506762331286, 71594.64202679058, 77156.2284377149, 84729.57635211785, 86729.56635216784, 913.2100732866156, 924.653255029364, 944.471096186138, 949.1647350331664, 956.6030097509595, 14285.64285892861, 14574.198419086628, 16006.439774607832, 16212.0, 16646.084465354037, 38193.61806382012, 39189.41215881821, 39720.205595888496, 40001.399978999754, 41499.58500414957, 53989.73005134949, 55945.44054559402, 56065.0, 56165.71917140388, 56498.74005039917, 7249.202587715453, 7309.4152467803515, 7357.852842943218, 7394.149672787483, 7720.343770779322, 11762.0, 11933.105017123924, 12238.632841014783, 12238.877611223774, 12348.0, 9669.468179250209, 10220.540075696463, 10358.482075896025, 10720.571177152826, 10868.510917008596, 6312.6528040956355, 10289.9485502575, 10608.204384671026, 10823.837642435212, 10946.014858662758, 10415.270931034755, 10447.58209671635, 10515.106215971728, 10522.684319470429, 10700.0, 7229.313215244543, 7374.188839227573, 7378.667959941923, 7405.481616286808, 7448.5158464699625, 10065.144462720751, 10188.745281368025, 10300.793984120426, 10420.905804890377, 10648.414337211529], "value": 9294.385531355847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.6695992961688, 1414.3564678071477, 1482.8591283828039, 1698.762173295738, 1760.1375326090213, 7008.544444611097, 7624.847503049936, 7721.420893432994, 8278.91721082789, 8290.170982901707, 7865.252800983912, 8056.315213206884, 8127.3091787198155, 8135.145809689986, 8137.267645911867, 2233.2853486884205, 2270.704808374909, 2274.385915802732, 2282.018731945263, 2284.132029828663, 2177.1617927098023, 2223.766504517019, 2224.421650370907, 2227.6658501224783, 2234.0728597631964, 2191.638379667353, 2212.4468882779306, 2215.4793623498463, 2230.7657695941934, 2263.7396699379533, 2159.686845407415, 2167.046499540197, 2181.0076415231033, 2183.7051997980307, 2186.693862859201, 2191.9452013699624, 2199.2082850173924, 2217.456723102834, 2217.46780772615, 2221.1781640792847, 8201.876971845428, 8252.05101413339, 8255.752327430188, 8260.29787468066, 8264.586770661443, 4644.071185762828, 4709.175894218498, 4725.149473094842, 4728.05438912219, 4768.2847572864, 2766.792490563216, 2910.2287893708185, 2925.590417341574, 2926.839023853687, 2942.2350188950813, 854.7350321400323, 880.4937161132375, 883.4919921045424, 887.436477836572, 890.812929284851, 10863.750668673125, 10994.615188468446, 11007.119430445546, 11097.1122310215, 11107.500162492708, 4180.122174343361, 4218.704690671685, 4365.126974605028, 4382.802773875183, 4411.470623525198, 9232.723018309462, 9282.675106371245, 9328.720138395858, 9404.153626173676, 9423.434593924387, 4619.19164146273, 4623.722576645412, 4645.744484053342, 4655.6973796703105, 4662.067586482717, 3712.1833196696684, 4129.256733787947, 4212.777225422554, 4221.6200541951375, 4279.122779830127, 3665.2852693725, 3745.793981331053, 3768.6231376862092, 3790.8673196437994, 3855.151866589346, 1142.2175809570472, 1147.4549588945183, 1149.8620165580016, 1157.0685598093617, 1191.5174354386488, 725.8439435521389, 856.8243510080418, 862.8619420892627, 875.4090988582681, 878.3587980773943, 5328.467153284718, 5422.15956526739, 5423.538999185034, 5450.836474905759, 5454.53636440899, 394.12504240585855, 396.3104198694251, 399.69623086454504, 403.31839191765823, 410.17145366359784, 3680.208755117609, 3798.3163030654746, 3819.0643292393543, 3835.520559930009, 3840.8847734568008, 9764.902350976541, 10076.647317343857, 10085.0, 10204.540795664212, 10247.795044099226, 9957.800843983225, 10042.246831487668, 10042.845072816574, 10051.698449046395, 10162.796744065077, 7464.962675186589, 7595.962020189974, 7616.0860696715645, 7661.693532258759, 7712.691492340244, 5305.416404195458, 5352.464753524772, 5366.221897824872, 5367.302250707383, 5418.268533748052, 9085.591148398205, 9098.454092754457, 9116.908830911607, 9145.314101442551, 9157.496337701225, 8673.566321683764, 9097.863532047157, 9104.544772761203, 9220.769480763034, 9405.106514881076, 6184.690765461619, 6701.0, 6762.8647427052165, 6902.309769023258, 6976.790696279119, 7973.043234811859, 7977.680892764224, 8032.879506807286, 8062.39532035088, 8071.71748988806, 7049.929500705132, 7208.098987626547, 7263.273672632695, 7322.231165727522, 7332.890006649798, 6819.352161544645, 6899.344562266577, 6978.47661425385, 7061.223265440694, 7267.818304542428, 6723.226828914738, 6785.355391237825, 6825.795226143224, 6854.897176542256, 6884.449244060564, 4517.75152366623, 4617.238155704271, 4631.976840115778, 4655.86032419028, 4702.318163866289, 4675.275332323496, 4740.312654665123, 4754.0729557737295, 4762.119007983534, 4793.616510679068], "value": 4154.66943847675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.43560057887123, 293.9147647182317, 305.5859310634091, 308.44172048592065, 311.57936785339797, 5162.277281180638, 5168.741562921853, 5184.688918664882, 5197.974010129953, 5204.531592156705, 5091.159958606825, 5091.567216786569, 5103.336566246392, 5112.3098381718455, 5137.820176293831, 3773.792441415721, 3880.670143037831, 3946.1713040261434, 3965.266425711253, 3973.185496973128, 3951.1505026419313, 3953.584873588275, 3971.9205615887663, 4014.5383280922774, 4018.718689691723, 3983.223271462066, 3993.800309984489, 4007.9378964574266, 4008.5790991945864, 4011.3581826907703, 3713.1274150574595, 3945.704072194568, 3967.4643923070303, 4002.8191683453306, 4010.8796736097966, 3406.9949364937156, 3441.6042155151977, 3451.620321764604, 3454.3091381723757, 3460.584729832436, 4908.77910494025, 4970.602351811846, 4993.575546078588, 5001.599872010231, 5005.974970125162, 4247.362895565659, 4535.387722657432, 4565.383673204108, 4570.542945705436, 4584.426946631671, 5267.657602255841, 5310.814121505768, 5335.039692855324, 5350.170723537858, 5356.3572371315695, 3751.456038874348, 3753.817547472565, 3767.792771397572, 3771.8679846205528, 3775.244951009809, 5345.385280692732, 5589.552835773128, 5624.0439125348785, 5659.292588426447, 5695.430456954313, 3849.7882616456363, 3869.071422858494, 3870.632289932452, 3877.728559000899, 3891.066144125446, 3928.6267804559093, 3931.3513270310077, 3937.8621748238675, 3939.4287828265315, 3939.5272567291536, 4512.210363186429, 4513.390692256569, 4518.390017347681, 4525.705829121097, 4529.8641040768825, 5060.862265395404, 5277.498637629419, 5303.867403314871, 5312.707801070978, 5407.783688652488, 1325.436689406998, 1330.401319406271, 1331.182935293337, 1341.6243451833307, 1352.6888815572474, 842.3555979675554, 848.325581162977, 854.7563944275852, 863.494855509534, 864.4510735682886, 4571.862844114682, 4614.3388380183105, 4615.5845973862515, 4616.215243408561, 4616.515265897099, 5378.7041712705395, 5387.272718183073, 5392.622516423813, 5396.757145928443, 5419.945800542023, 4400.9119817604105, 4555.9772201138785, 4596.655250856199, 4598.172328980749, 4614.792334344963, 2910.7338307835735, 2938.353562216309, 2938.617979662673, 2940.8529573521237, 2949.601803756508, 5099.388073431212, 5114.41184263807, 5166.302549155891, 5167.560757335668, 5169.870753231124, 5378.650387724785, 5577.860553486195, 5617.073182924853, 5636.436356364413, 5642.153676948408, 5088.643794934319, 5131.717755523482, 5144.819931302386, 5169.974150129226, 5188.898496109006, 5409.864753381197, 5416.458354164552, 5458.727063646881, 5473.890522189614, 5477.507024367826, 5117.309163262912, 5286.682799031916, 5413.323334583177, 5422.267993820784, 5434.918476222781, 5207.479252074762, 5209.895802084013, 5232.005918875554, 5248.711320877388, 5263.578913686973, 3796.8101594920695, 3811.7712937223855, 3816.8549435168784, 3819.675327597074, 3822.2164456285836, 5215.5827533797965, 5457.508824205841, 5490.231367608458, 5520.309961254843, 5535.861603459945, 5277.340332458442, 5299.708516031656, 5316.627836051439, 5323.228131920927, 5331.933613277438, 5209.451933690608, 5305.1776974569, 5330.333708286465, 5353.223782551586, 5368.1679339702405, 5158.226266060121, 5176.9741151294, 5199.844004679866, 5204.609654276021, 5272.9736351318, 5074.517920797518, 5207.895842083213, 5322.707251101227, 5337.519623233928, 5342.545883599938, 5153.5361817436615, 5160.122779127482, 5161.870953226199, 5169.508896654812, 5202.8959420812125], "value": 3990.2391777817356, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.4998251416353, 648.5946283572767, 660.4056349285645, 710.6695386645209, 716.4590733995832, 12982.935085324572, 13437.059405841595, 13447.663808404795, 13676.316184190788, 13683.24742139182, 13212.735745285088, 13307.534236301732, 13417.597472075853, 13428.865711342884, 13435.26106064166, 749.254491780679, 770.1797585571348, 796.040770871099, 796.2674339607546, 796.9203079692043, 791.4064451661254, 795.0380040151424, 796.1163108949062, 801.7234054251275, 803.5580430763057, 836.4897412578322, 837.0290463062848, 838.2372041442288, 838.4089217101958, 842.153635596225, 826.669332267098, 827.8220182660726, 829.9709510167145, 834.8789425533264, 835.0355339582792, 608.2062907905182, 609.7439075588263, 610.6397225636896, 611.1871211288975, 611.8562137897591, 13629.25039122848, 13647.0, 13647.454101836014, 13657.726845463134, 13659.0, 11810.586629467927, 12615.053870959715, 12771.262672170125, 13264.270465124415, 13446.93276533611, 11662.76674466506, 12046.518139274418, 12232.938835305766, 12378.195417297848, 12475.50097996079, 4141.834326626931, 4183.644390226835, 4193.433886425354, 4268.551802060801, 4306.913861722779, 57474.425255747745, 62430.68784656093, 63308.366916330706, 64056.3594364055, 64192.35807641911, 10085.647002355028, 10396.792064158675, 10471.424071675978, 10578.0, 10627.84058239127, 18635.254589816526, 18644.16101275446, 18663.533411664816, 18693.813061869478, 18697.0, 7162.856742865113, 7196.10048743907, 7271.454640901953, 7279.854402911912, 7508.2867127622785, 3693.963060369416, 3767.9434808477895, 3780.3384407728536, 3780.8865734028022, 3846.0961674006585, 2985.7462115719973, 3099.969000310013, 3100.3954228925145, 3107.658157602662, 3111.9222019449694, 540.4082529630049, 542.7530473634487, 550.1417788250342, 558.4973523828587, 560.8541779137454, 525.7029778175319, 561.3151954615363, 563.4731526023181, 608.1455554945309, 630.0580631955256, 8197.139300373376, 8242.835143297101, 8563.529005904611, 8791.472511649321, 8888.73333799987, 580.4195804195804, 590.4597293476421, 591.2579712460835, 591.382005803936, 594.2987275015523, 4063.5733248009124, 4097.1396006838895, 4193.370994350872, 4197.496300443905, 4209.5579964103945, 95282.52358738161, 96091.0, 97390.5130474343, 97556.51221743987, 98164.50917745366, 68244.6587767068, 69815.0, 70933.64533177404, 84645.0, 87928.5603571978, 74377.0, 75345.62327188329, 76481.0, 76763.61618191985, 77419.61290193514, 8812.559372031244, 9204.723858284262, 9229.953850230706, 9320.0, 9326.114019168168, 41809.0, 43837.34243986279, 44738.55261447344, 46433.66012908424, 47361.0, 53897.0, 55365.0, 55369.72315138399, 60431.395686042575, 60556.69721651363, 10860.348379097279, 10989.230753847474, 11158.10735141203, 11384.886151138713, 11418.828717569077, 13171.93414032962, 13357.53248636293, 13390.397432115384, 13646.522371716943, 14239.216843073731, 11816.416944596409, 12352.505899763908, 12384.81422778641, 12394.81407778902, 12803.219732817994, 10540.10409115203, 10541.104006159563, 10602.575896964036, 10661.0, 10663.200259980378, 10906.127509799355, 11173.441327933733, 11208.439578020903, 11485.393045824841, 11731.120165987755, 9790.657326993522, 10025.899741002788, 10194.133498652698, 10400.0, 10564.894351056391, 9650.806983860424, 10056.698299050748, 10057.899421005988, 10160.898391015995, 10192.439415831905], "value": 6716.03918167062, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 105.0, 112.0, 113.0, 114.0, 114.0, 112.0, 112.0, 113.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 122.0, 153.0, 171.0, 125.0, 149.0, 147.0, 125.0, 182.0, 124.0], "value": 145.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 163.0, 176.0, 165.0, 162.0, 164.0, 164.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 162.0, 78.0, 76.0, 76.0, 75.0, 165.0, 77.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 139.0, 87.0, 86.0, 86.0, 128.0, 85.0, 84.0, 142.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 119.0, 118.0, 119.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 148.0, 149.0, 149.0, 148.0, 148.0, 151.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 67.0, 66.0, 65.0, 69.0, 66.0, 68.0, 65.0, 64.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 64.0, 72.0, 66.0, 64.0, 65.0, 65.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 89.0, 81.0, 80.0, 78.0, 80.0, 83.0, 84.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 130.0, 135.0, 138.0, 129.0, 146.0, 134.0, 139.0, 186.0, 139.0], "value": 141.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 167.0, 163.0, 169.0, 172.0, 168.0, 165.0, 170.0, 166.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 70.0, 67.0, 67.0, 67.0, 67.0, 65.0, 69.0, 69.0], "value": 67.7, "unit": "score"}]}]} 22:22:20 INFO - Return code: 0 22:22:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:22:20 ERROR - # TBPL SUCCESS # 22:22:20 INFO - Running post-action listener: _resource_record_post_action 22:22:20 INFO - ##### 22:22:20 INFO - ##### Finished run-tests step (success) 22:22:20 INFO - ##### 22:22:20 INFO - Running post-run listener: _resource_record_post_run 22:22:20 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551075840; Read time: 16; Write time: 551948 22:22:20 INFO - TinderboxPrint: CPU usage
13.3% 22:22:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 22:22:20 INFO - TinderboxPrint: I/O write bytes / time
551,075,840 / 551,948 22:22:20 INFO - TinderboxPrint: CPU idle
8,294.6 (86.7%) 22:22:20 INFO - TinderboxPrint: CPU user
1,217.5 (12.7%) 22:22:20 INFO - TinderboxPrint: Swap in / out
0 / 0 22:22:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246104064; Read time: 0; Write time: 277476 22:22:20 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 300351488; Read time: 16; Write time: 273912 22:22:21 INFO - Running post-run listener: _upload_blobber_files 22:22:21 INFO - Blob upload gear active. 22:22:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:22:21 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 22:22:21 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:22:21 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:22:21 INFO - (blobuploader) - INFO - Open directory for files ... 22:22:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:22:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:22:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:22 INFO - (blobuploader) - INFO - Done attempting. 22:22:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:22:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:22:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:25 INFO - (blobuploader) - INFO - Done attempting. 22:22:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:22:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:22:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:26 INFO - (blobuploader) - INFO - Done attempting. 22:22:26 INFO - (blobuploader) - INFO - Iteration through files over. 22:22:26 INFO - Return code: 0 22:22:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:22:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:22:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c911c7addfe2662593544b08b5660f12aa94be22965232a1398fb85398124a6bd48186a99694b82f424091686ca3abe4df22a7bd9bbe1c070a3d3bb325802fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d417683b93c0cf891f516eae66a55d32e4ca80b5e945998ce1711dc2563a24c9d78f1281fe86eafe5e69201e735855e7014c495ecfd6ac8144dc1b88e2fcd1ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d8e57775e1709462a459e5240559d2c710c297d6b0a1c11a66f8b5ae9249eeec195fb42ce65e3e352f167ec682f057487ca113bd65f08fd04ac538ff823adae4"} 22:22:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:22:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:22:26 INFO - Contents: 22:22:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c911c7addfe2662593544b08b5660f12aa94be22965232a1398fb85398124a6bd48186a99694b82f424091686ca3abe4df22a7bd9bbe1c070a3d3bb325802fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d417683b93c0cf891f516eae66a55d32e4ca80b5e945998ce1711dc2563a24c9d78f1281fe86eafe5e69201e735855e7014c495ecfd6ac8144dc1b88e2fcd1ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d8e57775e1709462a459e5240559d2c710c297d6b0a1c11a66f8b5ae9249eeec195fb42ce65e3e352f167ec682f057487ca113bd65f08fd04ac538ff823adae4"} 22:22:26 INFO - Running post-run listener: copy_logs_to_upload_dir 22:22:26 INFO - Copying logs to upload dir... 22:22:26 INFO - mkdir: /builds/slave/test/build/upload/logs 22:22:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.354097 ========= master_lag: 283.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 20 secs) (at 2016-07-06 22:27:09.819758) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 mins, 6 secs) (at 2016-07-06 22:27:09.823009) ========= 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=d2a8c569965ab8367867b893000001a1-1467867707.199368-22513771 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/Fx-Team-Non-PGO/sha512/3c911c7addfe2662593544b08b5660f12aa94be22965232a1398fb85398124a6bd48186a99694b82f424091686ca3abe4df22a7bd9bbe1c070a3d3bb325802fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d417683b93c0cf891f516eae66a55d32e4ca80b5e945998ce1711dc2563a24c9d78f1281fe86eafe5e69201e735855e7014c495ecfd6ac8144dc1b88e2fcd1ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d8e57775e1709462a459e5240559d2c710c297d6b0a1c11a66f8b5ae9249eeec195fb42ce65e3e352f167ec682f057487ca113bd65f08fd04ac538ff823adae4"} build_url:https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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/Fx-Team-Non-PGO/sha512/3c911c7addfe2662593544b08b5660f12aa94be22965232a1398fb85398124a6bd48186a99694b82f424091686ca3abe4df22a7bd9bbe1c070a3d3bb325802fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d417683b93c0cf891f516eae66a55d32e4ca80b5e945998ce1711dc2563a24c9d78f1281fe86eafe5e69201e735855e7014c495ecfd6ac8144dc1b88e2fcd1ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d8e57775e1709462a459e5240559d2c710c297d6b0a1c11a66f8b5ae9249eeec195fb42ce65e3e352f167ec682f057487ca113bd65f08fd04ac538ff823adae4"}' ========= master_lag: 246.22 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 mins, 6 secs) (at 2016-07-06 22:31:16.058709) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 mins, 47 secs) (at 2016-07-06 22:31:16.059039) ========= 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=d2a8c569965ab8367867b893000001a1-1467867707.199368-22513771 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004841 ========= master_lag: 287.43 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 mins, 47 secs) (at 2016-07-06 22:36:03.492942) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 22:36:03.493829) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 22:36:03.985213) ========= ========= Total master_lag: 817.15 =========